{"level":"warn","ts":"2026-05-28T15:17:03.365487Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-28T15:17:03.365623Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.138: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.138:2380","--initial-cluster=instance=https://199.204.45.138:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.138:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.138: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-05-28T15:17:03.365702Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-28T15:17:03.365722Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.138:2380"]} {"level":"info","ts":"2026-05-28T15:17:03.365751Z","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-05-28T15:17:03.366377Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"]} {"level":"info","ts":"2026-05-28T15:17:03.366518Z","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.138:2380"],"listen-peer-urls":["https://199.204.45.138:2380"],"advertise-client-urls":["https://199.204.45.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.138: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-05-28T15:17:03.373173Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.438584ms"} {"level":"info","ts":"2026-05-28T15:17:03.382127Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f3d52791b64f7591","cluster-id":"90076b89649fe294"} {"level":"info","ts":"2026-05-28T15:17:03.382259Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=()"} {"level":"info","ts":"2026-05-28T15:17:03.382299Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became follower at term 0"} {"level":"info","ts":"2026-05-28T15:17:03.382324Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f3d52791b64f7591 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-28T15:17:03.382374Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became follower at term 1"} {"level":"info","ts":"2026-05-28T15:17:03.382446Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=(17569993028038260113)"} {"level":"warn","ts":"2026-05-28T15:17:03.394932Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-28T15:17:03.396415Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-28T15:17:03.397707Z","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-05-28T15:17:03.400584Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f3d52791b64f7591","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-28T15:17:03.404723Z","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-05-28T15:17:03.405048Z","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-05-28T15:17:03.405475Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f3d52791b64f7591","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-28T15:17:03.405765Z","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-05-28T15:17:03.406004Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f3d52791b64f7591","initial-advertise-peer-urls":["https://199.204.45.138:2380"],"listen-peer-urls":["https://199.204.45.138:2380"],"advertise-client-urls":["https://199.204.45.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-28T15:17:03.40607Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-28T15:17:03.406223Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=(17569993028038260113)"} {"level":"info","ts":"2026-05-28T15:17:03.406488Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"90076b89649fe294","local-member-id":"f3d52791b64f7591","added-peer-id":"f3d52791b64f7591","added-peer-peer-urls":["https://199.204.45.138:2380"]} {"level":"info","ts":"2026-05-28T15:17:03.40677Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.138:2380"} {"level":"info","ts":"2026-05-28T15:17:03.406821Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.138:2380"} {"level":"info","ts":"2026-05-28T15:17:03.406847Z","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-05-28T15:17:04.283564Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 is starting a new election at term 1"} {"level":"info","ts":"2026-05-28T15:17:04.28365Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-28T15:17:04.283672Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 received MsgPreVoteResp from f3d52791b64f7591 at term 1"} {"level":"info","ts":"2026-05-28T15:17:04.28369Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became candidate at term 2"} {"level":"info","ts":"2026-05-28T15:17:04.283701Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 received MsgVoteResp from f3d52791b64f7591 at term 2"} {"level":"info","ts":"2026-05-28T15:17:04.283717Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became leader at term 2"} {"level":"info","ts":"2026-05-28T15:17:04.283733Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f3d52791b64f7591 elected leader f3d52791b64f7591 at term 2"} {"level":"info","ts":"2026-05-28T15:17:04.284776Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-28T15:17:04.285819Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-28T15:17:04.285823Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f3d52791b64f7591","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.138:2379]}","request-path":"/0/members/f3d52791b64f7591/attributes","cluster-id":"90076b89649fe294","publish-timeout":"7s"} {"level":"info","ts":"2026-05-28T15:17:04.285935Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-28T15:17:04.287417Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-28T15:17:04.287482Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-28T15:17:04.287566Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-28T15:17:04.28785Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"90076b89649fe294","local-member-id":"f3d52791b64f7591","cluster-version":"3.5"} {"level":"info","ts":"2026-05-28T15:17:04.287978Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-28T15:17:04.288019Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-28T15:17:04.289408Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.138:2379"} {"level":"info","ts":"2026-05-28T15:17:05.783586Z","caller":"traceutil/trace.go:171","msg":"trace[1623777962] linearizableReadLoop","detail":"{readStateIndex:12; appliedIndex:6; }","duration":"109.59355ms","start":"2026-05-28T15:17:05.673969Z","end":"2026-05-28T15:17:05.783563Z","steps":["trace[1623777962] 'read index received' (duration: 100.997054ms)","trace[1623777962] 'applied index is now lower than readState.Index' (duration: 8.595406ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T15:17:05.783772Z","caller":"traceutil/trace.go:171","msg":"trace[2077143268] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"129.695484ms","start":"2026-05-28T15:17:05.654057Z","end":"2026-05-28T15:17:05.783752Z","steps":["trace[2077143268] 'process raft request' (duration: 120.814927ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:17:05.783927Z","caller":"traceutil/trace.go:171","msg":"trace[2043758478] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"129.570029ms","start":"2026-05-28T15:17:05.654346Z","end":"2026-05-28T15:17:05.783916Z","steps":["trace[2043758478] 'process raft request' (duration: 129.153893ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:17:05.783892Z","caller":"traceutil/trace.go:171","msg":"trace[268796654] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"129.529498ms","start":"2026-05-28T15:17:05.654328Z","end":"2026-05-28T15:17:05.783857Z","steps":["trace[268796654] 'process raft request' (duration: 129.151723ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T15:17:05.783956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.174613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-28T15:17:05.784046Z","caller":"traceutil/trace.go:171","msg":"trace[1429207004] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:9; }","duration":"130.300578ms","start":"2026-05-28T15:17:05.653725Z","end":"2026-05-28T15:17:05.784026Z","steps":["trace[1429207004] 'agreement among raft nodes before linearized reading' (duration: 130.127391ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:17:05.784102Z","caller":"traceutil/trace.go:171","msg":"trace[1860663717] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"129.953814ms","start":"2026-05-28T15:17:05.654137Z","end":"2026-05-28T15:17:05.784091Z","steps":["trace[1860663717] 'process raft request' (duration: 129.282818ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:17:05.784222Z","caller":"traceutil/trace.go:171","msg":"trace[2035421311] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"129.902472ms","start":"2026-05-28T15:17:05.654267Z","end":"2026-05-28T15:17:05.784169Z","steps":["trace[2035421311] 'process raft request' (duration: 129.188014ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T15:17:05.784195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.279705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.138\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-28T15:17:05.784314Z","caller":"traceutil/trace.go:171","msg":"trace[147020464] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"128.787809ms","start":"2026-05-28T15:17:05.655518Z","end":"2026-05-28T15:17:05.784305Z","steps":["trace[147020464] 'process raft request' (duration: 128.009279ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:17:05.784329Z","caller":"traceutil/trace.go:171","msg":"trace[106513989] range","detail":"{range_begin:/registry/masterleases/199.204.45.138; range_end:; response_count:0; response_revision:9; }","duration":"132.456632ms","start":"2026-05-28T15:17:05.651858Z","end":"2026-05-28T15:17:05.784315Z","steps":["trace[106513989] 'agreement among raft nodes before linearized reading' (duration: 132.283785ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T15:17:05.784347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.335534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-28T15:17:05.784278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.270128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-28T15:17:05.784374Z","caller":"traceutil/trace.go:171","msg":"trace[211206961] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:9; }","duration":"199.367005ms","start":"2026-05-28T15:17:05.584998Z","end":"2026-05-28T15:17:05.784365Z","steps":["trace[211206961] 'agreement among raft nodes before linearized reading' (duration: 199.330923ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:17:05.784405Z","caller":"traceutil/trace.go:171","msg":"trace[1798718265] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:9; }","duration":"128.433385ms","start":"2026-05-28T15:17:05.655957Z","end":"2026-05-28T15:17:05.78439Z","steps":["trace[1798718265] 'agreement among raft nodes before linearized reading' (duration: 128.221506ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:17:05.800479Z","caller":"traceutil/trace.go:171","msg":"trace[1470930158] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"121.281346ms","start":"2026-05-28T15:17:05.679179Z","end":"2026-05-28T15:17:05.80046Z","steps":["trace[1470930158] 'process raft request' (duration: 121.243514ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:17:05.800538Z","caller":"traceutil/trace.go:171","msg":"trace[373731925] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"121.494694ms","start":"2026-05-28T15:17:05.679023Z","end":"2026-05-28T15:17:05.800518Z","steps":["trace[373731925] 'process raft request' (duration: 121.315907ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T15:17:06.301575Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471726574328288906,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-28T15:17:06.801825Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471726574328288906,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-28T15:17:06.81585Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.01551303s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-28T15:17:07.78623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000262162s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-28T15:17:07.786326Z","caller":"traceutil/trace.go:171","msg":"trace[58132760] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000408138s","start":"2026-05-28T15:17:05.7859Z","end":"2026-05-28T15:17:07.786309Z","steps":["trace[58132760] 'agreement among raft nodes before linearized reading' (duration: 2.000292173s)"],"step_count":1} {"level":"warn","ts":"2026-05-28T15:17:07.786378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T15:17:05.785879Z","time spent":"2.000489781s","remote":"127.0.0.1:60198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/28 15:17:07 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-28T15:17:07.998523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.181845573s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-28T15:17:07.99889Z","caller":"traceutil/trace.go:171","msg":"trace[1377155638] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"2.212850467s","start":"2026-05-28T15:17:05.78599Z","end":"2026-05-28T15:17:07.99884Z","steps":["trace[1377155638] 'process raft request' (duration: 1.030170682s)","trace[1377155638] 'compare' (duration: 1.181716508s)"],"step_count":2} {"level":"info","ts":"2026-05-28T15:17:07.998946Z","caller":"traceutil/trace.go:171","msg":"trace[1984247996] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"2.210444094s","start":"2026-05-28T15:17:05.788488Z","end":"2026-05-28T15:17:07.998932Z","steps":["trace[1984247996] 'process raft request' (duration: 2.210411303s)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:17:07.998979Z","caller":"traceutil/trace.go:171","msg":"trace[1782922475] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"2.210706514s","start":"2026-05-28T15:17:05.788245Z","end":"2026-05-28T15:17:07.998951Z","steps":["trace[1782922475] 'process raft request' (duration: 2.210586299s)"],"step_count":1} {"level":"warn","ts":"2026-05-28T15:17:07.999026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T15:17:05.785969Z","time spent":"2.212982953s","remote":"127.0.0.1:60290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-28T15:17:07.999033Z","caller":"traceutil/trace.go:171","msg":"trace[804024087] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"2.212184412s","start":"2026-05-28T15:17:05.786836Z","end":"2026-05-28T15:17:07.99902Z","steps":["trace[804024087] 'process raft request' (duration: 2.211794717s)"],"step_count":1} {"level":"warn","ts":"2026-05-28T15:17:07.999062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T15:17:05.788238Z","time spent":"2.210783616s","remote":"127.0.0.1:60726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-28T15:17:07.999071Z","caller":"traceutil/trace.go:171","msg":"trace[1779849389] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"2.210653632s","start":"2026-05-28T15:17:05.788409Z","end":"2026-05-28T15:17:07.999062Z","steps":["trace[1779849389] 'process raft request' (duration: 2.210443764s)"],"step_count":1} {"level":"warn","ts":"2026-05-28T15:17:07.999119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T15:17:05.788403Z","time spent":"2.210690493s","remote":"127.0.0.1:60726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-28T15:17:07.99912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T15:17:05.786819Z","time spent":"2.212254644s","remote":"127.0.0.1:60638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-28T15:17:07.999257Z","caller":"traceutil/trace.go:171","msg":"trace[752152478] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"2.210794617s","start":"2026-05-28T15:17:05.788452Z","end":"2026-05-28T15:17:07.999247Z","steps":["trace[752152478] 'process raft request' (duration: 2.210423863s)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:17:07.998943Z","caller":"traceutil/trace.go:171","msg":"trace[366730849] transaction","detail":"{read_only:false; number_of_response:0; response_revision:13; }","duration":"2.211204833s","start":"2026-05-28T15:17:05.787706Z","end":"2026-05-28T15:17:07.998911Z","steps":["trace[366730849] 'process raft request' (duration: 2.210982094s)"],"step_count":1} {"level":"warn","ts":"2026-05-28T15:17:07.999374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T15:17:05.78769Z","time spent":"2.211659691s","remote":"127.0.0.1:60290","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-28T15:17:07.999033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T15:17:05.788484Z","time spent":"2.210509326s","remote":"127.0.0.1:60726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-28T15:17:07.9993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T15:17:05.788446Z","time spent":"2.210831508s","remote":"127.0.0.1:60726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-28T15:17:07.999944Z","caller":"traceutil/trace.go:171","msg":"trace[1848863539] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"2.21190867s","start":"2026-05-28T15:17:05.787964Z","end":"2026-05-28T15:17:07.999873Z","steps":["trace[1848863539] 'process raft request' (duration: 2.210804888s)"],"step_count":1} {"level":"warn","ts":"2026-05-28T15:17:08.000414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T15:17:05.787955Z","time spent":"2.212055825s","remote":"127.0.0.1:60726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-28T15:17:08.461834Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.432030506s","expected-duration":"1s"} {"level":"info","ts":"2026-05-28T15:17:08.503905Z","caller":"traceutil/trace.go:171","msg":"trace[1472213516] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"2.692716984s","start":"2026-05-28T15:17:05.811164Z","end":"2026-05-28T15:17:08.503881Z","steps":["trace[1472213516] 'process raft request' (duration: 2.650939942s)","trace[1472213516] 'compare' (duration: 41.419269ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T15:17:08.504269Z","caller":"traceutil/trace.go:171","msg":"trace[1855097592] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"499.849738ms","start":"2026-05-28T15:17:08.004405Z","end":"2026-05-28T15:17:08.504255Z","steps":["trace[1855097592] 'process raft request' (duration: 499.818766ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:17:08.50434Z","caller":"traceutil/trace.go:171","msg":"trace[191453703] linearizableReadLoop","detail":"{readStateIndex:23; appliedIndex:14; }","duration":"2.70363902s","start":"2026-05-28T15:17:05.800689Z","end":"2026-05-28T15:17:08.504328Z","steps":["trace[191453703] 'read index received' (duration: 1.015382646s)","trace[191453703] 'applied index is now lower than readState.Index' (duration: 1.688255324s)"],"step_count":2} {"level":"info","ts":"2026-05-28T15:17:08.504384Z","caller":"traceutil/trace.go:171","msg":"trace[263726211] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"501.150969ms","start":"2026-05-28T15:17:08.003222Z","end":"2026-05-28T15:17:08.504373Z","steps":["trace[263726211] 'process raft request' (duration: 500.434532ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T15:17:08.504432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T15:17:08.004397Z","time spent":"499.956402ms","remote":"127.0.0.1:60726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1007,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-28T15:17:08.50455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T15:17:08.00318Z","time spent":"501.277923ms","remote":"127.0.0.1:60638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":716,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-28T15:17:08.504617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.717930938s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3491"} {"level":"info","ts":"2026-05-28T15:17:08.504666Z","caller":"traceutil/trace.go:171","msg":"trace[533294413] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:25; }","duration":"2.71797519s","start":"2026-05-28T15:17:05.786677Z","end":"2026-05-28T15:17:08.504652Z","steps":["trace[533294413] 'agreement among raft nodes before linearized reading' (duration: 2.717853445s)"],"step_count":1} {"level":"warn","ts":"2026-05-28T15:17:08.50471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T15:17:05.786646Z","time spent":"2.718046662s","remote":"127.0.0.1:60352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3515,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-05-28T15:17:08.50482Z","caller":"traceutil/trace.go:171","msg":"trace[276896167] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"501.405969ms","start":"2026-05-28T15:17:08.003401Z","end":"2026-05-28T15:17:08.504807Z","steps":["trace[276896167] 'process raft request' (duration: 500.6884ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:17:08.504309Z","caller":"traceutil/trace.go:171","msg":"trace[1589935241] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"500.926059ms","start":"2026-05-28T15:17:08.003346Z","end":"2026-05-28T15:17:08.504272Z","steps":["trace[1589935241] 'process raft request' (duration: 500.594206ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T15:17:08.504948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T15:17:08.00333Z","time spent":"501.551844ms","remote":"127.0.0.1:60726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-28T15:17:08.505032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.70056634s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-djx8w\" ","response":"range_response_count:1 size:861"} {"level":"info","ts":"2026-05-28T15:17:08.505068Z","caller":"traceutil/trace.go:171","msg":"trace[1441881469] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-djx8w; range_end:; response_count:1; response_revision:25; }","duration":"2.700621072s","start":"2026-05-28T15:17:05.804437Z","end":"2026-05-28T15:17:08.505058Z","steps":["trace[1441881469] 'agreement among raft nodes before linearized reading' (duration: 2.70056402s)"],"step_count":1} {"level":"warn","ts":"2026-05-28T15:17:08.505099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T15:17:05.804426Z","time spent":"2.700666724s","remote":"127.0.0.1:60436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":885,"request content":"key:\"/registry/certificatesigningrequests/csr-djx8w\" "} {"level":"info","ts":"2026-05-28T15:17:08.505219Z","caller":"traceutil/trace.go:171","msg":"trace[1284066712] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"501.302014ms","start":"2026-05-28T15:17:08.003905Z","end":"2026-05-28T15:17:08.505207Z","steps":["trace[1284066712] 'process raft request' (duration: 500.263783ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T15:17:08.505227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.505484307s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-28T15:17:08.505349Z","caller":"traceutil/trace.go:171","msg":"trace[1919128899] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:25; }","duration":"1.505638173s","start":"2026-05-28T15:17:06.99969Z","end":"2026-05-28T15:17:08.505328Z","steps":["trace[1919128899] 'agreement among raft nodes before linearized reading' (duration: 1.505480897s)"],"step_count":1} {"level":"warn","ts":"2026-05-28T15:17:08.505356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.891057842s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"warn","ts":"2026-05-28T15:17:08.505315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T15:17:08.003899Z","time spent":"501.386308ms","remote":"127.0.0.1:60726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":947,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-28T15:17:08.505439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.948393324s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-28T15:17:08.505477Z","caller":"traceutil/trace.go:171","msg":"trace[424021224] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:25; }","duration":"1.948469356s","start":"2026-05-28T15:17:06.557001Z","end":"2026-05-28T15:17:08.50547Z","steps":["trace[424021224] 'agreement among raft nodes before linearized reading' (duration: 1.948422024s)"],"step_count":1} {"level":"warn","ts":"2026-05-28T15:17:08.50551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T15:17:06.556981Z","time spent":"1.948523088s","remote":"127.0.0.1:60538","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":28,"request content":"key:\"/registry/priorityclasses/system-node-critical\" "} {"level":"warn","ts":"2026-05-28T15:17:08.505569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.273027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-28T15:17:08.505628Z","caller":"traceutil/trace.go:171","msg":"trace[806594959] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:25; }","duration":"229.368252ms","start":"2026-05-28T15:17:08.276246Z","end":"2026-05-28T15:17:08.505614Z","steps":["trace[806594959] 'agreement among raft nodes before linearized reading' (duration: 229.284708ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T15:17:08.505677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.953168739s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-28T15:17:08.505716Z","caller":"traceutil/trace.go:171","msg":"trace[749124910] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:25; }","duration":"1.953233011s","start":"2026-05-28T15:17:06.552473Z","end":"2026-05-28T15:17:08.505706Z","steps":["trace[749124910] 'agreement among raft nodes before linearized reading' (duration: 1.953171669s)"],"step_count":1} {"level":"warn","ts":"2026-05-28T15:17:08.505747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T15:17:06.552462Z","time spent":"1.953278312s","remote":"127.0.0.1:60522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":28,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" "} {"level":"info","ts":"2026-05-28T15:17:08.505762Z","caller":"traceutil/trace.go:171","msg":"trace[701462535] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"501.750772ms","start":"2026-05-28T15:17:08.003947Z","end":"2026-05-28T15:17:08.505697Z","steps":["trace[701462535] 'process raft request' (duration: 500.251073ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T15:17:08.505841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.875327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-28T15:17:08.505892Z","caller":"traceutil/trace.go:171","msg":"trace[2005995104] range","detail":"{range_begin:/registry/resourcequotas/kube-public/; range_end:/registry/resourcequotas/kube-public0; response_count:0; response_revision:25; }","duration":"501.945959ms","start":"2026-05-28T15:17:08.003934Z","end":"2026-05-28T15:17:08.50588Z","steps":["trace[2005995104] 'agreement among raft nodes before linearized reading' (duration: 501.867526ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T15:17:08.505939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.109943736s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"warn","ts":"2026-05-28T15:17:08.50594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T15:17:08.003924Z","time spent":"502.005592ms","remote":"127.0.0.1:60278","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" "} {"level":"info","ts":"2026-05-28T15:17:08.505975Z","caller":"traceutil/trace.go:171","msg":"trace[837786879] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:25; }","duration":"2.110009739s","start":"2026-05-28T15:17:06.395956Z","end":"2026-05-28T15:17:08.505966Z","steps":["trace[837786879] 'agreement among raft nodes before linearized reading' (duration: 2.109959107s)"],"step_count":1} {"level":"warn","ts":"2026-05-28T15:17:08.506005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T15:17:06.395936Z","time spent":"2.11006382s","remote":"127.0.0.1:60290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-05-28T15:17:08.504293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T15:17:05.811149Z","time spent":"2.692808037s","remote":"127.0.0.1:60352","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3479,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T15:17:08.506139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.502111609s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-28T15:17:08.50616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.457765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-05-28T15:17:08.506181Z","caller":"traceutil/trace.go:171","msg":"trace[1891330729] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:25; }","duration":"2.502174402s","start":"2026-05-28T15:17:06.003991Z","end":"2026-05-28T15:17:08.506165Z","steps":["trace[1891330729] 'agreement among raft nodes before linearized reading' (duration: 2.50212737s)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:17:08.506203Z","caller":"traceutil/trace.go:171","msg":"trace[1916509943] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:25; }","duration":"505.537538ms","start":"2026-05-28T15:17:08.000653Z","end":"2026-05-28T15:17:08.506191Z","steps":["trace[1916509943] 'agreement among raft nodes before linearized reading' (duration: 505.451094ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T15:17:08.506249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.644906856s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"warn","ts":"2026-05-28T15:17:08.506272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T15:17:08.000635Z","time spent":"505.607561ms","remote":"127.0.0.1:60290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-05-28T15:17:08.504963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T15:17:08.00333Z","time spent":"501.582445ms","remote":"127.0.0.1:60726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":956,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-28T15:17:08.505397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T15:17:06.999673Z","time spent":"1.505713436s","remote":"127.0.0.1:60290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":30,"response count":0,"response size":28,"request content":"key:\"/registry/namespaces/default\" "} {"level":"warn","ts":"2026-05-28T15:17:08.506549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"617.478325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-28T15:17:08.505869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T15:17:08.003934Z","time spent":"501.907567ms","remote":"127.0.0.1:60726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1007,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-28T15:17:08.506639Z","caller":"traceutil/trace.go:171","msg":"trace[1543439426] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25; }","duration":"617.591539ms","start":"2026-05-28T15:17:07.88902Z","end":"2026-05-28T15:17:08.506611Z","steps":["trace[1543439426] 'agreement among raft nodes before linearized reading' (duration: 617.424652ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T15:17:08.506716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T15:17:07.889Z","time spent":"617.701613ms","remote":"127.0.0.1:60196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-28T15:17:08.505298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.830494448s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-28T15:17:08.506892Z","caller":"traceutil/trace.go:171","msg":"trace[432959471] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25; }","duration":"1.832082059s","start":"2026-05-28T15:17:06.674767Z","end":"2026-05-28T15:17:08.506849Z","steps":["trace[432959471] 'agreement among raft nodes before linearized reading' (duration: 1.830478787s)"],"step_count":1} {"level":"warn","ts":"2026-05-28T15:17:08.50699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T15:17:06.674756Z","time spent":"1.832209883s","remote":"127.0.0.1:60196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-28T15:17:08.505897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.109355893s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-05-28T15:17:08.507108Z","caller":"traceutil/trace.go:171","msg":"trace[58086] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:25; }","duration":"2.11056878s","start":"2026-05-28T15:17:06.396519Z","end":"2026-05-28T15:17:08.507088Z","steps":["trace[58086] 'agreement among raft nodes before linearized reading' (duration: 2.109351183s)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:17:08.506282Z","caller":"traceutil/trace.go:171","msg":"trace[978660776] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:25; }","duration":"2.644966928s","start":"2026-05-28T15:17:05.861305Z","end":"2026-05-28T15:17:08.506271Z","steps":["trace[978660776] 'agreement among raft nodes before linearized reading' (duration: 2.644918346s)"],"step_count":1} {"level":"warn","ts":"2026-05-28T15:17:08.507581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T15:17:05.861287Z","time spent":"2.646279319s","remote":"127.0.0.1:60290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-05-28T15:17:08.505405Z","caller":"traceutil/trace.go:171","msg":"trace[1668932657] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:25; }","duration":"1.891130676s","start":"2026-05-28T15:17:06.614259Z","end":"2026-05-28T15:17:08.505389Z","steps":["trace[1668932657] 'agreement among raft nodes before linearized reading' (duration: 1.891066173s)"],"step_count":1} {"level":"warn","ts":"2026-05-28T15:17:08.507714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T15:17:06.614244Z","time spent":"1.893461946s","remote":"127.0.0.1:60290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-05-28T15:17:08.506207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T15:17:06.003974Z","time spent":"2.502227584s","remote":"127.0.0.1:60450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" "} {"level":"warn","ts":"2026-05-28T15:17:08.508523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T15:17:06.396509Z","time spent":"2.110663603s","remote":"127.0.0.1:60290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-05-28T15:17:21.415977Z","caller":"traceutil/trace.go:171","msg":"trace[1767311501] transaction","detail":"{read_only:false; response_revision:408; number_of_response:1; }","duration":"186.660131ms","start":"2026-05-28T15:17:21.2293Z","end":"2026-05-28T15:17:21.41596Z","steps":["trace[1767311501] 'process raft request' (duration: 186.551937ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:17:21.669679Z","caller":"traceutil/trace.go:171","msg":"trace[1274337772] transaction","detail":"{read_only:false; response_revision:409; number_of_response:1; }","duration":"127.841667ms","start":"2026-05-28T15:17:21.541806Z","end":"2026-05-28T15:17:21.669648Z","steps":["trace[1274337772] 'process raft request' (duration: 88.191898ms)","trace[1274337772] 'compare' (duration: 39.519114ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T15:17:22.016449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.394631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-28T15:17:22.01652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.403335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-28T15:17:22.016591Z","caller":"traceutil/trace.go:171","msg":"trace[171920259] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:409; }","duration":"202.605778ms","start":"2026-05-28T15:17:21.813963Z","end":"2026-05-28T15:17:22.016569Z","steps":["trace[171920259] 'range keys from in-memory index tree' (duration: 202.236365ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:17:22.016629Z","caller":"traceutil/trace.go:171","msg":"trace[1400482701] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:409; }","duration":"185.56135ms","start":"2026-05-28T15:17:21.831039Z","end":"2026-05-28T15:17:22.016601Z","steps":["trace[1400482701] 'range keys from in-memory index tree' (duration: 185.250269ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:17:42.966256Z","caller":"traceutil/trace.go:171","msg":"trace[204771216] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"229.644841ms","start":"2026-05-28T15:17:42.736587Z","end":"2026-05-28T15:17:42.966232Z","steps":["trace[204771216] 'process raft request' (duration: 229.527887ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:17:42.984611Z","caller":"traceutil/trace.go:171","msg":"trace[1267852858] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"237.168091ms","start":"2026-05-28T15:17:42.747405Z","end":"2026-05-28T15:17:42.984573Z","steps":["trace[1267852858] 'process raft request' (duration: 237.026655ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:17:42.98464Z","caller":"traceutil/trace.go:171","msg":"trace[95193921] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"229.081051ms","start":"2026-05-28T15:17:42.75553Z","end":"2026-05-28T15:17:42.984611Z","steps":["trace[95193921] 'process raft request' (duration: 228.981087ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:17:42.984795Z","caller":"traceutil/trace.go:171","msg":"trace[832698073] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"229.162743ms","start":"2026-05-28T15:17:42.755623Z","end":"2026-05-28T15:17:42.984786Z","steps":["trace[832698073] 'process raft request' (duration: 228.985937ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:17:42.984852Z","caller":"traceutil/trace.go:171","msg":"trace[7411144] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"224.530214ms","start":"2026-05-28T15:17:42.76031Z","end":"2026-05-28T15:17:42.984841Z","steps":["trace[7411144] 'process raft request' (duration: 224.359128ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:17:42.98488Z","caller":"traceutil/trace.go:171","msg":"trace[1260792863] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"229.288948ms","start":"2026-05-28T15:17:42.755583Z","end":"2026-05-28T15:17:42.984872Z","steps":["trace[1260792863] 'process raft request' (duration: 228.958297ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:17:42.98494Z","caller":"traceutil/trace.go:171","msg":"trace[768816555] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"227.214825ms","start":"2026-05-28T15:17:42.757717Z","end":"2026-05-28T15:17:42.984931Z","steps":["trace[768816555] 'process raft request' (duration: 226.927236ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:17:42.984975Z","caller":"traceutil/trace.go:171","msg":"trace[1576361517] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"223.446106ms","start":"2026-05-28T15:17:42.761521Z","end":"2026-05-28T15:17:42.984967Z","steps":["trace[1576361517] 'process raft request' (duration: 223.180097ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:17:42.985022Z","caller":"traceutil/trace.go:171","msg":"trace[1904166154] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"185.277814ms","start":"2026-05-28T15:17:42.799736Z","end":"2026-05-28T15:17:42.985014Z","steps":["trace[1904166154] 'process raft request' (duration: 185.032476ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:17:42.985059Z","caller":"traceutil/trace.go:171","msg":"trace[293985436] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"185.178021ms","start":"2026-05-28T15:17:42.799873Z","end":"2026-05-28T15:17:42.985051Z","steps":["trace[293985436] 'process raft request' (duration: 184.965273ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:17:42.985184Z","caller":"traceutil/trace.go:171","msg":"trace[77990338] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"177.468435ms","start":"2026-05-28T15:17:42.807707Z","end":"2026-05-28T15:17:42.985176Z","steps":["trace[77990338] 'process raft request' (duration: 177.247147ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:17:43.281774Z","caller":"traceutil/trace.go:171","msg":"trace[1221423066] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"190.088004ms","start":"2026-05-28T15:17:43.091666Z","end":"2026-05-28T15:17:43.281754Z","steps":["trace[1221423066] 'process raft request' (duration: 170.168275ms)","trace[1221423066] 'compare' (duration: 19.840446ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T15:17:43.282588Z","caller":"traceutil/trace.go:171","msg":"trace[153128703] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"190.528089ms","start":"2026-05-28T15:17:43.092051Z","end":"2026-05-28T15:17:43.282579Z","steps":["trace[153128703] 'process raft request' (duration: 190.319182ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:17:43.282714Z","caller":"traceutil/trace.go:171","msg":"trace[1681963505] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"177.944046ms","start":"2026-05-28T15:17:43.104764Z","end":"2026-05-28T15:17:43.282709Z","steps":["trace[1681963505] 'process raft request' (duration: 177.692777ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:17:43.282915Z","caller":"traceutil/trace.go:171","msg":"trace[1523448768] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"123.631749ms","start":"2026-05-28T15:17:43.159259Z","end":"2026-05-28T15:17:43.28289Z","steps":["trace[1523448768] 'process raft request' (duration: 123.580277ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:17:43.283322Z","caller":"traceutil/trace.go:171","msg":"trace[875303381] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"163.659081ms","start":"2026-05-28T15:17:43.119652Z","end":"2026-05-28T15:17:43.283311Z","steps":["trace[875303381] 'process raft request' (duration: 163.051211ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:17:43.745228Z","caller":"traceutil/trace.go:171","msg":"trace[1479310087] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"115.621473ms","start":"2026-05-28T15:17:43.629568Z","end":"2026-05-28T15:17:43.745189Z","steps":["trace[1479310087] 'process raft request' (duration: 43.545074ms)","trace[1479310087] 'compare' (duration: 67.878724ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T15:17:44.119989Z","caller":"traceutil/trace.go:171","msg":"trace[2055667858] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"182.419799ms","start":"2026-05-28T15:17:43.937536Z","end":"2026-05-28T15:17:44.119956Z","steps":["trace[2055667858] 'process raft request' (duration: 118.918341ms)","trace[2055667858] 'compare' (duration: 63.359413ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T15:17:44.128768Z","caller":"traceutil/trace.go:171","msg":"trace[1375704020] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"185.36072ms","start":"2026-05-28T15:17:43.943347Z","end":"2026-05-28T15:17:44.128708Z","steps":["trace[1375704020] 'process raft request' (duration: 185.07446ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:17:49.76198Z","caller":"traceutil/trace.go:171","msg":"trace[1166248879] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"188.653312ms","start":"2026-05-28T15:17:49.573306Z","end":"2026-05-28T15:17:49.76196Z","steps":["trace[1166248879] 'process raft request' (duration: 188.179086ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:17:49.790318Z","caller":"traceutil/trace.go:171","msg":"trace[102409953] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"200.610729ms","start":"2026-05-28T15:17:49.589674Z","end":"2026-05-28T15:17:49.790285Z","steps":["trace[102409953] 'process raft request' (duration: 200.489165ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:17:50.020051Z","caller":"traceutil/trace.go:171","msg":"trace[1996964965] linearizableReadLoop","detail":"{readStateIndex:657; appliedIndex:656; }","duration":"205.361418ms","start":"2026-05-28T15:17:49.814666Z","end":"2026-05-28T15:17:50.020027Z","steps":["trace[1996964965] 'read index received' (duration: 166.527368ms)","trace[1996964965] 'applied index is now lower than readState.Index' (duration: 38.83304ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T15:17:50.020082Z","caller":"traceutil/trace.go:171","msg":"trace[1411726789] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"209.752638ms","start":"2026-05-28T15:17:49.810293Z","end":"2026-05-28T15:17:50.020045Z","steps":["trace[1411726789] 'process raft request' (duration: 170.898727ms)","trace[1411726789] 'compare' (duration: 38.611372ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T15:17:50.020349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.641858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T15:17:50.020459Z","caller":"traceutil/trace.go:171","msg":"trace[881663734] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:632; }","duration":"205.849335ms","start":"2026-05-28T15:17:49.814589Z","end":"2026-05-28T15:17:50.020438Z","steps":["trace[881663734] 'agreement among raft nodes before linearized reading' (duration: 205.516944ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T15:17:50.881934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.434606ms","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-05-28T15:17:50.882032Z","caller":"traceutil/trace.go:171","msg":"trace[1871958627] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:632; }","duration":"589.602762ms","start":"2026-05-28T15:17:50.292404Z","end":"2026-05-28T15:17:50.882007Z","steps":["trace[1871958627] 'range keys from in-memory index tree' (duration: 589.2307ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T15:17:50.882083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T15:17:50.292377Z","time spent":"589.694025ms","remote":"127.0.0.1:60450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-28T15:17:50.882147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.021993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-r2lkf\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-28T15:17:50.882286Z","caller":"traceutil/trace.go:171","msg":"trace[621646448] range","detail":"{range_begin:/registry/pods/kube-system/cilium-r2lkf; range_end:; response_count:1; response_revision:632; }","duration":"549.193099ms","start":"2026-05-28T15:17:50.333064Z","end":"2026-05-28T15:17:50.882258Z","steps":["trace[621646448] 'range keys from in-memory index tree' (duration: 548.823726ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T15:17:50.882457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"669.528596ms","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-05-28T15:17:50.882502Z","caller":"traceutil/trace.go:171","msg":"trace[910022860] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:632; }","duration":"669.609398ms","start":"2026-05-28T15:17:50.212882Z","end":"2026-05-28T15:17:50.882491Z","steps":["trace[910022860] 'range keys from in-memory index tree' (duration: 669.302968ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T15:17:50.88253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T15:17:50.212864Z","time spent":"669.65962ms","remote":"127.0.0.1:60450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-28T15:17:50.882609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.751936ms","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-05-28T15:17:50.882723Z","caller":"traceutil/trace.go:171","msg":"trace[1181534045] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:632; }","duration":"480.86677ms","start":"2026-05-28T15:17:50.401835Z","end":"2026-05-28T15:17:50.882702Z","steps":["trace[1181534045] 'range keys from in-memory index tree' (duration: 480.459375ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T15:17:50.88323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T15:17:50.401747Z","time spent":"481.433169ms","remote":"127.0.0.1:60450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-28T15:17:50.88308Z","caller":"traceutil/trace.go:171","msg":"trace[1697208310] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"461.053556ms","start":"2026-05-28T15:17:50.422002Z","end":"2026-05-28T15:17:50.883055Z","steps":["trace[1697208310] 'process raft request' (duration: 449.341089ms)","trace[1697208310] 'compare' (duration: 10.866129ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T15:17:50.883613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T15:17:50.421973Z","time spent":"461.543013ms","remote":"127.0.0.1:60286","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036317,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T15:17:50.882339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T15:17:50.333049Z","time spent":"549.277652ms","remote":"127.0.0.1:60364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16989,"request content":"key:\"/registry/pods/kube-system/cilium-r2lkf\" "} {"level":"info","ts":"2026-05-28T15:18:06.309985Z","caller":"traceutil/trace.go:171","msg":"trace[11915499] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"144.432376ms","start":"2026-05-28T15:18:06.165527Z","end":"2026-05-28T15:18:06.30996Z","steps":["trace[11915499] 'process raft request' (duration: 143.919439ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:18:14.946904Z","caller":"traceutil/trace.go:171","msg":"trace[91402661] transaction","detail":"{read_only:false; response_revision:905; number_of_response:1; }","duration":"108.683192ms","start":"2026-05-28T15:18:14.838158Z","end":"2026-05-28T15:18:14.946841Z","steps":["trace[91402661] 'process raft request' (duration: 81.660366ms)","trace[91402661] 'compare' (duration: 26.82248ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T15:18:14.946937Z","caller":"traceutil/trace.go:171","msg":"trace[1417773115] transaction","detail":"{read_only:false; response_revision:906; number_of_response:1; }","duration":"108.603879ms","start":"2026-05-28T15:18:14.838301Z","end":"2026-05-28T15:18:14.946905Z","steps":["trace[1417773115] 'process raft request' (duration: 108.459495ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:18:14.946961Z","caller":"traceutil/trace.go:171","msg":"trace[1216607967] transaction","detail":"{read_only:false; response_revision:908; number_of_response:1; }","duration":"105.520429ms","start":"2026-05-28T15:18:14.841423Z","end":"2026-05-28T15:18:14.946943Z","steps":["trace[1216607967] 'process raft request' (duration: 105.468308ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:18:14.947033Z","caller":"traceutil/trace.go:171","msg":"trace[1535671755] transaction","detail":"{read_only:false; response_revision:907; number_of_response:1; }","duration":"106.731638ms","start":"2026-05-28T15:18:14.840263Z","end":"2026-05-28T15:18:14.946994Z","steps":["trace[1535671755] 'process raft request' (duration: 106.583893ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:18:20.28205Z","caller":"traceutil/trace.go:171","msg":"trace[2147232901] linearizableReadLoop","detail":"{readStateIndex:993; appliedIndex:992; }","duration":"211.979153ms","start":"2026-05-28T15:18:20.070047Z","end":"2026-05-28T15:18:20.282026Z","steps":["trace[2147232901] 'read index received' (duration: 211.816068ms)","trace[2147232901] 'applied index is now lower than readState.Index' (duration: 162.505µs)"],"step_count":2} {"level":"info","ts":"2026-05-28T15:18:20.282102Z","caller":"traceutil/trace.go:171","msg":"trace[1132823134] transaction","detail":"{read_only:false; response_revision:960; number_of_response:1; }","duration":"417.026702ms","start":"2026-05-28T15:18:19.865051Z","end":"2026-05-28T15:18:20.282078Z","steps":["trace[1132823134] 'process raft request' (duration: 416.875357ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T15:18:20.282224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T15:18:19.865028Z","time spent":"417.121435ms","remote":"127.0.0.1:60364","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5472,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T15:18:20.282235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.19178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-28T15:18:20.282273Z","caller":"traceutil/trace.go:171","msg":"trace[471807906] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:960; }","duration":"212.238412ms","start":"2026-05-28T15:18:20.070027Z","end":"2026-05-28T15:18:20.282266Z","steps":["trace[471807906] 'agreement among raft nodes before linearized reading' (duration: 212.094167ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:18:20.584603Z","caller":"traceutil/trace.go:171","msg":"trace[977536636] transaction","detail":"{read_only:false; response_revision:965; number_of_response:1; }","duration":"154.679665ms","start":"2026-05-28T15:18:20.429879Z","end":"2026-05-28T15:18:20.584558Z","steps":["trace[977536636] 'process raft request' (duration: 121.79368ms)","trace[977536636] 'compare' (duration: 32.672998ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T15:18:20.797741Z","caller":"traceutil/trace.go:171","msg":"trace[633815537] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"127.936066ms","start":"2026-05-28T15:18:20.669768Z","end":"2026-05-28T15:18:20.797704Z","steps":["trace[633815537] 'process raft request' (duration: 87.922002ms)","trace[633815537] 'compare' (duration: 39.806407ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T15:18:21.690617Z","caller":"traceutil/trace.go:171","msg":"trace[1333897074] linearizableReadLoop","detail":"{readStateIndex:1009; appliedIndex:1008; }","duration":"197.009954ms","start":"2026-05-28T15:18:21.493582Z","end":"2026-05-28T15:18:21.690592Z","steps":["trace[1333897074] 'read index received' (duration: 196.792727ms)","trace[1333897074] 'applied index is now lower than readState.Index' (duration: 216.317µs)"],"step_count":2} {"level":"info","ts":"2026-05-28T15:18:21.690725Z","caller":"traceutil/trace.go:171","msg":"trace[939592] transaction","detail":"{read_only:false; response_revision:976; number_of_response:1; }","duration":"200.550507ms","start":"2026-05-28T15:18:21.490165Z","end":"2026-05-28T15:18:21.690716Z","steps":["trace[939592] 'process raft request' (duration: 200.265088ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T15:18:21.691078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.535684ms","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-05-28T15:18:21.691187Z","caller":"traceutil/trace.go:171","msg":"trace[1392175647] range","detail":"{range_begin:/registry/configmaps/local-path-storage/local-path-config; range_end:; response_count:1; response_revision:976; }","duration":"145.678369ms","start":"2026-05-28T15:18:21.545489Z","end":"2026-05-28T15:18:21.691167Z","steps":["trace[1392175647] 'agreement among raft nodes before linearized reading' (duration: 145.40116ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T15:18:21.691181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.580872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-njbj4\" ","response":"range_response_count:1 size:5069"} {"level":"info","ts":"2026-05-28T15:18:21.691403Z","caller":"traceutil/trace.go:171","msg":"trace[274216238] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-njbj4; range_end:; response_count:1; response_revision:976; }","duration":"197.828929ms","start":"2026-05-28T15:18:21.493542Z","end":"2026-05-28T15:18:21.691371Z","steps":["trace[274216238] 'agreement among raft nodes before linearized reading' (duration: 197.52556ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:18:21.916507Z","caller":"traceutil/trace.go:171","msg":"trace[232985912] transaction","detail":"{read_only:false; response_revision:977; number_of_response:1; }","duration":"208.872335ms","start":"2026-05-28T15:18:21.707608Z","end":"2026-05-28T15:18:21.91648Z","steps":["trace[232985912] 'process raft request' (duration: 183.499942ms)","trace[232985912] 'compare' (duration: 25.255389ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T15:18:21.916785Z","caller":"traceutil/trace.go:171","msg":"trace[1107772764] transaction","detail":"{read_only:false; response_revision:978; number_of_response:1; }","duration":"159.357858ms","start":"2026-05-28T15:18:21.757401Z","end":"2026-05-28T15:18:21.916759Z","steps":["trace[1107772764] 'process raft request' (duration: 159.12198ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:18:22.736332Z","caller":"traceutil/trace.go:171","msg":"trace[257300906] transaction","detail":"{read_only:false; response_revision:980; number_of_response:1; }","duration":"228.915415ms","start":"2026-05-28T15:18:22.507381Z","end":"2026-05-28T15:18:22.736297Z","steps":["trace[257300906] 'process raft request' (duration: 228.683918ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:18:22.736679Z","caller":"traceutil/trace.go:171","msg":"trace[458972143] linearizableReadLoop","detail":"{readStateIndex:1014; appliedIndex:1013; }","duration":"147.356795ms","start":"2026-05-28T15:18:22.588844Z","end":"2026-05-28T15:18:22.736201Z","steps":["trace[458972143] 'read index received' (duration: 147.111967ms)","trace[458972143] 'applied index is now lower than readState.Index' (duration: 244.068µs)"],"step_count":2} {"level":"warn","ts":"2026-05-28T15:18:22.737018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.153711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-28T15:18:22.737082Z","caller":"traceutil/trace.go:171","msg":"trace[471980664] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:980; }","duration":"148.276446ms","start":"2026-05-28T15:18:22.588792Z","end":"2026-05-28T15:18:22.737069Z","steps":["trace[471980664] 'agreement among raft nodes before linearized reading' (duration: 147.975206ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:18:23.011497Z","caller":"traceutil/trace.go:171","msg":"trace[271690000] transaction","detail":"{read_only:false; response_revision:982; number_of_response:1; }","duration":"269.471705ms","start":"2026-05-28T15:18:22.741991Z","end":"2026-05-28T15:18:23.011463Z","steps":["trace[271690000] 'process raft request' (duration: 263.960299ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:18:23.011588Z","caller":"traceutil/trace.go:171","msg":"trace[1501226383] transaction","detail":"{read_only:false; response_revision:983; number_of_response:1; }","duration":"245.436865ms","start":"2026-05-28T15:18:22.766127Z","end":"2026-05-28T15:18:23.011564Z","steps":["trace[1501226383] 'process raft request' (duration: 245.251229ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:18:23.031516Z","caller":"traceutil/trace.go:171","msg":"trace[129131071] linearizableReadLoop","detail":"{readStateIndex:1018; appliedIndex:1015; }","duration":"218.470101ms","start":"2026-05-28T15:18:22.813017Z","end":"2026-05-28T15:18:23.031487Z","steps":["trace[129131071] 'read index received' (duration: 192.947215ms)","trace[129131071] 'applied index is now lower than readState.Index' (duration: 25.521566ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T15:18:23.031649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.611285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T15:18:23.031682Z","caller":"traceutil/trace.go:171","msg":"trace[1370512343] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:984; }","duration":"218.691037ms","start":"2026-05-28T15:18:22.812981Z","end":"2026-05-28T15:18:23.031672Z","steps":["trace[1370512343] 'agreement among raft nodes before linearized reading' (duration: 218.607195ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:18:23.031607Z","caller":"traceutil/trace.go:171","msg":"trace[1874074672] transaction","detail":"{read_only:false; response_revision:984; number_of_response:1; }","duration":"229.0948ms","start":"2026-05-28T15:18:22.802469Z","end":"2026-05-28T15:18:23.031564Z","steps":["trace[1874074672] 'process raft request' (duration: 228.841562ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:18:31.164895Z","caller":"traceutil/trace.go:171","msg":"trace[728693216] linearizableReadLoop","detail":"{readStateIndex:1045; appliedIndex:1044; }","duration":"306.338038ms","start":"2026-05-28T15:18:30.858529Z","end":"2026-05-28T15:18:31.164867Z","steps":["trace[728693216] 'read index received' (duration: 306.192014ms)","trace[728693216] 'applied index is now lower than readState.Index' (duration: 145.034µs)"],"step_count":2} {"level":"info","ts":"2026-05-28T15:18:31.164944Z","caller":"traceutil/trace.go:171","msg":"trace[1310267479] transaction","detail":"{read_only:false; response_revision:1009; number_of_response:1; }","duration":"310.14758ms","start":"2026-05-28T15:18:30.854768Z","end":"2026-05-28T15:18:31.164915Z","steps":["trace[1310267479] 'process raft request' (duration: 309.955584ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T15:18:31.165085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T15:18:30.854745Z","time spent":"310.258654ms","remote":"127.0.0.1:60450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T15:18:31.165105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.558956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-28T15:18:31.165136Z","caller":"traceutil/trace.go:171","msg":"trace[1172779064] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1009; }","duration":"306.640668ms","start":"2026-05-28T15:18:30.858485Z","end":"2026-05-28T15:18:31.165126Z","steps":["trace[1172779064] 'agreement among raft nodes before linearized reading' (duration: 306.491354ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T15:18:31.165164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T15:18:30.858465Z","time spent":"306.692799ms","remote":"127.0.0.1:60450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-28T15:18:31.182576Z","caller":"traceutil/trace.go:171","msg":"trace[834442019] transaction","detail":"{read_only:false; response_revision:1010; number_of_response:1; }","duration":"118.501465ms","start":"2026-05-28T15:18:31.064054Z","end":"2026-05-28T15:18:31.182555Z","steps":["trace[834442019] 'process raft request' (duration: 118.405612ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:18:37.607396Z","caller":"traceutil/trace.go:171","msg":"trace[1415605784] linearizableReadLoop","detail":"{readStateIndex:1068; appliedIndex:1067; }","duration":"221.790108ms","start":"2026-05-28T15:18:37.385578Z","end":"2026-05-28T15:18:37.607356Z","steps":["trace[1415605784] 'read index received' (duration: 221.562851ms)","trace[1415605784] 'applied index is now lower than readState.Index' (duration: 213.957µs)"],"step_count":2} {"level":"info","ts":"2026-05-28T15:18:37.607423Z","caller":"traceutil/trace.go:171","msg":"trace[383903080] transaction","detail":"{read_only:false; response_revision:1031; number_of_response:1; }","duration":"238.221064ms","start":"2026-05-28T15:18:37.369179Z","end":"2026-05-28T15:18:37.6074Z","steps":["trace[383903080] 'process raft request' (duration: 238.008388ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T15:18:37.607687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.093487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-28T15:18:37.607728Z","caller":"traceutil/trace.go:171","msg":"trace[1704054226] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1031; }","duration":"222.16726ms","start":"2026-05-28T15:18:37.38555Z","end":"2026-05-28T15:18:37.607717Z","steps":["trace[1704054226] 'agreement among raft nodes before linearized reading' (duration: 221.987395ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T15:18:37.607764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.052342ms","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-05-28T15:18:37.607684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.159038ms","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-05-28T15:18:37.607862Z","caller":"traceutil/trace.go:171","msg":"trace[64121094] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1031; }","duration":"170.376086ms","start":"2026-05-28T15:18:37.437462Z","end":"2026-05-28T15:18:37.607838Z","steps":["trace[64121094] 'agreement among raft nodes before linearized reading' (duration: 170.115098ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:18:37.607801Z","caller":"traceutil/trace.go:171","msg":"trace[1774999555] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1031; }","duration":"168.117594ms","start":"2026-05-28T15:18:37.439674Z","end":"2026-05-28T15:18:37.607792Z","steps":["trace[1774999555] 'agreement among raft nodes before linearized reading' (duration: 168.039142ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T15:18:37.764787Z","caller":"traceutil/trace.go:171","msg":"trace[1744327363] transaction","detail":"{read_only:false; response_revision:1033; number_of_response:1; }","duration":"150.887264ms","start":"2026-05-28T15:18:37.613867Z","end":"2026-05-28T15:18:37.764754Z","steps":["trace[1744327363] 'process raft request' (duration: 73.877919ms)","trace[1744327363] 'compare' (duration: 76.808579ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T15:18:37.764807Z","caller":"traceutil/trace.go:171","msg":"trace[1928767975] transaction","detail":"{read_only:false; response_revision:1034; number_of_response:1; }","duration":"150.41747ms","start":"2026-05-28T15:18:37.61434Z","end":"2026-05-28T15:18:37.764758Z","steps":["trace[1928767975] 'process raft request' (duration: 150.347497ms)"],"step_count":1}