{"level":"warn","ts":"2026-08-22T10:30:40.992142Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-22T10:30:40.99228Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.38:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.38:2380","--initial-cluster=instance=https://199.204.45.38:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.38:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.38: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-08-22T10:30:40.992581Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-22T10:30:40.992605Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.38:2380"]} {"level":"info","ts":"2026-08-22T10:30:40.992633Z","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-08-22T10:30:40.993805Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"]} {"level":"info","ts":"2026-08-22T10:30:40.994031Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.38: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-08-22T10:30:40.999327Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.651868ms"} {"level":"info","ts":"2026-08-22T10:30:41.007481Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"331455d6226d3423","cluster-id":"25c7803fb83a1455"} {"level":"info","ts":"2026-08-22T10:30:41.007606Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=()"} {"level":"info","ts":"2026-08-22T10:30:41.007635Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became follower at term 0"} {"level":"info","ts":"2026-08-22T10:30:41.007678Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 331455d6226d3423 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-22T10:30:41.007701Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became follower at term 1"} {"level":"info","ts":"2026-08-22T10:30:41.007775Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"} {"level":"warn","ts":"2026-08-22T10:30:41.013603Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-22T10:30:41.014997Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-22T10:30:41.016018Z","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-08-22T10:30:41.018025Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"331455d6226d3423","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-22T10:30:41.018479Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"331455d6226d3423","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-22T10:30:41.018561Z","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-08-22T10:30:41.018628Z","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-08-22T10:30:41.018645Z","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-08-22T10:30:41.019252Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"} {"level":"info","ts":"2026-08-22T10:30:41.019408Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"25c7803fb83a1455","local-member-id":"331455d6226d3423","added-peer-id":"331455d6226d3423","added-peer-peer-urls":["https://199.204.45.38:2380"]} {"level":"info","ts":"2026-08-22T10:30:41.02392Z","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-08-22T10:30:41.02417Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.38:2380"} {"level":"info","ts":"2026-08-22T10:30:41.024206Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.38:2380"} {"level":"info","ts":"2026-08-22T10:30:41.024435Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"331455d6226d3423","initial-advertise-peer-urls":["https://199.204.45.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-22T10:30:41.024485Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-22T10:30:41.109037Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 is starting a new election at term 1"} {"level":"info","ts":"2026-08-22T10:30:41.109087Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-22T10:30:41.109129Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 received MsgPreVoteResp from 331455d6226d3423 at term 1"} {"level":"info","ts":"2026-08-22T10:30:41.109155Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became candidate at term 2"} {"level":"info","ts":"2026-08-22T10:30:41.109171Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 received MsgVoteResp from 331455d6226d3423 at term 2"} {"level":"info","ts":"2026-08-22T10:30:41.109189Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became leader at term 2"} {"level":"info","ts":"2026-08-22T10:30:41.109208Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 331455d6226d3423 elected leader 331455d6226d3423 at term 2"} {"level":"info","ts":"2026-08-22T10:30:41.110761Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"331455d6226d3423","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.38:2379]}","request-path":"/0/members/331455d6226d3423/attributes","cluster-id":"25c7803fb83a1455","publish-timeout":"7s"} {"level":"info","ts":"2026-08-22T10:30:41.110849Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-22T10:30:41.110985Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-22T10:30:41.111087Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-22T10:30:41.111551Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-22T10:30:41.111583Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-22T10:30:41.111612Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"25c7803fb83a1455","local-member-id":"331455d6226d3423","cluster-version":"3.5"} {"level":"info","ts":"2026-08-22T10:30:41.111711Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-22T10:30:41.111749Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-22T10:30:41.115865Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.38:2379"} {"level":"info","ts":"2026-08-22T10:30:41.122236Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-22T10:30:50.271064Z","caller":"traceutil/trace.go:171","msg":"trace[1022442807] linearizableReadLoop","detail":"{readStateIndex:336; appliedIndex:334; }","duration":"109.667116ms","start":"2026-08-22T10:30:50.161363Z","end":"2026-08-22T10:30:50.27103Z","steps":["trace[1022442807] 'read index received' (duration: 27.376708ms)","trace[1022442807] 'applied index is now lower than readState.Index' (duration: 82.287598ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:30:50.271208Z","caller":"traceutil/trace.go:171","msg":"trace[1241852433] transaction","detail":"{read_only:false; response_revision:324; number_of_response:1; }","duration":"109.576744ms","start":"2026-08-22T10:30:50.161606Z","end":"2026-08-22T10:30:50.271183Z","steps":["trace[1241852433] 'process raft request' (duration: 109.361368ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:30:50.27134Z","caller":"traceutil/trace.go:171","msg":"trace[546543623] transaction","detail":"{read_only:false; response_revision:323; number_of_response:1; }","duration":"110.062078ms","start":"2026-08-22T10:30:50.161268Z","end":"2026-08-22T10:30:50.27133Z","steps":["trace[546543623] 'process raft request' (duration: 52.202672ms)","trace[546543623] 'compare' (duration: 57.387192ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:30:50.271501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.144895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-08-22T10:30:50.271583Z","caller":"traceutil/trace.go:171","msg":"trace[1639068770] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:324; }","duration":"105.34198ms","start":"2026-08-22T10:30:50.166227Z","end":"2026-08-22T10:30:50.271569Z","steps":["trace[1639068770] 'agreement among raft nodes before linearized reading' (duration: 105.129664ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:30:50.272942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.549742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/view\" ","response":"range_response_count:1 size:2108"} {"level":"info","ts":"2026-08-22T10:30:50.273041Z","caller":"traceutil/trace.go:171","msg":"trace[96606119] range","detail":"{range_begin:/registry/clusterroles/view; range_end:; response_count:1; response_revision:324; }","duration":"111.676975ms","start":"2026-08-22T10:30:50.161328Z","end":"2026-08-22T10:30:50.273005Z","steps":["trace[96606119] 'agreement among raft nodes before linearized reading' (duration: 109.857222ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:30:50.596179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.601252ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-22T10:30:50.596404Z","caller":"traceutil/trace.go:171","msg":"trace[1740568202] transaction","detail":"{read_only:false; response_revision:326; number_of_response:1; }","duration":"317.381731ms","start":"2026-08-22T10:30:50.278978Z","end":"2026-08-22T10:30:50.59636Z","steps":["trace[1740568202] 'process raft request' (duration: 121.11555ms)","trace[1740568202] 'compare' (duration: 195.441737ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:30:50.596512Z","caller":"traceutil/trace.go:171","msg":"trace[626611134] linearizableReadLoop","detail":"{readStateIndex:339; appliedIndex:337; }","duration":"317.426252ms","start":"2026-08-22T10:30:50.27907Z","end":"2026-08-22T10:30:50.596496Z","steps":["trace[626611134] 'read index received' (duration: 57.541307ms)","trace[626611134] 'applied index is now lower than readState.Index' (duration: 259.884155ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:30:50.596574Z","caller":"traceutil/trace.go:171","msg":"trace[1568003234] transaction","detail":"{read_only:false; response_revision:328; number_of_response:1; }","duration":"316.806625ms","start":"2026-08-22T10:30:50.279702Z","end":"2026-08-22T10:30:50.596509Z","steps":["trace[1568003234] 'process raft request' (duration: 316.633139ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:30:50.596778Z","caller":"traceutil/trace.go:171","msg":"trace[1226355865] transaction","detail":"{read_only:false; response_revision:331; number_of_response:1; }","duration":"314.094765ms","start":"2026-08-22T10:30:50.282639Z","end":"2026-08-22T10:30:50.596734Z","steps":["trace[1226355865] 'process raft request' (duration: 313.804317ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:30:50.596814Z","caller":"traceutil/trace.go:171","msg":"trace[1265566722] transaction","detail":"{read_only:false; response_revision:330; number_of_response:1; }","duration":"314.58599ms","start":"2026-08-22T10:30:50.282206Z","end":"2026-08-22T10:30:50.596792Z","steps":["trace[1265566722] 'process raft request' (duration: 314.202659ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:30:50.596975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.839157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-08-22T10:30:50.597045Z","caller":"traceutil/trace.go:171","msg":"trace[1854175186] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:331; }","duration":"279.995892ms","start":"2026-08-22T10:30:50.317037Z","end":"2026-08-22T10:30:50.597033Z","steps":["trace[1854175186] 'agreement among raft nodes before linearized reading' (duration: 279.807226ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:30:50.597121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.292034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6961"} {"level":"info","ts":"2026-08-22T10:30:50.596727Z","caller":"traceutil/trace.go:171","msg":"trace[1923958229] transaction","detail":"{read_only:false; response_revision:327; number_of_response:1; }","duration":"317.060082ms","start":"2026-08-22T10:30:50.279586Z","end":"2026-08-22T10:30:50.596646Z","steps":["trace[1923958229] 'process raft request' (duration: 316.696511ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:30:50.597162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.979568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/edit\" ","response":"range_response_count:1 size:3475"} {"level":"info","ts":"2026-08-22T10:30:50.59721Z","caller":"traceutil/trace.go:171","msg":"trace[322245534] range","detail":"{range_begin:/registry/clusterroles/edit; range_end:; response_count:1; response_revision:331; }","duration":"318.149904ms","start":"2026-08-22T10:30:50.279049Z","end":"2026-08-22T10:30:50.597198Z","steps":["trace[322245534] 'agreement among raft nodes before linearized reading' (duration: 317.926817ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:30:50.597199Z","caller":"traceutil/trace.go:171","msg":"trace[1003418961] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:331; }","duration":"229.411577ms","start":"2026-08-22T10:30:50.367773Z","end":"2026-08-22T10:30:50.597185Z","steps":["trace[1003418961] 'agreement among raft nodes before linearized reading' (duration: 229.257623ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:30:50.597252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:30:50.279003Z","time spent":"318.239626ms","remote":"127.0.0.1:45702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":3497,"request content":"key:\"/registry/clusterroles/edit\" "} {"level":"warn","ts":"2026-08-22T10:30:50.597226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:30:50.282633Z","time spent":"314.213438ms","remote":"127.0.0.1:45452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2162,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T10:30:50.597299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:30:50.279573Z","time spent":"317.649659ms","remote":"127.0.0.1:45452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1723,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-22T10:30:50.597469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:30:50.282198Z","time spent":"314.733364ms","remote":"127.0.0.1:45702","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T10:30:50.596614Z","caller":"traceutil/trace.go:171","msg":"trace[44196594] transaction","detail":"{read_only:false; response_revision:329; number_of_response:1; }","duration":"314.780725ms","start":"2026-08-22T10:30:50.281822Z","end":"2026-08-22T10:30:50.596603Z","steps":["trace[44196594] 'process raft request' (duration: 314.554959ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:30:50.596609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:30:50.278961Z","time spent":"317.551476ms","remote":"127.0.0.1:45416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":680,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-22T10:30:50.597728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:30:50.279697Z","time spent":"316.98771ms","remote":"127.0.0.1:45822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3691,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T10:30:50.597685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:30:50.281816Z","time spent":"315.773644ms","remote":"127.0.0.1:45416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":754,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-22T10:30:51.723957Z","caller":"traceutil/trace.go:171","msg":"trace[233455722] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"194.033289ms","start":"2026-08-22T10:30:51.529899Z","end":"2026-08-22T10:30:51.723933Z","steps":["trace[233455722] 'process raft request' (duration: 193.883024ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:30:51.916865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.053518ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-22T10:30:51.916996Z","caller":"traceutil/trace.go:171","msg":"trace[520525631] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"180.407492ms","start":"2026-08-22T10:30:51.736564Z","end":"2026-08-22T10:30:51.916972Z","steps":["trace[520525631] 'process raft request' (duration: 52.116547ms)","trace[520525631] 'compare' (duration: 127.875563ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:30:54.907303Z","caller":"traceutil/trace.go:171","msg":"trace[1339716259] linearizableReadLoop","detail":"{readStateIndex:383; appliedIndex:382; }","duration":"201.357062ms","start":"2026-08-22T10:30:54.705921Z","end":"2026-08-22T10:30:54.907278Z","steps":["trace[1339716259] 'read index received' (duration: 201.150156ms)","trace[1339716259] 'applied index is now lower than readState.Index' (duration: 205.966µs)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:30:54.907446Z","caller":"traceutil/trace.go:171","msg":"trace[766291660] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"205.876263ms","start":"2026-08-22T10:30:54.701535Z","end":"2026-08-22T10:30:54.907411Z","steps":["trace[766291660] 'process raft request' (duration: 205.602595ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:30:54.907506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.562728ms","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-08-22T10:30:54.907545Z","caller":"traceutil/trace.go:171","msg":"trace[1334216896] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:368; }","duration":"201.6385ms","start":"2026-08-22T10:30:54.705894Z","end":"2026-08-22T10:30:54.907533Z","steps":["trace[1334216896] 'agreement among raft nodes before linearized reading' (duration: 201.475805ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:30:57.015018Z","caller":"traceutil/trace.go:171","msg":"trace[1331407687] linearizableReadLoop","detail":"{readStateIndex:388; appliedIndex:387; }","duration":"103.831115ms","start":"2026-08-22T10:30:56.911165Z","end":"2026-08-22T10:30:57.014996Z","steps":["trace[1331407687] 'read index received' (duration: 103.692331ms)","trace[1331407687] 'applied index is now lower than readState.Index' (duration: 137.954µs)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:30:57.015159Z","caller":"traceutil/trace.go:171","msg":"trace[621814710] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"328.205991ms","start":"2026-08-22T10:30:56.686896Z","end":"2026-08-22T10:30:57.015102Z","steps":["trace[621814710] 'process raft request' (duration: 327.970024ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:30:57.015324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:30:56.686869Z","time spent":"328.366924ms","remote":"127.0.0.1:45524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4115,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T10:30:57.015334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.148685ms","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-08-22T10:30:57.015435Z","caller":"traceutil/trace.go:171","msg":"trace[1035495023] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:373; }","duration":"104.298309ms","start":"2026-08-22T10:30:56.911124Z","end":"2026-08-22T10:30:57.015423Z","steps":["trace[1035495023] 'agreement among raft nodes before linearized reading' (duration: 104.144754ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:30:57.282097Z","caller":"traceutil/trace.go:171","msg":"trace[1298040801] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"122.753429ms","start":"2026-08-22T10:30:57.159321Z","end":"2026-08-22T10:30:57.282075Z","steps":["trace[1298040801] 'process raft request' (duration: 76.617785ms)","trace[1298040801] 'compare' (duration: 46.063572ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:30:57.614761Z","caller":"traceutil/trace.go:171","msg":"trace[749066483] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"298.065869ms","start":"2026-08-22T10:30:57.316642Z","end":"2026-08-22T10:30:57.614708Z","steps":["trace[749066483] 'process raft request' (duration: 297.520303ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:31:05.14232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.435381ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-22T10:31:05.142443Z","caller":"traceutil/trace.go:171","msg":"trace[893349306] linearizableReadLoop","detail":"{readStateIndex:408; appliedIndex:407; }","duration":"613.794716ms","start":"2026-08-22T10:31:04.52861Z","end":"2026-08-22T10:31:05.142404Z","steps":["trace[893349306] 'read index received' (duration: 190.111777ms)","trace[893349306] 'applied index is now lower than readState.Index' (duration: 423.681829ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:31:05.142559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"613.964211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T10:31:05.142586Z","caller":"traceutil/trace.go:171","msg":"trace[999264480] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:391; }","duration":"614.046943ms","start":"2026-08-22T10:31:04.528533Z","end":"2026-08-22T10:31:05.14258Z","steps":["trace[999264480] 'agreement among raft nodes before linearized reading' (duration: 613.930559ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:31:05.142534Z","caller":"traceutil/trace.go:171","msg":"trace[2109984403] transaction","detail":"{read_only:false; response_revision:391; number_of_response:1; }","duration":"861.139765ms","start":"2026-08-22T10:31:04.281364Z","end":"2026-08-22T10:31:05.142503Z","steps":["trace[2109984403] 'process raft request' (duration: 437.449357ms)","trace[2109984403] 'compare' (duration: 423.312088ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:31:05.142618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:04.528498Z","time spent":"614.114755ms","remote":"127.0.0.1:45356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-22T10:31:05.142846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:04.281344Z","time spent":"861.347412ms","remote":"127.0.0.1:45370","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T10:31:05.659143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.768895ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-22T10:31:05.659388Z","caller":"traceutil/trace.go:171","msg":"trace[1984728714] transaction","detail":"{read_only:false; response_revision:392; number_of_response:1; }","duration":"511.959362ms","start":"2026-08-22T10:31:05.1474Z","end":"2026-08-22T10:31:05.659359Z","steps":["trace[1984728714] 'process raft request' (duration: 247.874208ms)","trace[1984728714] 'compare' (duration: 263.633831ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:31:05.659388Z","caller":"traceutil/trace.go:171","msg":"trace[1439468354] linearizableReadLoop","detail":"{readStateIndex:410; appliedIndex:408; }","duration":"511.234292ms","start":"2026-08-22T10:31:05.148116Z","end":"2026-08-22T10:31:05.65935Z","steps":["trace[1439468354] 'read index received' (duration: 247.126127ms)","trace[1439468354] 'applied index is now lower than readState.Index' (duration: 264.106655ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:31:05.659542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:05.147388Z","time spent":"512.097385ms","remote":"127.0.0.1:45608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T10:31:05.659574Z","caller":"traceutil/trace.go:171","msg":"trace[1156416889] transaction","detail":"{read_only:false; response_revision:393; number_of_response:1; }","duration":"511.978412ms","start":"2026-08-22T10:31:05.147571Z","end":"2026-08-22T10:31:05.65955Z","steps":["trace[1156416889] 'process raft request' (duration: 511.700084ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:31:05.65965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.52527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-08-22T10:31:05.659687Z","caller":"traceutil/trace.go:171","msg":"trace[2091302557] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:393; }","duration":"511.583651ms","start":"2026-08-22T10:31:05.148094Z","end":"2026-08-22T10:31:05.659678Z","steps":["trace[2091302557] 'agreement among raft nodes before linearized reading' (duration: 511.464768ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:31:05.659696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:05.147564Z","time spent":"512.067195ms","remote":"127.0.0.1:45608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T10:31:05.659715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:05.148085Z","time spent":"511.623683ms","remote":"127.0.0.1:45610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/endpointslices/default/kubernetes\" "} {"level":"warn","ts":"2026-08-22T10:31:05.659865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.114271ms","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-08-22T10:31:05.659897Z","caller":"traceutil/trace.go:171","msg":"trace[805467137] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:393; }","duration":"342.185743ms","start":"2026-08-22T10:31:05.317702Z","end":"2026-08-22T10:31:05.659888Z","steps":["trace[805467137] 'agreement among raft nodes before linearized reading' (duration: 342.129731ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:31:05.659897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.367248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-22T10:31:05.659917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:05.317678Z","time spent":"342.234605ms","remote":"127.0.0.1:45608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-08-22T10:31:05.65993Z","caller":"traceutil/trace.go:171","msg":"trace[98260483] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:393; }","duration":"131.44196ms","start":"2026-08-22T10:31:05.528479Z","end":"2026-08-22T10:31:05.659921Z","steps":["trace[98260483] 'agreement among raft nodes before linearized reading' (duration: 131.374438ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:31:05.659979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.361551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4368"} {"level":"info","ts":"2026-08-22T10:31:05.66001Z","caller":"traceutil/trace.go:171","msg":"trace[493695941] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:393; }","duration":"264.432263ms","start":"2026-08-22T10:31:05.395568Z","end":"2026-08-22T10:31:05.66Z","steps":["trace[493695941] 'agreement among raft nodes before linearized reading' (duration: 264.375312ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:31:06.287741Z","caller":"traceutil/trace.go:171","msg":"trace[840359622] transaction","detail":"{read_only:false; response_revision:396; number_of_response:1; }","duration":"617.880082ms","start":"2026-08-22T10:31:05.66983Z","end":"2026-08-22T10:31:06.28771Z","steps":["trace[840359622] 'process raft request' (duration: 617.844561ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:31:06.287734Z","caller":"traceutil/trace.go:171","msg":"trace[491723445] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"622.988429ms","start":"2026-08-22T10:31:05.664721Z","end":"2026-08-22T10:31:06.28771Z","steps":["trace[491723445] 'process raft request' (duration: 622.850495ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:31:06.28785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:05.669806Z","time spent":"617.981145ms","remote":"127.0.0.1:45516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4360,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T10:31:06.287851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:05.664701Z","time spent":"623.092261ms","remote":"127.0.0.1:45608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T10:31:06.289636Z","caller":"traceutil/trace.go:171","msg":"trace[1935971638] transaction","detail":"{read_only:false; response_revision:397; number_of_response:1; }","duration":"321.615726ms","start":"2026-08-22T10:31:05.968005Z","end":"2026-08-22T10:31:06.289621Z","steps":["trace[1935971638] 'process raft request' (duration: 321.550744ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:31:06.289724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:05.967978Z","time spent":"321.703398ms","remote":"127.0.0.1:45608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T10:31:20.471443Z","caller":"traceutil/trace.go:171","msg":"trace[1151752646] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"112.34935ms","start":"2026-08-22T10:31:20.35906Z","end":"2026-08-22T10:31:20.471409Z","steps":["trace[1151752646] 'process raft request' (duration: 111.99249ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:31:20.785566Z","caller":"traceutil/trace.go:171","msg":"trace[255846994] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"145.905089ms","start":"2026-08-22T10:31:20.639642Z","end":"2026-08-22T10:31:20.785548Z","steps":["trace[255846994] 'process raft request' (duration: 145.814836ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:31:20.791625Z","caller":"traceutil/trace.go:171","msg":"trace[73877679] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"133.22781ms","start":"2026-08-22T10:31:20.658377Z","end":"2026-08-22T10:31:20.791605Z","steps":["trace[73877679] 'process raft request' (duration: 132.954612ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:31:20.791756Z","caller":"traceutil/trace.go:171","msg":"trace[1602132939] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"142.864093ms","start":"2026-08-22T10:31:20.648881Z","end":"2026-08-22T10:31:20.791745Z","steps":["trace[1602132939] 'process raft request' (duration: 142.347249ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:31:20.791846Z","caller":"traceutil/trace.go:171","msg":"trace[1448934453] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"139.670682ms","start":"2026-08-22T10:31:20.652144Z","end":"2026-08-22T10:31:20.791815Z","steps":["trace[1448934453] 'process raft request' (duration: 139.143027ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:31:20.791914Z","caller":"traceutil/trace.go:171","msg":"trace[1204561954] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"126.211152ms","start":"2026-08-22T10:31:20.665697Z","end":"2026-08-22T10:31:20.791908Z","steps":["trace[1204561954] 'process raft request' (duration: 125.763009ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:31:20.791961Z","caller":"traceutil/trace.go:171","msg":"trace[585727543] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"132.491259ms","start":"2026-08-22T10:31:20.659464Z","end":"2026-08-22T10:31:20.791956Z","steps":["trace[585727543] 'process raft request' (duration: 131.933593ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:31:20.791953Z","caller":"traceutil/trace.go:171","msg":"trace[334155902] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"120.196271ms","start":"2026-08-22T10:31:20.671722Z","end":"2026-08-22T10:31:20.791918Z","steps":["trace[334155902] 'process raft request' (duration: 119.771129ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:31:20.791972Z","caller":"traceutil/trace.go:171","msg":"trace[780647367] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"133.164928ms","start":"2026-08-22T10:31:20.658793Z","end":"2026-08-22T10:31:20.791958Z","steps":["trace[780647367] 'process raft request' (duration: 132.581552ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:31:20.792011Z","caller":"traceutil/trace.go:171","msg":"trace[1270935069] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"133.106567ms","start":"2026-08-22T10:31:20.658601Z","end":"2026-08-22T10:31:20.791707Z","steps":["trace[1270935069] 'process raft request' (duration: 132.753937ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:31:20.792268Z","caller":"traceutil/trace.go:171","msg":"trace[330803602] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"135.206176ms","start":"2026-08-22T10:31:20.656643Z","end":"2026-08-22T10:31:20.791849Z","steps":["trace[330803602] 'process raft request' (duration: 134.667341ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:31:21.487274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.543047ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"warn","ts":"2026-08-22T10:31:21.487149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.595146ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T10:31:21.487368Z","caller":"traceutil/trace.go:171","msg":"trace[1350785497] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:519; }","duration":"117.866644ms","start":"2026-08-22T10:31:21.369478Z","end":"2026-08-22T10:31:21.487345Z","steps":["trace[1350785497] 'range keys from in-memory index tree' (duration: 117.573335ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:31:21.487477Z","caller":"traceutil/trace.go:171","msg":"trace[462849488] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"610.902502ms","start":"2026-08-22T10:31:20.87657Z","end":"2026-08-22T10:31:21.487473Z","steps":["trace[462849488] 'process raft request' (duration: 610.778689ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:31:21.487507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:20.876564Z","time spent":"610.930773ms","remote":"127.0.0.1:45400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-22T10:31:21.487497Z","caller":"traceutil/trace.go:171","msg":"trace[1438888117] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"612.284701ms","start":"2026-08-22T10:31:20.875191Z","end":"2026-08-22T10:31:21.487476Z","steps":["trace[1438888117] 'process raft request' (duration: 116.450477ms)","trace[1438888117] 'compare' (duration: 495.435313ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:31:21.487584Z","caller":"traceutil/trace.go:171","msg":"trace[276586550] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"601.975059ms","start":"2026-08-22T10:31:20.885604Z","end":"2026-08-22T10:31:21.487579Z","steps":["trace[276586550] 'process raft request' (duration: 601.783584ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:31:21.487586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:20.875173Z","time spent":"612.368993ms","remote":"127.0.0.1:45400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79947,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T10:31:21.487614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:20.885585Z","time spent":"602.01186ms","remote":"127.0.0.1:45400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23057,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T10:31:21.487456Z","caller":"traceutil/trace.go:171","msg":"trace[1395502238] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"599.259702ms","start":"2026-08-22T10:31:20.888185Z","end":"2026-08-22T10:31:21.487444Z","steps":["trace[1395502238] 'process raft request' (duration: 599.231692ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:31:21.487716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:20.888167Z","time spent":"599.523539ms","remote":"127.0.0.1:45400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T10:31:22.119483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.960098ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-22T10:31:22.119779Z","caller":"traceutil/trace.go:171","msg":"trace[289991263] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"1.216678403s","start":"2026-08-22T10:31:20.90304Z","end":"2026-08-22T10:31:22.119719Z","steps":["trace[289991263] 'process raft request' (duration: 745.353944ms)","trace[289991263] 'compare' (duration: 470.771783ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:31:22.119945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:20.903025Z","time spent":"1.216834878s","remote":"127.0.0.1:45400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7693,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T10:31:22.120233Z","caller":"traceutil/trace.go:171","msg":"trace[1050140443] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"1.205339551s","start":"2026-08-22T10:31:20.914871Z","end":"2026-08-22T10:31:22.120211Z","steps":["trace[1050140443] 'process raft request' (duration: 1.204843867s)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:31:22.12034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:20.914807Z","time spent":"1.205482396s","remote":"127.0.0.1:45400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":150480,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T10:31:22.120434Z","caller":"traceutil/trace.go:171","msg":"trace[176920280] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"622.008101ms","start":"2026-08-22T10:31:21.498394Z","end":"2026-08-22T10:31:22.120402Z","steps":["trace[176920280] 'process raft request' (duration: 621.600159ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:31:22.120613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:21.498371Z","time spent":"622.146765ms","remote":"127.0.0.1:45400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10855,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T10:31:22.120672Z","caller":"traceutil/trace.go:171","msg":"trace[588958118] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"620.472867ms","start":"2026-08-22T10:31:21.500188Z","end":"2026-08-22T10:31:22.12066Z","steps":["trace[588958118] 'process raft request' (duration: 619.8649ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:31:22.120733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:21.500177Z","time spent":"620.532239ms","remote":"127.0.0.1:45894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":986,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-22T10:31:22.121074Z","caller":"traceutil/trace.go:171","msg":"trace[1927623593] linearizableReadLoop","detail":"{readStateIndex:553; appliedIndex:548; }","duration":"592.739343ms","start":"2026-08-22T10:31:21.528318Z","end":"2026-08-22T10:31:22.121057Z","steps":["trace[1927623593] 'read index received' (duration: 120.163419ms)","trace[1927623593] 'applied index is now lower than readState.Index' (duration: 472.574704ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:31:22.121188Z","caller":"traceutil/trace.go:171","msg":"trace[1529152510] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"620.275752ms","start":"2026-08-22T10:31:21.500901Z","end":"2026-08-22T10:31:22.121177Z","steps":["trace[1529152510] 'process raft request' (duration: 619.671115ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:31:22.121268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:21.500879Z","time spent":"620.344283ms","remote":"127.0.0.1:45400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29546,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T10:31:22.121383Z","caller":"traceutil/trace.go:171","msg":"trace[630535308] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"561.252662ms","start":"2026-08-22T10:31:21.560117Z","end":"2026-08-22T10:31:22.121369Z","steps":["trace[630535308] 'process raft request' (duration: 560.796009ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:31:22.121444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:21.560089Z","time spent":"561.328065ms","remote":"127.0.0.1:45400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97665,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-22T10:31:22.121587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"593.276698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T10:31:22.121631Z","caller":"traceutil/trace.go:171","msg":"trace[1904458315] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:529; }","duration":"593.457283ms","start":"2026-08-22T10:31:21.528162Z","end":"2026-08-22T10:31:22.121619Z","steps":["trace[1904458315] 'agreement among raft nodes before linearized reading' (duration: 593.371141ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:31:22.121665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:21.528138Z","time spent":"593.519335ms","remote":"127.0.0.1:45356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-22T10:31:22.121897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.546536ms","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-08-22T10:31:22.12195Z","caller":"traceutil/trace.go:171","msg":"trace[1063018069] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:529; }","duration":"383.636428ms","start":"2026-08-22T10:31:21.738302Z","end":"2026-08-22T10:31:22.121938Z","steps":["trace[1063018069] 'agreement among raft nodes before linearized reading' (duration: 383.529495ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:31:22.121972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.327421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-08-22T10:31:22.121993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:21.738285Z","time spent":"383.701051ms","remote":"127.0.0.1:45608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-22T10:31:22.122013Z","caller":"traceutil/trace.go:171","msg":"trace[625924223] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:529; }","duration":"324.368002ms","start":"2026-08-22T10:31:21.797633Z","end":"2026-08-22T10:31:22.122001Z","steps":["trace[625924223] 'agreement among raft nodes before linearized reading' (duration: 324.2942ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:31:22.122057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:21.797597Z","time spent":"324.451904ms","remote":"127.0.0.1:45608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-22T10:31:22.122177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.289678ms","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-08-22T10:31:22.122217Z","caller":"traceutil/trace.go:171","msg":"trace[1429643699] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:529; }","duration":"378.3731ms","start":"2026-08-22T10:31:21.743833Z","end":"2026-08-22T10:31:22.122206Z","steps":["trace[1429643699] 'agreement among raft nodes before linearized reading' (duration: 378.310298ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:31:22.122256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:21.743808Z","time spent":"378.440412ms","remote":"127.0.0.1:45608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-22T10:31:22.347014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.051162ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-22T10:31:22.347133Z","caller":"traceutil/trace.go:171","msg":"trace[1779870937] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"157.527262ms","start":"2026-08-22T10:31:22.189587Z","end":"2026-08-22T10:31:22.347114Z","steps":["trace[1779870937] 'process raft request' (duration: 54.292835ms)","trace[1779870937] 'compare' (duration: 102.920108ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:31:22.351815Z","caller":"traceutil/trace.go:171","msg":"trace[2097708410] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"121.475603ms","start":"2026-08-22T10:31:22.230316Z","end":"2026-08-22T10:31:22.351792Z","steps":["trace[2097708410] 'process raft request' (duration: 121.35606ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:31:22.402956Z","caller":"traceutil/trace.go:171","msg":"trace[1148243840] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"155.432323ms","start":"2026-08-22T10:31:22.247502Z","end":"2026-08-22T10:31:22.402934Z","steps":["trace[1148243840] 'process raft request' (duration: 155.33455ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:31:22.506231Z","caller":"traceutil/trace.go:171","msg":"trace[1048154803] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"133.227065ms","start":"2026-08-22T10:31:22.372981Z","end":"2026-08-22T10:31:22.506208Z","steps":["trace[1048154803] 'process raft request' (duration: 133.138142ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:31:22.506246Z","caller":"traceutil/trace.go:171","msg":"trace[2089913682] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"144.155325ms","start":"2026-08-22T10:31:22.362049Z","end":"2026-08-22T10:31:22.506204Z","steps":["trace[2089913682] 'process raft request' (duration: 112.468339ms)","trace[2089913682] 'compare' (duration: 31.372007ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:31:22.850978Z","caller":"traceutil/trace.go:171","msg":"trace[2094892520] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"327.936049ms","start":"2026-08-22T10:31:22.523024Z","end":"2026-08-22T10:31:22.85096Z","steps":["trace[2094892520] 'process raft request' (duration: 260.491072ms)","trace[2094892520] 'compare' (duration: 67.305573ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:31:22.851074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:22.523004Z","time spent":"328.014631ms","remote":"127.0.0.1:45400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31130,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T10:31:22.940493Z","caller":"traceutil/trace.go:171","msg":"trace[1867533859] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"411.388067ms","start":"2026-08-22T10:31:22.529086Z","end":"2026-08-22T10:31:22.940474Z","steps":["trace[1867533859] 'process raft request' (duration: 411.209092ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:31:22.940602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:22.529062Z","time spent":"411.482879ms","remote":"127.0.0.1:45608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T10:31:22.940598Z","caller":"traceutil/trace.go:171","msg":"trace[261413036] linearizableReadLoop","detail":"{readStateIndex:571; appliedIndex:569; }","duration":"410.020489ms","start":"2026-08-22T10:31:22.530541Z","end":"2026-08-22T10:31:22.940562Z","steps":["trace[261413036] 'read index received' (duration: 253.045572ms)","trace[261413036] 'applied index is now lower than readState.Index' (duration: 156.973287ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:31:22.940651Z","caller":"traceutil/trace.go:171","msg":"trace[1992835693] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"398.695498ms","start":"2026-08-22T10:31:22.541936Z","end":"2026-08-22T10:31:22.940632Z","steps":["trace[1992835693] 'process raft request' (duration: 398.465351ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:31:22.940767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:22.54192Z","time spent":"398.778381ms","remote":"127.0.0.1:45400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":80679,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T10:31:22.940766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.185463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T10:31:22.940804Z","caller":"traceutil/trace.go:171","msg":"trace[2137768392] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:547; }","duration":"410.304406ms","start":"2026-08-22T10:31:22.530488Z","end":"2026-08-22T10:31:22.940792Z","steps":["trace[2137768392] 'agreement among raft nodes before linearized reading' (duration: 410.171793ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:31:22.940835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:22.530471Z","time spent":"410.356338ms","remote":"127.0.0.1:45356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-22T10:31:23.359827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.621774ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-22T10:31:23.360154Z","caller":"traceutil/trace.go:171","msg":"trace[877743776] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"497.131752ms","start":"2026-08-22T10:31:22.863007Z","end":"2026-08-22T10:31:23.360138Z","steps":["trace[877743776] 'process raft request' (duration: 497.019899ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:31:23.360242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:22.862977Z","time spent":"497.220405ms","remote":"127.0.0.1:45400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65199,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T10:31:23.360291Z","caller":"traceutil/trace.go:171","msg":"trace[609993919] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"560.145503ms","start":"2026-08-22T10:31:22.800123Z","end":"2026-08-22T10:31:23.360268Z","steps":["trace[609993919] 'process raft request' (duration: 380.966973ms)","trace[609993919] 'compare' (duration: 178.289775ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:31:23.360371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:22.800093Z","time spent":"560.243856ms","remote":"127.0.0.1:45400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":569094,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-22T10:31:23.39703Z","caller":"traceutil/trace.go:171","msg":"trace[1485950668] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"406.47451ms","start":"2026-08-22T10:31:22.990537Z","end":"2026-08-22T10:31:23.397012Z","steps":["trace[1485950668] 'process raft request' (duration: 406.335006ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:31:23.397219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:22.990511Z","time spent":"406.622923ms","remote":"127.0.0.1:45400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":151212,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T10:31:23.436123Z","caller":"traceutil/trace.go:171","msg":"trace[36366558] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"145.668904ms","start":"2026-08-22T10:31:23.290434Z","end":"2026-08-22T10:31:23.436103Z","steps":["trace[36366558] 'process raft request' (duration: 145.560661ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:31:23.629752Z","caller":"traceutil/trace.go:171","msg":"trace[1867338388] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"178.617064ms","start":"2026-08-22T10:31:23.451115Z","end":"2026-08-22T10:31:23.629732Z","steps":["trace[1867338388] 'process raft request' (duration: 177.801371ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:31:23.635Z","caller":"traceutil/trace.go:171","msg":"trace[30693503] linearizableReadLoop","detail":"{readStateIndex:581; appliedIndex:578; }","duration":"110.049998ms","start":"2026-08-22T10:31:23.524925Z","end":"2026-08-22T10:31:23.634975Z","steps":["trace[30693503] 'read index received' (duration: 104.067869ms)","trace[30693503] 'applied index is now lower than readState.Index' (duration: 5.981069ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:31:23.63546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.510981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T10:31:23.635506Z","caller":"traceutil/trace.go:171","msg":"trace[1893974546] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:556; }","duration":"110.595483ms","start":"2026-08-22T10:31:23.524897Z","end":"2026-08-22T10:31:23.635492Z","steps":["trace[1893974546] 'agreement among raft nodes before linearized reading' (duration: 110.260253ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:31:23.63597Z","caller":"traceutil/trace.go:171","msg":"trace[1001002139] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"171.234196ms","start":"2026-08-22T10:31:23.464711Z","end":"2026-08-22T10:31:23.635946Z","steps":["trace[1001002139] 'process raft request' (duration: 169.863857ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:31:23.636134Z","caller":"traceutil/trace.go:171","msg":"trace[969160336] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"171.252006ms","start":"2026-08-22T10:31:23.46478Z","end":"2026-08-22T10:31:23.636032Z","steps":["trace[969160336] 'process raft request' (duration: 170.039952ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:31:26.984158Z","caller":"traceutil/trace.go:171","msg":"trace[1867950292] linearizableReadLoop","detail":"{readStateIndex:611; appliedIndex:610; }","duration":"454.964912ms","start":"2026-08-22T10:31:26.529171Z","end":"2026-08-22T10:31:26.984136Z","steps":["trace[1867950292] 'read index received' (duration: 454.325504ms)","trace[1867950292] 'applied index is now lower than readState.Index' (duration: 638.668µs)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:31:26.984234Z","caller":"traceutil/trace.go:171","msg":"trace[679200163] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"551.378368ms","start":"2026-08-22T10:31:26.432817Z","end":"2026-08-22T10:31:26.984196Z","steps":["trace[679200163] 'process raft request' (duration: 550.72333ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:31:26.984288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.100925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T10:31:26.984322Z","caller":"traceutil/trace.go:171","msg":"trace[1118391603] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:585; }","duration":"455.181848ms","start":"2026-08-22T10:31:26.529129Z","end":"2026-08-22T10:31:26.98431Z","steps":["trace[1118391603] 'agreement among raft nodes before linearized reading' (duration: 455.113986ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:31:26.984353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:26.529111Z","time spent":"455.234999ms","remote":"127.0.0.1:45356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-22T10:31:26.984398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:26.432796Z","time spent":"551.515742ms","remote":"127.0.0.1:45436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036105,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T10:31:26.987283Z","caller":"traceutil/trace.go:171","msg":"trace[1807471191] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"437.747436ms","start":"2026-08-22T10:31:26.549518Z","end":"2026-08-22T10:31:26.987265Z","steps":["trace[1807471191] 'process raft request' (duration: 437.582601ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:31:26.987394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:26.549496Z","time spent":"437.856549ms","remote":"127.0.0.1:45608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T10:31:28.272216Z","caller":"traceutil/trace.go:171","msg":"trace[743447680] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:617; }","duration":"505.759757ms","start":"2026-08-22T10:31:27.766401Z","end":"2026-08-22T10:31:28.27216Z","steps":["trace[743447680] 'read index received' (duration: 498.42238ms)","trace[743447680] 'applied index is now lower than readState.Index' (duration: 7.336467ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:31:28.272513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.983504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-08-22T10:31:28.272517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.092536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-5dxs8\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-08-22T10:31:28.272571Z","caller":"traceutil/trace.go:171","msg":"trace[1755565010] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:592; }","duration":"116.086467ms","start":"2026-08-22T10:31:28.156468Z","end":"2026-08-22T10:31:28.272554Z","steps":["trace[1755565010] 'agreement among raft nodes before linearized reading' (duration: 115.918872ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:31:28.27261Z","caller":"traceutil/trace.go:171","msg":"trace[2133017992] range","detail":"{range_begin:/registry/pods/kube-system/cilium-5dxs8; range_end:; response_count:1; response_revision:592; }","duration":"506.23421ms","start":"2026-08-22T10:31:27.766355Z","end":"2026-08-22T10:31:28.272589Z","steps":["trace[2133017992] 'agreement among raft nodes before linearized reading' (duration: 506.002703ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:31:28.272657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:27.766326Z","time spent":"506.321312ms","remote":"127.0.0.1:45524","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16983,"request content":"key:\"/registry/pods/kube-system/cilium-5dxs8\" "} {"level":"info","ts":"2026-08-22T10:31:28.27286Z","caller":"traceutil/trace.go:171","msg":"trace[2135517436] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"796.334039ms","start":"2026-08-22T10:31:27.476495Z","end":"2026-08-22T10:31:28.272829Z","steps":["trace[2135517436] 'process raft request' (duration: 788.833868ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:31:28.272987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:27.47647Z","time spent":"796.447912ms","remote":"127.0.0.1:45436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036161,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T10:31:29.028791Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757022612208514054,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-22T10:31:29.085865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"752.234687ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-22T10:31:29.08603Z","caller":"traceutil/trace.go:171","msg":"trace[1216761109] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"808.521851ms","start":"2026-08-22T10:31:28.277483Z","end":"2026-08-22T10:31:29.086005Z","steps":["trace[1216761109] 'process raft request' (duration: 808.463659ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:31:29.086088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:28.277475Z","time spent":"808.588963ms","remote":"127.0.0.1:45608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T10:31:29.086269Z","caller":"traceutil/trace.go:171","msg":"trace[338804038] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"808.997944ms","start":"2026-08-22T10:31:28.277257Z","end":"2026-08-22T10:31:29.086255Z","steps":["trace[338804038] 'process raft request' (duration: 56.299144ms)","trace[338804038] 'compare' (duration: 752.120034ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:31:29.086321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:28.277229Z","time spent":"809.066806ms","remote":"127.0.0.1:45608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T10:31:29.529301Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757022612208514054,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-22T10:31:30.030421Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757022612208514054,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-22T10:31:30.239877Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.906281766s","expected-duration":"1s"} {"level":"warn","ts":"2026-08-22T10:31:30.421078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.865773ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-22T10:31:30.421561Z","caller":"traceutil/trace.go:171","msg":"trace[1192542048] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"2.122840314s","start":"2026-08-22T10:31:28.298686Z","end":"2026-08-22T10:31:30.421526Z","steps":["trace[1192542048] 'process raft request' (duration: 1.941460406s)","trace[1192542048] 'compare' (duration: 180.73423ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:31:30.4217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:28.29866Z","time spent":"2.122969858s","remote":"127.0.0.1:45524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T10:31:30.422124Z","caller":"traceutil/trace.go:171","msg":"trace[2082310882] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"2.097544701s","start":"2026-08-22T10:31:28.32454Z","end":"2026-08-22T10:31:30.422084Z","steps":["trace[2082310882] 'process raft request' (duration: 2.096920194s)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:31:30.422263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:28.324522Z","time spent":"2.097684266s","remote":"127.0.0.1:45676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":897,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-22T10:31:30.426578Z","caller":"traceutil/trace.go:171","msg":"trace[725030786] linearizableReadLoop","detail":"{readStateIndex:624; appliedIndex:621; }","duration":"1.898514821s","start":"2026-08-22T10:31:28.528007Z","end":"2026-08-22T10:31:30.426522Z","steps":["trace[725030786] 'read index received' (duration: 1.712104082s)","trace[725030786] 'applied index is now lower than readState.Index' (duration: 186.409919ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:31:30.426709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.898692876s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T10:31:30.426764Z","caller":"traceutil/trace.go:171","msg":"trace[877761215] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:597; }","duration":"1.898796858s","start":"2026-08-22T10:31:28.527953Z","end":"2026-08-22T10:31:30.42675Z","steps":["trace[877761215] 'agreement among raft nodes before linearized reading' (duration: 1.898695326s)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:31:30.426798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:28.52793Z","time spent":"1.898861641s","remote":"127.0.0.1:45356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-22T10:31:30.426932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.428601487s","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-08-22T10:31:30.427041Z","caller":"traceutil/trace.go:171","msg":"trace[202695160] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:597; }","duration":"1.428832403s","start":"2026-08-22T10:31:28.998187Z","end":"2026-08-22T10:31:30.42702Z","steps":["trace[202695160] 'agreement among raft nodes before linearized reading' (duration: 1.428592066s)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:31:30.427113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:28.998166Z","time spent":"1.428931486s","remote":"127.0.0.1:45608","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-08-22T10:31:30.42781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.82924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T10:31:30.427905Z","caller":"traceutil/trace.go:171","msg":"trace[30764541] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:597; }","duration":"282.030576ms","start":"2026-08-22T10:31:30.145834Z","end":"2026-08-22T10:31:30.427864Z","steps":["trace[30764541] 'agreement among raft nodes before linearized reading' (duration: 281.081099ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:31:30.428081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.897424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-08-22T10:31:30.428171Z","caller":"traceutil/trace.go:171","msg":"trace[1501875336] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:597; }","duration":"139.033187ms","start":"2026-08-22T10:31:30.289111Z","end":"2026-08-22T10:31:30.428144Z","steps":["trace[1501875336] 'agreement among raft nodes before linearized reading' (duration: 137.761132ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:31:41.99246Z","caller":"traceutil/trace.go:171","msg":"trace[1655647694] linearizableReadLoop","detail":"{readStateIndex:776; appliedIndex:775; }","duration":"139.585456ms","start":"2026-08-22T10:31:41.852854Z","end":"2026-08-22T10:31:41.992439Z","steps":["trace[1655647694] 'read index received' (duration: 139.405781ms)","trace[1655647694] 'applied index is now lower than readState.Index' (duration: 178.495µs)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:31:41.992661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.794612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-vlbcl\" ","response":"range_response_count:1 size:5049"} {"level":"info","ts":"2026-08-22T10:31:41.992711Z","caller":"traceutil/trace.go:171","msg":"trace[663355841] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-vlbcl; range_end:; response_count:1; response_revision:745; }","duration":"139.911725ms","start":"2026-08-22T10:31:41.85279Z","end":"2026-08-22T10:31:41.992702Z","steps":["trace[663355841] 'agreement among raft nodes before linearized reading' (duration: 139.74179ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:31:41.992681Z","caller":"traceutil/trace.go:171","msg":"trace[746256843] transaction","detail":"{read_only:false; response_revision:745; number_of_response:1; }","duration":"231.558993ms","start":"2026-08-22T10:31:41.761078Z","end":"2026-08-22T10:31:41.992637Z","steps":["trace[746256843] 'process raft request' (duration: 231.233424ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:31:45.481569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.252755243s","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:39"} {"level":"info","ts":"2026-08-22T10:31:45.481665Z","caller":"traceutil/trace.go:171","msg":"trace[814380819] linearizableReadLoop","detail":"{readStateIndex:797; appliedIndex:796; }","duration":"982.618675ms","start":"2026-08-22T10:31:44.49903Z","end":"2026-08-22T10:31:45.481648Z","steps":["trace[814380819] 'read index received' (duration: 54.101µs)","trace[814380819] 'applied index is now lower than readState.Index' (duration: 982.563054ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:31:45.481732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:44.202995Z","time spent":"1.278732018s","remote":"127.0.0.1:45370","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-08-22T10:31:45.481841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"982.818401ms","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-08-22T10:31:45.481874Z","caller":"traceutil/trace.go:171","msg":"trace[525335663] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:765; }","duration":"982.893343ms","start":"2026-08-22T10:31:44.498972Z","end":"2026-08-22T10:31:45.481865Z","steps":["trace[525335663] 'agreement among raft nodes before linearized reading' (duration: 982.744769ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:31:45.481908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:44.498943Z","time spent":"982.958665ms","remote":"127.0.0.1:45608","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-08-22T10:31:45.496135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.797366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-08-22T10:31:45.496186Z","caller":"traceutil/trace.go:171","msg":"trace[171234540] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:766; }","duration":"338.865648ms","start":"2026-08-22T10:31:45.157305Z","end":"2026-08-22T10:31:45.496171Z","steps":["trace[171234540] 'agreement among raft nodes before linearized reading' (duration: 338.750585ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:31:45.496165Z","caller":"traceutil/trace.go:171","msg":"trace[534655095] transaction","detail":"{read_only:false; response_revision:766; number_of_response:1; }","duration":"617.397548ms","start":"2026-08-22T10:31:44.878737Z","end":"2026-08-22T10:31:45.496135Z","steps":["trace[534655095] 'process raft request' (duration: 617.12146ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:31:45.496222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:45.157296Z","time spent":"338.918619ms","remote":"127.0.0.1:45608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-22T10:31:45.496227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"993.482079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-08-22T10:31:45.496286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"967.316459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-22T10:31:45.496339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:44.87871Z","time spent":"617.545072ms","remote":"127.0.0.1:45594","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T10:31:45.496368Z","caller":"traceutil/trace.go:171","msg":"trace[1949300440] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:766; }","duration":"967.425382ms","start":"2026-08-22T10:31:44.528919Z","end":"2026-08-22T10:31:45.496344Z","steps":["trace[1949300440] 'agreement among raft nodes before linearized reading' (duration: 967.292998ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:31:45.496426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:44.528898Z","time spent":"967.510875ms","remote":"127.0.0.1:45356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-22T10:31:45.496301Z","caller":"traceutil/trace.go:171","msg":"trace[1941730633] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:766; }","duration":"993.587111ms","start":"2026-08-22T10:31:44.502694Z","end":"2026-08-22T10:31:45.496281Z","steps":["trace[1941730633] 'agreement among raft nodes before linearized reading' (duration: 993.350264ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:31:45.496552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:44.502683Z","time spent":"993.806437ms","remote":"127.0.0.1:45608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-22T10:31:45.496581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.137305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-08-22T10:31:45.497494Z","caller":"traceutil/trace.go:171","msg":"trace[1876715583] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:766; }","duration":"345.080551ms","start":"2026-08-22T10:31:45.152379Z","end":"2026-08-22T10:31:45.49746Z","steps":["trace[1876715583] 'agreement among raft nodes before linearized reading' (duration: 343.778755ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:31:45.497556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T10:31:45.152358Z","time spent":"345.182184ms","remote":"127.0.0.1:45608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-08-22T10:31:57.721236Z","caller":"traceutil/trace.go:171","msg":"trace[1927553703] transaction","detail":"{read_only:false; response_revision:919; number_of_response:1; }","duration":"158.55175ms","start":"2026-08-22T10:31:57.562643Z","end":"2026-08-22T10:31:57.721195Z","steps":["trace[1927553703] 'process raft request' (duration: 110.915311ms)","trace[1927553703] 'compare' (duration: 47.495005ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:31:57.724033Z","caller":"traceutil/trace.go:171","msg":"trace[1120184289] transaction","detail":"{read_only:false; response_revision:920; number_of_response:1; }","duration":"160.970077ms","start":"2026-08-22T10:31:57.56304Z","end":"2026-08-22T10:31:57.72401Z","steps":["trace[1120184289] 'process raft request' (duration: 160.837674ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:31:57.724242Z","caller":"traceutil/trace.go:171","msg":"trace[992599366] transaction","detail":"{read_only:false; response_revision:921; number_of_response:1; }","duration":"161.166463ms","start":"2026-08-22T10:31:57.563058Z","end":"2026-08-22T10:31:57.724225Z","steps":["trace[992599366] 'process raft request' (duration: 160.920336ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:31:57.724347Z","caller":"traceutil/trace.go:171","msg":"trace[1043108163] transaction","detail":"{read_only:false; response_revision:922; number_of_response:1; }","duration":"159.740393ms","start":"2026-08-22T10:31:57.564591Z","end":"2026-08-22T10:31:57.724331Z","steps":["trace[1043108163] 'process raft request' (duration: 159.561718ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T10:32:00.551326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.139282ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-22T10:32:00.551412Z","caller":"traceutil/trace.go:171","msg":"trace[60980454] linearizableReadLoop","detail":"{readStateIndex:978; appliedIndex:977; }","duration":"143.979611ms","start":"2026-08-22T10:32:00.407421Z","end":"2026-08-22T10:32:00.551401Z","steps":["trace[60980454] 'read index received' (duration: 31.674566ms)","trace[60980454] 'applied index is now lower than readState.Index' (duration: 112.304195ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T10:32:00.551467Z","caller":"traceutil/trace.go:171","msg":"trace[1376041083] transaction","detail":"{read_only:false; response_revision:942; number_of_response:1; }","duration":"155.614913ms","start":"2026-08-22T10:32:00.395813Z","end":"2026-08-22T10:32:00.551428Z","steps":["trace[1376041083] 'process raft request' (duration: 43.318228ms)","trace[1376041083] 'compare' (duration: 111.952276ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T10:32:00.551562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.149056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/local-path-storage/local-path-config\" ","response":"range_response_count:1 size:1464"} {"level":"info","ts":"2026-08-22T10:32:00.55158Z","caller":"traceutil/trace.go:171","msg":"trace[262961120] range","detail":"{range_begin:/registry/configmaps/local-path-storage/local-path-config; range_end:; response_count:1; response_revision:942; }","duration":"144.213828ms","start":"2026-08-22T10:32:00.407361Z","end":"2026-08-22T10:32:00.551574Z","steps":["trace[262961120] 'agreement among raft nodes before linearized reading' (duration: 144.103205ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T10:32:19.969896Z","caller":"traceutil/trace.go:171","msg":"trace[1800170077] transaction","detail":"{read_only:false; response_revision:1012; number_of_response:1; }","duration":"135.395269ms","start":"2026-08-22T10:32:19.834458Z","end":"2026-08-22T10:32:19.969853Z","steps":["trace[1800170077] 'process raft request' (duration: 134.971337ms)"],"step_count":1}