{"level":"warn","ts":"2026-05-27T06:02:39.575611Z","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-27T06:02:39.575726Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.54:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.54:2380","--initial-cluster=instance=https://199.19.213.54:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.54:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.54: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-27T06:02:39.575811Z","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-27T06:02:39.575829Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.54:2380"]} {"level":"info","ts":"2026-05-27T06:02:39.575891Z","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-27T06:02:39.576955Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.54:2379"]} {"level":"info","ts":"2026-05-27T06:02:39.577098Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.54:2380"],"listen-peer-urls":["https://199.19.213.54:2380"],"advertise-client-urls":["https://199.19.213.54:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.54:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.54: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-27T06:02:39.582026Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.560505ms"} {"level":"info","ts":"2026-05-27T06:02:39.589084Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"193b4dda7792855b","cluster-id":"dd6702a2f79ce697"} {"level":"info","ts":"2026-05-27T06:02:39.589167Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"193b4dda7792855b switched to configuration voters=()"} {"level":"info","ts":"2026-05-27T06:02:39.589233Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"193b4dda7792855b became follower at term 0"} {"level":"info","ts":"2026-05-27T06:02:39.589254Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 193b4dda7792855b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-27T06:02:39.589264Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"193b4dda7792855b became follower at term 1"} {"level":"info","ts":"2026-05-27T06:02:39.589343Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"193b4dda7792855b switched to configuration voters=(1818132475278427483)"} {"level":"warn","ts":"2026-05-27T06:02:39.595362Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-27T06:02:39.596755Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-27T06:02:39.597941Z","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-27T06:02:39.600353Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"193b4dda7792855b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-27T06:02:39.600582Z","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-27T06:02:39.600734Z","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-27T06:02:39.600751Z","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-27T06:02:39.600615Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"193b4dda7792855b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-27T06:02:39.602123Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"193b4dda7792855b switched to configuration voters=(1818132475278427483)"} {"level":"info","ts":"2026-05-27T06:02:39.602326Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"dd6702a2f79ce697","local-member-id":"193b4dda7792855b","added-peer-id":"193b4dda7792855b","added-peer-peer-urls":["https://199.19.213.54:2380"]} {"level":"info","ts":"2026-05-27T06:02:39.605601Z","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-27T06:02:39.605861Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"193b4dda7792855b","initial-advertise-peer-urls":["https://199.19.213.54:2380"],"listen-peer-urls":["https://199.19.213.54:2380"],"advertise-client-urls":["https://199.19.213.54:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.54:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-27T06:02:39.605898Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-27T06:02:39.606048Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.54:2380"} {"level":"info","ts":"2026-05-27T06:02:39.606065Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.54:2380"} {"level":"info","ts":"2026-05-27T06:02:40.390302Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"193b4dda7792855b is starting a new election at term 1"} {"level":"info","ts":"2026-05-27T06:02:40.390365Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"193b4dda7792855b became pre-candidate at term 1"} {"level":"info","ts":"2026-05-27T06:02:40.390394Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"193b4dda7792855b received MsgPreVoteResp from 193b4dda7792855b at term 1"} {"level":"info","ts":"2026-05-27T06:02:40.390413Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"193b4dda7792855b became candidate at term 2"} {"level":"info","ts":"2026-05-27T06:02:40.390422Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"193b4dda7792855b received MsgVoteResp from 193b4dda7792855b at term 2"} {"level":"info","ts":"2026-05-27T06:02:40.390432Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"193b4dda7792855b became leader at term 2"} {"level":"info","ts":"2026-05-27T06:02:40.390442Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 193b4dda7792855b elected leader 193b4dda7792855b at term 2"} {"level":"info","ts":"2026-05-27T06:02:40.391458Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"193b4dda7792855b","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.54:2379]}","request-path":"/0/members/193b4dda7792855b/attributes","cluster-id":"dd6702a2f79ce697","publish-timeout":"7s"} {"level":"info","ts":"2026-05-27T06:02:40.391599Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-27T06:02:40.391653Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-27T06:02:40.391874Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T06:02:40.393225Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"dd6702a2f79ce697","local-member-id":"193b4dda7792855b","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T06:02:40.393313Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.54:2379"} {"level":"info","ts":"2026-05-27T06:02:40.393356Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T06:02:40.39341Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T06:02:40.393648Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-27T06:02:40.397233Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-27T06:02:40.39803Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-27T06:03:16.742036Z","caller":"traceutil/trace.go:171","msg":"trace[1724762737] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"171.58456ms","start":"2026-05-27T06:03:16.570405Z","end":"2026-05-27T06:03:16.741989Z","steps":["trace[1724762737] 'process raft request' (duration: 171.426915ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T06:03:22.844794Z","caller":"traceutil/trace.go:171","msg":"trace[449409836] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"225.681849ms","start":"2026-05-27T06:03:22.619084Z","end":"2026-05-27T06:03:22.844765Z","steps":["trace[449409836] 'process raft request' (duration: 225.484113ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:03:23.464914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.556143ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T06:03:23.465158Z","caller":"traceutil/trace.go:171","msg":"trace[1099320959] linearizableReadLoop","detail":"{readStateIndex:677; appliedIndex:676; }","duration":"580.40243ms","start":"2026-05-27T06:03:22.884736Z","end":"2026-05-27T06:03:23.465139Z","steps":["trace[1099320959] 'read index received' (duration: 392.976223ms)","trace[1099320959] 'applied index is now lower than readState.Index' (duration: 187.424837ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T06:03:23.46529Z","caller":"traceutil/trace.go:171","msg":"trace[1685695027] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"616.75332ms","start":"2026-05-27T06:03:22.848516Z","end":"2026-05-27T06:03:23.465269Z","steps":["trace[1685695027] 'process raft request' (duration: 429.202039ms)","trace[1685695027] 'compare' (duration: 186.386548ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T06:03:23.46532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.578194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T06:03:23.465421Z","caller":"traceutil/trace.go:171","msg":"trace[1109061307] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:651; }","duration":"580.727928ms","start":"2026-05-27T06:03:22.884682Z","end":"2026-05-27T06:03:23.46541Z","steps":["trace[1109061307] 'agreement among raft nodes before linearized reading' (duration: 580.592375ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:03:23.465488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:03:22.88466Z","time spent":"580.81699ms","remote":"127.0.0.1:57416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-27T06:03:23.465393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:03:22.848489Z","time spent":"616.856732ms","remote":"127.0.0.1:57702","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T06:03:23.465719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.412908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-cwb9l\" ","response":"range_response_count:1 size:16961"} {"level":"warn","ts":"2026-05-27T06:03:23.46586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.436902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.54\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-27T06:03:23.465958Z","caller":"traceutil/trace.go:171","msg":"trace[731569654] range","detail":"{range_begin:/registry/masterleases/199.19.213.54; range_end:; response_count:1; response_revision:651; }","duration":"201.553937ms","start":"2026-05-27T06:03:23.264373Z","end":"2026-05-27T06:03:23.465926Z","steps":["trace[731569654] 'agreement among raft nodes before linearized reading' (duration: 201.30525ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T06:03:23.465956Z","caller":"traceutil/trace.go:171","msg":"trace[1209339665] range","detail":"{range_begin:/registry/pods/kube-system/cilium-cwb9l; range_end:; response_count:1; response_revision:651; }","duration":"247.577662ms","start":"2026-05-27T06:03:23.218239Z","end":"2026-05-27T06:03:23.465817Z","steps":["trace[1209339665] 'agreement among raft nodes before linearized reading' (duration: 247.129059ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T06:03:23.579956Z","caller":"traceutil/trace.go:171","msg":"trace[92537547] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"100.222378ms","start":"2026-05-27T06:03:23.47971Z","end":"2026-05-27T06:03:23.579932Z","steps":["trace[92537547] 'process raft request' (duration: 100.157696ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T06:03:23.580005Z","caller":"traceutil/trace.go:171","msg":"trace[813479700] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"109.537543ms","start":"2026-05-27T06:03:23.470424Z","end":"2026-05-27T06:03:23.579961Z","steps":["trace[813479700] 'process raft request' (duration: 104.901676ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:03:23.94144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.325261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-27T06:03:23.941522Z","caller":"traceutil/trace.go:171","msg":"trace[66952204] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:654; }","duration":"144.452104ms","start":"2026-05-27T06:03:23.797053Z","end":"2026-05-27T06:03:23.941505Z","steps":["trace[66952204] 'range keys from in-memory index tree' (duration: 144.115795ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:03:24.755438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.351862ms","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-27T06:03:24.755584Z","caller":"traceutil/trace.go:171","msg":"trace[1739255609] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:656; }","duration":"538.545598ms","start":"2026-05-27T06:03:24.217017Z","end":"2026-05-27T06:03:24.755562Z","steps":["trace[1739255609] 'range keys from in-memory index tree' (duration: 538.185128ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:03:24.755633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:03:24.216999Z","time spent":"538.624289ms","remote":"127.0.0.1:57702","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-27T06:03:40.216352Z","caller":"traceutil/trace.go:171","msg":"trace[811717256] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"177.612721ms","start":"2026-05-27T06:03:40.038683Z","end":"2026-05-27T06:03:40.216296Z","steps":["trace[811717256] 'process raft request' (duration: 177.427546ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T06:03:40.231535Z","caller":"traceutil/trace.go:171","msg":"trace[283388521] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"191.542796ms","start":"2026-05-27T06:03:40.039934Z","end":"2026-05-27T06:03:40.231477Z","steps":["trace[283388521] 'process raft request' (duration: 191.376092ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T06:04:13.296235Z","caller":"traceutil/trace.go:171","msg":"trace[1077491967] transaction","detail":"{read_only:false; response_revision:981; number_of_response:1; }","duration":"309.729822ms","start":"2026-05-27T06:04:12.986484Z","end":"2026-05-27T06:04:13.296214Z","steps":["trace[1077491967] 'process raft request' (duration: 309.578647ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:04:13.296385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:04:12.986461Z","time spent":"309.857625ms","remote":"127.0.0.1:57702","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T06:04:13.909953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.010556ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-05-27T06:04:13.910109Z","caller":"traceutil/trace.go:171","msg":"trace[1875880575] linearizableReadLoop","detail":"{readStateIndex:1021; appliedIndex:1019; }","duration":"176.263344ms","start":"2026-05-27T06:04:13.733834Z","end":"2026-05-27T06:04:13.910097Z","steps":["trace[1875880575] 'read index received' (duration: 37.231µs)","trace[1875880575] 'applied index is now lower than readState.Index' (duration: 176.225373ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T06:04:13.910156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:04:13.297627Z","time spent":"612.5268ms","remote":"127.0.0.1:57472","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-05-27T06:04:13.910366Z","caller":"traceutil/trace.go:171","msg":"trace[1973475551] transaction","detail":"{read_only:false; response_revision:982; number_of_response:1; }","duration":"442.601111ms","start":"2026-05-27T06:04:13.467758Z","end":"2026-05-27T06:04:13.910359Z","steps":["trace[1973475551] 'process raft request' (duration: 442.268182ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:04:13.910429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:04:13.467737Z","time spent":"442.646905ms","remote":"127.0.0.1:57702","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T06:04:13.910559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.735076ms","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-27T06:04:13.910577Z","caller":"traceutil/trace.go:171","msg":"trace[1384488491] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:982; }","duration":"176.792597ms","start":"2026-05-27T06:04:13.733779Z","end":"2026-05-27T06:04:13.910571Z","steps":["trace[1384488491] 'agreement among raft nodes before linearized reading' (duration: 176.727526ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T06:04:14.028685Z","caller":"traceutil/trace.go:171","msg":"trace[2109425662] linearizableReadLoop","detail":"{readStateIndex:1022; appliedIndex:1021; }","duration":"118.519965ms","start":"2026-05-27T06:04:13.910133Z","end":"2026-05-27T06:04:14.028653Z","steps":["trace[2109425662] 'read index received' (duration: 116.668344ms)","trace[2109425662] 'applied index is now lower than readState.Index' (duration: 1.849831ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T06:04:14.028787Z","caller":"traceutil/trace.go:171","msg":"trace[1097044926] transaction","detail":"{read_only:false; response_revision:983; number_of_response:1; }","duration":"191.96289ms","start":"2026-05-27T06:04:13.8368Z","end":"2026-05-27T06:04:14.028763Z","steps":["trace[1097044926] 'process raft request' (duration: 189.942104ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:04:14.028967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.745331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T06:04:14.029002Z","caller":"traceutil/trace.go:171","msg":"trace[1286369322] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:983; }","duration":"144.838393ms","start":"2026-05-27T06:04:13.884152Z","end":"2026-05-27T06:04:14.02899Z","steps":["trace[1286369322] 'agreement among raft nodes before linearized reading' (duration: 144.658108ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:04:14.029122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.164808ms","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-27T06:04:14.02924Z","caller":"traceutil/trace.go:171","msg":"trace[1976029065] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:983; }","duration":"138.326592ms","start":"2026-05-27T06:04:13.890888Z","end":"2026-05-27T06:04:14.029215Z","steps":["trace[1976029065] 'agreement among raft nodes before linearized reading' (duration: 137.90682ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T06:04:14.035836Z","caller":"traceutil/trace.go:171","msg":"trace[31505924] transaction","detail":"{read_only:false; response_revision:984; number_of_response:1; }","duration":"123.594334ms","start":"2026-05-27T06:04:13.912228Z","end":"2026-05-27T06:04:14.035822Z","steps":["trace[31505924] 'process raft request' (duration: 123.401499ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T06:04:14.035889Z","caller":"traceutil/trace.go:171","msg":"trace[571412823] transaction","detail":"{read_only:false; response_revision:985; number_of_response:1; }","duration":"121.150167ms","start":"2026-05-27T06:04:13.914718Z","end":"2026-05-27T06:04:14.035869Z","steps":["trace[571412823] 'process raft request' (duration: 121.013423ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:04:34.133705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.922801ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T06:04:34.133782Z","caller":"traceutil/trace.go:171","msg":"trace[503786353] transaction","detail":"{read_only:false; response_revision:1047; number_of_response:1; }","duration":"708.087344ms","start":"2026-05-27T06:04:33.42568Z","end":"2026-05-27T06:04:34.133767Z","steps":["trace[503786353] 'process raft request' (duration: 289.02409ms)","trace[503786353] 'compare' (duration: 418.711714ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T06:04:34.133829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:04:33.425659Z","time spent":"708.144155ms","remote":"127.0.0.1:57472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T06:04:34.681674Z","caller":"traceutil/trace.go:171","msg":"trace[1525079447] linearizableReadLoop","detail":"{readStateIndex:1091; appliedIndex:1089; }","duration":"1.050622804s","start":"2026-05-27T06:04:33.630987Z","end":"2026-05-27T06:04:34.68161Z","steps":["trace[1525079447] 'read index received' (duration: 83.737985ms)","trace[1525079447] 'applied index is now lower than readState.Index' (duration: 966.883619ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T06:04:34.681937Z","caller":"traceutil/trace.go:171","msg":"trace[541209674] transaction","detail":"{read_only:false; response_revision:1048; number_of_response:1; }","duration":"1.248881404s","start":"2026-05-27T06:04:33.433022Z","end":"2026-05-27T06:04:34.681903Z","steps":["trace[541209674] 'process raft request' (duration: 1.22560271s)","trace[541209674] 'compare' (duration: 22.802921ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T06:04:34.682231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:04:33.432992Z","time spent":"1.24910605s","remote":"127.0.0.1:57702","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T06:04:34.682418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.051390485s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-27T06:04:34.682523Z","caller":"traceutil/trace.go:171","msg":"trace[413357444] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:1048; }","duration":"1.051550339s","start":"2026-05-27T06:04:33.630951Z","end":"2026-05-27T06:04:34.682501Z","steps":["trace[413357444] 'agreement among raft nodes before linearized reading' (duration: 1.051313213s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:04:34.682577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:04:33.630936Z","time spent":"1.051629412s","remote":"127.0.0.1:57888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":4,"response size":30,"request content":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true "} {"level":"warn","ts":"2026-05-27T06:04:34.689188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"803.834891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-27T06:04:34.689293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.917275ms","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-27T06:04:34.689332Z","caller":"traceutil/trace.go:171","msg":"trace[2127688745] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1050; }","duration":"803.995327ms","start":"2026-05-27T06:04:33.885268Z","end":"2026-05-27T06:04:34.689263Z","steps":["trace[2127688745] 'agreement among raft nodes before linearized reading' (duration: 803.816471ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:04:34.689338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"552.188314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-27T06:04:34.689408Z","caller":"traceutil/trace.go:171","msg":"trace[2106657608] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1050; }","duration":"552.305568ms","start":"2026-05-27T06:04:34.137086Z","end":"2026-05-27T06:04:34.689392Z","steps":["trace[2106657608] 'agreement among raft nodes before linearized reading' (duration: 552.098992ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:04:34.689452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:04:34.137076Z","time spent":"552.3651ms","remote":"127.0.0.1:57702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-27T06:04:34.689569Z","caller":"traceutil/trace.go:171","msg":"trace[140111649] transaction","detail":"{read_only:false; response_revision:1049; number_of_response:1; }","duration":"688.456781ms","start":"2026-05-27T06:04:34.00109Z","end":"2026-05-27T06:04:34.689547Z","steps":["trace[140111649] 'process raft request' (duration: 687.654559ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T06:04:34.689641Z","caller":"traceutil/trace.go:171","msg":"trace[1279777372] transaction","detail":"{read_only:false; response_revision:1050; number_of_response:1; }","duration":"149.581305ms","start":"2026-05-27T06:04:34.540031Z","end":"2026-05-27T06:04:34.689612Z","steps":["trace[1279777372] 'process raft request' (duration: 149.001659ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:04:34.689734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.409517ms","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-27T06:04:34.689665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:04:34.001069Z","time spent":"688.533404ms","remote":"127.0.0.1:57702","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T06:04:34.689778Z","caller":"traceutil/trace.go:171","msg":"trace[1420002560] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1050; }","duration":"184.49976ms","start":"2026-05-27T06:04:34.505267Z","end":"2026-05-27T06:04:34.689767Z","steps":["trace[1420002560] 'agreement among raft nodes before linearized reading' (duration: 184.373967ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T06:04:34.68936Z","caller":"traceutil/trace.go:171","msg":"trace[870277345] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1050; }","duration":"184.039067ms","start":"2026-05-27T06:04:34.505304Z","end":"2026-05-27T06:04:34.689343Z","steps":["trace[870277345] 'agreement among raft nodes before linearized reading' (duration: 183.823141ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:04:34.689952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.664002ms","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-27T06:04:34.690068Z","caller":"traceutil/trace.go:171","msg":"trace[1333069950] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1050; }","duration":"555.811645ms","start":"2026-05-27T06:04:34.134221Z","end":"2026-05-27T06:04:34.690033Z","steps":["trace[1333069950] 'agreement among raft nodes before linearized reading' (duration: 555.363523ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:04:34.690137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:04:34.134206Z","time spent":"555.907878ms","remote":"127.0.0.1:57702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-27T06:04:34.690296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"554.735625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"} {"level":"info","ts":"2026-05-27T06:04:34.690351Z","caller":"traceutil/trace.go:171","msg":"trace[1572331085] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:1050; }","duration":"554.854538ms","start":"2026-05-27T06:04:34.135483Z","end":"2026-05-27T06:04:34.690337Z","steps":["trace[1572331085] 'agreement among raft nodes before linearized reading' (duration: 554.095077ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:04:34.690384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:04:34.13547Z","time spent":"554.906219ms","remote":"127.0.0.1:57604","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":444,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"warn","ts":"2026-05-27T06:04:34.690557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:04:33.885238Z","time spent":"805.301952ms","remote":"127.0.0.1:57416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-27T06:05:08.07555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.546047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T06:05:08.075797Z","caller":"traceutil/trace.go:171","msg":"trace[532104695] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1231; }","duration":"190.911948ms","start":"2026-05-27T06:05:07.884852Z","end":"2026-05-27T06:05:08.075764Z","steps":["trace[532104695] 'range keys from in-memory index tree' (duration: 190.422243ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T06:05:09.302078Z","caller":"traceutil/trace.go:171","msg":"trace[1469329907] transaction","detail":"{read_only:false; response_revision:1238; number_of_response:1; }","duration":"281.638395ms","start":"2026-05-27T06:05:09.020414Z","end":"2026-05-27T06:05:09.302052Z","steps":["trace[1469329907] 'process raft request' (duration: 212.73543ms)","trace[1469329907] 'compare' (duration: 68.513654ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T06:05:09.302948Z","caller":"traceutil/trace.go:171","msg":"trace[996480987] linearizableReadLoop","detail":"{readStateIndex:1291; appliedIndex:1289; }","duration":"262.482116ms","start":"2026-05-27T06:05:09.040455Z","end":"2026-05-27T06:05:09.302937Z","steps":["trace[996480987] 'read index received' (duration: 192.82059ms)","trace[996480987] 'applied index is now lower than readState.Index' (duration: 69.660606ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T06:05:09.303039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.567619ms","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-27T06:05:09.303073Z","caller":"traceutil/trace.go:171","msg":"trace[744505481] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1240; }","duration":"262.64357ms","start":"2026-05-27T06:05:09.040419Z","end":"2026-05-27T06:05:09.303063Z","steps":["trace[744505481] 'agreement among raft nodes before linearized reading' (duration: 262.559948ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T06:05:09.303066Z","caller":"traceutil/trace.go:171","msg":"trace[1736171664] transaction","detail":"{read_only:false; response_revision:1239; number_of_response:1; }","duration":"281.384348ms","start":"2026-05-27T06:05:09.021624Z","end":"2026-05-27T06:05:09.303008Z","steps":["trace[1736171664] 'process raft request' (duration: 281.224523ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T06:05:09.303188Z","caller":"traceutil/trace.go:171","msg":"trace[2007447428] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"246.981747ms","start":"2026-05-27T06:05:09.056198Z","end":"2026-05-27T06:05:09.303179Z","steps":["trace[2007447428] 'process raft request' (duration: 246.7081ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:05:09.856861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.114935ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-27T06:05:09.856965Z","caller":"traceutil/trace.go:171","msg":"trace[1273450302] transaction","detail":"{read_only:false; response_revision:1242; number_of_response:1; }","duration":"548.212865ms","start":"2026-05-27T06:05:09.308732Z","end":"2026-05-27T06:05:09.856945Z","steps":["trace[1273450302] 'process raft request' (duration: 259.930476ms)","trace[1273450302] 'compare' (duration: 287.777685ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T06:05:09.857017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:05:09.308693Z","time spent":"548.303998ms","remote":"127.0.0.1:57702","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":457,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T06:05:21.320076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.327321ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T06:05:21.320217Z","caller":"traceutil/trace.go:171","msg":"trace[1912248010] linearizableReadLoop","detail":"{readStateIndex:1377; appliedIndex:1376; }","duration":"226.861101ms","start":"2026-05-27T06:05:21.093332Z","end":"2026-05-27T06:05:21.320193Z","steps":["trace[1912248010] 'read index received' (duration: 6.231331ms)","trace[1912248010] 'applied index is now lower than readState.Index' (duration: 220.62821ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T06:05:21.320293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.964205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-27T06:05:21.320264Z","caller":"traceutil/trace.go:171","msg":"trace[1652941207] transaction","detail":"{read_only:false; response_revision:1323; number_of_response:1; }","duration":"251.330048ms","start":"2026-05-27T06:05:21.068889Z","end":"2026-05-27T06:05:21.320219Z","steps":["trace[1652941207] 'process raft request' (duration: 30.76108ms)","trace[1652941207] 'compare' (duration: 220.206348ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T06:05:21.32034Z","caller":"traceutil/trace.go:171","msg":"trace[1608164892] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:1323; }","duration":"227.046946ms","start":"2026-05-27T06:05:21.093278Z","end":"2026-05-27T06:05:21.320325Z","steps":["trace[1608164892] 'agreement among raft nodes before linearized reading' (duration: 226.973825ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T06:05:22.609682Z","caller":"traceutil/trace.go:171","msg":"trace[1931228542] transaction","detail":"{read_only:false; response_revision:1327; number_of_response:1; }","duration":"472.151702ms","start":"2026-05-27T06:05:22.137497Z","end":"2026-05-27T06:05:22.609649Z","steps":["trace[1931228542] 'process raft request' (duration: 471.973337ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:05:22.609864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:05:22.137482Z","time spent":"472.284446ms","remote":"127.0.0.1:57702","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T06:05:23.296205Z","caller":"traceutil/trace.go:171","msg":"trace[1711490850] transaction","detail":"{read_only:false; response_revision:1328; number_of_response:1; }","duration":"511.16635ms","start":"2026-05-27T06:05:22.785014Z","end":"2026-05-27T06:05:23.29618Z","steps":["trace[1711490850] 'process raft request' (duration: 510.999906ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T06:05:23.296244Z","caller":"traceutil/trace.go:171","msg":"trace[1402460983] linearizableReadLoop","detail":"{readStateIndex:1382; appliedIndex:1382; }","duration":"494.87513ms","start":"2026-05-27T06:05:22.801336Z","end":"2026-05-27T06:05:23.296212Z","steps":["trace[1402460983] 'read index received' (duration: 494.85752ms)","trace[1402460983] 'applied index is now lower than readState.Index' (duration: 14.51µs)"],"step_count":2} {"level":"warn","ts":"2026-05-27T06:05:23.296357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:05:22.784987Z","time spent":"511.293724ms","remote":"127.0.0.1:57702","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T06:05:23.29647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.102597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T06:05:23.296541Z","caller":"traceutil/trace.go:171","msg":"trace[1081059855] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1328; }","duration":"495.24005ms","start":"2026-05-27T06:05:22.80128Z","end":"2026-05-27T06:05:23.29652Z","steps":["trace[1081059855] 'agreement among raft nodes before linearized reading' (duration: 495.069306ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:05:23.29663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:05:22.801254Z","time spent":"495.350644ms","remote":"127.0.0.1:37598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-05-27T06:05:23.305499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.937635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-27T06:05:23.305546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.35505ms","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-27T06:05:23.305586Z","caller":"traceutil/trace.go:171","msg":"trace[662715121] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:1329; }","duration":"422.106669ms","start":"2026-05-27T06:05:22.883461Z","end":"2026-05-27T06:05:23.305567Z","steps":["trace[662715121] 'agreement among raft nodes before linearized reading' (duration: 421.906283ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:05:23.30564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:05:22.883439Z","time spent":"422.190021ms","remote":"127.0.0.1:37652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"info","ts":"2026-05-27T06:05:23.305746Z","caller":"traceutil/trace.go:171","msg":"trace[2124896313] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1329; }","duration":"293.501214ms","start":"2026-05-27T06:05:23.012105Z","end":"2026-05-27T06:05:23.305606Z","steps":["trace[2124896313] 'agreement among raft nodes before linearized reading' (duration: 293.338099ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:05:23.305783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.716313ms","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-27T06:05:23.30587Z","caller":"traceutil/trace.go:171","msg":"trace[2053887546] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1329; }","duration":"372.814757ms","start":"2026-05-27T06:05:22.933019Z","end":"2026-05-27T06:05:23.305833Z","steps":["trace[2053887546] 'agreement among raft nodes before linearized reading' (duration: 372.641161ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:05:23.30592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:05:22.933006Z","time spent":"372.902368ms","remote":"127.0.0.1:57702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-27T06:05:23.305988Z","caller":"traceutil/trace.go:171","msg":"trace[324275771] transaction","detail":"{read_only:false; response_revision:1329; number_of_response:1; }","duration":"412.638908ms","start":"2026-05-27T06:05:22.893321Z","end":"2026-05-27T06:05:23.30596Z","steps":["trace[324275771] 'process raft request' (duration: 411.918238ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:05:23.306097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.086313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-05-27T06:05:23.306123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T06:05:22.893301Z","time spent":"412.746661ms","remote":"127.0.0.1:57702","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T06:05:23.306147Z","caller":"traceutil/trace.go:171","msg":"trace[1792455340] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1329; }","duration":"263.148014ms","start":"2026-05-27T06:05:23.042975Z","end":"2026-05-27T06:05:23.306123Z","steps":["trace[1792455340] 'agreement among raft nodes before linearized reading' (duration: 263.01011ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T06:07:20.041586Z","caller":"traceutil/trace.go:171","msg":"trace[440751790] transaction","detail":"{read_only:false; response_revision:1865; number_of_response:1; }","duration":"132.973011ms","start":"2026-05-27T06:07:19.908587Z","end":"2026-05-27T06:07:20.04156Z","steps":["trace[440751790] 'process raft request' (duration: 124.32621ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T06:07:20.041582Z","caller":"traceutil/trace.go:171","msg":"trace[1661185121] linearizableReadLoop","detail":"{readStateIndex:1943; appliedIndex:1942; }","duration":"129.70116ms","start":"2026-05-27T06:07:19.911847Z","end":"2026-05-27T06:07:20.041548Z","steps":["trace[1661185121] 'read index received' (duration: 120.934805ms)","trace[1661185121] 'applied index is now lower than readState.Index' (duration: 8.764715ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T06:07:20.041804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.935497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-27T06:07:20.041886Z","caller":"traceutil/trace.go:171","msg":"trace[264531083] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1865; }","duration":"130.04879ms","start":"2026-05-27T06:07:19.911821Z","end":"2026-05-27T06:07:20.04187Z","steps":["trace[264531083] 'agreement among raft nodes before linearized reading' (duration: 129.829034ms)"],"step_count":1}