{"level":"warn","ts":"2026-06-08T18:44:04.235018Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-08T18:44:04.235121Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.21: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.21:2380","--initial-cluster=instance=https://199.19.213.21:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.21:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.21: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-06-08T18:44:04.235194Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-08T18:44:04.23521Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.21:2380"]} {"level":"info","ts":"2026-06-08T18:44:04.235238Z","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-06-08T18:44:04.236028Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.21:2379"]} {"level":"info","ts":"2026-06-08T18:44:04.23612Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.21:2380"],"listen-peer-urls":["https://199.19.213.21:2380"],"advertise-client-urls":["https://199.19.213.21:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.21:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.21: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-06-08T18:44:04.241458Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.072553ms"} {"level":"info","ts":"2026-06-08T18:44:04.256781Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c39f03fd9ad57fdc","cluster-id":"3c95a04d00bbaaa4"} {"level":"info","ts":"2026-06-08T18:44:04.256983Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c39f03fd9ad57fdc switched to configuration voters=()"} {"level":"info","ts":"2026-06-08T18:44:04.257049Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c39f03fd9ad57fdc became follower at term 0"} {"level":"info","ts":"2026-06-08T18:44:04.257136Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c39f03fd9ad57fdc [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-08T18:44:04.257178Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c39f03fd9ad57fdc became follower at term 1"} {"level":"info","ts":"2026-06-08T18:44:04.257388Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c39f03fd9ad57fdc switched to configuration voters=(14095989746452234204)"} {"level":"warn","ts":"2026-06-08T18:44:04.282296Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-08T18:44:04.2855Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-08T18:44:04.287542Z","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-06-08T18:44:04.291608Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c39f03fd9ad57fdc","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-08T18:44:04.292179Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c39f03fd9ad57fdc","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-08T18:44:04.292173Z","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-06-08T18:44:04.292411Z","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-06-08T18:44:04.292471Z","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-06-08T18:44:04.294261Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c39f03fd9ad57fdc switched to configuration voters=(14095989746452234204)"} {"level":"info","ts":"2026-06-08T18:44:04.294675Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"3c95a04d00bbaaa4","local-member-id":"c39f03fd9ad57fdc","added-peer-id":"c39f03fd9ad57fdc","added-peer-peer-urls":["https://199.19.213.21:2380"]} {"level":"info","ts":"2026-06-08T18:44:04.299496Z","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-06-08T18:44:04.299782Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c39f03fd9ad57fdc","initial-advertise-peer-urls":["https://199.19.213.21:2380"],"listen-peer-urls":["https://199.19.213.21:2380"],"advertise-client-urls":["https://199.19.213.21:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.21:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-08T18:44:04.299836Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-08T18:44:04.299988Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.21:2380"} {"level":"info","ts":"2026-06-08T18:44:04.300017Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.21:2380"} {"level":"info","ts":"2026-06-08T18:44:04.659942Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c39f03fd9ad57fdc is starting a new election at term 1"} {"level":"info","ts":"2026-06-08T18:44:04.660025Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c39f03fd9ad57fdc became pre-candidate at term 1"} {"level":"info","ts":"2026-06-08T18:44:04.660059Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c39f03fd9ad57fdc received MsgPreVoteResp from c39f03fd9ad57fdc at term 1"} {"level":"info","ts":"2026-06-08T18:44:04.660086Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c39f03fd9ad57fdc became candidate at term 2"} {"level":"info","ts":"2026-06-08T18:44:04.660102Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c39f03fd9ad57fdc received MsgVoteResp from c39f03fd9ad57fdc at term 2"} {"level":"info","ts":"2026-06-08T18:44:04.660124Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c39f03fd9ad57fdc became leader at term 2"} {"level":"info","ts":"2026-06-08T18:44:04.660143Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c39f03fd9ad57fdc elected leader c39f03fd9ad57fdc at term 2"} {"level":"info","ts":"2026-06-08T18:44:04.661178Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c39f03fd9ad57fdc","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.21:2379]}","request-path":"/0/members/c39f03fd9ad57fdc/attributes","cluster-id":"3c95a04d00bbaaa4","publish-timeout":"7s"} {"level":"info","ts":"2026-06-08T18:44:04.661212Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-08T18:44:04.661433Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-08T18:44:04.661532Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-08T18:44:04.661937Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-08T18:44:04.661963Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-08T18:44:04.664783Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-08T18:44:04.664971Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"3c95a04d00bbaaa4","local-member-id":"c39f03fd9ad57fdc","cluster-version":"3.5"} {"level":"info","ts":"2026-06-08T18:44:04.665157Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-08T18:44:04.665218Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-08T18:44:04.66721Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.21:2379"} {"level":"info","ts":"2026-06-08T18:44:15.989786Z","caller":"traceutil/trace.go:171","msg":"trace[1174444439] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"355.72143ms","start":"2026-06-08T18:44:15.634033Z","end":"2026-06-08T18:44:15.989755Z","steps":["trace[1174444439] 'process raft request' (duration: 292.474043ms)","trace[1174444439] 'compare' (duration: 63.142546ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T18:44:15.990448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:44:15.634016Z","time spent":"356.017432ms","remote":"127.0.0.1:50066","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1731,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-08T18:44:15.994776Z","caller":"traceutil/trace.go:171","msg":"trace[33391183] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"358.147568ms","start":"2026-06-08T18:44:15.636604Z","end":"2026-06-08T18:44:15.994752Z","steps":["trace[33391183] 'process raft request' (duration: 357.991487ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:44:15.994907Z","caller":"traceutil/trace.go:171","msg":"trace[204070492] linearizableReadLoop","detail":"{readStateIndex:373; appliedIndex:370; }","duration":"315.890963ms","start":"2026-06-08T18:44:15.678996Z","end":"2026-06-08T18:44:15.994887Z","steps":["trace[204070492] 'read index received' (duration: 247.523766ms)","trace[204070492] 'applied index is now lower than readState.Index' (duration: 68.363647ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T18:44:15.995035Z","caller":"traceutil/trace.go:171","msg":"trace[1487242131] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"354.432651ms","start":"2026-06-08T18:44:15.640589Z","end":"2026-06-08T18:44:15.995022Z","steps":["trace[1487242131] 'process raft request' (duration: 354.114578ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:44:15.995176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.836642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-06-08T18:44:15.995249Z","caller":"traceutil/trace.go:171","msg":"trace[264020416] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:364; }","duration":"215.941772ms","start":"2026-06-08T18:44:15.779296Z","end":"2026-06-08T18:44:15.995237Z","steps":["trace[264020416] 'agreement among raft nodes before linearized reading' (duration: 215.835882ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:44:15.995177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.224658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"warn","ts":"2026-06-08T18:44:15.995256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.515022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-06-08T18:44:15.99536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.718481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-06-08T18:44:15.995389Z","caller":"traceutil/trace.go:171","msg":"trace[1262397405] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:364; }","duration":"115.778691ms","start":"2026-06-08T18:44:15.879603Z","end":"2026-06-08T18:44:15.995382Z","steps":["trace[1262397405] 'agreement among raft nodes before linearized reading' (duration: 115.730711ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:44:15.995329Z","caller":"traceutil/trace.go:171","msg":"trace[722155498] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:364; }","duration":"163.434249ms","start":"2026-06-08T18:44:15.831876Z","end":"2026-06-08T18:44:15.99531Z","steps":["trace[722155498] 'agreement among raft nodes before linearized reading' (duration: 163.237098ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:44:15.995459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:44:15.636597Z","time spent":"358.249369ms","remote":"127.0.0.1:50066","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2162,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T18:44:15.995425Z","caller":"traceutil/trace.go:171","msg":"trace[1661066409] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:364; }","duration":"266.654923ms","start":"2026-06-08T18:44:15.728691Z","end":"2026-06-08T18:44:15.995346Z","steps":["trace[1661066409] 'agreement among raft nodes before linearized reading' (duration: 266.407941ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:44:15.99562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.606168ms","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-06-08T18:44:15.995641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:44:15.640583Z","time spent":"354.488981ms","remote":"127.0.0.1:50168","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6736,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T18:44:15.995725Z","caller":"traceutil/trace.go:171","msg":"trace[1768939920] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:364; }","duration":"316.732249ms","start":"2026-06-08T18:44:15.678977Z","end":"2026-06-08T18:44:15.99571Z","steps":["trace[1768939920] 'agreement among raft nodes before linearized reading' (duration: 316.547187ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:44:15.995902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:44:15.678968Z","time spent":"316.915071ms","remote":"127.0.0.1:50176","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-06-08T18:44:16.178656Z","caller":"traceutil/trace.go:171","msg":"trace[835460013] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"150.636374ms","start":"2026-06-08T18:44:16.027991Z","end":"2026-06-08T18:44:16.178627Z","steps":["trace[835460013] 'process raft request' (duration: 99.1195ms)","trace[835460013] 'compare' (duration: 51.368053ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T18:44:16.277217Z","caller":"traceutil/trace.go:171","msg":"trace[215790313] linearizableReadLoop","detail":"{readStateIndex:384; appliedIndex:380; }","duration":"157.441235ms","start":"2026-06-08T18:44:16.119755Z","end":"2026-06-08T18:44:16.277196Z","steps":["trace[215790313] 'read index received' (duration: 7.349025ms)","trace[215790313] 'applied index is now lower than readState.Index' (duration: 150.09126ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T18:44:16.277395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.632286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-06-08T18:44:16.277387Z","caller":"traceutil/trace.go:171","msg":"trace[434846571] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"190.470039ms","start":"2026-06-08T18:44:16.086874Z","end":"2026-06-08T18:44:16.277344Z","steps":["trace[434846571] 'process raft request' (duration: 190.271928ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:44:16.277438Z","caller":"traceutil/trace.go:171","msg":"trace[106013828] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:375; }","duration":"157.727148ms","start":"2026-06-08T18:44:16.119701Z","end":"2026-06-08T18:44:16.277429Z","steps":["trace[106013828] 'agreement among raft nodes before linearized reading' (duration: 157.587637ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:44:16.277775Z","caller":"traceutil/trace.go:171","msg":"trace[12781096] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"194.51822ms","start":"2026-06-08T18:44:16.083023Z","end":"2026-06-08T18:44:16.277541Z","steps":["trace[12781096] 'process raft request' (duration: 193.935116ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:44:16.277854Z","caller":"traceutil/trace.go:171","msg":"trace[45035390] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"193.33183ms","start":"2026-06-08T18:44:16.08392Z","end":"2026-06-08T18:44:16.277251Z","steps":["trace[45035390] 'process raft request' (duration: 193.163249ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:44:16.507154Z","caller":"traceutil/trace.go:171","msg":"trace[930620433] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"324.668716ms","start":"2026-06-08T18:44:16.18246Z","end":"2026-06-08T18:44:16.507129Z","steps":["trace[930620433] 'process raft request' (duration: 229.559428ms)","trace[930620433] 'compare' (duration: 94.838876ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T18:44:16.507297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:44:16.182437Z","time spent":"324.800357ms","remote":"127.0.0.1:50034","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-06-08T18:44:16.507571Z","caller":"traceutil/trace.go:171","msg":"trace[147046637] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"324.922238ms","start":"2026-06-08T18:44:16.182603Z","end":"2026-06-08T18:44:16.507525Z","steps":["trace[147046637] 'process raft request' (duration: 324.469924ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:44:16.507625Z","caller":"traceutil/trace.go:171","msg":"trace[1514876651] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"324.269383ms","start":"2026-06-08T18:44:16.183326Z","end":"2026-06-08T18:44:16.507596Z","steps":["trace[1514876651] 'process raft request' (duration: 323.838059ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:44:16.507884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:44:16.182585Z","time spent":"325.112109ms","remote":"127.0.0.1:50034","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":830,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-08T18:44:16.508011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:44:16.183316Z","time spent":"324.444724ms","remote":"127.0.0.1:50168","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3527,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-08T18:44:16.508313Z","caller":"traceutil/trace.go:171","msg":"trace[975948098] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"317.863184ms","start":"2026-06-08T18:44:16.190426Z","end":"2026-06-08T18:44:16.508289Z","steps":["trace[975948098] 'process raft request' (duration: 316.784675ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:44:16.508459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:44:16.190419Z","time spent":"317.971345ms","remote":"127.0.0.1:50168","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4001,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T18:44:16.508478Z","caller":"traceutil/trace.go:171","msg":"trace[1887085915] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"227.526021ms","start":"2026-06-08T18:44:16.280938Z","end":"2026-06-08T18:44:16.508464Z","steps":["trace[1887085915] 'process raft request' (duration: 227.238169ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:44:16.508605Z","caller":"traceutil/trace.go:171","msg":"trace[1890516103] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"226.814746ms","start":"2026-06-08T18:44:16.281775Z","end":"2026-06-08T18:44:16.508589Z","steps":["trace[1890516103] 'process raft request' (duration: 226.541054ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:44:16.508782Z","caller":"traceutil/trace.go:171","msg":"trace[1649471554] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"226.372173ms","start":"2026-06-08T18:44:16.282387Z","end":"2026-06-08T18:44:16.508759Z","steps":["trace[1649471554] 'process raft request' (duration: 225.970339ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:44:16.640646Z","caller":"traceutil/trace.go:171","msg":"trace[2080308273] transaction","detail":"{read_only:false; response_revision:385; number_of_response:1; }","duration":"126.923992ms","start":"2026-06-08T18:44:16.513692Z","end":"2026-06-08T18:44:16.640616Z","steps":["trace[2080308273] 'process raft request' (duration: 95.44976ms)","trace[2080308273] 'compare' (duration: 31.23465ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T18:44:16.64075Z","caller":"traceutil/trace.go:171","msg":"trace[2476066] transaction","detail":"{read_only:false; response_revision:387; number_of_response:1; }","duration":"125.492042ms","start":"2026-06-08T18:44:16.515221Z","end":"2026-06-08T18:44:16.640713Z","steps":["trace[2476066] 'process raft request' (duration: 125.337741ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:44:16.640679Z","caller":"traceutil/trace.go:171","msg":"trace[1270041976] linearizableReadLoop","detail":"{readStateIndex:397; appliedIndex:392; }","duration":"112.738884ms","start":"2026-06-08T18:44:16.527917Z","end":"2026-06-08T18:44:16.640656Z","steps":["trace[1270041976] 'read index received' (duration: 7.412408ms)","trace[1270041976] 'applied index is now lower than readState.Index' (duration: 105.325406ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T18:44:16.640938Z","caller":"traceutil/trace.go:171","msg":"trace[609729093] transaction","detail":"{read_only:false; response_revision:388; number_of_response:1; }","duration":"123.426425ms","start":"2026-06-08T18:44:16.517501Z","end":"2026-06-08T18:44:16.640927Z","steps":["trace[609729093] 'process raft request' (duration: 123.110553ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:44:16.641084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.685299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-proxy-jgtn4\" ","response":"range_response_count:1 size:3439"} {"level":"warn","ts":"2026-06-08T18:44:16.641108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.160407ms","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-06-08T18:44:16.641111Z","caller":"traceutil/trace.go:171","msg":"trace[125939751] transaction","detail":"{read_only:false; response_revision:386; number_of_response:1; }","duration":"126.358427ms","start":"2026-06-08T18:44:16.51472Z","end":"2026-06-08T18:44:16.641078Z","steps":["trace[125939751] 'process raft request' (duration: 125.801123ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:44:16.641135Z","caller":"traceutil/trace.go:171","msg":"trace[1413555192] range","detail":"{range_begin:/registry/pods/kube-system/kube-proxy-jgtn4; range_end:; response_count:1; response_revision:388; }","duration":"101.78442ms","start":"2026-06-08T18:44:16.539339Z","end":"2026-06-08T18:44:16.641124Z","steps":["trace[1413555192] 'agreement among raft nodes before linearized reading' (duration: 101.671079ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:44:16.641183Z","caller":"traceutil/trace.go:171","msg":"trace[1399802561] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:388; }","duration":"113.256608ms","start":"2026-06-08T18:44:16.527885Z","end":"2026-06-08T18:44:16.641142Z","steps":["trace[1399802561] 'agreement among raft nodes before linearized reading' (duration: 113.155547ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:44:18.160171Z","caller":"traceutil/trace.go:171","msg":"trace[667027719] linearizableReadLoop","detail":"{readStateIndex:410; appliedIndex:409; }","duration":"137.74156ms","start":"2026-06-08T18:44:18.022409Z","end":"2026-06-08T18:44:18.160151Z","steps":["trace[667027719] 'read index received' (duration: 134.234294ms)","trace[667027719] 'applied index is now lower than readState.Index' (duration: 3.506276ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T18:44:18.160233Z","caller":"traceutil/trace.go:171","msg":"trace[177788230] transaction","detail":"{read_only:false; response_revision:400; number_of_response:1; }","duration":"449.874774ms","start":"2026-06-08T18:44:17.710325Z","end":"2026-06-08T18:44:18.1602Z","steps":["trace[177788230] 'process raft request' (duration: 446.420198ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:44:18.160326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.898261ms","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-06-08T18:44:18.160367Z","caller":"traceutil/trace.go:171","msg":"trace[393218741] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:400; }","duration":"137.987212ms","start":"2026-06-08T18:44:18.022368Z","end":"2026-06-08T18:44:18.160356Z","steps":["trace[393218741] 'agreement among raft nodes before linearized reading' (duration: 137.907921ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:44:18.16041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:44:17.7103Z","time spent":"450.004925ms","remote":"127.0.0.1:50444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2903,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T18:44:18.160456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.326639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.21\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-08T18:44:18.160506Z","caller":"traceutil/trace.go:171","msg":"trace[1852361725] range","detail":"{range_begin:/registry/masterleases/199.19.213.21; range_end:; response_count:1; response_revision:400; }","duration":"120.37882ms","start":"2026-06-08T18:44:18.040116Z","end":"2026-06-08T18:44:18.160494Z","steps":["trace[1852361725] 'agreement among raft nodes before linearized reading' (duration: 120.302779ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:44:19.935216Z","caller":"traceutil/trace.go:171","msg":"trace[496608504] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"319.937653ms","start":"2026-06-08T18:44:19.615257Z","end":"2026-06-08T18:44:19.935195Z","steps":["trace[496608504] 'process raft request' (duration: 319.401898ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:44:19.935358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:44:19.615241Z","time spent":"320.034223ms","remote":"127.0.0.1:50168","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4645,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T18:44:21.539641Z","caller":"traceutil/trace.go:171","msg":"trace[1347560243] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"123.497516ms","start":"2026-06-08T18:44:21.416117Z","end":"2026-06-08T18:44:21.539614Z","steps":["trace[1347560243] 'process raft request' (duration: 123.298865ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:44:21.817244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.958514ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-08T18:44:21.817389Z","caller":"traceutil/trace.go:171","msg":"trace[1428418179] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"263.852947ms","start":"2026-06-08T18:44:21.553514Z","end":"2026-06-08T18:44:21.817367Z","steps":["trace[1428418179] 'process raft request' (duration: 156.561931ms)","trace[1428418179] 'compare' (duration: 106.817993ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T18:44:22.484053Z","caller":"traceutil/trace.go:171","msg":"trace[1907650601] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"206.124739ms","start":"2026-06-08T18:44:22.277582Z","end":"2026-06-08T18:44:22.483707Z","steps":["trace[1907650601] 'process raft request' (duration: 205.968808ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:44:22.81764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.901741ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-08T18:44:22.817755Z","caller":"traceutil/trace.go:171","msg":"trace[724030710] linearizableReadLoop","detail":"{readStateIndex:430; appliedIndex:429; }","duration":"114.904127ms","start":"2026-06-08T18:44:22.702834Z","end":"2026-06-08T18:44:22.817739Z","steps":["trace[724030710] 'read index received' (duration: 35.241µs)","trace[724030710] 'applied index is now lower than readState.Index' (duration: 114.867826ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T18:44:22.817868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.031378ms","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-06-08T18:44:22.817808Z","caller":"traceutil/trace.go:171","msg":"trace[1325690268] transaction","detail":"{read_only:false; response_revision:419; number_of_response:1; }","duration":"253.604871ms","start":"2026-06-08T18:44:22.564167Z","end":"2026-06-08T18:44:22.817772Z","steps":["trace[1325690268] 'process raft request' (duration: 102.487677ms)","trace[1325690268] 'compare' (duration: 150.76573ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T18:44:22.817906Z","caller":"traceutil/trace.go:171","msg":"trace[550395267] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:419; }","duration":"115.101959ms","start":"2026-06-08T18:44:22.702793Z","end":"2026-06-08T18:44:22.817895Z","steps":["trace[550395267] 'agreement among raft nodes before linearized reading' (duration: 115.035399ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:44:22.818061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.335946ms","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-06-08T18:44:22.818093Z","caller":"traceutil/trace.go:171","msg":"trace[1553633182] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:419; }","duration":"109.408287ms","start":"2026-06-08T18:44:22.708677Z","end":"2026-06-08T18:44:22.818086Z","steps":["trace[1553633182] 'agreement among raft nodes before linearized reading' (duration: 109.357706ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:44:30.152062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.484247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4056"} {"level":"info","ts":"2026-06-08T18:44:30.152144Z","caller":"traceutil/trace.go:171","msg":"trace[1232592673] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:436; }","duration":"502.639559ms","start":"2026-06-08T18:44:29.649488Z","end":"2026-06-08T18:44:30.152127Z","steps":["trace[1232592673] 'range keys from in-memory index tree' (duration: 502.283586ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:44:30.152183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:44:29.64946Z","time spent":"502.714179ms","remote":"127.0.0.1:50438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":4079,"request content":"key:\"/registry/deployments/kube-system/coredns\" "} {"level":"info","ts":"2026-06-08T18:44:35.068694Z","caller":"traceutil/trace.go:171","msg":"trace[513770008] linearizableReadLoop","detail":"{readStateIndex:492; appliedIndex:491; }","duration":"103.599029ms","start":"2026-06-08T18:44:34.965072Z","end":"2026-06-08T18:44:35.068671Z","steps":["trace[513770008] 'read index received' (duration: 103.455837ms)","trace[513770008] 'applied index is now lower than readState.Index' (duration: 142.242µs)"],"step_count":2} {"level":"info","ts":"2026-06-08T18:44:35.068773Z","caller":"traceutil/trace.go:171","msg":"trace[990609262] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"113.046464ms","start":"2026-06-08T18:44:34.955692Z","end":"2026-06-08T18:44:35.068738Z","steps":["trace[990609262] 'process raft request' (duration: 112.792162ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:44:35.068883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.378257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-08T18:44:35.068901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.80235ms","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-06-08T18:44:35.068968Z","caller":"traceutil/trace.go:171","msg":"trace[104913056] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:476; }","duration":"103.922242ms","start":"2026-06-08T18:44:34.965027Z","end":"2026-06-08T18:44:35.068949Z","steps":["trace[104913056] 'agreement among raft nodes before linearized reading' (duration: 103.776751ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:44:35.06892Z","caller":"traceutil/trace.go:171","msg":"trace[623580453] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:476; }","duration":"103.473807ms","start":"2026-06-08T18:44:34.965436Z","end":"2026-06-08T18:44:35.06891Z","steps":["trace[623580453] 'agreement among raft nodes before linearized reading' (duration: 103.383347ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:44:43.602843Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9213413384443012488,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-08T18:44:43.709012Z","caller":"traceutil/trace.go:171","msg":"trace[153755040] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"849.646328ms","start":"2026-06-08T18:44:42.859323Z","end":"2026-06-08T18:44:43.708969Z","steps":["trace[153755040] 'process raft request' (duration: 849.507325ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:44:43.709529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:44:42.859288Z","time spent":"849.982045ms","remote":"127.0.0.1:50020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-08T18:44:43.732176Z","caller":"traceutil/trace.go:171","msg":"trace[367458382] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"858.827544ms","start":"2026-06-08T18:44:42.873326Z","end":"2026-06-08T18:44:43.732154Z","steps":["trace[367458382] 'process raft request' (duration: 858.66367ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:44:43.732222Z","caller":"traceutil/trace.go:171","msg":"trace[2137665943] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"854.622591ms","start":"2026-06-08T18:44:42.87756Z","end":"2026-06-08T18:44:43.732183Z","steps":["trace[2137665943] 'process raft request' (duration: 854.509569ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:44:43.732307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:44:42.873306Z","time spent":"858.941235ms","remote":"127.0.0.1:50020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-08T18:44:43.73236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:44:42.877544Z","time spent":"854.747883ms","remote":"127.0.0.1:50020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-08T18:44:43.73247Z","caller":"traceutil/trace.go:171","msg":"trace[1369551237] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"856.143684ms","start":"2026-06-08T18:44:42.87631Z","end":"2026-06-08T18:44:43.732453Z","steps":["trace[1369551237] 'process raft request' (duration: 855.723855ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:44:43.732495Z","caller":"traceutil/trace.go:171","msg":"trace[766191249] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"868.608597ms","start":"2026-06-08T18:44:42.863871Z","end":"2026-06-08T18:44:43.732479Z","steps":["trace[766191249] 'process raft request' (duration: 868.005355ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:44:43.732578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:44:42.863852Z","time spent":"868.682409ms","remote":"127.0.0.1:50020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-08T18:44:43.732617Z","caller":"traceutil/trace.go:171","msg":"trace[1587223599] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"854.044018ms","start":"2026-06-08T18:44:42.878542Z","end":"2026-06-08T18:44:43.732586Z","steps":["trace[1587223599] 'process raft request' (duration: 853.563308ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:44:43.732711Z","caller":"traceutil/trace.go:171","msg":"trace[1333735692] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"851.978614ms","start":"2026-06-08T18:44:42.880723Z","end":"2026-06-08T18:44:43.732701Z","steps":["trace[1333735692] 'process raft request' (duration: 851.525584ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:44:43.732743Z","caller":"traceutil/trace.go:171","msg":"trace[1809800770] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"833.081129ms","start":"2026-06-08T18:44:42.89965Z","end":"2026-06-08T18:44:43.732731Z","steps":["trace[1809800770] 'process raft request' (duration: 832.768851ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:44:43.73266Z","caller":"traceutil/trace.go:171","msg":"trace[1902862804] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"840.472652ms","start":"2026-06-08T18:44:42.892132Z","end":"2026-06-08T18:44:43.732604Z","steps":["trace[1902862804] 'process raft request' (duration: 840.223646ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:44:43.732771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:44:42.880717Z","time spent":"852.029335ms","remote":"127.0.0.1:50020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-08T18:44:43.732758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:44:42.878536Z","time spent":"854.143511ms","remote":"127.0.0.1:50020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-08T18:44:43.732632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:44:42.876295Z","time spent":"856.223576ms","remote":"127.0.0.1:50020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-08T18:44:43.732835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:44:42.899635Z","time spent":"833.15012ms","remote":"127.0.0.1:50020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-08T18:44:43.732917Z","caller":"traceutil/trace.go:171","msg":"trace[1542649458] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"817.505557ms","start":"2026-06-08T18:44:42.915395Z","end":"2026-06-08T18:44:43.732901Z","steps":["trace[1542649458] 'process raft request' (duration: 817.071147ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:44:43.732932Z","caller":"traceutil/trace.go:171","msg":"trace[197278426] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"853.829893ms","start":"2026-06-08T18:44:42.878686Z","end":"2026-06-08T18:44:43.732516Z","steps":["trace[197278426] 'process raft request' (duration: 853.453015ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:44:43.733006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:44:42.915376Z","time spent":"817.577708ms","remote":"127.0.0.1:50020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-08T18:44:43.733161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:44:42.878682Z","time spent":"854.424537ms","remote":"127.0.0.1:50020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-08T18:44:43.733213Z","caller":"traceutil/trace.go:171","msg":"trace[3259623] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"707.630991ms","start":"2026-06-08T18:44:43.025573Z","end":"2026-06-08T18:44:43.733204Z","steps":["trace[3259623] 'process raft request' (duration: 707.356565ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:44:43.733257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:44:43.025517Z","time spent":"707.719143ms","remote":"127.0.0.1:50020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-08T18:44:43.733164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:44:42.892118Z","time spent":"840.692326ms","remote":"127.0.0.1:50020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-08T18:44:43.753534Z","caller":"traceutil/trace.go:171","msg":"trace[334884771] linearizableReadLoop","detail":"{readStateIndex:559; appliedIndex:546; }","duration":"651.073962ms","start":"2026-06-08T18:44:43.102429Z","end":"2026-06-08T18:44:43.753503Z","steps":["trace[334884771] 'read index received' (duration: 606.434993ms)","trace[334884771] 'applied index is now lower than readState.Index' (duration: 44.634579ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T18:44:43.753735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"651.295367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-06-08T18:44:43.753794Z","caller":"traceutil/trace.go:171","msg":"trace[555958112] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:543; }","duration":"651.380279ms","start":"2026-06-08T18:44:43.102376Z","end":"2026-06-08T18:44:43.753756Z","steps":["trace[555958112] 'agreement among raft nodes before linearized reading' (duration: 651.234226ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:44:43.753828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:44:43.102352Z","time spent":"651.467801ms","remote":"127.0.0.1:50246","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-08T18:44:43.765035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"656.51079ms","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-06-08T18:44:43.765086Z","caller":"traceutil/trace.go:171","msg":"trace[995078565] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:549; }","duration":"656.599792ms","start":"2026-06-08T18:44:43.108475Z","end":"2026-06-08T18:44:43.765075Z","steps":["trace[995078565] 'agreement among raft nodes before linearized reading' (duration: 656.52097ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:44:43.765105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:44:43.10846Z","time spent":"656.640393ms","remote":"127.0.0.1:50246","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-06-08T18:44:43.765193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"654.61055ms","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-06-08T18:44:43.765211Z","caller":"traceutil/trace.go:171","msg":"trace[1849870256] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:549; }","duration":"654.65345ms","start":"2026-06-08T18:44:43.110552Z","end":"2026-06-08T18:44:43.765205Z","steps":["trace[1849870256] 'agreement among raft nodes before linearized reading' (duration: 654.622489ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:44:43.765224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:44:43.110537Z","time spent":"654.683311ms","remote":"127.0.0.1:50246","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-08T18:44:48.987255Z","caller":"traceutil/trace.go:171","msg":"trace[845747122] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"303.146785ms","start":"2026-06-08T18:44:48.684086Z","end":"2026-06-08T18:44:48.987233Z","steps":["trace[845747122] 'process raft request' (duration: 225.49228ms)","trace[845747122] 'compare' (duration: 77.42575ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T18:44:48.98737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:44:48.684053Z","time spent":"303.261919ms","remote":"127.0.0.1:50332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1092,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-08T18:44:50.247431Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9213413384443012728,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-08T18:44:50.344112Z","caller":"traceutil/trace.go:171","msg":"trace[756574564] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"614.744187ms","start":"2026-06-08T18:44:49.729341Z","end":"2026-06-08T18:44:50.344085Z","steps":["trace[756574564] 'process raft request' (duration: 614.595243ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:44:50.344272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:44:49.729329Z","time spent":"614.855739ms","remote":"127.0.0.1:50168","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T18:44:51.131595Z","caller":"traceutil/trace.go:171","msg":"trace[736175382] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"1.252124451s","start":"2026-06-08T18:44:49.879455Z","end":"2026-06-08T18:44:51.131579Z","steps":["trace[736175382] 'process raft request' (duration: 1.251400406s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:44:51.131726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:44:49.879419Z","time spent":"1.252236183s","remote":"127.0.0.1:50054","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T18:44:51.131989Z","caller":"traceutil/trace.go:171","msg":"trace[1722298972] linearizableReadLoop","detail":"{readStateIndex:659; appliedIndex:657; }","duration":"1.384670094s","start":"2026-06-08T18:44:49.746716Z","end":"2026-06-08T18:44:51.131386Z","steps":["trace[1722298972] 'read index received' (duration: 597.334279ms)","trace[1722298972] 'applied index is now lower than readState.Index' (duration: 787.334825ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T18:44:51.132064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.385336897s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T18:44:51.132131Z","caller":"traceutil/trace.go:171","msg":"trace[85754511] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:637; }","duration":"1.385430369s","start":"2026-06-08T18:44:49.746686Z","end":"2026-06-08T18:44:51.132116Z","steps":["trace[85754511] 'agreement among raft nodes before linearized reading' (duration: 1.385325697s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:44:51.132165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:44:49.746679Z","time spent":"1.38547895s","remote":"127.0.0.1:49980","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-06-08T18:44:51.152566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.333818535s","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-06-08T18:44:51.15263Z","caller":"traceutil/trace.go:171","msg":"trace[1460402686] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:638; }","duration":"1.333929188s","start":"2026-06-08T18:44:49.818686Z","end":"2026-06-08T18:44:51.152615Z","steps":["trace[1460402686] 'agreement among raft nodes before linearized reading' (duration: 1.333753304s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:44:51.152662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:44:49.818667Z","time spent":"1.333989468s","remote":"127.0.0.1:50246","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-06-08T18:44:51.15288Z","caller":"traceutil/trace.go:171","msg":"trace[1920277113] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"607.292171ms","start":"2026-06-08T18:44:50.54558Z","end":"2026-06-08T18:44:51.152872Z","steps":["trace[1920277113] 'process raft request' (duration: 606.73365ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:44:51.152949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:44:50.545555Z","time spent":"607.347822ms","remote":"127.0.0.1:50246","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T18:44:51.153093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"643.121807ms","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-06-08T18:44:51.15312Z","caller":"traceutil/trace.go:171","msg":"trace[883251728] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:638; }","duration":"643.185618ms","start":"2026-06-08T18:44:50.509927Z","end":"2026-06-08T18:44:51.153113Z","steps":["trace[883251728] 'agreement among raft nodes before linearized reading' (duration: 643.109807ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:44:51.153139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:44:50.509904Z","time spent":"643.229929ms","remote":"127.0.0.1:50246","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-06-08T18:44:51.153357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.257962133s","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-06-08T18:44:51.153413Z","caller":"traceutil/trace.go:171","msg":"trace[1077056514] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:638; }","duration":"1.258044494s","start":"2026-06-08T18:44:49.895356Z","end":"2026-06-08T18:44:51.1534Z","steps":["trace[1077056514] 'agreement among raft nodes before linearized reading' (duration: 1.257837249s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:44:51.153443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.271952088s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-06-08T18:44:51.153443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:44:49.895339Z","time spent":"1.258096995s","remote":"127.0.0.1:50246","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-08T18:44:51.153473Z","caller":"traceutil/trace.go:171","msg":"trace[799980890] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:638; }","duration":"1.27200526s","start":"2026-06-08T18:44:49.881461Z","end":"2026-06-08T18:44:51.153467Z","steps":["trace[799980890] 'agreement among raft nodes before linearized reading' (duration: 1.271937689s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:44:51.153492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:44:49.881445Z","time spent":"1.27204285s","remote":"127.0.0.1:50246","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-08T18:44:51.293426Z","caller":"traceutil/trace.go:171","msg":"trace[1592608087] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"136.032422ms","start":"2026-06-08T18:44:51.157362Z","end":"2026-06-08T18:44:51.293395Z","steps":["trace[1592608087] 'process raft request' (duration: 66.7214ms)","trace[1592608087] 'compare' (duration: 68.902343ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T18:44:53.516702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.939376497s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-08T18:44:53.516997Z","caller":"traceutil/trace.go:171","msg":"trace[290208111] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"2.358988222s","start":"2026-06-08T18:44:51.157983Z","end":"2026-06-08T18:44:53.516972Z","steps":["trace[290208111] 'process raft request' (duration: 419.245757ms)","trace[290208111] 'compare' (duration: 1.939156513s)"],"step_count":2} {"level":"warn","ts":"2026-06-08T18:44:53.517091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:44:51.157968Z","time spent":"2.359082283s","remote":"127.0.0.1:50246","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T18:44:53.517497Z","caller":"traceutil/trace.go:171","msg":"trace[444303181] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"2.319406957s","start":"2026-06-08T18:44:51.198078Z","end":"2026-06-08T18:44:53.517485Z","steps":["trace[444303181] 'process raft request' (duration: 2.318886577s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:44:53.517562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:44:51.198054Z","time spent":"2.319476608s","remote":"127.0.0.1:50490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-08T18:44:53.517662Z","caller":"traceutil/trace.go:171","msg":"trace[1362381723] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"2.359657014s","start":"2026-06-08T18:44:51.157975Z","end":"2026-06-08T18:44:53.517632Z","steps":["trace[1362381723] 'process raft request' (duration: 2.358855249s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:44:53.517801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:44:51.157961Z","time spent":"2.359759496s","remote":"127.0.0.1:50246","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T18:44:53.517813Z","caller":"traceutil/trace.go:171","msg":"trace[744330225] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"2.359347848s","start":"2026-06-08T18:44:51.158445Z","end":"2026-06-08T18:44:53.517793Z","steps":["trace[744330225] 'process raft request' (duration: 2.358485632s)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:44:53.517849Z","caller":"traceutil/trace.go:171","msg":"trace[964794728] linearizableReadLoop","detail":"{readStateIndex:665; appliedIndex:661; }","duration":"769.848891ms","start":"2026-06-08T18:44:52.747988Z","end":"2026-06-08T18:44:53.517837Z","steps":["trace[964794728] 'read index received' (duration: 43.071µs)","trace[964794728] 'applied index is now lower than readState.Index' (duration: 769.80433ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T18:44:53.517894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:44:51.158437Z","time spent":"2.35941454s","remote":"127.0.0.1:50246","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T18:44:53.541009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"792.998737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T18:44:53.541097Z","caller":"traceutil/trace.go:171","msg":"trace[1879807653] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:643; }","duration":"793.13767ms","start":"2026-06-08T18:44:52.747937Z","end":"2026-06-08T18:44:53.541075Z","steps":["trace[1879807653] 'agreement among raft nodes before linearized reading' (duration: 769.982124ms)","trace[1879807653] 'range keys from in-memory index tree' (duration: 23.006004ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T18:44:53.541277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:44:52.747918Z","time spent":"793.344854ms","remote":"127.0.0.1:49974","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-06-08T18:44:53.541546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.440144ms","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-06-08T18:44:53.541679Z","caller":"traceutil/trace.go:171","msg":"trace[340182479] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:643; }","duration":"243.7697ms","start":"2026-06-08T18:44:53.297887Z","end":"2026-06-08T18:44:53.541657Z","steps":["trace[340182479] 'agreement among raft nodes before linearized reading' (duration: 243.335422ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:44:55.385096Z","caller":"traceutil/trace.go:171","msg":"trace[52560053] transaction","detail":"{read_only:false; response_revision:665; number_of_response:1; }","duration":"500.984066ms","start":"2026-06-08T18:44:54.884095Z","end":"2026-06-08T18:44:55.38508Z","steps":["trace[52560053] 'process raft request' (duration: 500.891404ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:44:55.385232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:44:54.884088Z","time spent":"501.090567ms","remote":"127.0.0.1:50020","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-06-08T18:44:55.389676Z","caller":"traceutil/trace.go:171","msg":"trace[943994280] transaction","detail":"{read_only:false; response_revision:666; number_of_response:1; }","duration":"308.157796ms","start":"2026-06-08T18:44:55.081498Z","end":"2026-06-08T18:44:55.389656Z","steps":["trace[943994280] 'process raft request' (duration: 307.893891ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:44:55.389741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:44:55.08147Z","time spent":"308.241958ms","remote":"127.0.0.1:50020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4234,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-08T18:44:55.389724Z","caller":"traceutil/trace.go:171","msg":"trace[2050660401] transaction","detail":"{read_only:false; response_revision:667; number_of_response:1; }","duration":"109.14842ms","start":"2026-06-08T18:44:55.280552Z","end":"2026-06-08T18:44:55.389701Z","steps":["trace[2050660401] 'process raft request' (duration: 108.959226ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:45:08.83198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.082305293s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T18:45:08.832062Z","caller":"traceutil/trace.go:171","msg":"trace[1070537704] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:795; }","duration":"1.082434625s","start":"2026-06-08T18:45:07.74961Z","end":"2026-06-08T18:45:08.832044Z","steps":["trace[1070537704] 'range keys from in-memory index tree' (duration: 1.082229732s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:45:08.8321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:45:07.749587Z","time spent":"1.082504166s","remote":"127.0.0.1:49974","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-06-08T18:45:08.832162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"995.478486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-jqmn7\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-06-08T18:45:08.832218Z","caller":"traceutil/trace.go:171","msg":"trace[908326656] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-jqmn7; range_end:; response_count:1; response_revision:795; }","duration":"995.589778ms","start":"2026-06-08T18:45:07.836613Z","end":"2026-06-08T18:45:08.832203Z","steps":["trace[908326656] 'range keys from in-memory index tree' (duration: 995.346125ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:45:08.832252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:45:07.836595Z","time spent":"995.647859ms","remote":"127.0.0.1:50168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-jqmn7\" "} {"level":"warn","ts":"2026-06-08T18:45:08.832341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"600.151273ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-08T18:45:08.832484Z","caller":"traceutil/trace.go:171","msg":"trace[1579075551] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"974.89771ms","start":"2026-06-08T18:45:07.857571Z","end":"2026-06-08T18:45:08.832469Z","steps":["trace[1579075551] 'process raft request' (duration: 374.452062ms)","trace[1579075551] 'compare' (duration: 599.884858ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T18:45:08.832527Z","caller":"traceutil/trace.go:171","msg":"trace[1865053208] linearizableReadLoop","detail":"{readStateIndex:823; appliedIndex:822; }","duration":"789.517309ms","start":"2026-06-08T18:45:08.042938Z","end":"2026-06-08T18:45:08.832455Z","steps":["trace[1865053208] 'read index received' (duration: 189.118853ms)","trace[1865053208] 'applied index is now lower than readState.Index' (duration: 600.397166ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T18:45:08.832611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:45:07.857545Z","time spent":"974.984291ms","remote":"127.0.0.1:50246","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-06-08T18:45:08.832667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"789.731983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.21\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-08T18:45:08.832699Z","caller":"traceutil/trace.go:171","msg":"trace[1045704809] range","detail":"{range_begin:/registry/masterleases/199.19.213.21; range_end:; response_count:1; response_revision:796; }","duration":"789.805164ms","start":"2026-06-08T18:45:08.042885Z","end":"2026-06-08T18:45:08.83269Z","steps":["trace[1045704809] 'agreement among raft nodes before linearized reading' (duration: 789.676532ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:45:08.832739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:45:08.042864Z","time spent":"789.863455ms","remote":"127.0.0.1:50002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.19.213.21\" "} {"level":"info","ts":"2026-06-08T18:45:09.128599Z","caller":"traceutil/trace.go:171","msg":"trace[1518900492] linearizableReadLoop","detail":"{readStateIndex:824; appliedIndex:823; }","duration":"286.731884ms","start":"2026-06-08T18:45:08.841838Z","end":"2026-06-08T18:45:09.12857Z","steps":["trace[1518900492] 'read index received' (duration: 284.898032ms)","trace[1518900492] 'applied index is now lower than readState.Index' (duration: 1.832382ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T18:45:09.128879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.974038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T18:45:09.129048Z","caller":"traceutil/trace.go:171","msg":"trace[859499017] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:796; }","duration":"287.215272ms","start":"2026-06-08T18:45:08.841818Z","end":"2026-06-08T18:45:09.129033Z","steps":["trace[859499017] 'agreement among raft nodes before linearized reading' (duration: 286.956258ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:45:09.137742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.364489ms","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-06-08T18:45:09.137821Z","caller":"traceutil/trace.go:171","msg":"trace[143665412] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:797; }","duration":"192.482291ms","start":"2026-06-08T18:45:08.945322Z","end":"2026-06-08T18:45:09.137804Z","steps":["trace[143665412] 'agreement among raft nodes before linearized reading' (duration: 192.274377ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:45:09.137953Z","caller":"traceutil/trace.go:171","msg":"trace[942315817] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"295.325549ms","start":"2026-06-08T18:45:08.842612Z","end":"2026-06-08T18:45:09.137938Z","steps":["trace[942315817] 'process raft request' (duration: 294.79167ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:45:49.930315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.076648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-08T18:45:49.930422Z","caller":"traceutil/trace.go:171","msg":"trace[1582988986] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1067; }","duration":"112.21086ms","start":"2026-06-08T18:45:49.818193Z","end":"2026-06-08T18:45:49.930404Z","steps":["trace[1582988986] 'count revisions from in-memory index tree' (duration: 111.983907ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:45:49.930892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.821953ms","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-06-08T18:45:49.930986Z","caller":"traceutil/trace.go:171","msg":"trace[495036924] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1067; }","duration":"110.965724ms","start":"2026-06-08T18:45:49.819999Z","end":"2026-06-08T18:45:49.930965Z","steps":["trace[495036924] 'range keys from in-memory index tree' (duration: 110.569888ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:45:49.931089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.420192ms","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-06-08T18:45:49.931128Z","caller":"traceutil/trace.go:171","msg":"trace[703383858] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1067; }","duration":"126.497772ms","start":"2026-06-08T18:45:49.804619Z","end":"2026-06-08T18:45:49.931117Z","steps":["trace[703383858] 'range keys from in-memory index tree' (duration: 126.266949ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:45:49.931278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.427194ms","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-06-08T18:45:49.931305Z","caller":"traceutil/trace.go:171","msg":"trace[1569351689] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1067; }","duration":"120.506215ms","start":"2026-06-08T18:45:49.810789Z","end":"2026-06-08T18:45:49.931295Z","steps":["trace[1569351689] 'range keys from in-memory index tree' (duration: 120.299173ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:45:49.93128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.601346ms","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-06-08T18:45:49.931352Z","caller":"traceutil/trace.go:171","msg":"trace[108042059] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1067; }","duration":"105.702177ms","start":"2026-06-08T18:45:49.825631Z","end":"2026-06-08T18:45:49.931333Z","steps":["trace[108042059] 'range keys from in-memory index tree' (duration: 105.467035ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:45:50.107611Z","caller":"traceutil/trace.go:171","msg":"trace[124800703] transaction","detail":"{read_only:false; response_revision:1068; number_of_response:1; }","duration":"172.431589ms","start":"2026-06-08T18:45:49.935157Z","end":"2026-06-08T18:45:50.107589Z","steps":["trace[124800703] 'process raft request' (duration: 172.283518ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:45:50.108482Z","caller":"traceutil/trace.go:171","msg":"trace[327370551] transaction","detail":"{read_only:false; response_revision:1072; number_of_response:1; }","duration":"110.934256ms","start":"2026-06-08T18:45:49.997528Z","end":"2026-06-08T18:45:50.108462Z","steps":["trace[327370551] 'process raft request' (duration: 110.871995ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:45:50.108894Z","caller":"traceutil/trace.go:171","msg":"trace[84319203] transaction","detail":"{read_only:false; response_revision:1069; number_of_response:1; }","duration":"172.648573ms","start":"2026-06-08T18:45:49.93623Z","end":"2026-06-08T18:45:50.108878Z","steps":["trace[84319203] 'process raft request' (duration: 172.023874ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:45:50.109029Z","caller":"traceutil/trace.go:171","msg":"trace[287943876] transaction","detail":"{read_only:false; response_revision:1070; number_of_response:1; }","duration":"172.529481ms","start":"2026-06-08T18:45:49.93649Z","end":"2026-06-08T18:45:50.10902Z","steps":["trace[287943876] 'process raft request' (duration: 171.822411ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:45:50.10914Z","caller":"traceutil/trace.go:171","msg":"trace[829532721] transaction","detail":"{read_only:false; response_revision:1071; number_of_response:1; }","duration":"171.717331ms","start":"2026-06-08T18:45:49.937414Z","end":"2026-06-08T18:45:50.109131Z","steps":["trace[829532721] 'process raft request' (duration: 170.92786ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:45:55.633735Z","caller":"traceutil/trace.go:171","msg":"trace[1993798788] linearizableReadLoop","detail":"{readStateIndex:1123; appliedIndex:1122; }","duration":"195.379193ms","start":"2026-06-08T18:45:55.438331Z","end":"2026-06-08T18:45:55.633711Z","steps":["trace[1993798788] 'read index received' (duration: 195.227992ms)","trace[1993798788] 'applied index is now lower than readState.Index' (duration: 150.191µs)"],"step_count":2} {"level":"info","ts":"2026-06-08T18:45:55.633775Z","caller":"traceutil/trace.go:171","msg":"trace[731946524] transaction","detail":"{read_only:false; response_revision:1086; number_of_response:1; }","duration":"206.337959ms","start":"2026-06-08T18:45:55.427406Z","end":"2026-06-08T18:45:55.633744Z","steps":["trace[731946524] 'process raft request' (duration: 206.174167ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:45:55.633865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.507455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T18:45:55.6339Z","caller":"traceutil/trace.go:171","msg":"trace[456975392] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1086; }","duration":"195.593896ms","start":"2026-06-08T18:45:55.438297Z","end":"2026-06-08T18:45:55.633891Z","steps":["trace[456975392] 'agreement among raft nodes before linearized reading' (duration: 195.504884ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:46:09.898665Z","caller":"traceutil/trace.go:171","msg":"trace[432013889] linearizableReadLoop","detail":"{readStateIndex:1172; appliedIndex:1171; }","duration":"149.318235ms","start":"2026-06-08T18:46:09.749324Z","end":"2026-06-08T18:46:09.898642Z","steps":["trace[432013889] 'read index received' (duration: 149.234194ms)","trace[432013889] 'applied index is now lower than readState.Index' (duration: 83.001µs)"],"step_count":2} {"level":"info","ts":"2026-06-08T18:46:09.898791Z","caller":"traceutil/trace.go:171","msg":"trace[334742975] transaction","detail":"{read_only:false; response_revision:1132; number_of_response:1; }","duration":"193.884893ms","start":"2026-06-08T18:46:09.704894Z","end":"2026-06-08T18:46:09.898779Z","steps":["trace[334742975] 'process raft request' (duration: 193.60456ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:46:09.898998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.119041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T18:46:09.899075Z","caller":"traceutil/trace.go:171","msg":"trace[825691520] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:1132; }","duration":"141.235272ms","start":"2026-06-08T18:46:09.757823Z","end":"2026-06-08T18:46:09.899058Z","steps":["trace[825691520] 'agreement among raft nodes before linearized reading' (duration: 141.103991ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:46:09.89921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.899801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T18:46:09.899256Z","caller":"traceutil/trace.go:171","msg":"trace[14742326] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1132; }","duration":"149.958752ms","start":"2026-06-08T18:46:09.749287Z","end":"2026-06-08T18:46:09.899245Z","steps":["trace[14742326] 'agreement among raft nodes before linearized reading' (duration: 149.877811ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:46:10.557529Z","caller":"traceutil/trace.go:171","msg":"trace[133596144] transaction","detail":"{read_only:false; response_revision:1133; number_of_response:1; }","duration":"474.991636ms","start":"2026-06-08T18:46:10.082518Z","end":"2026-06-08T18:46:10.55751Z","steps":["trace[133596144] 'process raft request' (duration: 474.872295ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:46:10.557654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:46:10.082494Z","time spent":"475.087617ms","remote":"127.0.0.1:50246","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T18:46:10.589477Z","caller":"traceutil/trace.go:171","msg":"trace[358483729] linearizableReadLoop","detail":"{readStateIndex:1174; appliedIndex:1172; }","duration":"198.394074ms","start":"2026-06-08T18:46:10.391071Z","end":"2026-06-08T18:46:10.589465Z","steps":["trace[358483729] 'read index received' (duration: 166.287529ms)","trace[358483729] 'applied index is now lower than readState.Index' (duration: 32.105654ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T18:46:10.589553Z","caller":"traceutil/trace.go:171","msg":"trace[542642086] transaction","detail":"{read_only:false; response_revision:1134; number_of_response:1; }","duration":"267.830422ms","start":"2026-06-08T18:46:10.321704Z","end":"2026-06-08T18:46:10.589535Z","steps":["trace[542642086] 'process raft request' (duration: 267.690181ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:46:10.5897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.596987ms","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-06-08T18:46:10.589732Z","caller":"traceutil/trace.go:171","msg":"trace[1421809638] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1134; }","duration":"198.696617ms","start":"2026-06-08T18:46:10.391028Z","end":"2026-06-08T18:46:10.589724Z","steps":["trace[1421809638] 'agreement among raft nodes before linearized reading' (duration: 198.539626ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:46:10.589746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.773274ms","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-06-08T18:46:10.58981Z","caller":"traceutil/trace.go:171","msg":"trace[157372832] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1134; }","duration":"195.889635ms","start":"2026-06-08T18:46:10.393905Z","end":"2026-06-08T18:46:10.589795Z","steps":["trace[157372832] 'agreement among raft nodes before linearized reading' (duration: 195.759874ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:46:10.589938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.651903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-08T18:46:10.589965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.961806ms","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-06-08T18:46:10.589985Z","caller":"traceutil/trace.go:171","msg":"trace[1108635691] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1134; }","duration":"195.704354ms","start":"2026-06-08T18:46:10.39427Z","end":"2026-06-08T18:46:10.589975Z","steps":["trace[1108635691] 'agreement among raft nodes before linearized reading' (duration: 195.568702ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:46:10.589987Z","caller":"traceutil/trace.go:171","msg":"trace[1416429315] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1134; }","duration":"195.998877ms","start":"2026-06-08T18:46:10.393981Z","end":"2026-06-08T18:46:10.58998Z","steps":["trace[1416429315] 'agreement among raft nodes before linearized reading' (duration: 195.937446ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:46:10.790259Z","caller":"traceutil/trace.go:171","msg":"trace[636728637] transaction","detail":"{read_only:false; response_revision:1135; number_of_response:1; }","duration":"196.207268ms","start":"2026-06-08T18:46:10.594025Z","end":"2026-06-08T18:46:10.790233Z","steps":["trace[636728637] 'process raft request' (duration: 109.110909ms)","trace[636728637] 'compare' (duration: 86.977738ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T18:46:10.855335Z","caller":"traceutil/trace.go:171","msg":"trace[1710188266] linearizableReadLoop","detail":"{readStateIndex:1178; appliedIndex:1176; }","duration":"105.6696ms","start":"2026-06-08T18:46:10.749645Z","end":"2026-06-08T18:46:10.855314Z","steps":["trace[1710188266] 'read index received' (duration: 105.607189ms)","trace[1710188266] 'applied index is now lower than readState.Index' (duration: 61.141µs)"],"step_count":2} {"level":"info","ts":"2026-06-08T18:46:10.855338Z","caller":"traceutil/trace.go:171","msg":"trace[350911470] transaction","detail":"{read_only:false; response_revision:1136; number_of_response:1; }","duration":"259.78186ms","start":"2026-06-08T18:46:10.595512Z","end":"2026-06-08T18:46:10.855294Z","steps":["trace[350911470] 'process raft request' (duration: 259.633958ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:46:10.855475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.811912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T18:46:10.855466Z","caller":"traceutil/trace.go:171","msg":"trace[1639572436] transaction","detail":"{read_only:false; response_revision:1138; number_of_response:1; }","duration":"259.8192ms","start":"2026-06-08T18:46:10.595619Z","end":"2026-06-08T18:46:10.855438Z","steps":["trace[1639572436] 'process raft request' (duration: 259.656579ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:46:10.855508Z","caller":"traceutil/trace.go:171","msg":"trace[1460349816] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1138; }","duration":"105.901952ms","start":"2026-06-08T18:46:10.749596Z","end":"2026-06-08T18:46:10.855498Z","steps":["trace[1460349816] 'agreement among raft nodes before linearized reading' (duration: 105.832431ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:46:10.855582Z","caller":"traceutil/trace.go:171","msg":"trace[1021827648] transaction","detail":"{read_only:false; response_revision:1137; number_of_response:1; }","duration":"259.994083ms","start":"2026-06-08T18:46:10.595561Z","end":"2026-06-08T18:46:10.855555Z","steps":["trace[1021827648] 'process raft request' (duration: 259.683929ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:46:50.448609Z","caller":"traceutil/trace.go:171","msg":"trace[610121861] transaction","detail":"{read_only:false; response_revision:1297; number_of_response:1; }","duration":"228.176895ms","start":"2026-06-08T18:46:50.220413Z","end":"2026-06-08T18:46:50.44859Z","steps":["trace[610121861] 'process raft request' (duration: 228.062094ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T18:46:58.746477Z","caller":"traceutil/trace.go:171","msg":"trace[1287789868] transaction","detail":"{read_only:false; response_revision:1330; number_of_response:1; }","duration":"257.635624ms","start":"2026-06-08T18:46:58.488812Z","end":"2026-06-08T18:46:58.746448Z","steps":["trace[1287789868] 'process raft request' (duration: 257.491322ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:46:59.668029Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9213413384443014308,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-08T18:46:59.76789Z","caller":"traceutil/trace.go:171","msg":"trace[1385548712] linearizableReadLoop","detail":"{readStateIndex:1383; appliedIndex:1382; }","duration":"600.866395ms","start":"2026-06-08T18:46:59.166996Z","end":"2026-06-08T18:46:59.767863Z","steps":["trace[1385548712] 'read index received' (duration: 600.624003ms)","trace[1385548712] 'applied index is now lower than readState.Index' (duration: 241.632µs)"],"step_count":2} {"level":"info","ts":"2026-06-08T18:46:59.768012Z","caller":"traceutil/trace.go:171","msg":"trace[1142499605] transaction","detail":"{read_only:false; response_revision:1332; number_of_response:1; }","duration":"707.026089ms","start":"2026-06-08T18:46:59.060947Z","end":"2026-06-08T18:46:59.767973Z","steps":["trace[1142499605] 'process raft request' (duration: 706.753056ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:46:59.768241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"601.245808ms","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-06-08T18:46:59.768319Z","caller":"traceutil/trace.go:171","msg":"trace[1702255641] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1332; }","duration":"601.326898ms","start":"2026-06-08T18:46:59.166945Z","end":"2026-06-08T18:46:59.768272Z","steps":["trace[1702255641] 'agreement among raft nodes before linearized reading' (duration: 601.031126ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:46:59.768361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:46:59.166924Z","time spent":"601.42971ms","remote":"127.0.0.1:50246","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-06-08T18:46:59.768382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"558.13623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-06-08T18:46:59.768502Z","caller":"traceutil/trace.go:171","msg":"trace[177961225] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1332; }","duration":"558.260541ms","start":"2026-06-08T18:46:59.210211Z","end":"2026-06-08T18:46:59.768472Z","steps":["trace[177961225] 'agreement among raft nodes before linearized reading' (duration: 558.061759ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:46:59.76852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"569.866911ms","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-06-08T18:46:59.768633Z","caller":"traceutil/trace.go:171","msg":"trace[333777936] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1332; }","duration":"570.027883ms","start":"2026-06-08T18:46:59.198592Z","end":"2026-06-08T18:46:59.76862Z","steps":["trace[333777936] 'agreement among raft nodes before linearized reading' (duration: 569.58382ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T18:46:59.768714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:46:59.19858Z","time spent":"570.119864ms","remote":"127.0.0.1:50246","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-06-08T18:46:59.768544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:46:59.210201Z","time spent":"558.333952ms","remote":"127.0.0.1:50246","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-08T18:46:59.768235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T18:46:59.060926Z","time spent":"707.186351ms","remote":"127.0.0.1:50246","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"}