{"level":"warn","ts":"2026-05-06T01:14:31.438695Z","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-06T01:14:31.438781Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.205: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.205:2380","--initial-cluster=instance=https://199.204.45.205:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.205:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.205: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-06T01:14:31.43884Z","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-06T01:14:31.438853Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.205:2380"]} {"level":"info","ts":"2026-05-06T01:14:31.43887Z","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-06T01:14:31.439524Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"]} {"level":"info","ts":"2026-05-06T01:14:31.439605Z","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.205:2380"],"listen-peer-urls":["https://199.204.45.205:2380"],"advertise-client-urls":["https://199.204.45.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.205: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-06T01:14:31.446784Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.95448ms"} {"level":"info","ts":"2026-05-06T01:14:31.463638Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"71d28e9ac1bc4e5d","cluster-id":"4a4ae660c7a9a6a7"} {"level":"info","ts":"2026-05-06T01:14:31.463807Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=()"} {"level":"info","ts":"2026-05-06T01:14:31.463955Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 0"} {"level":"info","ts":"2026-05-06T01:14:31.463989Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 71d28e9ac1bc4e5d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-06T01:14:31.464016Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 1"} {"level":"info","ts":"2026-05-06T01:14:31.464095Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"} {"level":"warn","ts":"2026-05-06T01:14:31.476482Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-06T01:14:31.478062Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-06T01:14:31.47911Z","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-06T01:14:31.482318Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"71d28e9ac1bc4e5d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-06T01:14:31.482521Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"71d28e9ac1bc4e5d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-06T01:14:31.483737Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"} {"level":"info","ts":"2026-05-06T01:14:31.483841Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4a4ae660c7a9a6a7","local-member-id":"71d28e9ac1bc4e5d","added-peer-id":"71d28e9ac1bc4e5d","added-peer-peer-urls":["https://199.204.45.205:2380"]} {"level":"info","ts":"2026-05-06T01:14:31.483987Z","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-06T01:14:31.484036Z","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-06T01:14:31.484065Z","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-06T01:14:31.490997Z","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-06T01:14:31.49123Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"71d28e9ac1bc4e5d","initial-advertise-peer-urls":["https://199.204.45.205:2380"],"listen-peer-urls":["https://199.204.45.205:2380"],"advertise-client-urls":["https://199.204.45.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-06T01:14:31.491274Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-06T01:14:31.491258Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.205:2380"} {"level":"info","ts":"2026-05-06T01:14:31.491353Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.205:2380"} {"level":"info","ts":"2026-05-06T01:14:31.665647Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d is starting a new election at term 1"} {"level":"info","ts":"2026-05-06T01:14:31.665696Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became pre-candidate at term 1"} {"level":"info","ts":"2026-05-06T01:14:31.665732Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgPreVoteResp from 71d28e9ac1bc4e5d at term 1"} {"level":"info","ts":"2026-05-06T01:14:31.665746Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became candidate at term 2"} {"level":"info","ts":"2026-05-06T01:14:31.665773Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgVoteResp from 71d28e9ac1bc4e5d at term 2"} {"level":"info","ts":"2026-05-06T01:14:31.665787Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became leader at term 2"} {"level":"info","ts":"2026-05-06T01:14:31.665798Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 71d28e9ac1bc4e5d elected leader 71d28e9ac1bc4e5d at term 2"} {"level":"info","ts":"2026-05-06T01:14:31.666787Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"71d28e9ac1bc4e5d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.205:2379]}","request-path":"/0/members/71d28e9ac1bc4e5d/attributes","cluster-id":"4a4ae660c7a9a6a7","publish-timeout":"7s"} {"level":"info","ts":"2026-05-06T01:14:31.666892Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-06T01:14:31.66692Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-06T01:14:31.667065Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-06T01:14:31.667893Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4a4ae660c7a9a6a7","local-member-id":"71d28e9ac1bc4e5d","cluster-version":"3.5"} {"level":"info","ts":"2026-05-06T01:14:31.667961Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-06T01:14:31.667981Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-06T01:14:31.668991Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.205:2379"} {"level":"info","ts":"2026-05-06T01:14:31.669093Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-06T01:14:31.66914Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-06T01:14:31.669159Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-06T01:14:36.377278Z","caller":"traceutil/trace.go:171","msg":"trace[210472344] linearizableReadLoop","detail":"{readStateIndex:218; appliedIndex:217; }","duration":"276.297631ms","start":"2026-05-06T01:14:36.100954Z","end":"2026-05-06T01:14:36.377252Z","steps":["trace[210472344] 'read index received' (duration: 276.189528ms)","trace[210472344] 'applied index is now lower than readState.Index' (duration: 107.083µs)"],"step_count":2} {"level":"info","ts":"2026-05-06T01:14:36.377346Z","caller":"traceutil/trace.go:171","msg":"trace[231056664] transaction","detail":"{read_only:false; response_revision:213; number_of_response:1; }","duration":"424.287105ms","start":"2026-05-06T01:14:35.953013Z","end":"2026-05-06T01:14:36.377301Z","steps":["trace[231056664] 'process raft request' (duration: 424.095481ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:36.377539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.547367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3709"} {"level":"info","ts":"2026-05-06T01:14:36.377837Z","caller":"traceutil/trace.go:171","msg":"trace[710390373] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:213; }","duration":"276.914566ms","start":"2026-05-06T01:14:36.100905Z","end":"2026-05-06T01:14:36.377819Z","steps":["trace[710390373] 'agreement among raft nodes before linearized reading' (duration: 276.480125ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:36.377988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:14:35.952988Z","time spent":"424.508161ms","remote":"127.0.0.1:46722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-06T01:14:37.280418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.778928ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-06T01:14:37.280545Z","caller":"traceutil/trace.go:171","msg":"trace[722377739] transaction","detail":"{read_only:false; response_revision:214; number_of_response:1; }","duration":"894.13705ms","start":"2026-05-06T01:14:36.386384Z","end":"2026-05-06T01:14:37.280521Z","steps":["trace[722377739] 'process raft request' (duration: 672.86604ms)","trace[722377739] 'compare' (duration: 220.664456ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T01:14:37.28066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:14:36.386367Z","time spent":"894.218643ms","remote":"127.0.0.1:46722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T01:14:37.511969Z","caller":"traceutil/trace.go:171","msg":"trace[1622396238] linearizableReadLoop","detail":"{readStateIndex:220; appliedIndex:219; }","duration":"208.511399ms","start":"2026-05-06T01:14:37.303433Z","end":"2026-05-06T01:14:37.511945Z","steps":["trace[1622396238] 'read index received' (duration: 208.315764ms)","trace[1622396238] 'applied index is now lower than readState.Index' (duration: 194.685µs)"],"step_count":2} {"level":"info","ts":"2026-05-06T01:14:37.512215Z","caller":"traceutil/trace.go:171","msg":"trace[1172488775] transaction","detail":"{read_only:false; response_revision:215; number_of_response:1; }","duration":"1.125115078s","start":"2026-05-06T01:14:36.387082Z","end":"2026-05-06T01:14:37.512197Z","steps":["trace[1172488775] 'process raft request' (duration: 1.124742768s)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:37.512302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.078631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T01:14:37.512389Z","caller":"traceutil/trace.go:171","msg":"trace[1814521354] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:215; }","duration":"103.190403ms","start":"2026-05-06T01:14:37.409163Z","end":"2026-05-06T01:14:37.512353Z","steps":["trace[1814521354] 'agreement among raft nodes before linearized reading' (duration: 103.084081ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:37.512467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:14:36.387043Z","time spent":"1.12525831s","remote":"127.0.0.1:46628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4003,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-06T01:14:37.512516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.050382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T01:14:37.512615Z","caller":"traceutil/trace.go:171","msg":"trace[705208231] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:215; }","duration":"209.208646ms","start":"2026-05-06T01:14:37.303386Z","end":"2026-05-06T01:14:37.512594Z","steps":["trace[705208231] 'agreement among raft nodes before linearized reading' (duration: 209.026002ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:15:02.659005Z","caller":"traceutil/trace.go:171","msg":"trace[1058072071] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"216.540887ms","start":"2026-05-06T01:15:02.442439Z","end":"2026-05-06T01:15:02.65898Z","steps":["trace[1058072071] 'process raft request' (duration: 216.405843ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:15:02.667089Z","caller":"traceutil/trace.go:171","msg":"trace[1248872623] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"223.80112ms","start":"2026-05-06T01:15:02.44324Z","end":"2026-05-06T01:15:02.667041Z","steps":["trace[1248872623] 'process raft request' (duration: 223.644976ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:15:02.66722Z","caller":"traceutil/trace.go:171","msg":"trace[1250558372] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"223.790449ms","start":"2026-05-06T01:15:02.443348Z","end":"2026-05-06T01:15:02.667139Z","steps":["trace[1250558372] 'process raft request' (duration: 223.633856ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:15:02.667324Z","caller":"traceutil/trace.go:171","msg":"trace[1530409241] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"217.201454ms","start":"2026-05-06T01:15:02.450089Z","end":"2026-05-06T01:15:02.667291Z","steps":["trace[1530409241] 'process raft request' (duration: 217.02855ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:15:02.667331Z","caller":"traceutil/trace.go:171","msg":"trace[1197417163] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"207.720303ms","start":"2026-05-06T01:15:02.459579Z","end":"2026-05-06T01:15:02.667299Z","steps":["trace[1197417163] 'process raft request' (duration: 207.568269ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:15:02.667213Z","caller":"traceutil/trace.go:171","msg":"trace[1140268268] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"222.263889ms","start":"2026-05-06T01:15:02.444906Z","end":"2026-05-06T01:15:02.66717Z","steps":["trace[1140268268] 'process raft request' (duration: 222.103115ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:15:02.667422Z","caller":"traceutil/trace.go:171","msg":"trace[117321095] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"207.710792ms","start":"2026-05-06T01:15:02.459668Z","end":"2026-05-06T01:15:02.667379Z","steps":["trace[117321095] 'process raft request' (duration: 207.540558ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:15:02.667505Z","caller":"traceutil/trace.go:171","msg":"trace[824035747] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"197.875792ms","start":"2026-05-06T01:15:02.469623Z","end":"2026-05-06T01:15:02.667499Z","steps":["trace[824035747] 'process raft request' (duration: 197.721149ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:15:02.667455Z","caller":"traceutil/trace.go:171","msg":"trace[857667482] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"207.697684ms","start":"2026-05-06T01:15:02.459745Z","end":"2026-05-06T01:15:02.667443Z","steps":["trace[857667482] 'process raft request' (duration: 207.518488ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:15:02.667556Z","caller":"traceutil/trace.go:171","msg":"trace[1388725694] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"191.227806ms","start":"2026-05-06T01:15:02.476318Z","end":"2026-05-06T01:15:02.667546Z","steps":["trace[1388725694] 'process raft request' (duration: 191.074652ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:15:02.667635Z","caller":"traceutil/trace.go:171","msg":"trace[1605471308] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"164.514739ms","start":"2026-05-06T01:15:02.503109Z","end":"2026-05-06T01:15:02.667624Z","steps":["trace[1605471308] 'process raft request' (duration: 164.331284ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:15:03.397126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.611473ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-06T01:15:03.397248Z","caller":"traceutil/trace.go:171","msg":"trace[2098534218] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"669.716564ms","start":"2026-05-06T01:15:02.72751Z","end":"2026-05-06T01:15:03.397226Z","steps":["trace[2098534218] 'process raft request' (duration: 111.918215ms)","trace[2098534218] 'compare' (duration: 556.914246ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T01:15:03.397317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:15:02.727492Z","time spent":"669.792027ms","remote":"127.0.0.1:46494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T01:15:03.490078Z","caller":"traceutil/trace.go:171","msg":"trace[1822162145] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"758.901027ms","start":"2026-05-06T01:15:02.731084Z","end":"2026-05-06T01:15:03.489985Z","steps":["trace[1822162145] 'process raft request' (duration: 758.604319ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:15:03.490253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:15:02.731063Z","time spent":"759.100562ms","remote":"127.0.0.1:46494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T01:15:03.490746Z","caller":"traceutil/trace.go:171","msg":"trace[385594857] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"735.64657ms","start":"2026-05-06T01:15:02.755049Z","end":"2026-05-06T01:15:03.490721Z","steps":["trace[385594857] 'process raft request' (duration: 735.469196ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:15:03.490917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:15:02.755017Z","time spent":"735.821045ms","remote":"127.0.0.1:46494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79947,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T01:15:03.491187Z","caller":"traceutil/trace.go:171","msg":"trace[36397602] linearizableReadLoop","detail":"{readStateIndex:519; appliedIndex:513; }","duration":"167.375645ms","start":"2026-05-06T01:15:03.323787Z","end":"2026-05-06T01:15:03.491162Z","steps":["trace[36397602] 'read index received' (duration: 165.776993ms)","trace[36397602] 'applied index is now lower than readState.Index' (duration: 1.597501ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T01:15:03.491223Z","caller":"traceutil/trace.go:171","msg":"trace[851311514] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"752.447377ms","start":"2026-05-06T01:15:02.738753Z","end":"2026-05-06T01:15:03.4912Z","steps":["trace[851311514] 'process raft request' (duration: 751.627425ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:15:03.491262Z","caller":"traceutil/trace.go:171","msg":"trace[1869115831] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"733.752271ms","start":"2026-05-06T01:15:02.757501Z","end":"2026-05-06T01:15:03.491254Z","steps":["trace[1869115831] 'process raft request' (duration: 733.185836ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:15:03.491317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:15:02.757481Z","time spent":"733.805373ms","remote":"127.0.0.1:46494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-06T01:15:03.491339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:15:02.738729Z","time spent":"752.55353ms","remote":"127.0.0.1:46494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29452,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-06T01:15:03.491369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.5602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T01:15:03.491211Z","caller":"traceutil/trace.go:171","msg":"trace[749114650] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"750.28048ms","start":"2026-05-06T01:15:02.740886Z","end":"2026-05-06T01:15:03.491167Z","steps":["trace[749114650] 'process raft request' (duration: 749.582101ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:15:03.491419Z","caller":"traceutil/trace.go:171","msg":"trace[1565779209] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"701.885778ms","start":"2026-05-06T01:15:02.789525Z","end":"2026-05-06T01:15:03.49141Z","steps":["trace[1565779209] 'process raft request' (duration: 701.486117ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:15:03.491422Z","caller":"traceutil/trace.go:171","msg":"trace[1578128569] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:497; }","duration":"167.677103ms","start":"2026-05-06T01:15:03.323735Z","end":"2026-05-06T01:15:03.491412Z","steps":["trace[1578128569] 'agreement among raft nodes before linearized reading' (duration: 167.541819ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:15:03.491466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:15:02.789502Z","time spent":"701.936818ms","remote":"127.0.0.1:46494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":150480,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-06T01:15:03.491464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:15:02.740865Z","time spent":"750.567316ms","remote":"127.0.0.1:46494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58844,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-06T01:15:03.491509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.063571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-06T01:15:03.491567Z","caller":"traceutil/trace.go:171","msg":"trace[673787756] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:497; }","duration":"103.170864ms","start":"2026-05-06T01:15:03.388384Z","end":"2026-05-06T01:15:03.491554Z","steps":["trace[673787756] 'agreement among raft nodes before linearized reading' (duration: 102.987289ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:15:09.152135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.325078ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-06T01:15:09.152275Z","caller":"traceutil/trace.go:171","msg":"trace[134250433] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"236.871157ms","start":"2026-05-06T01:15:08.915381Z","end":"2026-05-06T01:15:09.152252Z","steps":["trace[134250433] 'process raft request' (duration: 56.330552ms)","trace[134250433] 'compare' (duration: 180.170224ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T01:15:09.342122Z","caller":"traceutil/trace.go:171","msg":"trace[484540370] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"166.8514ms","start":"2026-05-06T01:15:09.175246Z","end":"2026-05-06T01:15:09.342097Z","steps":["trace[484540370] 'process raft request' (duration: 166.631984ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:15:09.393543Z","caller":"traceutil/trace.go:171","msg":"trace[596706319] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"113.534188ms","start":"2026-05-06T01:15:09.279973Z","end":"2026-05-06T01:15:09.393508Z","steps":["trace[596706319] 'process raft request' (duration: 112.793958ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:15:10.169501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.946308ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-06T01:15:10.169845Z","caller":"traceutil/trace.go:171","msg":"trace[1593279482] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"719.764272ms","start":"2026-05-06T01:15:09.450037Z","end":"2026-05-06T01:15:10.169801Z","steps":["trace[1593279482] 'process raft request' (duration: 476.426663ms)","trace[1593279482] 'compare' (duration: 242.690752ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T01:15:10.170175Z","caller":"traceutil/trace.go:171","msg":"trace[412059204] linearizableReadLoop","detail":"{readStateIndex:600; appliedIndex:599; }","duration":"620.335809ms","start":"2026-05-06T01:15:09.549797Z","end":"2026-05-06T01:15:10.170133Z","steps":["trace[412059204] 'read index received' (duration: 376.679902ms)","trace[412059204] 'applied index is now lower than readState.Index' (duration: 243.652036ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T01:15:10.170299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:15:09.450008Z","time spent":"719.929247ms","remote":"127.0.0.1:46944","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-06T01:15:10.194412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.137403ms","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-06T01:15:10.194476Z","caller":"traceutil/trace.go:171","msg":"trace[1494462968] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:577; }","duration":"477.250727ms","start":"2026-05-06T01:15:09.717209Z","end":"2026-05-06T01:15:10.19446Z","steps":["trace[1494462968] 'agreement among raft nodes before linearized reading' (duration: 477.113684ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:15:10.194492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"644.694134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-06T01:15:10.194505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:15:09.717188Z","time spent":"477.311258ms","remote":"127.0.0.1:46722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-06T01:15:10.194532Z","caller":"traceutil/trace.go:171","msg":"trace[999033512] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:577; }","duration":"644.763954ms","start":"2026-05-06T01:15:09.549752Z","end":"2026-05-06T01:15:10.194516Z","steps":["trace[999033512] 'agreement among raft nodes before linearized reading' (duration: 620.576084ms)","trace[999033512] 'range keys from in-memory index tree' (duration: 23.962186ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T01:15:10.194565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:15:09.54973Z","time spent":"644.827438ms","remote":"127.0.0.1:46722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-06T01:15:10.194409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.842597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-05-06T01:15:10.194608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.657873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-06T01:15:10.194626Z","caller":"traceutil/trace.go:171","msg":"trace[1971511519] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:577; }","duration":"334.092083ms","start":"2026-05-06T01:15:09.860508Z","end":"2026-05-06T01:15:10.1946Z","steps":["trace[1971511519] 'agreement among raft nodes before linearized reading' (duration: 333.786135ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:15:10.194731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:15:09.860483Z","time spent":"334.216636ms","remote":"127.0.0.1:46722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-06T01:15:10.194736Z","caller":"traceutil/trace.go:171","msg":"trace[1464675960] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:577; }","duration":"447.797257ms","start":"2026-05-06T01:15:09.74689Z","end":"2026-05-06T01:15:10.194688Z","steps":["trace[1464675960] 'agreement among raft nodes before linearized reading' (duration: 447.446738ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:15:10.194796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:15:09.746878Z","time spent":"447.90344ms","remote":"127.0.0.1:46722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-06T01:15:11.49124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.898643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T01:15:11.491323Z","caller":"traceutil/trace.go:171","msg":"trace[385308187] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:592; }","duration":"170.026336ms","start":"2026-05-06T01:15:11.321277Z","end":"2026-05-06T01:15:11.491304Z","steps":["trace[385308187] 'range keys from in-memory index tree' (duration: 169.829661ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:15:30.158075Z","caller":"traceutil/trace.go:171","msg":"trace[685634028] transaction","detail":"{read_only:false; response_revision:749; number_of_response:1; }","duration":"397.422482ms","start":"2026-05-06T01:15:29.760627Z","end":"2026-05-06T01:15:30.15805Z","steps":["trace[685634028] 'process raft request' (duration: 397.273838ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:15:30.158324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:15:29.760604Z","time spent":"397.634107ms","remote":"127.0.0.1:46722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T01:16:05.769394Z","caller":"traceutil/trace.go:171","msg":"trace[1897472491] transaction","detail":"{read_only:false; response_revision:975; number_of_response:1; }","duration":"382.057674ms","start":"2026-05-06T01:16:05.387312Z","end":"2026-05-06T01:16:05.76937Z","steps":["trace[1897472491] 'process raft request' (duration: 381.91551ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:16:05.769578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:16:05.387291Z","time spent":"382.207107ms","remote":"127.0.0.1:46722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T01:16:06.029597Z","caller":"traceutil/trace.go:171","msg":"trace[2138696424] linearizableReadLoop","detail":"{readStateIndex:1014; appliedIndex:1013; }","duration":"149.450848ms","start":"2026-05-06T01:16:05.880115Z","end":"2026-05-06T01:16:06.029566Z","steps":["trace[2138696424] 'read index received' (duration: 145.371039ms)","trace[2138696424] 'applied index is now lower than readState.Index' (duration: 4.078259ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T01:16:06.029662Z","caller":"traceutil/trace.go:171","msg":"trace[407453679] transaction","detail":"{read_only:false; response_revision:976; number_of_response:1; }","duration":"251.767177ms","start":"2026-05-06T01:16:05.777837Z","end":"2026-05-06T01:16:06.029605Z","steps":["trace[407453679] 'process raft request' (duration: 247.648137ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:16:06.029766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.630823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T01:16:06.029821Z","caller":"traceutil/trace.go:171","msg":"trace[534454223] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:976; }","duration":"149.752835ms","start":"2026-05-06T01:16:05.880051Z","end":"2026-05-06T01:16:06.029804Z","steps":["trace[534454223] 'agreement among raft nodes before linearized reading' (duration: 149.631662ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:16:28.403082Z","caller":"traceutil/trace.go:171","msg":"trace[2104136079] transaction","detail":"{read_only:false; response_revision:1048; number_of_response:1; }","duration":"569.974137ms","start":"2026-05-06T01:16:27.833049Z","end":"2026-05-06T01:16:28.403024Z","steps":["trace[2104136079] 'process raft request' (duration: 569.420003ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:16:28.403271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:16:27.833024Z","time spent":"570.151211ms","remote":"127.0.0.1:46722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-06T01:16:28.687019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.280983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-06T01:16:28.687136Z","caller":"traceutil/trace.go:171","msg":"trace[1319397903] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1048; }","duration":"140.424167ms","start":"2026-05-06T01:16:28.546692Z","end":"2026-05-06T01:16:28.687116Z","steps":["trace[1319397903] 'range keys from in-memory index tree' (duration: 140.143549ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:16:31.634923Z","caller":"traceutil/trace.go:171","msg":"trace[1751756113] transaction","detail":"{read_only:false; response_revision:1056; number_of_response:1; }","duration":"847.354458ms","start":"2026-05-06T01:16:30.787548Z","end":"2026-05-06T01:16:31.634902Z","steps":["trace[1751756113] 'process raft request' (duration: 847.193373ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:16:31.635077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:16:30.787527Z","time spent":"847.453139ms","remote":"127.0.0.1:46722","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-05-06T01:16:31.643413Z","caller":"traceutil/trace.go:171","msg":"trace[272915857] transaction","detail":"{read_only:false; response_revision:1058; number_of_response:1; }","duration":"854.845797ms","start":"2026-05-06T01:16:30.788544Z","end":"2026-05-06T01:16:31.643389Z","steps":["trace[272915857] 'process raft request' (duration: 854.757865ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:16:31.64357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:16:30.788537Z","time spent":"854.948469ms","remote":"127.0.0.1:46722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T01:16:31.643592Z","caller":"traceutil/trace.go:171","msg":"trace[125880364] transaction","detail":"{read_only:false; response_revision:1059; number_of_response:1; }","duration":"854.906469ms","start":"2026-05-06T01:16:30.788674Z","end":"2026-05-06T01:16:31.64358Z","steps":["trace[125880364] 'process raft request' (duration: 854.673183ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:16:31.643742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:16:30.788649Z","time spent":"855.043242ms","remote":"127.0.0.1:46722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T01:16:31.643864Z","caller":"traceutil/trace.go:171","msg":"trace[586379881] linearizableReadLoop","detail":"{readStateIndex:1103; appliedIndex:1098; }","duration":"319.596968ms","start":"2026-05-06T01:16:31.324259Z","end":"2026-05-06T01:16:31.643856Z","steps":["trace[586379881] 'read index received' (duration: 310.558626ms)","trace[586379881] 'applied index is now lower than readState.Index' (duration: 9.037482ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T01:16:31.643785Z","caller":"traceutil/trace.go:171","msg":"trace[791083007] transaction","detail":"{read_only:false; response_revision:1057; number_of_response:1; }","duration":"855.275839ms","start":"2026-05-06T01:16:30.78848Z","end":"2026-05-06T01:16:31.643756Z","steps":["trace[791083007] 'process raft request' (duration: 854.696603ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:16:31.643911Z","caller":"traceutil/trace.go:171","msg":"trace[2101436436] transaction","detail":"{read_only:false; response_revision:1060; number_of_response:1; }","duration":"854.106137ms","start":"2026-05-06T01:16:30.789783Z","end":"2026-05-06T01:16:31.643889Z","steps":["trace[2101436436] 'process raft request' (duration: 853.752258ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:16:31.643965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.483741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-06T01:16:31.643986Z","caller":"traceutil/trace.go:171","msg":"trace[2088832921] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1060; }","duration":"118.505823ms","start":"2026-05-06T01:16:31.525473Z","end":"2026-05-06T01:16:31.643979Z","steps":["trace[2088832921] 'agreement among raft nodes before linearized reading' (duration: 118.475952ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:16:31.644043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:16:30.789774Z","time spent":"854.21004ms","remote":"127.0.0.1:46722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-06T01:16:31.644144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:16:30.78847Z","time spent":"855.494545ms","remote":"127.0.0.1:46722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-06T01:16:31.643933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.681639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T01:16:31.644301Z","caller":"traceutil/trace.go:171","msg":"trace[727427344] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1060; }","duration":"320.124751ms","start":"2026-05-06T01:16:31.324168Z","end":"2026-05-06T01:16:31.644293Z","steps":["trace[727427344] 'agreement among raft nodes before linearized reading' (duration: 319.744931ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:16:31.644328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:16:31.324095Z","time spent":"320.225973ms","remote":"127.0.0.1:46438","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-05-06T01:16:47.215784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.250569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-06T01:16:47.215848Z","caller":"traceutil/trace.go:171","msg":"trace[866084316] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1159; }","duration":"403.365042ms","start":"2026-05-06T01:16:46.812469Z","end":"2026-05-06T01:16:47.215834Z","steps":["trace[866084316] 'range keys from in-memory index tree' (duration: 403.082155ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:16:47.215877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:16:46.812448Z","time spent":"403.422613ms","remote":"127.0.0.1:46722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-06T01:16:47.21605Z","caller":"traceutil/trace.go:171","msg":"trace[577553094] transaction","detail":"{read_only:false; response_revision:1160; number_of_response:1; }","duration":"357.918829ms","start":"2026-05-06T01:16:46.858109Z","end":"2026-05-06T01:16:47.216027Z","steps":["trace[577553094] 'process raft request' (duration: 353.757219ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:16:47.216181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:16:46.85808Z","time spent":"358.029183ms","remote":"127.0.0.1:46722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T01:16:47.520126Z","caller":"traceutil/trace.go:171","msg":"trace[396778393] linearizableReadLoop","detail":"{readStateIndex:1210; appliedIndex:1209; }","duration":"198.823675ms","start":"2026-05-06T01:16:47.32128Z","end":"2026-05-06T01:16:47.520104Z","steps":["trace[396778393] 'read index received' (duration: 198.66859ms)","trace[396778393] 'applied index is now lower than readState.Index' (duration: 154.085µs)"],"step_count":2} {"level":"info","ts":"2026-05-06T01:16:47.520159Z","caller":"traceutil/trace.go:171","msg":"trace[192227349] transaction","detail":"{read_only:false; response_revision:1161; number_of_response:1; }","duration":"299.8521ms","start":"2026-05-06T01:16:47.220291Z","end":"2026-05-06T01:16:47.520143Z","steps":["trace[192227349] 'process raft request' (duration: 299.678985ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:16:47.520233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.941698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T01:16:47.520265Z","caller":"traceutil/trace.go:171","msg":"trace[1892404492] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1161; }","duration":"199.01931ms","start":"2026-05-06T01:16:47.321235Z","end":"2026-05-06T01:16:47.520254Z","steps":["trace[1892404492] 'agreement among raft nodes before linearized reading' (duration: 198.953878ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:16:56.155866Z","caller":"traceutil/trace.go:171","msg":"trace[747095508] transaction","detail":"{read_only:false; response_revision:1190; number_of_response:1; }","duration":"143.150715ms","start":"2026-05-06T01:16:56.012688Z","end":"2026-05-06T01:16:56.155839Z","steps":["trace[747095508] 'process raft request' (duration: 119.013632ms)","trace[747095508] 'compare' (duration: 23.820594ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T01:16:56.166212Z","caller":"traceutil/trace.go:171","msg":"trace[1990229508] transaction","detail":"{read_only:false; response_revision:1191; number_of_response:1; }","duration":"151.021715ms","start":"2026-05-06T01:16:56.01517Z","end":"2026-05-06T01:16:56.166192Z","steps":["trace[1990229508] 'process raft request' (duration: 150.917612ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:17:03.447665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.268665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T01:17:03.447737Z","caller":"traceutil/trace.go:171","msg":"trace[253120900] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1232; }","duration":"123.390159ms","start":"2026-05-06T01:17:03.324332Z","end":"2026-05-06T01:17:03.447722Z","steps":["trace[253120900] 'range keys from in-memory index tree' (duration: 123.165292ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:17:03.447748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.373285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T01:17:03.447801Z","caller":"traceutil/trace.go:171","msg":"trace[25678847] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:1232; }","duration":"103.471078ms","start":"2026-05-06T01:17:03.344315Z","end":"2026-05-06T01:17:03.447786Z","steps":["trace[25678847] 'count revisions from in-memory index tree' (duration: 103.229672ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:17:04.125667Z","caller":"traceutil/trace.go:171","msg":"trace[407128817] transaction","detail":"{read_only:false; response_revision:1233; number_of_response:1; }","duration":"519.587256ms","start":"2026-05-06T01:17:03.606065Z","end":"2026-05-06T01:17:04.125652Z","steps":["trace[407128817] 'process raft request' (duration: 519.3719ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:17:04.125805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.822926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-05-06T01:17:04.12581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:17:03.606049Z","time spent":"519.691148ms","remote":"127.0.0.1:46722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T01:17:04.125834Z","caller":"traceutil/trace.go:171","msg":"trace[1103660589] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1233; }","duration":"157.888797ms","start":"2026-05-06T01:17:03.967935Z","end":"2026-05-06T01:17:04.125824Z","steps":["trace[1103660589] 'agreement among raft nodes before linearized reading' (duration: 157.790694ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:17:04.125945Z","caller":"traceutil/trace.go:171","msg":"trace[1217797443] linearizableReadLoop","detail":"{readStateIndex:1285; appliedIndex:1284; }","duration":"157.62799ms","start":"2026-05-06T01:17:03.967981Z","end":"2026-05-06T01:17:04.125609Z","steps":["trace[1217797443] 'read index received' (duration: 157.404194ms)","trace[1217797443] 'applied index is now lower than readState.Index' (duration: 222.696µs)"],"step_count":2} {"level":"warn","ts":"2026-05-06T01:17:04.126225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.505124ms","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-06T01:17:04.126311Z","caller":"traceutil/trace.go:171","msg":"trace[54831262] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1233; }","duration":"137.638939ms","start":"2026-05-06T01:17:03.988652Z","end":"2026-05-06T01:17:04.126291Z","steps":["trace[54831262] 'agreement among raft nodes before linearized reading' (duration: 137.404612ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:17:04.458274Z","caller":"traceutil/trace.go:171","msg":"trace[72484799] transaction","detail":"{read_only:false; response_revision:1235; number_of_response:1; }","duration":"323.969573ms","start":"2026-05-06T01:17:04.134293Z","end":"2026-05-06T01:17:04.458263Z","steps":["trace[72484799] 'process raft request' (duration: 323.89366ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:17:04.458264Z","caller":"traceutil/trace.go:171","msg":"trace[1355401877] linearizableReadLoop","detail":"{readStateIndex:1287; appliedIndex:1285; }","duration":"247.66039ms","start":"2026-05-06T01:17:04.210579Z","end":"2026-05-06T01:17:04.458239Z","steps":["trace[1355401877] 'read index received' (duration: 158.205946ms)","trace[1355401877] 'applied index is now lower than readState.Index' (duration: 89.453674ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T01:17:04.45836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:17:04.13427Z","time spent":"324.041074ms","remote":"127.0.0.1:46722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T01:17:04.458363Z","caller":"traceutil/trace.go:171","msg":"trace[785900327] transaction","detail":"{read_only:false; response_revision:1234; number_of_response:1; }","duration":"327.235891ms","start":"2026-05-06T01:17:04.131092Z","end":"2026-05-06T01:17:04.458328Z","steps":["trace[785900327] 'process raft request' (duration: 237.627323ms)","trace[785900327] 'compare' (duration: 89.300019ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T01:17:04.458453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.982088ms","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-06T01:17:04.458493Z","caller":"traceutil/trace.go:171","msg":"trace[1007968893] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1235; }","duration":"239.06659ms","start":"2026-05-06T01:17:04.219417Z","end":"2026-05-06T01:17:04.458483Z","steps":["trace[1007968893] 'agreement among raft nodes before linearized reading' (duration: 238.942387ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:17:04.458531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:17:04.131045Z","time spent":"327.405755ms","remote":"127.0.0.1:46722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-06T01:17:04.458693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.113052ms","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-05-06T01:17:04.458743Z","caller":"traceutil/trace.go:171","msg":"trace[159553672] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1235; }","duration":"248.194384ms","start":"2026-05-06T01:17:04.210531Z","end":"2026-05-06T01:17:04.458726Z","steps":["trace[159553672] 'agreement among raft nodes before linearized reading' (duration: 247.804224ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:17:04.716496Z","caller":"traceutil/trace.go:171","msg":"trace[670691915] transaction","detail":"{read_only:false; response_revision:1238; number_of_response:1; }","duration":"130.415906ms","start":"2026-05-06T01:17:04.586062Z","end":"2026-05-06T01:17:04.716478Z","steps":["trace[670691915] 'process raft request' (duration: 130.313793ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:17:04.751963Z","caller":"traceutil/trace.go:171","msg":"trace[2013635489] transaction","detail":"{read_only:false; response_revision:1239; number_of_response:1; }","duration":"153.977244ms","start":"2026-05-06T01:17:04.597666Z","end":"2026-05-06T01:17:04.751644Z","steps":["trace[2013635489] 'process raft request' (duration: 153.81767ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:17:05.140118Z","caller":"traceutil/trace.go:171","msg":"trace[307163531] linearizableReadLoop","detail":"{readStateIndex:1295; appliedIndex:1294; }","duration":"158.937046ms","start":"2026-05-06T01:17:04.981159Z","end":"2026-05-06T01:17:05.140096Z","steps":["trace[307163531] 'read index received' (duration: 158.792422ms)","trace[307163531] 'applied index is now lower than readState.Index' (duration: 143.654µs)"],"step_count":2} {"level":"warn","ts":"2026-05-06T01:17:05.1403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.127221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T01:17:05.140351Z","caller":"traceutil/trace.go:171","msg":"trace[1252171403] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1242; }","duration":"159.223563ms","start":"2026-05-06T01:17:04.981117Z","end":"2026-05-06T01:17:05.140341Z","steps":["trace[1252171403] 'agreement among raft nodes before linearized reading' (duration: 159.067089ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:17:05.14015Z","caller":"traceutil/trace.go:171","msg":"trace[841821774] transaction","detail":"{read_only:false; response_revision:1242; number_of_response:1; }","duration":"160.915868ms","start":"2026-05-06T01:17:04.979211Z","end":"2026-05-06T01:17:05.140127Z","steps":["trace[841821774] 'process raft request' (duration: 160.766195ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:17:05.841792Z","caller":"traceutil/trace.go:171","msg":"trace[1059092103] transaction","detail":"{read_only:false; response_revision:1243; number_of_response:1; }","duration":"698.075702ms","start":"2026-05-06T01:17:05.143696Z","end":"2026-05-06T01:17:05.841771Z","steps":["trace[1059092103] 'process raft request' (duration: 647.72422ms)","trace[1059092103] 'compare' (duration: 50.2693ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T01:17:05.841888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:17:05.143677Z","time spent":"698.168194ms","remote":"127.0.0.1:46722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-06T01:17:05.84615Z","caller":"traceutil/trace.go:171","msg":"trace[1184558352] linearizableReadLoop","detail":"{readStateIndex:1297; appliedIndex:1295; }","duration":"524.193388ms","start":"2026-05-06T01:17:05.321939Z","end":"2026-05-06T01:17:05.846133Z","steps":["trace[1184558352] 'read index received' (duration: 469.49031ms)","trace[1184558352] 'applied index is now lower than readState.Index' (duration: 54.702448ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T01:17:05.84625Z","caller":"traceutil/trace.go:171","msg":"trace[1895906683] transaction","detail":"{read_only:false; response_revision:1244; number_of_response:1; }","duration":"701.349939ms","start":"2026-05-06T01:17:05.14489Z","end":"2026-05-06T01:17:05.84624Z","steps":["trace[1895906683] 'process raft request' (duration: 701.148133ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:17:05.846339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:17:05.144876Z","time spent":"701.407721ms","remote":"127.0.0.1:46524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":836,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-06T01:17:05.846539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"524.594289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T01:17:05.846566Z","caller":"traceutil/trace.go:171","msg":"trace[2028605269] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1244; }","duration":"524.651742ms","start":"2026-05-06T01:17:05.321907Z","end":"2026-05-06T01:17:05.846559Z","steps":["trace[2028605269] 'agreement among raft nodes before linearized reading' (duration: 524.585989ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:17:05.846585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:17:05.321892Z","time spent":"524.689372ms","remote":"127.0.0.1:46438","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-05-06T01:17:06.005007Z","caller":"traceutil/trace.go:171","msg":"trace[1892910404] linearizableReadLoop","detail":"{readStateIndex:1298; appliedIndex:1297; }","duration":"158.765711ms","start":"2026-05-06T01:17:05.84621Z","end":"2026-05-06T01:17:06.004976Z","steps":["trace[1892910404] 'read index received' (duration: 131.184556ms)","trace[1892910404] 'applied index is now lower than readState.Index' (duration: 27.575845ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T01:17:06.005026Z","caller":"traceutil/trace.go:171","msg":"trace[1824171979] transaction","detail":"{read_only:false; response_revision:1245; number_of_response:1; }","duration":"159.144801ms","start":"2026-05-06T01:17:05.845848Z","end":"2026-05-06T01:17:06.004993Z","steps":["trace[1824171979] 'process raft request' (duration: 131.517385ms)","trace[1824171979] 'compare' (duration: 27.355999ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T01:17:06.005195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.801764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T01:17:06.005227Z","caller":"traceutil/trace.go:171","msg":"trace[569630973] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1245; }","duration":"157.887657ms","start":"2026-05-06T01:17:05.84733Z","end":"2026-05-06T01:17:06.005218Z","steps":["trace[569630973] 'agreement among raft nodes before linearized reading' (duration: 157.812826ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:17:06.005269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.170011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-05-06T01:17:06.005351Z","caller":"traceutil/trace.go:171","msg":"trace[158349511] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1245; }","duration":"159.272274ms","start":"2026-05-06T01:17:05.846054Z","end":"2026-05-06T01:17:06.005326Z","steps":["trace[158349511] 'agreement among raft nodes before linearized reading' (duration: 159.001357ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:17:06.71887Z","caller":"traceutil/trace.go:171","msg":"trace[347195115] transaction","detail":"{read_only:false; response_revision:1248; number_of_response:1; }","duration":"253.500165ms","start":"2026-05-06T01:17:06.465345Z","end":"2026-05-06T01:17:06.718846Z","steps":["trace[347195115] 'process raft request' (duration: 253.32303ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:17:06.928904Z","caller":"traceutil/trace.go:171","msg":"trace[2102525687] linearizableReadLoop","detail":"{readStateIndex:1302; appliedIndex:1300; }","duration":"397.38734ms","start":"2026-05-06T01:17:06.531493Z","end":"2026-05-06T01:17:06.928881Z","steps":["trace[2102525687] 'read index received' (duration: 187.167918ms)","trace[2102525687] 'applied index is now lower than readState.Index' (duration: 210.218322ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T01:17:06.928918Z","caller":"traceutil/trace.go:171","msg":"trace[1667024110] transaction","detail":"{read_only:false; response_revision:1249; number_of_response:1; }","duration":"462.979957ms","start":"2026-05-06T01:17:06.465918Z","end":"2026-05-06T01:17:06.928898Z","steps":["trace[1667024110] 'process raft request' (duration: 390.841554ms)","trace[1667024110] 'compare' (duration: 71.896157ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T01:17:06.929153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:17:06.465907Z","time spent":"463.192203ms","remote":"127.0.0.1:46722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-06T01:17:06.929295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.301205ms","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-05-06T01:17:06.929378Z","caller":"traceutil/trace.go:171","msg":"trace[246041337] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1250; }","duration":"380.421237ms","start":"2026-05-06T01:17:06.548944Z","end":"2026-05-06T01:17:06.929366Z","steps":["trace[246041337] 'agreement among raft nodes before linearized reading' (duration: 380.192511ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:17:06.929447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:17:06.548927Z","time spent":"380.507859ms","remote":"127.0.0.1:46722","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-05-06T01:17:06.929289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.78909ms","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-06T01:17:06.929535Z","caller":"traceutil/trace.go:171","msg":"trace[1919589891] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1250; }","duration":"398.082199ms","start":"2026-05-06T01:17:06.531436Z","end":"2026-05-06T01:17:06.929518Z","steps":["trace[1919589891] 'agreement among raft nodes before linearized reading' (duration: 397.7195ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:17:06.929562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:17:06.531405Z","time spent":"398.149069ms","remote":"127.0.0.1:46722","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-05-06T01:17:06.928985Z","caller":"traceutil/trace.go:171","msg":"trace[318247275] transaction","detail":"{read_only:false; response_revision:1250; number_of_response:1; }","duration":"172.128306ms","start":"2026-05-06T01:17:06.756851Z","end":"2026-05-06T01:17:06.92898Z","steps":["trace[318247275] 'process raft request' (duration: 171.987643ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:18:04.752855Z","caller":"traceutil/trace.go:171","msg":"trace[796264552] transaction","detail":"{read_only:false; response_revision:1542; number_of_response:1; }","duration":"130.981522ms","start":"2026-05-06T01:18:04.621842Z","end":"2026-05-06T01:18:04.752823Z","steps":["trace[796264552] 'process raft request' (duration: 130.796748ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:20:36.041648Z","caller":"traceutil/trace.go:171","msg":"trace[194481667] transaction","detail":"{read_only:false; response_revision:2266; number_of_response:1; }","duration":"185.516289ms","start":"2026-05-06T01:20:35.856102Z","end":"2026-05-06T01:20:36.041618Z","steps":["trace[194481667] 'process raft request' (duration: 111.333631ms)","trace[194481667] 'compare' (duration: 74.071535ms)"],"step_count":2}