{"level":"warn","ts":"2026-05-27T13:43:18.150808Z","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-27T13:43:18.150906Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.22: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.22:2380","--initial-cluster=instance=https://199.204.45.22:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.22:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.22: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-27T13:43:18.150986Z","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-27T13:43:18.150995Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.22:2380"]} {"level":"info","ts":"2026-05-27T13:43:18.151012Z","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-27T13:43:18.151694Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"]} {"level":"info","ts":"2026-05-27T13:43:18.151821Z","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.22:2380"],"listen-peer-urls":["https://199.204.45.22:2380"],"advertise-client-urls":["https://199.204.45.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.22: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-27T13:43:18.158284Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.220623ms"} {"level":"info","ts":"2026-05-27T13:43:18.170813Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fed19d9291630e09","cluster-id":"6ebf1e01320cc017"} {"level":"info","ts":"2026-05-27T13:43:18.17097Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=()"} {"level":"info","ts":"2026-05-27T13:43:18.171017Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became follower at term 0"} {"level":"info","ts":"2026-05-27T13:43:18.171043Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fed19d9291630e09 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-27T13:43:18.171066Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became follower at term 1"} {"level":"info","ts":"2026-05-27T13:43:18.171124Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=(18361630408596196873)"} {"level":"warn","ts":"2026-05-27T13:43:18.180208Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-27T13:43:18.181992Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-27T13:43:18.183139Z","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-27T13:43:18.186123Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fed19d9291630e09","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-27T13:43:18.186986Z","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-27T13:43:18.186989Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fed19d9291630e09","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-27T13:43:18.187089Z","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-27T13:43:18.187125Z","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-27T13:43:18.18821Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=(18361630408596196873)"} {"level":"info","ts":"2026-05-27T13:43:18.188403Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6ebf1e01320cc017","local-member-id":"fed19d9291630e09","added-peer-id":"fed19d9291630e09","added-peer-peer-urls":["https://199.204.45.22:2380"]} {"level":"info","ts":"2026-05-27T13:43:18.191099Z","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-27T13:43:18.191179Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.22:2380"} {"level":"info","ts":"2026-05-27T13:43:18.191251Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.22:2380"} {"level":"info","ts":"2026-05-27T13:43:18.193003Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fed19d9291630e09","initial-advertise-peer-urls":["https://199.204.45.22:2380"],"listen-peer-urls":["https://199.204.45.22:2380"],"advertise-client-urls":["https://199.204.45.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-27T13:43:18.193063Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-27T13:43:19.071841Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 is starting a new election at term 1"} {"level":"info","ts":"2026-05-27T13:43:19.071893Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-27T13:43:19.071907Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 received MsgPreVoteResp from fed19d9291630e09 at term 1"} {"level":"info","ts":"2026-05-27T13:43:19.071918Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became candidate at term 2"} {"level":"info","ts":"2026-05-27T13:43:19.071923Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 received MsgVoteResp from fed19d9291630e09 at term 2"} {"level":"info","ts":"2026-05-27T13:43:19.071966Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became leader at term 2"} {"level":"info","ts":"2026-05-27T13:43:19.071974Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fed19d9291630e09 elected leader fed19d9291630e09 at term 2"} {"level":"info","ts":"2026-05-27T13:43:19.074449Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T13:43:19.077189Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6ebf1e01320cc017","local-member-id":"fed19d9291630e09","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T13:43:19.077303Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-27T13:43:19.077329Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fed19d9291630e09","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.22:2379]}","request-path":"/0/members/fed19d9291630e09/attributes","cluster-id":"6ebf1e01320cc017","publish-timeout":"7s"} {"level":"info","ts":"2026-05-27T13:43:19.077646Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-27T13:43:19.077794Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-27T13:43:19.077831Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-27T13:43:19.077845Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T13:43:19.077881Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T13:43:19.080609Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.22:2379"} {"level":"info","ts":"2026-05-27T13:43:19.082445Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-27T13:43:20.665481Z","caller":"traceutil/trace.go:171","msg":"trace[1356972586] linearizableReadLoop","detail":"{readStateIndex:5; appliedIndex:4; }","duration":"224.98671ms","start":"2026-05-27T13:43:20.440472Z","end":"2026-05-27T13:43:20.665459Z","steps":["trace[1356972586] 'read index received' (duration: 224.956249ms)","trace[1356972586] 'applied index is now lower than readState.Index' (duration: 29.931µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:43:20.665551Z","caller":"traceutil/trace.go:171","msg":"trace[559146403] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"230.083236ms","start":"2026-05-27T13:43:20.435446Z","end":"2026-05-27T13:43:20.66553Z","steps":["trace[559146403] 'process raft request' (duration: 229.847552ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:43:20.665662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.174794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-27T13:43:20.665706Z","caller":"traceutil/trace.go:171","msg":"trace[410036494] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:2; }","duration":"225.258996ms","start":"2026-05-27T13:43:20.440437Z","end":"2026-05-27T13:43:20.665696Z","steps":["trace[410036494] 'agreement among raft nodes before linearized reading' (duration: 225.132693ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:21.070876Z","caller":"traceutil/trace.go:171","msg":"trace[529998593] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"621.616863ms","start":"2026-05-27T13:43:20.449195Z","end":"2026-05-27T13:43:21.070812Z","steps":["trace[529998593] 'process raft request' (duration: 621.431339ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:21.070945Z","caller":"traceutil/trace.go:171","msg":"trace[1716503835] linearizableReadLoop","detail":"{readStateIndex:12; appliedIndex:5; }","duration":"405.360099ms","start":"2026-05-27T13:43:20.665555Z","end":"2026-05-27T13:43:21.070915Z","steps":["trace[1716503835] 'read index received' (duration: 405.146243ms)","trace[1716503835] 'applied index is now lower than readState.Index' (duration: 212.706µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:43:21.071281Z","caller":"traceutil/trace.go:171","msg":"trace[139351733] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"559.330892ms","start":"2026-05-27T13:43:20.511938Z","end":"2026-05-27T13:43:21.071269Z","steps":["trace[139351733] 'process raft request' (duration: 558.80982ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:43:21.071506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"573.626753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-27T13:43:21.071508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"561.184341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.22\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-27T13:43:21.071602Z","caller":"traceutil/trace.go:171","msg":"trace[2119177369] range","detail":"{range_begin:/registry/masterleases/199.204.45.22; range_end:; response_count:0; response_revision:9; }","duration":"561.327705ms","start":"2026-05-27T13:43:20.510263Z","end":"2026-05-27T13:43:21.07159Z","steps":["trace[2119177369] 'agreement among raft nodes before linearized reading' (duration: 561.10869ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:43:21.071637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"624.31186ms","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-27T13:43:21.071669Z","caller":"traceutil/trace.go:171","msg":"trace[70927695] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:9; }","duration":"624.350591ms","start":"2026-05-27T13:43:20.44731Z","end":"2026-05-27T13:43:21.071661Z","steps":["trace[70927695] 'agreement among raft nodes before linearized reading' (duration: 624.31191ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:43:21.071684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:43:20.510243Z","time spent":"561.410926ms","remote":"127.0.0.1:60168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/199.204.45.22\" "} {"level":"warn","ts":"2026-05-27T13:43:21.071762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"624.465904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-27T13:43:21.071793Z","caller":"traceutil/trace.go:171","msg":"trace[2090109760] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:9; }","duration":"624.505534ms","start":"2026-05-27T13:43:20.447277Z","end":"2026-05-27T13:43:21.071783Z","steps":["trace[2090109760] 'agreement among raft nodes before linearized reading' (duration: 624.467834ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:43:21.071822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:43:20.447272Z","time spent":"624.544125ms","remote":"127.0.0.1:60436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-27T13:43:21.071982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"624.917243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-27T13:43:21.072023Z","caller":"traceutil/trace.go:171","msg":"trace[345014581] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:9; }","duration":"624.951994ms","start":"2026-05-27T13:43:20.447056Z","end":"2026-05-27T13:43:21.072008Z","steps":["trace[345014581] 'agreement among raft nodes before linearized reading' (duration: 624.904673ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:21.071992Z","caller":"traceutil/trace.go:171","msg":"trace[1644793800] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"559.804822ms","start":"2026-05-27T13:43:20.512178Z","end":"2026-05-27T13:43:21.071983Z","steps":["trace[1644793800] 'process raft request' (duration: 558.609116ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:43:21.072088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"631.542873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-27T13:43:21.072115Z","caller":"traceutil/trace.go:171","msg":"trace[605566191] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:9; }","duration":"631.613865ms","start":"2026-05-27T13:43:20.440494Z","end":"2026-05-27T13:43:21.072108Z","steps":["trace[605566191] 'agreement among raft nodes before linearized reading' (duration: 631.578224ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:43:21.072149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:43:20.440471Z","time spent":"631.661556ms","remote":"127.0.0.1:60558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-05-27T13:43:21.072385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:43:20.512169Z","time spent":"559.916304ms","remote":"127.0.0.1:60702","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:43:21.072496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:43:20.449178Z","time spent":"621.778988ms","remote":"127.0.0.1:60430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:43:21.072616Z","caller":"traceutil/trace.go:171","msg":"trace[783926059] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"559.379672ms","start":"2026-05-27T13:43:20.51323Z","end":"2026-05-27T13:43:21.07261Z","steps":["trace[783926059] 'process raft request' (duration: 557.614356ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:43:21.072702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:43:20.513218Z","time spent":"559.432064ms","remote":"127.0.0.1:60702","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:43:21.072843Z","caller":"traceutil/trace.go:171","msg":"trace[2049609476] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"559.587527ms","start":"2026-05-27T13:43:20.513248Z","end":"2026-05-27T13:43:21.072836Z","steps":["trace[2049609476] 'process raft request' (duration: 557.619957ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:43:21.072997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:43:20.513238Z","time spent":"559.73824ms","remote":"127.0.0.1:60702","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:43:21.073178Z","caller":"traceutil/trace.go:171","msg":"trace[132266237] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"559.849473ms","start":"2026-05-27T13:43:20.51331Z","end":"2026-05-27T13:43:21.07316Z","steps":["trace[132266237] 'process raft request' (duration: 557.577526ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:43:21.0717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:43:20.447303Z","time spent":"624.390973ms","remote":"127.0.0.1:60436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-27T13:43:21.073314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:43:20.511919Z","time spent":"559.401874ms","remote":"127.0.0.1:60624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:43:21.073429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:43:20.513303Z","time spent":"560.030476ms","remote":"127.0.0.1:60702","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:43:21.072054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:43:20.447026Z","time spent":"625.021735ms","remote":"127.0.0.1:60390","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":27,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" "} {"level":"warn","ts":"2026-05-27T13:43:21.073429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.654656ms","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-27T13:43:21.073665Z","caller":"traceutil/trace.go:171","msg":"trace[2048016074] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:9; }","duration":"510.932533ms","start":"2026-05-27T13:43:20.562719Z","end":"2026-05-27T13:43:21.073652Z","steps":["trace[2048016074] 'agreement among raft nodes before linearized reading' (duration: 510.679737ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:43:21.073652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"560.951775ms","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":"warn","ts":"2026-05-27T13:43:21.071605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"622.200656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-27T13:43:21.072547Z","caller":"traceutil/trace.go:171","msg":"trace[1771750841] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"559.396633ms","start":"2026-05-27T13:43:20.513142Z","end":"2026-05-27T13:43:21.072539Z","steps":["trace[1771750841] 'process raft request' (duration: 557.671927ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:43:21.074022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:43:20.513116Z","time spent":"560.819594ms","remote":"127.0.0.1:60702","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:43:21.073708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:43:20.562676Z","time spent":"511.022845ms","remote":"127.0.0.1:60288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-05-27T13:43:21.073762Z","caller":"traceutil/trace.go:171","msg":"trace[2086396196] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:9; }","duration":"561.09315ms","start":"2026-05-27T13:43:20.512644Z","end":"2026-05-27T13:43:21.073737Z","steps":["trace[2086396196] 'agreement among raft nodes before linearized reading' (duration: 560.925575ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:43:21.074271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:43:20.512634Z","time spent":"561.60545ms","remote":"127.0.0.1:60258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"warn","ts":"2026-05-27T13:43:21.074362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"563.305945ms","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-27T13:43:21.074556Z","caller":"traceutil/trace.go:171","msg":"trace[1468709942] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:9; }","duration":"563.492619ms","start":"2026-05-27T13:43:20.510998Z","end":"2026-05-27T13:43:21.074491Z","steps":["trace[1468709942] 'agreement among raft nodes before linearized reading' (duration: 562.425856ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:43:21.074623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:43:20.510969Z","time spent":"563.635481ms","remote":"127.0.0.1:60288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-05-27T13:43:21.074002Z","caller":"traceutil/trace.go:171","msg":"trace[879171652] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:0; response_revision:9; }","duration":"624.615117ms","start":"2026-05-27T13:43:20.449377Z","end":"2026-05-27T13:43:21.073992Z","steps":["trace[879171652] 'agreement among raft nodes before linearized reading' (duration: 622.210506ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:21.071562Z","caller":"traceutil/trace.go:171","msg":"trace[780407420] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:9; }","duration":"573.677104ms","start":"2026-05-27T13:43:20.49786Z","end":"2026-05-27T13:43:21.071537Z","steps":["trace[780407420] 'agreement among raft nodes before linearized reading' (duration: 573.561932ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:43:21.07557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:43:20.449367Z","time spent":"626.186169ms","remote":"127.0.0.1:60216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/ranges/serviceips\" "} {"level":"warn","ts":"2026-05-27T13:43:21.075581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:43:20.497837Z","time spent":"577.552404ms","remote":"127.0.0.1:60288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-05-27T13:43:21.109275Z","caller":"traceutil/trace.go:171","msg":"trace[2054336921] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"430.396269ms","start":"2026-05-27T13:43:20.678824Z","end":"2026-05-27T13:43:21.109221Z","steps":["trace[2054336921] 'process raft request' (duration: 430.151124ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:43:21.109357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.772837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3490"} {"level":"info","ts":"2026-05-27T13:43:21.109469Z","caller":"traceutil/trace.go:171","msg":"trace[1998891142] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:10; }","duration":"439.939521ms","start":"2026-05-27T13:43:20.669512Z","end":"2026-05-27T13:43:21.109451Z","steps":["trace[1998891142] 'agreement among raft nodes before linearized reading' (duration: 439.723626ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:43:21.109545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:43:20.669496Z","time spent":"440.038782ms","remote":"127.0.0.1:60364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3513,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-05-27T13:43:21.109933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:43:20.678799Z","time spent":"430.587893ms","remote":"127.0.0.1:60364","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3478,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:43:26.177428Z","caller":"traceutil/trace.go:171","msg":"trace[1179129640] linearizableReadLoop","detail":"{readStateIndex:302; appliedIndex:301; }","duration":"209.63886ms","start":"2026-05-27T13:43:25.96776Z","end":"2026-05-27T13:43:26.177399Z","steps":["trace[1179129640] 'read index received' (duration: 184.387681ms)","trace[1179129640] 'applied index is now lower than readState.Index' (duration: 25.247099ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:43:26.177532Z","caller":"traceutil/trace.go:171","msg":"trace[1240850292] transaction","detail":"{read_only:false; response_revision:290; number_of_response:1; }","duration":"248.382847ms","start":"2026-05-27T13:43:25.929126Z","end":"2026-05-27T13:43:26.177508Z","steps":["trace[1240850292] 'process raft request' (duration: 223.158288ms)","trace[1240850292] 'compare' (duration: 24.992564ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:43:26.177561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.773682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-05-27T13:43:26.177743Z","caller":"traceutil/trace.go:171","msg":"trace[533783703] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:290; }","duration":"210.000177ms","start":"2026-05-27T13:43:25.96773Z","end":"2026-05-27T13:43:26.177731Z","steps":["trace[533783703] 'agreement among raft nodes before linearized reading' (duration: 209.766113ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:42.34791Z","caller":"traceutil/trace.go:171","msg":"trace[541929326] transaction","detail":"{read_only:false; response_revision:396; number_of_response:1; }","duration":"115.666465ms","start":"2026-05-27T13:43:42.232215Z","end":"2026-05-27T13:43:42.347881Z","steps":["trace[541929326] 'process raft request' (duration: 115.348379ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:42.525437Z","caller":"traceutil/trace.go:171","msg":"trace[1228166420] transaction","detail":"{read_only:false; response_revision:399; number_of_response:1; }","duration":"160.70093ms","start":"2026-05-27T13:43:42.36471Z","end":"2026-05-27T13:43:42.525411Z","steps":["trace[1228166420] 'process raft request' (duration: 120.112885ms)","trace[1228166420] 'compare' (duration: 40.470233ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:43:42.548411Z","caller":"traceutil/trace.go:171","msg":"trace[401919315] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"180.394227ms","start":"2026-05-27T13:43:42.367998Z","end":"2026-05-27T13:43:42.548392Z","steps":["trace[401919315] 'process raft request' (duration: 180.344076ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:42.548465Z","caller":"traceutil/trace.go:171","msg":"trace[885778679] transaction","detail":"{read_only:false; response_revision:400; number_of_response:1; }","duration":"183.517303ms","start":"2026-05-27T13:43:42.364921Z","end":"2026-05-27T13:43:42.548438Z","steps":["trace[885778679] 'process raft request' (duration: 183.32366ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:42.770436Z","caller":"traceutil/trace.go:171","msg":"trace[1609017970] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"240.806371ms","start":"2026-05-27T13:43:42.529598Z","end":"2026-05-27T13:43:42.770404Z","steps":["trace[1609017970] 'process raft request' (duration: 173.195436ms)","trace[1609017970] 'compare' (duration: 67.308209ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:43:42.770524Z","caller":"traceutil/trace.go:171","msg":"trace[872991550] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"240.17208ms","start":"2026-05-27T13:43:42.530323Z","end":"2026-05-27T13:43:42.770495Z","steps":["trace[872991550] 'process raft request' (duration: 239.998967ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:42.770669Z","caller":"traceutil/trace.go:171","msg":"trace[528355706] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"238.453748ms","start":"2026-05-27T13:43:42.532188Z","end":"2026-05-27T13:43:42.770642Z","steps":["trace[528355706] 'process raft request' (duration: 238.182133ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:42.770816Z","caller":"traceutil/trace.go:171","msg":"trace[1934105909] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"216.45236ms","start":"2026-05-27T13:43:42.554353Z","end":"2026-05-27T13:43:42.770805Z","steps":["trace[1934105909] 'process raft request' (duration: 216.41554ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:42.770911Z","caller":"traceutil/trace.go:171","msg":"trace[1285048788] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"237.084764ms","start":"2026-05-27T13:43:42.533818Z","end":"2026-05-27T13:43:42.770903Z","steps":["trace[1285048788] 'process raft request' (duration: 236.893831ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:42.969433Z","caller":"traceutil/trace.go:171","msg":"trace[1377046045] transaction","detail":"{read_only:false; number_of_response:1; response_revision:410; }","duration":"131.477931ms","start":"2026-05-27T13:43:42.837925Z","end":"2026-05-27T13:43:42.969403Z","steps":["trace[1377046045] 'process raft request' (duration: 49.851602ms)","trace[1377046045] 'compare' (duration: 81.448896ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:43:42.969565Z","caller":"traceutil/trace.go:171","msg":"trace[603711353] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"128.183862ms","start":"2026-05-27T13:43:42.841355Z","end":"2026-05-27T13:43:42.969539Z","steps":["trace[603711353] 'process raft request' (duration: 127.998678ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:51.870478Z","caller":"traceutil/trace.go:171","msg":"trace[1523339694] transaction","detail":"{read_only:false; response_revision:448; number_of_response:1; }","duration":"164.022506ms","start":"2026-05-27T13:43:51.70643Z","end":"2026-05-27T13:43:51.870453Z","steps":["trace[1523339694] 'process raft request' (duration: 163.878674ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:56.039059Z","caller":"traceutil/trace.go:171","msg":"trace[1287424259] linearizableReadLoop","detail":"{readStateIndex:511; appliedIndex:510; }","duration":"143.72468ms","start":"2026-05-27T13:43:55.89531Z","end":"2026-05-27T13:43:56.039035Z","steps":["trace[1287424259] 'read index received' (duration: 143.674909ms)","trace[1287424259] 'applied index is now lower than readState.Index' (duration: 48.951µs)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:43:56.039223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.895513ms","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-27T13:43:56.039249Z","caller":"traceutil/trace.go:171","msg":"trace[318199332] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:493; }","duration":"143.969704ms","start":"2026-05-27T13:43:55.895272Z","end":"2026-05-27T13:43:56.039242Z","steps":["trace[318199332] 'agreement among raft nodes before linearized reading' (duration: 143.869963ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:56.039361Z","caller":"traceutil/trace.go:171","msg":"trace[1891681456] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"144.926561ms","start":"2026-05-27T13:43:55.894376Z","end":"2026-05-27T13:43:56.039303Z","steps":["trace[1891681456] 'process raft request' (duration: 144.569776ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:56.042594Z","caller":"traceutil/trace.go:171","msg":"trace[965506658] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"130.479178ms","start":"2026-05-27T13:43:55.912087Z","end":"2026-05-27T13:43:56.042566Z","steps":["trace[965506658] 'process raft request' (duration: 130.00592ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:56.04263Z","caller":"traceutil/trace.go:171","msg":"trace[543136531] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"127.573768ms","start":"2026-05-27T13:43:55.915031Z","end":"2026-05-27T13:43:56.042605Z","steps":["trace[543136531] 'process raft request' (duration: 127.164002ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:56.042728Z","caller":"traceutil/trace.go:171","msg":"trace[782580487] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"128.644217ms","start":"2026-05-27T13:43:55.914072Z","end":"2026-05-27T13:43:56.042716Z","steps":["trace[782580487] 'process raft request' (duration: 128.059748ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:56.042801Z","caller":"traceutil/trace.go:171","msg":"trace[1100834134] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"128.662417ms","start":"2026-05-27T13:43:55.914129Z","end":"2026-05-27T13:43:56.042791Z","steps":["trace[1100834134] 'process raft request' (duration: 128.035287ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:56.042835Z","caller":"traceutil/trace.go:171","msg":"trace[341519240] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"137.819771ms","start":"2026-05-27T13:43:55.905007Z","end":"2026-05-27T13:43:56.042827Z","steps":["trace[341519240] 'process raft request' (duration: 136.923776ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:56.042891Z","caller":"traceutil/trace.go:171","msg":"trace[177430146] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"133.960165ms","start":"2026-05-27T13:43:55.908922Z","end":"2026-05-27T13:43:56.042882Z","steps":["trace[177430146] 'process raft request' (duration: 133.095061ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:56.043302Z","caller":"traceutil/trace.go:171","msg":"trace[216427515] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"123.948809ms","start":"2026-05-27T13:43:55.919343Z","end":"2026-05-27T13:43:56.043291Z","steps":["trace[216427515] 'process raft request' (duration: 122.89285ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:56.043389Z","caller":"traceutil/trace.go:171","msg":"trace[1286430117] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"117.002742ms","start":"2026-05-27T13:43:55.926378Z","end":"2026-05-27T13:43:56.043381Z","steps":["trace[1286430117] 'process raft request' (duration: 115.947314ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:56.043454Z","caller":"traceutil/trace.go:171","msg":"trace[1092215976] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"132.858718ms","start":"2026-05-27T13:43:55.910588Z","end":"2026-05-27T13:43:56.043446Z","steps":["trace[1092215976] 'process raft request' (duration: 131.466894ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:57.194854Z","caller":"traceutil/trace.go:171","msg":"trace[758097949] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"111.294168ms","start":"2026-05-27T13:43:57.083481Z","end":"2026-05-27T13:43:57.194775Z","steps":["trace[758097949] 'process raft request' (duration: 91.067952ms)","trace[758097949] 'compare' (duration: 16.444283ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:43:57.195028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.060198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gatewayclasses.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:10870"} {"level":"info","ts":"2026-05-27T13:43:57.195088Z","caller":"traceutil/trace.go:171","msg":"trace[1959431156] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/gatewayclasses.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:566; }","duration":"110.15936ms","start":"2026-05-27T13:43:57.084912Z","end":"2026-05-27T13:43:57.195071Z","steps":["trace[1959431156] 'agreement among raft nodes before linearized reading' (duration: 109.982807ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:43:57.194876Z","caller":"traceutil/trace.go:171","msg":"trace[1162466571] linearizableReadLoop","detail":"{readStateIndex:586; appliedIndex:584; }","duration":"109.872175ms","start":"2026-05-27T13:43:57.084953Z","end":"2026-05-27T13:43:57.194825Z","steps":["trace[1162466571] 'read index received' (duration: 19.813219ms)","trace[1162466571] 'applied index is now lower than readState.Index' (duration: 90.055756ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:43:57.995747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.328471ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T13:43:57.995834Z","caller":"traceutil/trace.go:171","msg":"trace[1948666984] linearizableReadLoop","detail":"{readStateIndex:589; appliedIndex:588; }","duration":"602.855074ms","start":"2026-05-27T13:43:57.392966Z","end":"2026-05-27T13:43:57.995821Z","steps":["trace[1948666984] 'read index received' (duration: 179.266637ms)","trace[1948666984] 'applied index is now lower than readState.Index' (duration: 423.587737ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:43:57.995895Z","caller":"traceutil/trace.go:171","msg":"trace[2008738884] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"634.086723ms","start":"2026-05-27T13:43:57.3618Z","end":"2026-05-27T13:43:57.995887Z","steps":["trace[2008738884] 'process raft request' (duration: 210.422435ms)","trace[2008738884] 'compare' (duration: 423.197269ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:43:57.995936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:43:57.361781Z","time spent":"634.134313ms","remote":"127.0.0.1:60436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:43:57.99618Z","caller":"traceutil/trace.go:171","msg":"trace[1438138707] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"567.7176ms","start":"2026-05-27T13:43:57.428409Z","end":"2026-05-27T13:43:57.996127Z","steps":["trace[1438138707] 'process raft request' (duration: 567.522647ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:43:57.996268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"603.290841ms","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-27T13:43:57.996294Z","caller":"traceutil/trace.go:171","msg":"trace[831058520] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:570; }","duration":"603.324572ms","start":"2026-05-27T13:43:57.392962Z","end":"2026-05-27T13:43:57.996287Z","steps":["trace[831058520] 'agreement among raft nodes before linearized reading' (duration: 603.20429ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:43:57.996311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:43:57.428384Z","time spent":"567.853833ms","remote":"127.0.0.1:60200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":208470,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:43:57.996355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:43:57.392922Z","time spent":"603.390883ms","remote":"127.0.0.1:60436","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-27T13:43:58.002131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"579.308652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:7708"} {"level":"info","ts":"2026-05-27T13:43:58.002185Z","caller":"traceutil/trace.go:171","msg":"trace[2121489564] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:570; }","duration":"579.416484ms","start":"2026-05-27T13:43:57.422755Z","end":"2026-05-27T13:43:58.002172Z","steps":["trace[2121489564] 'agreement among raft nodes before linearized reading' (duration: 579.292212ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:43:58.002226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:43:57.422737Z","time spent":"579.481496ms","remote":"127.0.0.1:60200","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":1,"response size":7731,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io\" "} {"level":"info","ts":"2026-05-27T13:44:02.183851Z","caller":"traceutil/trace.go:171","msg":"trace[1187426541] linearizableReadLoop","detail":"{readStateIndex:613; appliedIndex:612; }","duration":"110.553349ms","start":"2026-05-27T13:44:02.073259Z","end":"2026-05-27T13:44:02.183813Z","steps":["trace[1187426541] 'read index received' (duration: 109.587673ms)","trace[1187426541] 'applied index is now lower than readState.Index' (duration: 964.316µs)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:44:02.184047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.741583ms","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-27T13:44:02.184095Z","caller":"traceutil/trace.go:171","msg":"trace[779090110] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:592; }","duration":"110.853815ms","start":"2026-05-27T13:44:02.073226Z","end":"2026-05-27T13:44:02.18408Z","steps":["trace[779090110] 'agreement among raft nodes before linearized reading' (duration: 110.724203ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:44:02.184073Z","caller":"traceutil/trace.go:171","msg":"trace[1580928507] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"147.096481ms","start":"2026-05-27T13:44:02.036943Z","end":"2026-05-27T13:44:02.184039Z","steps":["trace[1580928507] 'process raft request' (duration: 145.82545ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:44:02.192072Z","caller":"traceutil/trace.go:171","msg":"trace[54965587] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"108.624428ms","start":"2026-05-27T13:44:02.083435Z","end":"2026-05-27T13:44:02.19206Z","steps":["trace[54965587] 'process raft request' (duration: 108.522345ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:44:02.391366Z","caller":"traceutil/trace.go:171","msg":"trace[175897124] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"142.234362ms","start":"2026-05-27T13:44:02.2491Z","end":"2026-05-27T13:44:02.391334Z","steps":["trace[175897124] 'process raft request' (duration: 133.632823ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:44:02.391517Z","caller":"traceutil/trace.go:171","msg":"trace[237097031] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"128.181495ms","start":"2026-05-27T13:44:02.263301Z","end":"2026-05-27T13:44:02.391482Z","steps":["trace[237097031] 'process raft request' (duration: 127.913091ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:44:03.518821Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1011513768030609449,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T13:44:04.019429Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1011513768030609449,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T13:44:04.18828Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.187649349s","expected-duration":"1s"} {"level":"info","ts":"2026-05-27T13:44:04.207761Z","caller":"traceutil/trace.go:171","msg":"trace[720507409] linearizableReadLoop","detail":"{readStateIndex:623; appliedIndex:622; }","duration":"1.189047949s","start":"2026-05-27T13:44:03.018599Z","end":"2026-05-27T13:44:04.207647Z","steps":["trace[720507409] 'read index received' (duration: 1.169870512s)","trace[720507409] 'applied index is now lower than readState.Index' (duration: 19.175377ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:44:04.208111Z","caller":"traceutil/trace.go:171","msg":"trace[1813861532] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"1.207581668s","start":"2026-05-27T13:44:03.000506Z","end":"2026-05-27T13:44:04.208087Z","steps":["trace[1813861532] 'process raft request' (duration: 1.188017795s)","trace[1813861532] 'compare' (duration: 17.959818ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:44:04.208256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:44:03.000478Z","time spent":"1.207680929s","remote":"127.0.0.1:60690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:44:04.208622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.190019094s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-t75dg\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-05-27T13:44:04.208664Z","caller":"traceutil/trace.go:171","msg":"trace[1553055415] range","detail":"{range_begin:/registry/pods/kube-system/cilium-t75dg; range_end:; response_count:1; response_revision:601; }","duration":"1.190093035s","start":"2026-05-27T13:44:03.018555Z","end":"2026-05-27T13:44:04.208648Z","steps":["trace[1553055415] 'agreement among raft nodes before linearized reading' (duration: 1.189904032s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:44:04.208748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:44:03.018529Z","time spent":"1.190208727s","remote":"127.0.0.1:60376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-t75dg\" "} {"level":"warn","ts":"2026-05-27T13:44:04.20891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.830874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-27T13:44:04.208922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.073994596s","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-27T13:44:04.208974Z","caller":"traceutil/trace.go:171","msg":"trace[1538663355] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:601; }","duration":"293.928945ms","start":"2026-05-27T13:44:03.915027Z","end":"2026-05-27T13:44:04.208956Z","steps":["trace[1538663355] 'agreement among raft nodes before linearized reading' (duration: 293.835173ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:44:04.20904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.560439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-27T13:44:04.209116Z","caller":"traceutil/trace.go:171","msg":"trace[2125429625] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:601; }","duration":"171.699671ms","start":"2026-05-27T13:44:04.037395Z","end":"2026-05-27T13:44:04.209094Z","steps":["trace[2125429625] 'agreement among raft nodes before linearized reading' (duration: 171.438736ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:44:04.20947Z","caller":"traceutil/trace.go:171","msg":"trace[1638189346] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:601; }","duration":"1.074076837s","start":"2026-05-27T13:44:03.134896Z","end":"2026-05-27T13:44:04.208972Z","steps":["trace[1638189346] 'agreement among raft nodes before linearized reading' (duration: 1.073817173s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:44:04.209502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:44:03.134845Z","time spent":"1.074650287s","remote":"127.0.0.1:60436","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-27T13:44:18.848631Z","caller":"traceutil/trace.go:171","msg":"trace[831734437] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"553.458285ms","start":"2026-05-27T13:44:18.295155Z","end":"2026-05-27T13:44:18.848614Z","steps":["trace[831734437] 'process raft request' (duration: 553.333233ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:44:18.848767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:44:18.295139Z","time spent":"553.565596ms","remote":"127.0.0.1:60436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:44:18.858255Z","caller":"traceutil/trace.go:171","msg":"trace[1829993349] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"545.81287ms","start":"2026-05-27T13:44:18.312425Z","end":"2026-05-27T13:44:18.858238Z","steps":["trace[1829993349] 'process raft request' (duration: 545.708008ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:44:18.858359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:44:18.312411Z","time spent":"545.891142ms","remote":"127.0.0.1:60436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:44:21.810758Z","caller":"traceutil/trace.go:171","msg":"trace[145118818] linearizableReadLoop","detail":"{readStateIndex:795; appliedIndex:794; }","duration":"252.209592ms","start":"2026-05-27T13:44:21.558525Z","end":"2026-05-27T13:44:21.810735Z","steps":["trace[145118818] 'read index received' (duration: 252.030799ms)","trace[145118818] 'applied index is now lower than readState.Index' (duration: 177.643µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:44:21.810909Z","caller":"traceutil/trace.go:171","msg":"trace[579472248] transaction","detail":"{read_only:false; response_revision:769; number_of_response:1; }","duration":"679.841977ms","start":"2026-05-27T13:44:21.131052Z","end":"2026-05-27T13:44:21.810894Z","steps":["trace[579472248] 'process raft request' (duration: 679.532823ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:44:21.811265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.71311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:44:21.811349Z","caller":"traceutil/trace.go:171","msg":"trace[357010440] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:769; }","duration":"252.859961ms","start":"2026-05-27T13:44:21.558469Z","end":"2026-05-27T13:44:21.811329Z","steps":["trace[357010440] 'agreement among raft nodes before linearized reading' (duration: 252.699479ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:44:21.811678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:44:21.131035Z","time spent":"679.919359ms","remote":"127.0.0.1:60376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4027,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:44:26.302095Z","caller":"traceutil/trace.go:171","msg":"trace[831457513] linearizableReadLoop","detail":"{readStateIndex:854; appliedIndex:853; }","duration":"139.999126ms","start":"2026-05-27T13:44:26.162068Z","end":"2026-05-27T13:44:26.302067Z","steps":["trace[831457513] 'read index received' (duration: 139.745393ms)","trace[831457513] 'applied index is now lower than readState.Index' (duration: 252.653µs)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:44:26.302323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.2247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/envoy-gateway-system/\" range_end:\"/registry/deployments/envoy-gateway-system0\" limit:10000 ","response":"range_response_count:1 size:5616"} {"level":"info","ts":"2026-05-27T13:44:26.302366Z","caller":"traceutil/trace.go:171","msg":"trace[628655752] range","detail":"{range_begin:/registry/deployments/envoy-gateway-system/; range_end:/registry/deployments/envoy-gateway-system0; response_count:1; response_revision:826; }","duration":"140.30799ms","start":"2026-05-27T13:44:26.162045Z","end":"2026-05-27T13:44:26.302353Z","steps":["trace[628655752] 'agreement among raft nodes before linearized reading' (duration: 140.127468ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:44:26.302633Z","caller":"traceutil/trace.go:171","msg":"trace[465572526] transaction","detail":"{read_only:false; response_revision:826; number_of_response:1; }","duration":"144.144006ms","start":"2026-05-27T13:44:26.158474Z","end":"2026-05-27T13:44:26.302618Z","steps":["trace[465572526] 'process raft request' (duration: 143.450336ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:44:28.565898Z","caller":"traceutil/trace.go:171","msg":"trace[2110812616] transaction","detail":"{read_only:false; response_revision:839; number_of_response:1; }","duration":"101.659007ms","start":"2026-05-27T13:44:28.464162Z","end":"2026-05-27T13:44:28.565821Z","steps":["trace[2110812616] 'process raft request' (duration: 99.218542ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:44:29.008076Z","caller":"traceutil/trace.go:171","msg":"trace[1745327245] linearizableReadLoop","detail":"{readStateIndex:876; appliedIndex:875; }","duration":"106.360855ms","start":"2026-05-27T13:44:28.901692Z","end":"2026-05-27T13:44:29.008053Z","steps":["trace[1745327245] 'read index received' (duration: 106.172112ms)","trace[1745327245] 'applied index is now lower than readState.Index' (duration: 187.713µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:44:29.008234Z","caller":"traceutil/trace.go:171","msg":"trace[2039527812] transaction","detail":"{read_only:false; response_revision:847; number_of_response:1; }","duration":"108.100139ms","start":"2026-05-27T13:44:28.900106Z","end":"2026-05-27T13:44:29.008206Z","steps":["trace[2039527812] 'process raft request' (duration: 107.808105ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:44:29.008343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.641549ms","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-27T13:44:29.008378Z","caller":"traceutil/trace.go:171","msg":"trace[1580370824] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:847; }","duration":"106.72564ms","start":"2026-05-27T13:44:28.901641Z","end":"2026-05-27T13:44:29.008367Z","steps":["trace[1580370824] 'agreement among raft nodes before linearized reading' (duration: 106.584818ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:44:36.300786Z","caller":"traceutil/trace.go:171","msg":"trace[793867601] transaction","detail":"{read_only:false; response_revision:941; number_of_response:1; }","duration":"101.22279ms","start":"2026-05-27T13:44:36.19954Z","end":"2026-05-27T13:44:36.300762Z","steps":["trace[793867601] 'process raft request' (duration: 101.066378ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:44:36.460006Z","caller":"traceutil/trace.go:171","msg":"trace[409390625] transaction","detail":"{read_only:false; response_revision:943; number_of_response:1; }","duration":"139.675669ms","start":"2026-05-27T13:44:36.320235Z","end":"2026-05-27T13:44:36.45991Z","steps":["trace[409390625] 'process raft request' (duration: 81.345371ms)","trace[409390625] 'compare' (duration: 58.176176ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:44:36.473607Z","caller":"traceutil/trace.go:171","msg":"trace[723301969] transaction","detail":"{read_only:false; response_revision:944; number_of_response:1; }","duration":"149.104501ms","start":"2026-05-27T13:44:36.324479Z","end":"2026-05-27T13:44:36.473584Z","steps":["trace[723301969] 'process raft request' (duration: 148.959729ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:44:37.205418Z","caller":"traceutil/trace.go:171","msg":"trace[1055053064] transaction","detail":"{read_only:false; response_revision:948; number_of_response:1; }","duration":"128.436775ms","start":"2026-05-27T13:44:37.076965Z","end":"2026-05-27T13:44:37.205402Z","steps":["trace[1055053064] 'process raft request' (duration: 128.105041ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:45:10.93308Z","caller":"traceutil/trace.go:171","msg":"trace[1507832601] transaction","detail":"{read_only:false; response_revision:1062; number_of_response:1; }","duration":"129.141588ms","start":"2026-05-27T13:45:10.803916Z","end":"2026-05-27T13:45:10.933057Z","steps":["trace[1507832601] 'process raft request' (duration: 128.809924ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:45:29.395011Z","caller":"traceutil/trace.go:171","msg":"trace[1593659678] transaction","detail":"{read_only:false; response_revision:1123; number_of_response:1; }","duration":"247.057339ms","start":"2026-05-27T13:45:29.147916Z","end":"2026-05-27T13:45:29.394974Z","steps":["trace[1593659678] 'process raft request' (duration: 246.902167ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:45:31.521295Z","caller":"traceutil/trace.go:171","msg":"trace[721883469] transaction","detail":"{read_only:false; response_revision:1129; number_of_response:1; }","duration":"117.566572ms","start":"2026-05-27T13:45:31.403384Z","end":"2026-05-27T13:45:31.52095Z","steps":["trace[721883469] 'process raft request' (duration: 117.042025ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:45:50.701278Z","caller":"traceutil/trace.go:171","msg":"trace[1036806611] transaction","detail":"{read_only:false; response_revision:1192; number_of_response:1; }","duration":"116.157255ms","start":"2026-05-27T13:45:50.585098Z","end":"2026-05-27T13:45:50.701255Z","steps":["trace[1036806611] 'process raft request' (duration: 116.029584ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:12.43736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.514461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:46:12.437474Z","caller":"traceutil/trace.go:171","msg":"trace[594572244] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1301; }","duration":"421.703743ms","start":"2026-05-27T13:46:12.015745Z","end":"2026-05-27T13:46:12.437448Z","steps":["trace[594572244] 'count revisions from in-memory index tree' (duration: 421.354939ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:12.43753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:12.015722Z","time spent":"421.791324ms","remote":"127.0.0.1:60416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"warn","ts":"2026-05-27T13:46:12.437368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.865841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.22\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-27T13:46:12.438308Z","caller":"traceutil/trace.go:171","msg":"trace[1094175490] range","detail":"{range_begin:/registry/masterleases/199.204.45.22; range_end:; response_count:1; response_revision:1301; }","duration":"208.879324ms","start":"2026-05-27T13:46:12.229389Z","end":"2026-05-27T13:46:12.438269Z","steps":["trace[1094175490] 'range keys from in-memory index tree' (duration: 207.69277ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:46:35.692398Z","caller":"traceutil/trace.go:171","msg":"trace[1429393726] linearizableReadLoop","detail":"{readStateIndex:1440; appliedIndex:1439; }","duration":"104.589132ms","start":"2026-05-27T13:46:35.587783Z","end":"2026-05-27T13:46:35.692373Z","steps":["trace[1429393726] 'read index received' (duration: 104.390244ms)","trace[1429393726] 'applied index is now lower than readState.Index' (duration: 198.048µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:46:35.692456Z","caller":"traceutil/trace.go:171","msg":"trace[453463143] transaction","detail":"{read_only:false; response_revision:1383; number_of_response:1; }","duration":"114.220522ms","start":"2026-05-27T13:46:35.578214Z","end":"2026-05-27T13:46:35.692434Z","steps":["trace[453463143] 'process raft request' (duration: 114.013124ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:35.692588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.780408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-public/system:controller:bootstrap-signer\" ","response":"range_response_count:1 size:741"} {"level":"info","ts":"2026-05-27T13:46:35.692648Z","caller":"traceutil/trace.go:171","msg":"trace[2052644706] range","detail":"{range_begin:/registry/rolebindings/kube-public/system:controller:bootstrap-signer; range_end:; response_count:1; response_revision:1383; }","duration":"104.877751ms","start":"2026-05-27T13:46:35.587752Z","end":"2026-05-27T13:46:35.69263Z","steps":["trace[2052644706] 'agreement among raft nodes before linearized reading' (duration: 104.766278ms)"],"step_count":1}