{"level":"warn","ts":"2026-02-17T18:55:31.828292Z","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-17T18:55:31.828364Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.248:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.248:2380","--initial-cluster=instance=https://199.204.45.248:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.248:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.248: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-17T18:55:31.828428Z","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-17T18:55:31.828436Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.248:2380"]} {"level":"info","ts":"2026-02-17T18:55:31.828454Z","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-17T18:55:31.830361Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"]} {"level":"info","ts":"2026-02-17T18:55:31.833213Z","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.204.45.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.248: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-17T18:55:31.841804Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.648907ms"} {"level":"info","ts":"2026-02-17T18:55:31.852504Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"39582465ceaa2f67","cluster-id":"87fd8ddedde3be45"} {"level":"info","ts":"2026-02-17T18:55:31.852668Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=()"} {"level":"info","ts":"2026-02-17T18:55:31.852736Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 0"} {"level":"info","ts":"2026-02-17T18:55:31.852783Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 39582465ceaa2f67 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-17T18:55:31.852842Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 1"} {"level":"info","ts":"2026-02-17T18:55:31.852916Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"} {"level":"warn","ts":"2026-02-17T18:55:31.862415Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-17T18:55:31.8853Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-17T18:55:31.932139Z","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-17T18:55:31.935316Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"39582465ceaa2f67","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-17T18:55:31.937768Z","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-17T18:55:31.938197Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"39582465ceaa2f67","initial-advertise-peer-urls":["https://199.204.45.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-17T18:55:31.93837Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-17T18:55:31.938606Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.248:2380"} {"level":"info","ts":"2026-02-17T18:55:31.939253Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.248:2380"} {"level":"info","ts":"2026-02-17T18:55:31.938712Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"39582465ceaa2f67","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-17T18:55:31.938844Z","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-17T18:55:31.940211Z","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-17T18:55:31.940311Z","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-17T18:55:31.939111Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"} {"level":"info","ts":"2026-02-17T18:55:31.941338Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","added-peer-id":"39582465ceaa2f67","added-peer-peer-urls":["https://199.204.45.248:2380"]} {"level":"info","ts":"2026-02-17T18:55:32.854445Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 is starting a new election at term 1"} {"level":"info","ts":"2026-02-17T18:55:32.854497Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-17T18:55:32.854529Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgPreVoteResp from 39582465ceaa2f67 at term 1"} {"level":"info","ts":"2026-02-17T18:55:32.854543Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became candidate at term 2"} {"level":"info","ts":"2026-02-17T18:55:32.854548Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgVoteResp from 39582465ceaa2f67 at term 2"} {"level":"info","ts":"2026-02-17T18:55:32.854556Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became leader at term 2"} {"level":"info","ts":"2026-02-17T18:55:32.854563Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 39582465ceaa2f67 elected leader 39582465ceaa2f67 at term 2"} {"level":"info","ts":"2026-02-17T18:55:32.855976Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"39582465ceaa2f67","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.248:2379]}","request-path":"/0/members/39582465ceaa2f67/attributes","cluster-id":"87fd8ddedde3be45","publish-timeout":"7s"} {"level":"info","ts":"2026-02-17T18:55:32.856016Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-17T18:55:32.856306Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T18:55:32.856373Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-17T18:55:32.858541Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-17T18:55:32.858554Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-17T18:55:32.859933Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.248:2379"} {"level":"info","ts":"2026-02-17T18:55:32.860994Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-17T18:55:32.870893Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T18:55:32.870939Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T18:55:32.871101Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T18:55:35.378757Z","caller":"traceutil/trace.go:171","msg":"trace[489373698] linearizableReadLoop","detail":"{readStateIndex:75; appliedIndex:74; }","duration":"487.834576ms","start":"2026-02-17T18:55:34.890904Z","end":"2026-02-17T18:55:35.378739Z","steps":["trace[489373698] 'read index received' (duration: 487.382034ms)","trace[489373698] 'applied index is now lower than readState.Index' (duration: 451.652µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T18:55:35.37898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T18:55:34.852517Z","time spent":"526.447827ms","remote":"127.0.0.1:52960","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-17T18:55:35.379823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.640546ms","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-17T18:55:35.3799Z","caller":"traceutil/trace.go:171","msg":"trace[1725604475] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:70; }","duration":"313.708516ms","start":"2026-02-17T18:55:35.066145Z","end":"2026-02-17T18:55:35.379853Z","steps":["trace[1725604475] 'agreement among raft nodes before linearized reading' (duration: 313.645716ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:55:35.379938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T18:55:35.066127Z","time spent":"313.797246ms","remote":"127.0.0.1:53238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":27,"request content":"key:\"/registry/priorityclasses/system-node-critical\" "} {"level":"warn","ts":"2026-02-17T18:55:35.37909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.154457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T18:55:35.380038Z","caller":"traceutil/trace.go:171","msg":"trace[89251551] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:70; }","duration":"489.14766ms","start":"2026-02-17T18:55:34.890876Z","end":"2026-02-17T18:55:35.380024Z","steps":["trace[89251551] 'agreement among raft nodes before linearized reading' (duration: 488.146347ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:55:35.380132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.787346ms","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-17T18:55:35.380161Z","caller":"traceutil/trace.go:171","msg":"trace[1414993259] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:70; }","duration":"313.826477ms","start":"2026-02-17T18:55:35.066327Z","end":"2026-02-17T18:55:35.380153Z","steps":["trace[1414993259] 'agreement among raft nodes before linearized reading' (duration: 313.785627ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:55:35.380096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.483828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T18:55:35.381087Z","caller":"traceutil/trace.go:171","msg":"trace[1821145875] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:70; }","duration":"202.532982ms","start":"2026-02-17T18:55:35.178539Z","end":"2026-02-17T18:55:35.381072Z","steps":["trace[1821145875] 'agreement among raft nodes before linearized reading' (duration: 201.525318ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:55:35.380134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T18:55:34.890861Z","time spent":"489.262061ms","remote":"127.0.0.1:53046","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":27,"request content":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" "} {"level":"warn","ts":"2026-02-17T18:55:35.380434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T18:55:35.066322Z","time spent":"314.083568ms","remote":"127.0.0.1:53212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" "} {"level":"warn","ts":"2026-02-17T18:55:35.88665Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415870834167254488,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T18:55:36.428812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.709012ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-02-17T18:55:36.428918Z","caller":"traceutil/trace.go:171","msg":"trace[342936638] transaction","detail":"{read_only:false; response_revision:71; number_of_response:1; }","duration":"1.04455916s","start":"2026-02-17T18:55:35.384341Z","end":"2026-02-17T18:55:36.4289Z","steps":["trace[342936638] 'process raft request' (duration: 731.252756ms)","trace[342936638] 'compare' (duration: 312.540721ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T18:55:36.428966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T18:55:35.384328Z","time spent":"1.04462258s","remote":"127.0.0.1:52960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":592,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-17T18:55:37.213544Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.097971402s","expected-duration":"1s"} {"level":"warn","ts":"2026-02-17T18:55:37.659575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.656411ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-02-17T18:55:37.659842Z","caller":"traceutil/trace.go:171","msg":"trace[320094608] transaction","detail":"{read_only:false; response_revision:74; number_of_response:1; }","duration":"1.225355593s","start":"2026-02-17T18:55:36.434464Z","end":"2026-02-17T18:55:37.659819Z","steps":["trace[320094608] 'process raft request' (duration: 1.225304153s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:55:37.659927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T18:55:36.434437Z","time spent":"1.225452293s","remote":"127.0.0.1:52960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":625,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T18:55:37.660248Z","caller":"traceutil/trace.go:171","msg":"trace[785239457] transaction","detail":"{read_only:false; response_revision:73; number_of_response:1; }","duration":"2.275560001s","start":"2026-02-17T18:55:35.384675Z","end":"2026-02-17T18:55:37.660235Z","steps":["trace[785239457] 'process raft request' (duration: 2.275018159s)"],"step_count":1} {"level":"info","ts":"2026-02-17T18:55:37.660245Z","caller":"traceutil/trace.go:171","msg":"trace[1868758556] transaction","detail":"{read_only:false; response_revision:72; number_of_response:1; }","duration":"2.275619431s","start":"2026-02-17T18:55:35.384584Z","end":"2026-02-17T18:55:37.660203Z","steps":["trace[1868758556] 'process raft request' (duration: 1.829234378s)","trace[1868758556] 'compare' (duration: 445.41857ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T18:55:37.660301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T18:55:35.384671Z","time spent":"2.275603951s","remote":"127.0.0.1:53238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":429,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-17T18:55:37.66041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T18:55:35.38457Z","time spent":"2.275762602s","remote":"127.0.0.1:53076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3431,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T18:55:37.660447Z","caller":"traceutil/trace.go:171","msg":"trace[1722871277] linearizableReadLoop","detail":"{readStateIndex:78; appliedIndex:75; }","duration":"2.274716808s","start":"2026-02-17T18:55:35.385718Z","end":"2026-02-17T18:55:37.660435Z","steps":["trace[1722871277] 'read index received' (duration: 729.893671ms)","trace[1722871277] 'applied index is now lower than readState.Index' (duration: 1.544821907s)"],"step_count":2} {"level":"warn","ts":"2026-02-17T18:55:37.660669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.274932169s","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-17T18:55:37.660703Z","caller":"traceutil/trace.go:171","msg":"trace[1866103150] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:74; }","duration":"2.274989609s","start":"2026-02-17T18:55:35.385703Z","end":"2026-02-17T18:55:37.660693Z","steps":["trace[1866103150] 'agreement among raft nodes before linearized reading' (duration: 2.274864538s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:55:37.660738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T18:55:35.385695Z","time spent":"2.275033139s","remote":"127.0.0.1:53222","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":27,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" "} {"level":"warn","ts":"2026-02-17T18:55:37.660809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.387166232s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T18:55:37.660859Z","caller":"traceutil/trace.go:171","msg":"trace[367299392] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:74; }","duration":"1.387272332s","start":"2026-02-17T18:55:36.273574Z","end":"2026-02-17T18:55:37.660846Z","steps":["trace[367299392] 'agreement among raft nodes before linearized reading' (duration: 1.387174172s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:55:37.660891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T18:55:36.273546Z","time spent":"1.387338102s","remote":"127.0.0.1:52880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-17T18:55:37.661038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.98523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T18:55:37.661064Z","caller":"traceutil/trace.go:171","msg":"trace[1428574781] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:74; }","duration":"145.01169ms","start":"2026-02-17T18:55:37.516044Z","end":"2026-02-17T18:55:37.661056Z","steps":["trace[1428574781] 'agreement among raft nodes before linearized reading' (duration: 144.97302ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T18:55:50.529425Z","caller":"traceutil/trace.go:171","msg":"trace[1009201457] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"132.861264ms","start":"2026-02-17T18:55:50.396498Z","end":"2026-02-17T18:55:50.52936Z","steps":["trace[1009201457] 'process raft request' (duration: 106.966147ms)","trace[1009201457] 'compare' (duration: 25.781687ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T18:56:03.23331Z","caller":"traceutil/trace.go:171","msg":"trace[26819082] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"101.587079ms","start":"2026-02-17T18:56:03.131439Z","end":"2026-02-17T18:56:03.233026Z","steps":["trace[26819082] 'process raft request' (duration: 101.422248ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T18:56:05.587714Z","caller":"traceutil/trace.go:171","msg":"trace[266300308] linearizableReadLoop","detail":"{readStateIndex:528; appliedIndex:527; }","duration":"326.015436ms","start":"2026-02-17T18:56:05.261672Z","end":"2026-02-17T18:56:05.587687Z","steps":["trace[266300308] 'read index received' (duration: 325.857245ms)","trace[266300308] 'applied index is now lower than readState.Index' (duration: 138.901µs)"],"step_count":2} {"level":"info","ts":"2026-02-17T18:56:05.587909Z","caller":"traceutil/trace.go:171","msg":"trace[1026891930] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"331.67757ms","start":"2026-02-17T18:56:05.256222Z","end":"2026-02-17T18:56:05.587899Z","steps":["trace[1026891930] 'process raft request' (duration: 331.217089ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:56:05.588127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T18:56:05.256204Z","time spent":"331.72955ms","remote":"127.0.0.1:53158","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-17T18:56:05.587892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.210646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T18:56:05.589239Z","caller":"traceutil/trace.go:171","msg":"trace[21581437] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:511; }","duration":"327.61745ms","start":"2026-02-17T18:56:05.261607Z","end":"2026-02-17T18:56:05.589224Z","steps":["trace[21581437] 'agreement among raft nodes before linearized reading' (duration: 326.208076ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:56:05.589312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T18:56:05.261587Z","time spent":"327.71222ms","remote":"127.0.0.1:52880","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-17T18:56:05.765963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.671919ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T18:56:05.766049Z","caller":"traceutil/trace.go:171","msg":"trace[1839488097] linearizableReadLoop","detail":"{readStateIndex:529; appliedIndex:528; }","duration":"175.601947ms","start":"2026-02-17T18:56:05.590433Z","end":"2026-02-17T18:56:05.766035Z","steps":["trace[1839488097] 'read index received' (duration: 35.687097ms)","trace[1839488097] 'applied index is now lower than readState.Index' (duration: 139.91396ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T18:56:05.766108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.674477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T18:56:05.766122Z","caller":"traceutil/trace.go:171","msg":"trace[1676077910] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:512; }","duration":"175.718647ms","start":"2026-02-17T18:56:05.590398Z","end":"2026-02-17T18:56:05.766117Z","steps":["trace[1676077910] 'agreement among raft nodes before linearized reading' (duration: 175.668517ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T18:56:05.766322Z","caller":"traceutil/trace.go:171","msg":"trace[2143434659] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"433.939389ms","start":"2026-02-17T18:56:05.332375Z","end":"2026-02-17T18:56:05.766314Z","steps":["trace[2143434659] 'process raft request' (duration: 293.846298ms)","trace[2143434659] 'compare' (duration: 139.544349ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T18:56:05.766354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T18:56:05.332345Z","time spent":"433.990759ms","remote":"127.0.0.1:53158","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-17T18:56:06.642072Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415870834167255390,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T18:56:07.142952Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415870834167255390,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T18:56:07.643389Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415870834167255390,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T18:56:08.144439Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415870834167255390,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T18:56:08.216162Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.424917906s","expected-duration":"1s"} {"level":"info","ts":"2026-02-17T18:56:08.216501Z","caller":"traceutil/trace.go:171","msg":"trace[1816064276] linearizableReadLoop","detail":"{readStateIndex:530; appliedIndex:529; }","duration":"2.074689757s","start":"2026-02-17T18:56:06.14179Z","end":"2026-02-17T18:56:08.21648Z","steps":["trace[1816064276] 'read index received' (duration: 2.074501117s)","trace[1816064276] 'applied index is now lower than readState.Index' (duration: 187.73µs)"],"step_count":2} {"level":"info","ts":"2026-02-17T18:56:08.216719Z","caller":"traceutil/trace.go:171","msg":"trace[1387277273] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"2.425557818s","start":"2026-02-17T18:56:05.791153Z","end":"2026-02-17T18:56:08.216711Z","steps":["trace[1387277273] 'process raft request' (duration: 2.425192787s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:56:08.216828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T18:56:05.791134Z","time spent":"2.425613218s","remote":"127.0.0.1:53068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4254,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T18:56:08.217053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.608306618s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-17T18:56:08.217145Z","caller":"traceutil/trace.go:171","msg":"trace[1585871183] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:513; }","duration":"1.608427318s","start":"2026-02-17T18:56:06.608695Z","end":"2026-02-17T18:56:08.217122Z","steps":["trace[1585871183] 'agreement among raft nodes before linearized reading' (duration: 1.608104887s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:56:08.217208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T18:56:06.608625Z","time spent":"1.608563448s","remote":"127.0.0.1:53158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-17T18:56:08.217219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"625.776919ms","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-17T18:56:08.21726Z","caller":"traceutil/trace.go:171","msg":"trace[2059740787] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:513; }","duration":"625.852019ms","start":"2026-02-17T18:56:07.591395Z","end":"2026-02-17T18:56:08.217247Z","steps":["trace[2059740787] 'agreement among raft nodes before linearized reading' (duration: 625.777709ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:56:08.217296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T18:56:07.591373Z","time spent":"625.909819ms","remote":"127.0.0.1:53158","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-17T18:56:08.217401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.07559831s","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-17T18:56:08.217428Z","caller":"traceutil/trace.go:171","msg":"trace[1961815838] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:513; }","duration":"2.075683s","start":"2026-02-17T18:56:06.141737Z","end":"2026-02-17T18:56:08.21742Z","steps":["trace[1961815838] 'agreement among raft nodes before linearized reading' (duration: 2.075621099s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:56:08.217452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T18:56:06.141699Z","time spent":"2.07574699s","remote":"127.0.0.1:53158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-17T18:56:08.217586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.451450453s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-17T18:56:08.217612Z","caller":"traceutil/trace.go:171","msg":"trace[275569307] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:513; }","duration":"1.451522403s","start":"2026-02-17T18:56:06.766081Z","end":"2026-02-17T18:56:08.217604Z","steps":["trace[275569307] 'agreement among raft nodes before linearized reading' (duration: 1.451478433s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:56:08.217636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T18:56:06.766057Z","time spent":"1.451572893s","remote":"127.0.0.1:53158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-17T18:56:08.217834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"954.410414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T18:56:08.21788Z","caller":"traceutil/trace.go:171","msg":"trace[366842389] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:513; }","duration":"954.500514ms","start":"2026-02-17T18:56:07.263366Z","end":"2026-02-17T18:56:08.217867Z","steps":["trace[366842389] 'agreement among raft nodes before linearized reading' (duration: 954.436184ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:56:08.217908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T18:56:07.263341Z","time spent":"954.559944ms","remote":"127.0.0.1:52880","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-17T18:56:16.764161Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415870834167255483,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T18:56:16.949094Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.619489026s","expected-duration":"1s"} {"level":"info","ts":"2026-02-17T18:56:16.950401Z","caller":"traceutil/trace.go:171","msg":"trace[681358162] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"1.620205789s","start":"2026-02-17T18:56:15.329441Z","end":"2026-02-17T18:56:16.949647Z","steps":["trace[681358162] 'process raft request' (duration: 1.619985418s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:56:16.950581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T18:56:15.329425Z","time spent":"1.621022781s","remote":"127.0.0.1:53076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T18:56:18.264293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000671726s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-02-17T18:56:18.264397Z","caller":"traceutil/trace.go:171","msg":"trace[1791328187] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000793437s","start":"2026-02-17T18:56:16.263575Z","end":"2026-02-17T18:56:18.264369Z","steps":["trace[1791328187] 'agreement among raft nodes before linearized reading' (duration: 2.000666816s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:56:18.264458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T18:56:16.26346Z","time spent":"2.000986887s","remote":"127.0.0.1:52880","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 18:56:18 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-17T18:56:20.018198Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.068927996s","expected-duration":"1s"} {"level":"warn","ts":"2026-02-17T18:56:20.194813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T18:56:17.746792Z","time spent":"2.448010416s","remote":"127.0.0.1:54124","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-17T18:56:20.196016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.551564ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T18:56:20.196063Z","caller":"traceutil/trace.go:171","msg":"trace[2005927387] linearizableReadLoop","detail":"{readStateIndex:578; appliedIndex:576; }","duration":"3.93246826s","start":"2026-02-17T18:56:16.263582Z","end":"2026-02-17T18:56:20.196051Z","steps":["trace[2005927387] 'read index received' (duration: 685.819329ms)","trace[2005927387] 'applied index is now lower than readState.Index' (duration: 3.246647831s)"],"step_count":2} {"level":"info","ts":"2026-02-17T18:56:20.196227Z","caller":"traceutil/trace.go:171","msg":"trace[2108260452] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"4.272504054s","start":"2026-02-17T18:56:15.923714Z","end":"2026-02-17T18:56:20.196219Z","steps":["trace[2108260452] 'process raft request' (duration: 4.094680129s)","trace[2108260452] 'compare' (duration: 176.11347ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T18:56:20.196257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T18:56:15.923691Z","time spent":"4.272549944s","remote":"127.0.0.1:53158","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-17T18:56:20.1964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.879617503s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-17T18:56:20.196414Z","caller":"traceutil/trace.go:171","msg":"trace[542213073] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:558; }","duration":"3.879667343s","start":"2026-02-17T18:56:16.316741Z","end":"2026-02-17T18:56:20.196409Z","steps":["trace[542213073] 'agreement among raft nodes before linearized reading' (duration: 3.879578203s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:56:20.196431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T18:56:16.316723Z","time spent":"3.879701883s","remote":"127.0.0.1:53158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-17T18:56:20.196539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.406783332s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T18:56:20.196551Z","caller":"traceutil/trace.go:171","msg":"trace[410927627] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:558; }","duration":"1.406836812s","start":"2026-02-17T18:56:18.78971Z","end":"2026-02-17T18:56:20.196547Z","steps":["trace[410927627] 'agreement among raft nodes before linearized reading' (duration: 1.406816632s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:56:20.196565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T18:56:18.789688Z","time spent":"1.406874392s","remote":"127.0.0.1:52880","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-17T18:56:20.19664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.720875751s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.248\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-17T18:56:20.196652Z","caller":"traceutil/trace.go:171","msg":"trace[2144149386] range","detail":"{range_begin:/registry/masterleases/199.204.45.248; range_end:; response_count:1; response_revision:558; }","duration":"1.720931641s","start":"2026-02-17T18:56:18.475717Z","end":"2026-02-17T18:56:20.196648Z","steps":["trace[2144149386] 'agreement among raft nodes before linearized reading' (duration: 1.720904781s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:56:20.196665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T18:56:18.475696Z","time spent":"1.720965881s","remote":"127.0.0.1:52926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.248\" "} {"level":"warn","ts":"2026-02-17T18:56:20.196728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.932066245s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T18:56:20.196739Z","caller":"traceutil/trace.go:171","msg":"trace[1568323756] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:558; }","duration":"1.932156095s","start":"2026-02-17T18:56:18.264579Z","end":"2026-02-17T18:56:20.196735Z","steps":["trace[1568323756] 'agreement among raft nodes before linearized reading' (duration: 1.932136775s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:56:20.196751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T18:56:18.264557Z","time spent":"1.932190935s","remote":"127.0.0.1:52882","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-17T18:56:20.196838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.864323693s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-17T18:56:20.196851Z","caller":"traceutil/trace.go:171","msg":"trace[555678447] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:558; }","duration":"3.864380743s","start":"2026-02-17T18:56:16.332465Z","end":"2026-02-17T18:56:20.196846Z","steps":["trace[555678447] 'agreement among raft nodes before linearized reading' (duration: 3.864340813s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:56:20.196862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T18:56:16.332454Z","time spent":"3.864405343s","remote":"127.0.0.1:53158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-17T18:56:20.19694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.873489898s","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-17T18:56:20.196955Z","caller":"traceutil/trace.go:171","msg":"trace[1909526669] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:558; }","duration":"3.873511828s","start":"2026-02-17T18:56:16.323436Z","end":"2026-02-17T18:56:20.196948Z","steps":["trace[1909526669] 'agreement among raft nodes before linearized reading' (duration: 3.873473957s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:56:20.196967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T18:56:16.323431Z","time spent":"3.873533288s","remote":"127.0.0.1:53158","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-17T18:56:20.197044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.877043157s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-17T18:56:20.197056Z","caller":"traceutil/trace.go:171","msg":"trace[1095141363] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:558; }","duration":"3.877070607s","start":"2026-02-17T18:56:16.319981Z","end":"2026-02-17T18:56:20.197052Z","steps":["trace[1095141363] 'agreement among raft nodes before linearized reading' (duration: 3.877033167s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:56:20.197067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T18:56:16.319732Z","time spent":"3.877332048s","remote":"127.0.0.1:53158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-17T18:56:20.465574Z","caller":"traceutil/trace.go:171","msg":"trace[763822242] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"109.942332ms","start":"2026-02-17T18:56:20.351402Z","end":"2026-02-17T18:56:20.461344Z","steps":["trace[763822242] 'process raft request' (duration: 108.715199ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T18:56:22.962495Z","caller":"traceutil/trace.go:171","msg":"trace[1409063981] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"238.813857ms","start":"2026-02-17T18:56:22.723657Z","end":"2026-02-17T18:56:22.962471Z","steps":["trace[1409063981] 'process raft request' (duration: 238.684007ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T18:56:22.964866Z","caller":"traceutil/trace.go:171","msg":"trace[1714111263] linearizableReadLoop","detail":"{readStateIndex:610; appliedIndex:609; }","duration":"210.494795ms","start":"2026-02-17T18:56:22.754356Z","end":"2026-02-17T18:56:22.964851Z","steps":["trace[1714111263] 'read index received' (duration: 208.829431ms)","trace[1714111263] 'applied index is now lower than readState.Index' (duration: 1.664724ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T18:56:22.965042Z","caller":"traceutil/trace.go:171","msg":"trace[655858414] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"221.160413ms","start":"2026-02-17T18:56:22.743871Z","end":"2026-02-17T18:56:22.965031Z","steps":["trace[655858414] 'process raft request' (duration: 220.920382ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:56:22.965242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.865326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T18:56:22.965277Z","caller":"traceutil/trace.go:171","msg":"trace[344172857] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:0; response_revision:589; }","duration":"210.930637ms","start":"2026-02-17T18:56:22.754335Z","end":"2026-02-17T18:56:22.965265Z","steps":["trace[344172857] 'agreement among raft nodes before linearized reading' (duration: 210.841286ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:56:22.965442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.188985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T18:56:22.96547Z","caller":"traceutil/trace.go:171","msg":"trace[523078125] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:0; response_revision:589; }","duration":"210.225475ms","start":"2026-02-17T18:56:22.755236Z","end":"2026-02-17T18:56:22.965461Z","steps":["trace[523078125] 'agreement among raft nodes before linearized reading' (duration: 210.183275ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:56:22.965776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.181835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T18:56:22.965807Z","caller":"traceutil/trace.go:171","msg":"trace[552385892] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:0; response_revision:589; }","duration":"100.214085ms","start":"2026-02-17T18:56:22.865584Z","end":"2026-02-17T18:56:22.965799Z","steps":["trace[552385892] 'agreement among raft nodes before linearized reading' (duration: 100.168825ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:56:22.965914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.011774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T18:56:22.965939Z","caller":"traceutil/trace.go:171","msg":"trace[2051490917] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:589; }","duration":"210.047404ms","start":"2026-02-17T18:56:22.755884Z","end":"2026-02-17T18:56:22.965931Z","steps":["trace[2051490917] 'agreement among raft nodes before linearized reading' (duration: 210.013974ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:56:22.966043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.672926ms","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":"info","ts":"2026-02-17T18:56:22.966068Z","caller":"traceutil/trace.go:171","msg":"trace[1181832454] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:589; }","duration":"210.700917ms","start":"2026-02-17T18:56:22.755358Z","end":"2026-02-17T18:56:22.966059Z","steps":["trace[1181832454] 'agreement among raft nodes before linearized reading' (duration: 210.665956ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:56:22.966165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.806597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T18:56:22.966191Z","caller":"traceutil/trace.go:171","msg":"trace[2014969977] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:0; response_revision:589; }","duration":"210.836427ms","start":"2026-02-17T18:56:22.755345Z","end":"2026-02-17T18:56:22.966182Z","steps":["trace[2014969977] 'agreement among raft nodes before linearized reading' (duration: 210.803287ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:56:22.966294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.953857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T18:56:22.966318Z","caller":"traceutil/trace.go:171","msg":"trace[141441566] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:0; response_revision:589; }","duration":"210.982687ms","start":"2026-02-17T18:56:22.755328Z","end":"2026-02-17T18:56:22.966311Z","steps":["trace[141441566] 'agreement among raft nodes before linearized reading' (duration: 210.947867ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:56:22.966417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.088307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T18:56:22.96644Z","caller":"traceutil/trace.go:171","msg":"trace[1698140407] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:0; response_revision:589; }","duration":"211.111147ms","start":"2026-02-17T18:56:22.755322Z","end":"2026-02-17T18:56:22.966433Z","steps":["trace[1698140407] 'agreement among raft nodes before linearized reading' (duration: 211.077277ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:56:22.966538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.223968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T18:56:22.966564Z","caller":"traceutil/trace.go:171","msg":"trace[417264875] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:0; response_revision:589; }","duration":"211.256078ms","start":"2026-02-17T18:56:22.755301Z","end":"2026-02-17T18:56:22.966557Z","steps":["trace[417264875] 'agreement among raft nodes before linearized reading' (duration: 211.220828ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T18:56:24.82728Z","caller":"traceutil/trace.go:171","msg":"trace[1456429085] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"158.479281ms","start":"2026-02-17T18:56:24.668781Z","end":"2026-02-17T18:56:24.82726Z","steps":["trace[1456429085] 'process raft request' (duration: 153.698679ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T18:57:32.954201Z","caller":"traceutil/trace.go:171","msg":"trace[1181089554] linearizableReadLoop","detail":"{readStateIndex:971; appliedIndex:970; }","duration":"222.91389ms","start":"2026-02-17T18:57:32.730922Z","end":"2026-02-17T18:57:32.953835Z","steps":["trace[1181089554] 'read index received' (duration: 211.457173ms)","trace[1181089554] 'applied index is now lower than readState.Index' (duration: 11.455437ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T18:57:32.954338Z","caller":"traceutil/trace.go:171","msg":"trace[1626323401] transaction","detail":"{read_only:false; response_revision:934; number_of_response:1; }","duration":"322.177482ms","start":"2026-02-17T18:57:32.632147Z","end":"2026-02-17T18:57:32.954324Z","steps":["trace[1626323401] 'process raft request' (duration: 310.150084ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:57:32.954432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T18:57:32.632106Z","time spent":"322.266242ms","remote":"127.0.0.1:52960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":852,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-17T18:57:32.954795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.863022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-17T18:57:32.95484Z","caller":"traceutil/trace.go:171","msg":"trace[631578869] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:934; }","duration":"223.938202ms","start":"2026-02-17T18:57:32.73089Z","end":"2026-02-17T18:57:32.954828Z","steps":["trace[631578869] 'agreement among raft nodes before linearized reading' (duration: 223.752822ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:57:32.95842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.941737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-17T18:57:32.958535Z","caller":"traceutil/trace.go:171","msg":"trace[1500204836] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:935; }","duration":"127.074287ms","start":"2026-02-17T18:57:32.831448Z","end":"2026-02-17T18:57:32.958523Z","steps":["trace[1500204836] 'agreement among raft nodes before linearized reading' (duration: 126.896657ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:57:32.958864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.876304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-17T18:57:32.958906Z","caller":"traceutil/trace.go:171","msg":"trace[1903831875] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:935; }","duration":"202.948954ms","start":"2026-02-17T18:57:32.755946Z","end":"2026-02-17T18:57:32.958895Z","steps":["trace[1903831875] 'agreement among raft nodes before linearized reading' (duration: 202.828613ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:57:32.95937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.063484ms","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-17T18:57:32.959418Z","caller":"traceutil/trace.go:171","msg":"trace[114292871] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:935; }","duration":"220.123234ms","start":"2026-02-17T18:57:32.739282Z","end":"2026-02-17T18:57:32.959405Z","steps":["trace[114292871] 'agreement among raft nodes before linearized reading' (duration: 219.002721ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T18:57:47.333784Z","caller":"traceutil/trace.go:171","msg":"trace[1988928832] transaction","detail":"{read_only:false; response_revision:1000; number_of_response:1; }","duration":"195.180343ms","start":"2026-02-17T18:57:47.138584Z","end":"2026-02-17T18:57:47.333764Z","steps":["trace[1988928832] 'process raft request' (duration: 195.068393ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T18:57:48.281809Z","caller":"traceutil/trace.go:171","msg":"trace[1614385824] linearizableReadLoop","detail":"{readStateIndex:1042; appliedIndex:1041; }","duration":"370.16114ms","start":"2026-02-17T18:57:47.911617Z","end":"2026-02-17T18:57:48.281778Z","steps":["trace[1614385824] 'read index received' (duration: 340.495741ms)","trace[1614385824] 'applied index is now lower than readState.Index' (duration: 29.664399ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T18:57:48.282043Z","caller":"traceutil/trace.go:171","msg":"trace[1554362431] transaction","detail":"{read_only:false; response_revision:1001; number_of_response:1; }","duration":"853.697122ms","start":"2026-02-17T18:57:47.428331Z","end":"2026-02-17T18:57:48.282028Z","steps":["trace[1554362431] 'process raft request' (duration: 823.853513ms)","trace[1554362431] 'compare' (duration: 29.004127ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T18:57:48.282976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.349262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T18:57:48.28305Z","caller":"traceutil/trace.go:171","msg":"trace[1600667851] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:1001; }","duration":"371.465593ms","start":"2026-02-17T18:57:47.911565Z","end":"2026-02-17T18:57:48.283031Z","steps":["trace[1600667851] 'agreement among raft nodes before linearized reading' (duration: 371.362892ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:57:48.283088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T18:57:47.911545Z","time spent":"371.533033ms","remote":"127.0.0.1:53188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true "} {"level":"warn","ts":"2026-02-17T18:57:48.2831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T18:57:47.428301Z","time spent":"854.727035ms","remote":"127.0.0.1:53158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T18:58:17.486236Z","caller":"traceutil/trace.go:171","msg":"trace[2076788540] linearizableReadLoop","detail":"{readStateIndex:1135; appliedIndex:1134; }","duration":"120.85153ms","start":"2026-02-17T18:58:17.365369Z","end":"2026-02-17T18:58:17.486221Z","steps":["trace[2076788540] 'read index received' (duration: 120.632869ms)","trace[2076788540] 'applied index is now lower than readState.Index' (duration: 218.171µs)"],"step_count":2} {"level":"info","ts":"2026-02-17T18:58:17.486326Z","caller":"traceutil/trace.go:171","msg":"trace[607280920] transaction","detail":"{read_only:false; response_revision:1088; number_of_response:1; }","duration":"123.790126ms","start":"2026-02-17T18:58:17.362528Z","end":"2026-02-17T18:58:17.486318Z","steps":["trace[607280920] 'process raft request' (duration: 123.533285ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:58:17.487246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.859172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" limit:500 ","response":"range_response_count:4 size:329940"} {"level":"info","ts":"2026-02-17T18:58:17.487286Z","caller":"traceutil/trace.go:171","msg":"trace[1046562588] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:1088; }","duration":"121.912282ms","start":"2026-02-17T18:58:17.365365Z","end":"2026-02-17T18:58:17.487277Z","steps":["trace[1046562588] 'agreement among raft nodes before linearized reading' (duration: 121.344701ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T18:58:19.470237Z","caller":"traceutil/trace.go:171","msg":"trace[2142015063] linearizableReadLoop","detail":"{readStateIndex:1141; appliedIndex:1140; }","duration":"105.273593ms","start":"2026-02-17T18:58:19.364937Z","end":"2026-02-17T18:58:19.470211Z","steps":["trace[2142015063] 'read index received' (duration: 64.056808ms)","trace[2142015063] 'applied index is now lower than readState.Index' (duration: 41.215635ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T18:58:19.470489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.530234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-17T18:58:19.470713Z","caller":"traceutil/trace.go:171","msg":"trace[2050946244] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1093; }","duration":"105.681574ms","start":"2026-02-17T18:58:19.364919Z","end":"2026-02-17T18:58:19.470601Z","steps":["trace[2050946244] 'agreement among raft nodes before linearized reading' (duration: 105.465324ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T18:58:19.472201Z","caller":"traceutil/trace.go:171","msg":"trace[1532711150] transaction","detail":"{read_only:false; response_revision:1093; number_of_response:1; }","duration":"109.359743ms","start":"2026-02-17T18:58:19.362819Z","end":"2026-02-17T18:58:19.472178Z","steps":["trace[1532711150] 'process raft request' (duration: 66.227593ms)","trace[1532711150] 'compare' (duration: 40.989845ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T18:58:19.744891Z","caller":"traceutil/trace.go:171","msg":"trace[781601960] linearizableReadLoop","detail":"{readStateIndex:1142; appliedIndex:1141; }","duration":"209.364643ms","start":"2026-02-17T18:58:19.535504Z","end":"2026-02-17T18:58:19.744868Z","steps":["trace[781601960] 'read index received' (duration: 178.418102ms)","trace[781601960] 'applied index is now lower than readState.Index' (duration: 30.945581ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T18:58:19.744912Z","caller":"traceutil/trace.go:171","msg":"trace[996644963] transaction","detail":"{read_only:false; response_revision:1094; number_of_response:1; }","duration":"241.644628ms","start":"2026-02-17T18:58:19.503235Z","end":"2026-02-17T18:58:19.74488Z","steps":["trace[996644963] 'process raft request' (duration: 210.628987ms)","trace[996644963] 'compare' (duration: 30.50243ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T18:58:19.745155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.634244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-17T18:58:19.745189Z","caller":"traceutil/trace.go:171","msg":"trace[466267321] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1094; }","duration":"209.703294ms","start":"2026-02-17T18:58:19.535477Z","end":"2026-02-17T18:58:19.74518Z","steps":["trace[466267321] 'agreement among raft nodes before linearized reading' (duration: 209.556164ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:58:19.745454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.148889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:3717"} {"level":"warn","ts":"2026-02-17T18:58:19.746432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.585776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/local-path-provisioner-6f56467975-w4gn4\" ","response":"range_response_count:1 size:3887"} {"level":"info","ts":"2026-02-17T18:58:19.746621Z","caller":"traceutil/trace.go:171","msg":"trace[619186816] range","detail":"{range_begin:/registry/deployments/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:1094; }","duration":"194.193369ms","start":"2026-02-17T18:58:19.551276Z","end":"2026-02-17T18:58:19.745469Z","steps":["trace[619186816] 'agreement among raft nodes before linearized reading' (duration: 193.999428ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T18:58:19.746643Z","caller":"traceutil/trace.go:171","msg":"trace[968324199] range","detail":"{range_begin:/registry/pods/local-path-storage/local-path-provisioner-6f56467975-w4gn4; range_end:; response_count:1; response_revision:1094; }","duration":"176.158478ms","start":"2026-02-17T18:58:19.570469Z","end":"2026-02-17T18:58:19.746627Z","steps":["trace[968324199] 'agreement among raft nodes before linearized reading' (duration: 175.486006ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T18:58:19.948181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.937996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/local-path-provisioner-6f56467975-w4gn4\" ","response":"range_response_count:1 size:3887"} {"level":"info","ts":"2026-02-17T18:58:19.948273Z","caller":"traceutil/trace.go:171","msg":"trace[1064007438] range","detail":"{range_begin:/registry/pods/local-path-storage/local-path-provisioner-6f56467975-w4gn4; range_end:; response_count:1; response_revision:1095; }","duration":"102.051536ms","start":"2026-02-17T18:58:19.8462Z","end":"2026-02-17T18:58:19.948252Z","steps":["trace[1064007438] 'range keys from in-memory index tree' (duration: 101.808916ms)"],"step_count":1}