{"level":"warn","ts":"2026-05-22T00:43:40.55299Z","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-22T00:43:40.55309Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.3: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.3:2380","--initial-cluster=instance=https://199.204.45.3:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.3:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.3: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-22T00:43:40.553171Z","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-22T00:43:40.553184Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.3:2380"]} {"level":"info","ts":"2026-05-22T00:43:40.553203Z","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-22T00:43:40.553894Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"]} {"level":"info","ts":"2026-05-22T00:43:40.554014Z","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.3:2380"],"listen-peer-urls":["https://199.204.45.3:2380"],"advertise-client-urls":["https://199.204.45.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.3: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-22T00:43:40.6956Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"137.786923ms"} {"level":"info","ts":"2026-05-22T00:43:40.709273Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"597401b06ce1cf3d","cluster-id":"dfc54657ad8a2432"} {"level":"info","ts":"2026-05-22T00:43:40.709377Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=()"} {"level":"info","ts":"2026-05-22T00:43:40.709399Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became follower at term 0"} {"level":"info","ts":"2026-05-22T00:43:40.70941Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 597401b06ce1cf3d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-22T00:43:40.709453Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became follower at term 1"} {"level":"info","ts":"2026-05-22T00:43:40.709575Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=(6445778823926632253)"} {"level":"warn","ts":"2026-05-22T00:43:40.721459Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-22T00:43:40.724869Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-22T00:43:40.727097Z","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-22T00:43:40.730265Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"597401b06ce1cf3d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-22T00:43:40.730598Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"597401b06ce1cf3d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-22T00:43:40.730642Z","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-22T00:43:40.730657Z","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-22T00:43:40.730663Z","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-22T00:43:40.731169Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=(6445778823926632253)"} {"level":"info","ts":"2026-05-22T00:43:40.731263Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"dfc54657ad8a2432","local-member-id":"597401b06ce1cf3d","added-peer-id":"597401b06ce1cf3d","added-peer-peer-urls":["https://199.204.45.3:2380"]} {"level":"info","ts":"2026-05-22T00:43:40.745659Z","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-22T00:43:40.745802Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.3:2380"} {"level":"info","ts":"2026-05-22T00:43:40.745872Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.3:2380"} {"level":"info","ts":"2026-05-22T00:43:40.746542Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"597401b06ce1cf3d","initial-advertise-peer-urls":["https://199.204.45.3:2380"],"listen-peer-urls":["https://199.204.45.3:2380"],"advertise-client-urls":["https://199.204.45.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-22T00:43:40.746575Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-22T00:43:41.210392Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d is starting a new election at term 1"} {"level":"info","ts":"2026-05-22T00:43:41.21048Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became pre-candidate at term 1"} {"level":"info","ts":"2026-05-22T00:43:41.210526Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d received MsgPreVoteResp from 597401b06ce1cf3d at term 1"} {"level":"info","ts":"2026-05-22T00:43:41.210548Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became candidate at term 2"} {"level":"info","ts":"2026-05-22T00:43:41.21056Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d received MsgVoteResp from 597401b06ce1cf3d at term 2"} {"level":"info","ts":"2026-05-22T00:43:41.210584Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became leader at term 2"} {"level":"info","ts":"2026-05-22T00:43:41.210598Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 597401b06ce1cf3d elected leader 597401b06ce1cf3d at term 2"} {"level":"info","ts":"2026-05-22T00:43:41.211585Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"597401b06ce1cf3d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.3:2379]}","request-path":"/0/members/597401b06ce1cf3d/attributes","cluster-id":"dfc54657ad8a2432","publish-timeout":"7s"} {"level":"info","ts":"2026-05-22T00:43:41.211632Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-22T00:43:41.212136Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-22T00:43:41.212443Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-22T00:43:41.212782Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-22T00:43:41.212823Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-22T00:43:41.215771Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.3:2379"} {"level":"info","ts":"2026-05-22T00:43:41.215937Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-22T00:43:41.216515Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"dfc54657ad8a2432","local-member-id":"597401b06ce1cf3d","cluster-version":"3.5"} {"level":"info","ts":"2026-05-22T00:43:41.216608Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-22T00:43:41.216634Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-22T00:43:43.869561Z","caller":"traceutil/trace.go:171","msg":"trace[1028569623] linearizableReadLoop","detail":"{readStateIndex:118; appliedIndex:117; }","duration":"315.522343ms","start":"2026-05-22T00:43:43.554011Z","end":"2026-05-22T00:43:43.869533Z","steps":["trace[1028569623] 'read index received' (duration: 304.232518ms)","trace[1028569623] 'applied index is now lower than readState.Index' (duration: 11.288905ms)"],"step_count":2} {"level":"warn","ts":"2026-05-22T00:43:43.869749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.720076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-22T00:43:43.869813Z","caller":"traceutil/trace.go:171","msg":"trace[1379906945] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:113; }","duration":"315.824772ms","start":"2026-05-22T00:43:43.553978Z","end":"2026-05-22T00:43:43.869803Z","steps":["trace[1379906945] 'agreement among raft nodes before linearized reading' (duration: 315.657988ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:43:43.8698Z","caller":"traceutil/trace.go:171","msg":"trace[832181327] transaction","detail":"{read_only:false; response_revision:113; number_of_response:1; }","duration":"392.254782ms","start":"2026-05-22T00:43:43.477486Z","end":"2026-05-22T00:43:43.869741Z","steps":["trace[832181327] 'process raft request' (duration: 380.722205ms)","trace[832181327] 'compare' (duration: 11.211948ms)"],"step_count":2} {"level":"warn","ts":"2026-05-22T00:43:43.869853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:43:43.553963Z","time spent":"315.879171ms","remote":"127.0.0.1:51040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-22T00:43:43.870401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:43:43.477476Z","time spent":"392.377877ms","remote":"127.0.0.1:51352","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-22T00:44:03.535019Z","caller":"traceutil/trace.go:171","msg":"trace[45729662] transaction","detail":"{read_only:false; response_revision:426; number_of_response:1; }","duration":"105.212616ms","start":"2026-05-22T00:44:03.429778Z","end":"2026-05-22T00:44:03.534991Z","steps":["trace[45729662] 'process raft request' (duration: 105.064897ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:44:03.696771Z","caller":"traceutil/trace.go:171","msg":"trace[1116426109] linearizableReadLoop","detail":"{readStateIndex:442; appliedIndex:441; }","duration":"153.657065ms","start":"2026-05-22T00:44:03.543082Z","end":"2026-05-22T00:44:03.696739Z","steps":["trace[1116426109] 'read index received' (duration: 153.428367ms)","trace[1116426109] 'applied index is now lower than readState.Index' (duration: 227.608µs)"],"step_count":2} {"level":"info","ts":"2026-05-22T00:44:03.696827Z","caller":"traceutil/trace.go:171","msg":"trace[588726195] transaction","detail":"{read_only:false; response_revision:427; number_of_response:1; }","duration":"155.510095ms","start":"2026-05-22T00:44:03.541279Z","end":"2026-05-22T00:44:03.696789Z","steps":["trace[588726195] 'process raft request' (duration: 155.267337ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:03.696922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.957172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-22T00:44:03.696965Z","caller":"traceutil/trace.go:171","msg":"trace[1563929655] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:427; }","duration":"154.056221ms","start":"2026-05-22T00:44:03.542897Z","end":"2026-05-22T00:44:03.696953Z","steps":["trace[1563929655] 'agreement among raft nodes before linearized reading' (duration: 153.947912ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:03.970046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.926907ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-22T00:44:03.970374Z","caller":"traceutil/trace.go:171","msg":"trace[518383342] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"268.080619ms","start":"2026-05-22T00:44:03.702267Z","end":"2026-05-22T00:44:03.970348Z","steps":["trace[518383342] 'process raft request' (duration: 267.905181ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:44:03.970467Z","caller":"traceutil/trace.go:171","msg":"trace[559483433] transaction","detail":"{read_only:false; response_revision:431; number_of_response:1; }","duration":"266.392808ms","start":"2026-05-22T00:44:03.704045Z","end":"2026-05-22T00:44:03.970438Z","steps":["trace[559483433] 'process raft request' (duration: 266.182971ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:44:03.970777Z","caller":"traceutil/trace.go:171","msg":"trace[438586858] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"268.567044ms","start":"2026-05-22T00:44:03.701691Z","end":"2026-05-22T00:44:03.970258Z","steps":["trace[438586858] 'process raft request' (duration: 108.204872ms)","trace[438586858] 'compare' (duration: 159.772218ms)"],"step_count":2} {"level":"info","ts":"2026-05-22T00:44:04.385969Z","caller":"traceutil/trace.go:171","msg":"trace[1898211002] transaction","detail":"{read_only:false; response_revision:444; number_of_response:1; }","duration":"178.661819ms","start":"2026-05-22T00:44:04.207279Z","end":"2026-05-22T00:44:04.38594Z","steps":["trace[1898211002] 'process raft request' (duration: 178.59318ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:44:04.386005Z","caller":"traceutil/trace.go:171","msg":"trace[1015505324] transaction","detail":"{read_only:false; response_revision:443; number_of_response:1; }","duration":"181.032875ms","start":"2026-05-22T00:44:04.204927Z","end":"2026-05-22T00:44:04.38596Z","steps":["trace[1015505324] 'process raft request' (duration: 151.076091ms)","trace[1015505324] 'compare' (duration: 29.698716ms)"],"step_count":2} {"level":"info","ts":"2026-05-22T00:44:04.398388Z","caller":"traceutil/trace.go:171","msg":"trace[72672658] transaction","detail":"{read_only:false; response_revision:445; number_of_response:1; }","duration":"177.608749ms","start":"2026-05-22T00:44:04.220736Z","end":"2026-05-22T00:44:04.398345Z","steps":["trace[72672658] 'process raft request' (duration: 177.447651ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:44:04.398674Z","caller":"traceutil/trace.go:171","msg":"trace[681594379] transaction","detail":"{read_only:false; response_revision:447; number_of_response:1; }","duration":"177.467801ms","start":"2026-05-22T00:44:04.221177Z","end":"2026-05-22T00:44:04.398645Z","steps":["trace[681594379] 'process raft request' (duration: 177.346972ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:44:04.398654Z","caller":"traceutil/trace.go:171","msg":"trace[1864078730] transaction","detail":"{read_only:false; response_revision:446; number_of_response:1; }","duration":"177.569759ms","start":"2026-05-22T00:44:04.221067Z","end":"2026-05-22T00:44:04.398637Z","steps":["trace[1864078730] 'process raft request' (duration: 177.226172ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:04.748501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.937213ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-22T00:44:04.748775Z","caller":"traceutil/trace.go:171","msg":"trace[56282832] linearizableReadLoop","detail":"{readStateIndex:469; appliedIndex:465; }","duration":"299.522261ms","start":"2026-05-22T00:44:04.44921Z","end":"2026-05-22T00:44:04.748732Z","steps":["trace[56282832] 'read index received' (duration: 162.219192ms)","trace[56282832] 'applied index is now lower than readState.Index' (duration: 137.302199ms)"],"step_count":2} {"level":"info","ts":"2026-05-22T00:44:04.748855Z","caller":"traceutil/trace.go:171","msg":"trace[1768505600] transaction","detail":"{read_only:false; response_revision:449; number_of_response:1; }","duration":"345.809501ms","start":"2026-05-22T00:44:04.403035Z","end":"2026-05-22T00:44:04.748844Z","steps":["trace[1768505600] 'process raft request' (duration: 208.454443ms)","trace[1768505600] 'compare' (duration: 136.800384ms)"],"step_count":2} {"level":"warn","ts":"2026-05-22T00:44:04.748907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:44:04.403012Z","time spent":"345.869391ms","remote":"127.0.0.1:51080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-22T00:44:04.749127Z","caller":"traceutil/trace.go:171","msg":"trace[1080289331] transaction","detail":"{read_only:false; response_revision:450; number_of_response:1; }","duration":"345.279816ms","start":"2026-05-22T00:44:04.403839Z","end":"2026-05-22T00:44:04.749118Z","steps":["trace[1080289331] 'process raft request' (duration: 344.764261ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:04.749174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:44:04.40383Z","time spent":"345.320355ms","remote":"127.0.0.1:51080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":830,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-22T00:44:04.74946Z","caller":"traceutil/trace.go:171","msg":"trace[2106062880] transaction","detail":"{read_only:false; response_revision:451; number_of_response:1; }","duration":"343.215967ms","start":"2026-05-22T00:44:04.406234Z","end":"2026-05-22T00:44:04.74945Z","steps":["trace[2106062880] 'process raft request' (duration: 342.409266ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:44:04.749639Z","caller":"traceutil/trace.go:171","msg":"trace[267913338] transaction","detail":"{read_only:false; response_revision:452; number_of_response:1; }","duration":"343.241847ms","start":"2026-05-22T00:44:04.406377Z","end":"2026-05-22T00:44:04.749619Z","steps":["trace[267913338] 'process raft request' (duration: 342.314266ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:04.749881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.384012ms","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-22T00:44:04.749946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:44:04.406212Z","time spent":"343.384156ms","remote":"127.0.0.1:51198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4037,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-22T00:44:04.749968Z","caller":"traceutil/trace.go:171","msg":"trace[629784848] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:452; }","duration":"181.514391ms","start":"2026-05-22T00:44:04.56843Z","end":"2026-05-22T00:44:04.749944Z","steps":["trace[629784848] 'agreement among raft nodes before linearized reading' (duration: 181.329393ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:04.750075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:44:04.40636Z","time spent":"343.325537ms","remote":"127.0.0.1:51498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3840,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-22T00:44:04.75037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.735138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.3\" ","response":"range_response_count:1 size:131"} {"level":"warn","ts":"2026-05-22T00:44:04.750536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.327503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/coredns-7c96b6546b\" ","response":"range_response_count:1 size:3819"} {"level":"info","ts":"2026-05-22T00:44:04.750548Z","caller":"traceutil/trace.go:171","msg":"trace[1242314995] range","detail":"{range_begin:/registry/masterleases/199.204.45.3; range_end:; response_count:1; response_revision:452; }","duration":"193.941387ms","start":"2026-05-22T00:44:04.556593Z","end":"2026-05-22T00:44:04.750534Z","steps":["trace[1242314995] 'agreement among raft nodes before linearized reading' (duration: 192.978037ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:44:04.750596Z","caller":"traceutil/trace.go:171","msg":"trace[316362362] range","detail":"{range_begin:/registry/replicasets/kube-system/coredns-7c96b6546b; range_end:; response_count:1; response_revision:452; }","duration":"301.412391ms","start":"2026-05-22T00:44:04.449163Z","end":"2026-05-22T00:44:04.750575Z","steps":["trace[316362362] 'agreement among raft nodes before linearized reading' (duration: 300.505801ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:04.750641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:44:04.449149Z","time spent":"301.48467ms","remote":"127.0.0.1:51498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":3842,"request content":"key:\"/registry/replicasets/kube-system/coredns-7c96b6546b\" "} {"level":"info","ts":"2026-05-22T00:44:06.38552Z","caller":"traceutil/trace.go:171","msg":"trace[809758736] transaction","detail":"{read_only:false; response_revision:461; number_of_response:1; }","duration":"340.735101ms","start":"2026-05-22T00:44:06.044766Z","end":"2026-05-22T00:44:06.385502Z","steps":["trace[809758736] 'process raft request' (duration: 340.612992ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:06.385647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:44:06.044748Z","time spent":"340.83688ms","remote":"127.0.0.1:51262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-22T00:44:12.444377Z","caller":"traceutil/trace.go:171","msg":"trace[618135531] linearizableReadLoop","detail":"{readStateIndex:492; appliedIndex:491; }","duration":"414.075319ms","start":"2026-05-22T00:44:12.030277Z","end":"2026-05-22T00:44:12.444352Z","steps":["trace[618135531] 'read index received' (duration: 413.900869ms)","trace[618135531] 'applied index is now lower than readState.Index' (duration: 173.13µs)"],"step_count":2} {"level":"warn","ts":"2026-05-22T00:44:12.444502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.208759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-22T00:44:12.444569Z","caller":"traceutil/trace.go:171","msg":"trace[986884983] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:473; }","duration":"414.299799ms","start":"2026-05-22T00:44:12.03023Z","end":"2026-05-22T00:44:12.444529Z","steps":["trace[986884983] 'agreement among raft nodes before linearized reading' (duration: 414.223238ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:12.444611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:44:12.030213Z","time spent":"414.391049ms","remote":"127.0.0.1:51040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-22T00:44:12.444707Z","caller":"traceutil/trace.go:171","msg":"trace[12460707] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"547.205103ms","start":"2026-05-22T00:44:11.89747Z","end":"2026-05-22T00:44:12.444675Z","steps":["trace[12460707] 'process raft request' (duration: 546.730473ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:12.444908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:44:11.897448Z","time spent":"547.345952ms","remote":"127.0.0.1:51262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-22T00:44:12.951127Z","caller":"traceutil/trace.go:171","msg":"trace[246678675] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"103.226045ms","start":"2026-05-22T00:44:12.84788Z","end":"2026-05-22T00:44:12.951106Z","steps":["trace[246678675] 'process raft request' (duration: 103.088935ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:44:14.554377Z","caller":"traceutil/trace.go:171","msg":"trace[1754883743] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"100.614352ms","start":"2026-05-22T00:44:14.453741Z","end":"2026-05-22T00:44:14.554355Z","steps":["trace[1754883743] 'process raft request' (duration: 100.449572ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:14.774281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.451803ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-22T00:44:14.774381Z","caller":"traceutil/trace.go:171","msg":"trace[1002834404] linearizableReadLoop","detail":"{readStateIndex:498; appliedIndex:497; }","duration":"216.247922ms","start":"2026-05-22T00:44:14.558116Z","end":"2026-05-22T00:44:14.774364Z","steps":["trace[1002834404] 'read index received' (duration: 80.585459ms)","trace[1002834404] 'applied index is now lower than readState.Index' (duration: 135.660913ms)"],"step_count":2} {"level":"warn","ts":"2026-05-22T00:44:14.774485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.365962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.3\" ","response":"range_response_count:1 size:131"} {"level":"info","ts":"2026-05-22T00:44:14.774514Z","caller":"traceutil/trace.go:171","msg":"trace[1388270591] range","detail":"{range_begin:/registry/masterleases/199.204.45.3; range_end:; response_count:1; response_revision:479; }","duration":"216.443482ms","start":"2026-05-22T00:44:14.558062Z","end":"2026-05-22T00:44:14.774505Z","steps":["trace[1388270591] 'agreement among raft nodes before linearized reading' (duration: 216.360532ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:44:14.774867Z","caller":"traceutil/trace.go:171","msg":"trace[824018980] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"216.889632ms","start":"2026-05-22T00:44:14.557954Z","end":"2026-05-22T00:44:14.774844Z","steps":["trace[824018980] 'process raft request' (duration: 80.791309ms)","trace[824018980] 'compare' (duration: 135.336993ms)"],"step_count":2} {"level":"warn","ts":"2026-05-22T00:44:15.303552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.810651ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-22T00:44:15.303648Z","caller":"traceutil/trace.go:171","msg":"trace[583574496] linearizableReadLoop","detail":"{readStateIndex:500; appliedIndex:499; }","duration":"348.32889ms","start":"2026-05-22T00:44:14.955298Z","end":"2026-05-22T00:44:15.303627Z","steps":["trace[583574496] 'read index received' (duration: 57.41µs)","trace[583574496] 'applied index is now lower than readState.Index' (duration: 348.27057ms)"],"step_count":2} {"level":"warn","ts":"2026-05-22T00:44:15.303756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.4756ms","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-22T00:44:15.30379Z","caller":"traceutil/trace.go:171","msg":"trace[1706673212] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:480; }","duration":"348.55163ms","start":"2026-05-22T00:44:14.955229Z","end":"2026-05-22T00:44:15.303781Z","steps":["trace[1706673212] 'agreement among raft nodes before linearized reading' (duration: 348.47546ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:15.303823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:44:14.955207Z","time spent":"348.60741ms","remote":"127.0.0.1:51262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-22T00:44:15.303754Z","caller":"traceutil/trace.go:171","msg":"trace[1040876475] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"464.12313ms","start":"2026-05-22T00:44:14.839593Z","end":"2026-05-22T00:44:15.303716Z","steps":["trace[1040876475] 'process raft request' (duration: 86.079248ms)","trace[1040876475] 'compare' (duration: 377.676001ms)"],"step_count":2} {"level":"warn","ts":"2026-05-22T00:44:15.303997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:44:14.839569Z","time spent":"464.3089ms","remote":"127.0.0.1:51056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":116,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-22T00:44:15.304127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.715471ms","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-22T00:44:15.304236Z","caller":"traceutil/trace.go:171","msg":"trace[931680558] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:480; }","duration":"245.867971ms","start":"2026-05-22T00:44:15.05835Z","end":"2026-05-22T00:44:15.304218Z","steps":["trace[931680558] 'agreement among raft nodes before linearized reading' (duration: 245.679311ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:44:15.505966Z","caller":"traceutil/trace.go:171","msg":"trace[711473700] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"198.199071ms","start":"2026-05-22T00:44:15.307748Z","end":"2026-05-22T00:44:15.505947Z","steps":["trace[711473700] 'process raft request' (duration: 198.083471ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:44:15.550152Z","caller":"traceutil/trace.go:171","msg":"trace[1518928966] linearizableReadLoop","detail":"{readStateIndex:502; appliedIndex:500; }","duration":"241.681069ms","start":"2026-05-22T00:44:15.30845Z","end":"2026-05-22T00:44:15.550131Z","steps":["trace[1518928966] 'read index received' (duration: 197.411891ms)","trace[1518928966] 'applied index is now lower than readState.Index' (duration: 44.268298ms)"],"step_count":2} {"level":"warn","ts":"2026-05-22T00:44:15.550284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.810499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-22T00:44:15.550308Z","caller":"traceutil/trace.go:171","msg":"trace[708361560] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:482; }","duration":"241.869009ms","start":"2026-05-22T00:44:15.308431Z","end":"2026-05-22T00:44:15.5503Z","steps":["trace[708361560] 'agreement among raft nodes before linearized reading' (duration: 241.783389ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:44:15.550465Z","caller":"traceutil/trace.go:171","msg":"trace[455872867] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"242.320479ms","start":"2026-05-22T00:44:15.308118Z","end":"2026-05-22T00:44:15.550438Z","steps":["trace[455872867] 'process raft request' (duration: 241.872429ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:44:18.697288Z","caller":"traceutil/trace.go:171","msg":"trace[937674353] linearizableReadLoop","detail":"{readStateIndex:543; appliedIndex:542; }","duration":"120.382583ms","start":"2026-05-22T00:44:18.576882Z","end":"2026-05-22T00:44:18.697264Z","steps":["trace[937674353] 'read index received' (duration: 120.201913ms)","trace[937674353] 'applied index is now lower than readState.Index' (duration: 179.54µs)"],"step_count":2} {"level":"warn","ts":"2026-05-22T00:44:18.697447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.534515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-22T00:44:18.697483Z","caller":"traceutil/trace.go:171","msg":"trace[1569617835] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:523; }","duration":"120.602635ms","start":"2026-05-22T00:44:18.576868Z","end":"2026-05-22T00:44:18.697471Z","steps":["trace[1569617835] 'agreement among raft nodes before linearized reading' (duration: 120.523075ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:44:18.69754Z","caller":"traceutil/trace.go:171","msg":"trace[2122115006] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"126.164822ms","start":"2026-05-22T00:44:18.571355Z","end":"2026-05-22T00:44:18.69752Z","steps":["trace[2122115006] 'process raft request' (duration: 125.75318ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:19.531514Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933265993572624787,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-22T00:44:19.830664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.043323126s","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-22T00:44:19.830739Z","caller":"traceutil/trace.go:171","msg":"trace[1922935047] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:523; }","duration":"1.043444407s","start":"2026-05-22T00:44:18.787278Z","end":"2026-05-22T00:44:19.830722Z","steps":["trace[1922935047] 'range keys from in-memory index tree' (duration: 1.043202486s)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:19.830779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:44:18.787259Z","time spent":"1.043512568s","remote":"127.0.0.1:51262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-22T00:44:19.841893Z","caller":"traceutil/trace.go:171","msg":"trace[728076757] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"936.097455ms","start":"2026-05-22T00:44:18.905729Z","end":"2026-05-22T00:44:19.841826Z","steps":["trace[728076757] 'process raft request' (duration: 935.782864ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:19.842029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:44:18.905713Z","time spent":"936.247296ms","remote":"127.0.0.1:51062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-22T00:44:19.852419Z","caller":"traceutil/trace.go:171","msg":"trace[322117931] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"934.863629ms","start":"2026-05-22T00:44:18.917527Z","end":"2026-05-22T00:44:19.85239Z","steps":["trace[322117931] 'process raft request' (duration: 934.451558ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:19.852522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:44:18.917509Z","time spent":"934.96915ms","remote":"127.0.0.1:51062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-22T00:44:19.85269Z","caller":"traceutil/trace.go:171","msg":"trace[597001150] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"943.070156ms","start":"2026-05-22T00:44:18.909609Z","end":"2026-05-22T00:44:19.852679Z","steps":["trace[597001150] 'process raft request' (duration: 942.154482ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:19.852741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:44:18.909581Z","time spent":"943.138696ms","remote":"127.0.0.1:51062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-22T00:44:19.852821Z","caller":"traceutil/trace.go:171","msg":"trace[1807999200] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"943.129187ms","start":"2026-05-22T00:44:18.909684Z","end":"2026-05-22T00:44:19.852813Z","steps":["trace[1807999200] 'process raft request' (duration: 942.186312ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:19.852864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:44:18.909677Z","time spent":"943.169397ms","remote":"127.0.0.1:51062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-22T00:44:19.852929Z","caller":"traceutil/trace.go:171","msg":"trace[1035551304] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"939.880866ms","start":"2026-05-22T00:44:18.913043Z","end":"2026-05-22T00:44:19.852924Z","steps":["trace[1035551304] 'process raft request' (duration: 938.879022ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:19.852975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:44:18.913026Z","time spent":"939.935316ms","remote":"127.0.0.1:51062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-22T00:44:19.853173Z","caller":"traceutil/trace.go:171","msg":"trace[983109152] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"934.949941ms","start":"2026-05-22T00:44:18.918202Z","end":"2026-05-22T00:44:19.853151Z","steps":["trace[983109152] 'process raft request' (duration: 933.923336ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:19.853402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:44:18.918197Z","time spent":"935.040981ms","remote":"127.0.0.1:51062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-22T00:44:19.853337Z","caller":"traceutil/trace.go:171","msg":"trace[1913813992] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"925.830111ms","start":"2026-05-22T00:44:18.927499Z","end":"2026-05-22T00:44:19.853329Z","steps":["trace[1913813992] 'process raft request' (duration: 924.672446ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:19.853588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:44:18.927484Z","time spent":"926.076122ms","remote":"127.0.0.1:51062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-22T00:44:19.853593Z","caller":"traceutil/trace.go:171","msg":"trace[377305537] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"935.424282ms","start":"2026-05-22T00:44:18.918156Z","end":"2026-05-22T00:44:19.85358Z","steps":["trace[377305537] 'process raft request' (duration: 933.898586ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:19.85365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:44:18.918147Z","time spent":"935.474912ms","remote":"127.0.0.1:51062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-22T00:44:19.853734Z","caller":"traceutil/trace.go:171","msg":"trace[1460760394] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"935.548883ms","start":"2026-05-22T00:44:18.918176Z","end":"2026-05-22T00:44:19.853725Z","steps":["trace[1460760394] 'process raft request' (duration: 933.912436ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:19.853776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:44:18.918164Z","time spent":"935.594183ms","remote":"127.0.0.1:51062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-22T00:44:19.853861Z","caller":"traceutil/trace.go:171","msg":"trace[2043402033] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"917.088864ms","start":"2026-05-22T00:44:18.936748Z","end":"2026-05-22T00:44:19.853837Z","steps":["trace[2043402033] 'process raft request' (duration: 915.470248ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:44:19.853932Z","caller":"traceutil/trace.go:171","msg":"trace[931609117] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"888.650094ms","start":"2026-05-22T00:44:18.965275Z","end":"2026-05-22T00:44:19.853925Z","steps":["trace[931609117] 'process raft request' (duration: 887.128667ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:19.853973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:44:18.965248Z","time spent":"888.709424ms","remote":"127.0.0.1:51062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-22T00:44:19.853997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:44:18.936718Z","time spent":"917.215475ms","remote":"127.0.0.1:51062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-22T00:44:19.854188Z","caller":"traceutil/trace.go:171","msg":"trace[794176714] linearizableReadLoop","detail":"{readStateIndex:555; appliedIndex:543; }","duration":"823.720307ms","start":"2026-05-22T00:44:19.03046Z","end":"2026-05-22T00:44:19.85418Z","steps":["trace[794176714] 'read index received' (duration: 811.286467ms)","trace[794176714] 'applied index is now lower than readState.Index' (duration: 12.43208ms)"],"step_count":2} {"level":"info","ts":"2026-05-22T00:44:19.854227Z","caller":"traceutil/trace.go:171","msg":"trace[1531801316] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"771.254876ms","start":"2026-05-22T00:44:19.082957Z","end":"2026-05-22T00:44:19.854212Z","steps":["trace[1531801316] 'process raft request' (duration: 769.72832ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:19.854251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"823.789337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-22T00:44:19.85428Z","caller":"traceutil/trace.go:171","msg":"trace[196147541] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:537; }","duration":"823.845697ms","start":"2026-05-22T00:44:19.030423Z","end":"2026-05-22T00:44:19.854269Z","steps":["trace[196147541] 'agreement among raft nodes before linearized reading' (duration: 823.803067ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:19.854303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:44:19.030401Z","time spent":"823.897937ms","remote":"127.0.0.1:51040","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-22T00:44:19.8543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:44:19.082929Z","time spent":"771.341706ms","remote":"127.0.0.1:51062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-22T00:44:19.860708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.12599ms","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-22T00:44:19.860752Z","caller":"traceutil/trace.go:171","msg":"trace[280302088] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:538; }","duration":"344.223311ms","start":"2026-05-22T00:44:19.516519Z","end":"2026-05-22T00:44:19.860742Z","steps":["trace[280302088] 'agreement among raft nodes before linearized reading' (duration: 344.13898ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:19.860773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:44:19.516498Z","time spent":"344.270731ms","remote":"127.0.0.1:51262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-22T00:44:19.861079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.362038ms","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-22T00:44:19.861103Z","caller":"traceutil/trace.go:171","msg":"trace[1611161688] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:538; }","duration":"293.417218ms","start":"2026-05-22T00:44:19.567678Z","end":"2026-05-22T00:44:19.861095Z","steps":["trace[1611161688] 'agreement among raft nodes before linearized reading' (duration: 293.317377ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:26.256049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.000449ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-22T00:44:26.256236Z","caller":"traceutil/trace.go:171","msg":"trace[1412213335] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:650; }","duration":"227.331573ms","start":"2026-05-22T00:44:26.028885Z","end":"2026-05-22T00:44:26.256217Z","steps":["trace[1412213335] 'read index received' (duration: 95.101891ms)","trace[1412213335] 'applied index is now lower than readState.Index' (duration: 132.228202ms)"],"step_count":2} {"level":"warn","ts":"2026-05-22T00:44:26.256372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.484754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-22T00:44:26.256399Z","caller":"traceutil/trace.go:171","msg":"trace[1442491272] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:624; }","duration":"227.555174ms","start":"2026-05-22T00:44:26.028833Z","end":"2026-05-22T00:44:26.256388Z","steps":["trace[1442491272] 'agreement among raft nodes before linearized reading' (duration: 227.434933ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:44:26.256967Z","caller":"traceutil/trace.go:171","msg":"trace[1147740360] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"293.249057ms","start":"2026-05-22T00:44:25.963662Z","end":"2026-05-22T00:44:26.256911Z","steps":["trace[1147740360] 'process raft request' (duration: 160.266768ms)","trace[1147740360] 'compare' (duration: 131.798187ms)"],"step_count":2} {"level":"info","ts":"2026-05-22T00:44:26.257563Z","caller":"traceutil/trace.go:171","msg":"trace[1629635437] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"292.708821ms","start":"2026-05-22T00:44:25.964822Z","end":"2026-05-22T00:44:26.25753Z","steps":["trace[1629635437] 'process raft request' (duration: 291.335858ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:44:26.694377Z","caller":"traceutil/trace.go:171","msg":"trace[1451304092] linearizableReadLoop","detail":"{readStateIndex:653; appliedIndex:652; }","duration":"272.420719ms","start":"2026-05-22T00:44:26.421923Z","end":"2026-05-22T00:44:26.694344Z","steps":["trace[1451304092] 'read index received' (duration: 271.508391ms)","trace[1451304092] 'applied index is now lower than readState.Index' (duration: 910.968µs)"],"step_count":2} {"level":"info","ts":"2026-05-22T00:44:26.694425Z","caller":"traceutil/trace.go:171","msg":"trace[100045489] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"622.189092ms","start":"2026-05-22T00:44:26.072215Z","end":"2026-05-22T00:44:26.694404Z","steps":["trace[100045489] 'process raft request' (duration: 621.494375ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:26.694542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.601061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-l9mcn\" ","response":"range_response_count:1 size:16957"} {"level":"warn","ts":"2026-05-22T00:44:26.694561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:44:26.072186Z","time spent":"622.292662ms","remote":"127.0.0.1:51100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036153,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-22T00:44:26.694597Z","caller":"traceutil/trace.go:171","msg":"trace[1999197458] range","detail":"{range_begin:/registry/pods/kube-system/cilium-l9mcn; range_end:; response_count:1; response_revision:625; }","duration":"272.714752ms","start":"2026-05-22T00:44:26.421867Z","end":"2026-05-22T00:44:26.694582Z","steps":["trace[1999197458] 'agreement among raft nodes before linearized reading' (duration: 272.597761ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:27.234655Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933265993572625013,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-22T00:44:27.562987Z","caller":"traceutil/trace.go:171","msg":"trace[1421183111] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"849.774865ms","start":"2026-05-22T00:44:26.713188Z","end":"2026-05-22T00:44:27.562963Z","steps":["trace[1421183111] 'process raft request' (duration: 849.628023ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:27.563133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:44:26.713162Z","time spent":"849.891256ms","remote":"127.0.0.1:51198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17126,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-22T00:44:27.580465Z","caller":"traceutil/trace.go:171","msg":"trace[1509912012] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:653; }","duration":"846.003272ms","start":"2026-05-22T00:44:26.734441Z","end":"2026-05-22T00:44:27.580444Z","steps":["trace[1509912012] 'read index received' (duration: 828.386362ms)","trace[1509912012] 'applied index is now lower than readState.Index' (duration: 17.61602ms)"],"step_count":2} {"level":"info","ts":"2026-05-22T00:44:27.580555Z","caller":"traceutil/trace.go:171","msg":"trace[1910867152] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"712.235866ms","start":"2026-05-22T00:44:26.868294Z","end":"2026-05-22T00:44:27.58053Z","steps":["trace[1910867152] 'process raft request' (duration: 712.098414ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:44:27.580478Z","caller":"traceutil/trace.go:171","msg":"trace[128260911] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"826.8147ms","start":"2026-05-22T00:44:26.753641Z","end":"2026-05-22T00:44:27.580456Z","steps":["trace[128260911] 'process raft request' (duration: 826.630358ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:27.580614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"846.154593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-22T00:44:27.580672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.457385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-22T00:44:27.580738Z","caller":"traceutil/trace.go:171","msg":"trace[758429753] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:628; }","duration":"846.319705ms","start":"2026-05-22T00:44:26.734409Z","end":"2026-05-22T00:44:27.580729Z","steps":["trace[758429753] 'agreement among raft nodes before linearized reading' (duration: 846.147483ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:27.580731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:44:26.753615Z","time spent":"827.038063ms","remote":"127.0.0.1:51326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":897,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-22T00:44:27.580773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:44:26.7344Z","time spent":"846.364565ms","remote":"127.0.0.1:51262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-22T00:44:27.580763Z","caller":"traceutil/trace.go:171","msg":"trace[320670087] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:628; }","duration":"548.589107ms","start":"2026-05-22T00:44:27.032152Z","end":"2026-05-22T00:44:27.580741Z","steps":["trace[320670087] 'agreement among raft nodes before linearized reading' (duration: 548.444605ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:27.580785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:44:26.868276Z","time spent":"712.322316ms","remote":"127.0.0.1:51262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-22T00:44:27.580818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:44:27.032132Z","time spent":"548.675407ms","remote":"127.0.0.1:51040","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-22T00:44:28.092735Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933265993572625019,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-22T00:44:28.593297Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933265993572625019,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-22T00:44:28.790073Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.205312641s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-22T00:44:29.868009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.077644061s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-22T00:44:29.868117Z","caller":"traceutil/trace.go:171","msg":"trace[1491528836] linearizableReadLoop","detail":"{readStateIndex:657; appliedIndex:656; }","duration":"2.275448195s","start":"2026-05-22T00:44:27.592653Z","end":"2026-05-22T00:44:29.868102Z","steps":["trace[1491528836] 'read index received' (duration: 1.197557721s)","trace[1491528836] 'applied index is now lower than readState.Index' (duration: 1.077889374s)"],"step_count":2} {"level":"info","ts":"2026-05-22T00:44:29.868301Z","caller":"traceutil/trace.go:171","msg":"trace[172048669] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"2.283598669s","start":"2026-05-22T00:44:27.584689Z","end":"2026-05-22T00:44:29.868288Z","steps":["trace[172048669] 'process raft request' (duration: 1.205594634s)","trace[172048669] 'compare' (duration: 1.07752338s)"],"step_count":2} {"level":"warn","ts":"2026-05-22T00:44:29.868358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:44:27.584678Z","time spent":"2.28364909s","remote":"127.0.0.1:51262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-22T00:44:29.868471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"839.392912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-22T00:44:29.868527Z","caller":"traceutil/trace.go:171","msg":"trace[1745372542] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:629; }","duration":"839.500493ms","start":"2026-05-22T00:44:29.029014Z","end":"2026-05-22T00:44:29.868514Z","steps":["trace[1745372542] 'agreement among raft nodes before linearized reading' (duration: 839.401912ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:29.868554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:44:29.028995Z","time spent":"839.553244ms","remote":"127.0.0.1:51040","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-22T00:44:29.868687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.276037071s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-22T00:44:29.868715Z","caller":"traceutil/trace.go:171","msg":"trace[843496608] range","detail":"{range_begin:/registry/rolebindings/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:629; }","duration":"2.276076382s","start":"2026-05-22T00:44:27.59263Z","end":"2026-05-22T00:44:29.868707Z","steps":["trace[843496608] 'agreement among raft nodes before linearized reading' (duration: 2.276039511s)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:29.868733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:44:27.592623Z","time spent":"2.276106342s","remote":"127.0.0.1:51336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/rolebindings/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-05-22T00:44:29.868756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.878312624s","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-22T00:44:29.868809Z","caller":"traceutil/trace.go:171","msg":"trace[409649424] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:629; }","duration":"1.878412856s","start":"2026-05-22T00:44:27.990383Z","end":"2026-05-22T00:44:29.868796Z","steps":["trace[409649424] 'agreement among raft nodes before linearized reading' (duration: 1.878024101s)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:29.868896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.607940853s","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-22T00:44:29.868952Z","caller":"traceutil/trace.go:171","msg":"trace[108497102] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:629; }","duration":"1.608062905s","start":"2026-05-22T00:44:28.260876Z","end":"2026-05-22T00:44:29.868939Z","steps":["trace[108497102] 'agreement among raft nodes before linearized reading' (duration: 1.607928943s)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:29.868993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:44:28.260853Z","time spent":"1.608132566s","remote":"127.0.0.1:51262","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":"warn","ts":"2026-05-22T00:44:29.868897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:44:27.990347Z","time spent":"1.878538517s","remote":"127.0.0.1:51262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-22T00:44:29.869073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.607857623s","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-22T00:44:29.86918Z","caller":"traceutil/trace.go:171","msg":"trace[1094398670] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:629; }","duration":"1.607974185s","start":"2026-05-22T00:44:28.261175Z","end":"2026-05-22T00:44:29.869149Z","steps":["trace[1094398670] 'agreement among raft nodes before linearized reading' (duration: 1.60762485s)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:29.869255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:44:28.261146Z","time spent":"1.608095446s","remote":"127.0.0.1:51262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-22T00:44:30.401964Z","caller":"traceutil/trace.go:171","msg":"trace[679520946] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"135.247337ms","start":"2026-05-22T00:44:30.266691Z","end":"2026-05-22T00:44:30.401938Z","steps":["trace[679520946] 'process raft request' (duration: 134.765392ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:44:32.137005Z","caller":"traceutil/trace.go:171","msg":"trace[594947835] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"459.280326ms","start":"2026-05-22T00:44:31.677671Z","end":"2026-05-22T00:44:32.136951Z","steps":["trace[594947835] 'process raft request' (duration: 458.660938ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:32.137172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:44:31.677649Z","time spent":"459.440618ms","remote":"127.0.0.1:51062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3202,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-22T00:44:32.149818Z","caller":"traceutil/trace.go:171","msg":"trace[1178821193] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"272.903199ms","start":"2026-05-22T00:44:31.876894Z","end":"2026-05-22T00:44:32.149797Z","steps":["trace[1178821193] 'process raft request' (duration: 272.847958ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:44:32.149857Z","caller":"traceutil/trace.go:171","msg":"trace[1921016172] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"299.961541ms","start":"2026-05-22T00:44:31.849873Z","end":"2026-05-22T00:44:32.149835Z","steps":["trace[1921016172] 'process raft request' (duration: 299.18431ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:32.150007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:44:31.849841Z","time spent":"300.054443ms","remote":"127.0.0.1:51100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-22T00:44:32.150305Z","caller":"traceutil/trace.go:171","msg":"trace[2069301129] linearizableReadLoop","detail":"{readStateIndex:688; appliedIndex:686; }","duration":"274.768894ms","start":"2026-05-22T00:44:31.875468Z","end":"2026-05-22T00:44:32.150237Z","steps":["trace[2069301129] 'read index received' (duration: 260.908714ms)","trace[2069301129] 'applied index is now lower than readState.Index' (duration: 13.85693ms)"],"step_count":2} {"level":"warn","ts":"2026-05-22T00:44:32.150485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.011047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-22T00:44:32.150564Z","caller":"traceutil/trace.go:171","msg":"trace[1006345014] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:661; }","duration":"275.135248ms","start":"2026-05-22T00:44:31.875418Z","end":"2026-05-22T00:44:32.150553Z","steps":["trace[1006345014] 'agreement among raft nodes before linearized reading' (duration: 274.996366ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:32.151168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.384395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-05-22T00:44:32.151248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.420883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-22T00:44:32.151296Z","caller":"traceutil/trace.go:171","msg":"trace[1795355265] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:663; }","duration":"121.480453ms","start":"2026-05-22T00:44:32.029799Z","end":"2026-05-22T00:44:32.151279Z","steps":["trace[1795355265] 'agreement among raft nodes before linearized reading' (duration: 121.424782ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:32.151718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.213187ms","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-22T00:44:32.151758Z","caller":"traceutil/trace.go:171","msg":"trace[1213708792] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:663; }","duration":"257.281167ms","start":"2026-05-22T00:44:31.894469Z","end":"2026-05-22T00:44:32.15175Z","steps":["trace[1213708792] 'agreement among raft nodes before linearized reading' (duration: 257.114205ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:32.151865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.364829ms","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-22T00:44:32.151888Z","caller":"traceutil/trace.go:171","msg":"trace[1562073249] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:663; }","duration":"257.404789ms","start":"2026-05-22T00:44:31.894477Z","end":"2026-05-22T00:44:32.151882Z","steps":["trace[1562073249] 'agreement among raft nodes before linearized reading' (duration: 257.347318ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:44:32.151218Z","caller":"traceutil/trace.go:171","msg":"trace[392500082] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:663; }","duration":"259.453845ms","start":"2026-05-22T00:44:31.891754Z","end":"2026-05-22T00:44:32.151208Z","steps":["trace[392500082] 'agreement among raft nodes before linearized reading' (duration: 259.363564ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:34.89942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.077904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:1 size:10377"} {"level":"info","ts":"2026-05-22T00:44:34.899528Z","caller":"traceutil/trace.go:171","msg":"trace[540355401] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:717; }","duration":"224.230007ms","start":"2026-05-22T00:44:34.675277Z","end":"2026-05-22T00:44:34.899507Z","steps":["trace[540355401] 'range keys from in-memory index tree' (duration: 223.882881ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:44:42.349865Z","caller":"traceutil/trace.go:171","msg":"trace[681876732] linearizableReadLoop","detail":"{readStateIndex:814; appliedIndex:813; }","duration":"137.006706ms","start":"2026-05-22T00:44:42.212832Z","end":"2026-05-22T00:44:42.349839Z","steps":["trace[681876732] 'read index received' (duration: 136.953695ms)","trace[681876732] 'applied index is now lower than readState.Index' (duration: 51.321µs)"],"step_count":2} {"level":"info","ts":"2026-05-22T00:44:42.350078Z","caller":"traceutil/trace.go:171","msg":"trace[811384319] transaction","detail":"{read_only:false; response_revision:782; number_of_response:1; }","duration":"137.613558ms","start":"2026-05-22T00:44:42.212443Z","end":"2026-05-22T00:44:42.350056Z","steps":["trace[811384319] 'process raft request' (duration: 137.244151ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:42.350269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.333862ms","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-22T00:44:42.350381Z","caller":"traceutil/trace.go:171","msg":"trace[89359299] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:782; }","duration":"137.551097ms","start":"2026-05-22T00:44:42.212812Z","end":"2026-05-22T00:44:42.350363Z","steps":["trace[89359299] 'agreement among raft nodes before linearized reading' (duration: 137.157269ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:44:42.350945Z","caller":"traceutil/trace.go:171","msg":"trace[409860373] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"134.277541ms","start":"2026-05-22T00:44:42.216648Z","end":"2026-05-22T00:44:42.350925Z","steps":["trace[409860373] 'process raft request' (duration: 134.21881ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:44:42.350984Z","caller":"traceutil/trace.go:171","msg":"trace[1450946033] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"135.22542ms","start":"2026-05-22T00:44:42.215728Z","end":"2026-05-22T00:44:42.350953Z","steps":["trace[1450946033] 'process raft request' (duration: 135.028727ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:45.560476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"775.728827ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-22T00:44:45.560695Z","caller":"traceutil/trace.go:171","msg":"trace[1419606416] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"1.160399465s","start":"2026-05-22T00:44:44.40028Z","end":"2026-05-22T00:44:45.56068Z","steps":["trace[1419606416] 'process raft request' (duration: 1.160343374s)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:45.560756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:44:44.40027Z","time spent":"1.160459786s","remote":"127.0.0.1:51262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-22T00:44:45.560769Z","caller":"traceutil/trace.go:171","msg":"trace[1851776661] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"1.160953256s","start":"2026-05-22T00:44:44.399788Z","end":"2026-05-22T00:44:45.560741Z","steps":["trace[1851776661] 'process raft request' (duration: 384.875932ms)","trace[1851776661] 'compare' (duration: 775.417669ms)"],"step_count":2} {"level":"info","ts":"2026-05-22T00:44:45.560914Z","caller":"traceutil/trace.go:171","msg":"trace[1198040453] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"1.160778432s","start":"2026-05-22T00:44:44.400127Z","end":"2026-05-22T00:44:45.560905Z","steps":["trace[1198040453] 'process raft request' (duration: 1.160440365s)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:44:45.560972Z","caller":"traceutil/trace.go:171","msg":"trace[55011015] linearizableReadLoop","detail":"{readStateIndex:832; appliedIndex:828; }","duration":"1.032872344s","start":"2026-05-22T00:44:44.528089Z","end":"2026-05-22T00:44:45.560962Z","steps":["trace[55011015] 'read index received' (duration: 256.605456ms)","trace[55011015] 'applied index is now lower than readState.Index' (duration: 776.265808ms)"],"step_count":2} {"level":"warn","ts":"2026-05-22T00:44:45.560981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:44:44.400104Z","time spent":"1.160837374s","remote":"127.0.0.1:51262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-22T00:44:45.560909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:44:44.399765Z","time spent":"1.161072928s","remote":"127.0.0.1:51262","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-22T00:44:45.5612Z","caller":"traceutil/trace.go:171","msg":"trace[1466702019] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"1.160539337s","start":"2026-05-22T00:44:44.40065Z","end":"2026-05-22T00:44:45.56119Z","steps":["trace[1466702019] 'process raft request' (duration: 1.159999576s)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:45.561262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:44:44.40064Z","time spent":"1.160591219s","remote":"127.0.0.1:51262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-22T00:44:45.561509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.828364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-22T00:44:45.561552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.001447443s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.3\" ","response":"range_response_count:1 size:131"} {"level":"info","ts":"2026-05-22T00:44:45.561568Z","caller":"traceutil/trace.go:171","msg":"trace[140846339] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:799; }","duration":"530.939006ms","start":"2026-05-22T00:44:45.030615Z","end":"2026-05-22T00:44:45.561554Z","steps":["trace[140846339] 'agreement among raft nodes before linearized reading' (duration: 530.852644ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:44:45.561591Z","caller":"traceutil/trace.go:171","msg":"trace[277425001] range","detail":"{range_begin:/registry/masterleases/199.204.45.3; range_end:; response_count:1; response_revision:799; }","duration":"1.001510745s","start":"2026-05-22T00:44:44.56007Z","end":"2026-05-22T00:44:45.561581Z","steps":["trace[277425001] 'agreement among raft nodes before linearized reading' (duration: 1.00133871s)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:45.561577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.033469936s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-lcsj8\" ","response":"range_response_count:1 size:3963"} {"level":"warn","ts":"2026-05-22T00:44:45.561611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:44:45.030596Z","time spent":"531.008198ms","remote":"127.0.0.1:51040","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-22T00:44:45.561621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:44:44.560058Z","time spent":"1.001556585s","remote":"127.0.0.1:51056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":1,"response size":154,"request content":"key:\"/registry/masterleases/199.204.45.3\" "} {"level":"info","ts":"2026-05-22T00:44:45.561654Z","caller":"traceutil/trace.go:171","msg":"trace[225541378] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-lcsj8; range_end:; response_count:1; response_revision:799; }","duration":"1.033582659s","start":"2026-05-22T00:44:44.528043Z","end":"2026-05-22T00:44:45.561626Z","steps":["trace[225541378] 'agreement among raft nodes before linearized reading' (duration: 1.033346914s)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:45.561689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:44:44.528026Z","time spent":"1.033657051s","remote":"127.0.0.1:51198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3986,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-lcsj8\" "} {"level":"info","ts":"2026-05-22T00:44:45.798006Z","caller":"traceutil/trace.go:171","msg":"trace[1351815894] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"227.804924ms","start":"2026-05-22T00:44:45.570182Z","end":"2026-05-22T00:44:45.797987Z","steps":["trace[1351815894] 'process raft request' (duration: 227.679032ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:44:45.798153Z","caller":"traceutil/trace.go:171","msg":"trace[301044299] linearizableReadLoop","detail":"{readStateIndex:834; appliedIndex:832; }","duration":"175.932556ms","start":"2026-05-22T00:44:45.62221Z","end":"2026-05-22T00:44:45.798142Z","steps":["trace[301044299] 'read index received' (duration: 156.117648ms)","trace[301044299] 'applied index is now lower than readState.Index' (duration: 19.637124ms)"],"step_count":2} {"level":"warn","ts":"2026-05-22T00:44:45.798314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.082499ms","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-22T00:44:45.798378Z","caller":"traceutil/trace.go:171","msg":"trace[489816093] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:800; }","duration":"176.195002ms","start":"2026-05-22T00:44:45.622165Z","end":"2026-05-22T00:44:45.79836Z","steps":["trace[489816093] 'agreement among raft nodes before linearized reading' (duration: 175.958276ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:44:54.863314Z","caller":"traceutil/trace.go:171","msg":"trace[52126674] transaction","detail":"{read_only:false; response_revision:906; number_of_response:1; }","duration":"128.578454ms","start":"2026-05-22T00:44:54.734708Z","end":"2026-05-22T00:44:54.863287Z","steps":["trace[52126674] 'process raft request' (duration: 128.44682ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:44:54.863367Z","caller":"traceutil/trace.go:171","msg":"trace[975271620] transaction","detail":"{read_only:false; response_revision:909; number_of_response:1; }","duration":"107.139123ms","start":"2026-05-22T00:44:54.756208Z","end":"2026-05-22T00:44:54.863347Z","steps":["trace[975271620] 'process raft request' (duration: 107.096572ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:44:54.863386Z","caller":"traceutil/trace.go:171","msg":"trace[1677089736] transaction","detail":"{read_only:false; response_revision:907; number_of_response:1; }","duration":"128.297587ms","start":"2026-05-22T00:44:54.735043Z","end":"2026-05-22T00:44:54.863341Z","steps":["trace[1677089736] 'process raft request' (duration: 128.147793ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:44:54.863601Z","caller":"traceutil/trace.go:171","msg":"trace[716599550] transaction","detail":"{read_only:false; response_revision:905; number_of_response:1; }","duration":"129.399415ms","start":"2026-05-22T00:44:54.734185Z","end":"2026-05-22T00:44:54.863584Z","steps":["trace[716599550] 'process raft request' (duration: 29.117972ms)","trace[716599550] 'compare' (duration: 99.729659ms)"],"step_count":2} {"level":"info","ts":"2026-05-22T00:44:54.863749Z","caller":"traceutil/trace.go:171","msg":"trace[1307677910] transaction","detail":"{read_only:false; response_revision:908; number_of_response:1; }","duration":"126.853278ms","start":"2026-05-22T00:44:54.736884Z","end":"2026-05-22T00:44:54.863737Z","steps":["trace[1307677910] 'process raft request' (duration: 126.360616ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:44:54.863889Z","caller":"traceutil/trace.go:171","msg":"trace[1645227071] linearizableReadLoop","detail":"{readStateIndex:941; appliedIndex:936; }","duration":"129.20366ms","start":"2026-05-22T00:44:54.734674Z","end":"2026-05-22T00:44:54.863878Z","steps":["trace[1645227071] 'read index received' (duration: 14.53527ms)","trace[1645227071] 'applied index is now lower than readState.Index' (duration: 114.66718ms)"],"step_count":2} {"level":"warn","ts":"2026-05-22T00:44:54.864135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.447317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-dj7hk\" ","response":"range_response_count:1 size:4882"} {"level":"info","ts":"2026-05-22T00:44:54.864176Z","caller":"traceutil/trace.go:171","msg":"trace[479258548] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-dj7hk; range_end:; response_count:1; response_revision:909; }","duration":"129.524809ms","start":"2026-05-22T00:44:54.734639Z","end":"2026-05-22T00:44:54.864164Z","steps":["trace[479258548] 'agreement among raft nodes before linearized reading' (duration: 129.401875ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:54.864215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.601842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/coredns-67659f764b\" ","response":"range_response_count:1 size:3903"} {"level":"info","ts":"2026-05-22T00:44:54.864265Z","caller":"traceutil/trace.go:171","msg":"trace[184054120] range","detail":"{range_begin:/registry/replicasets/kube-system/coredns-67659f764b; range_end:; response_count:1; response_revision:909; }","duration":"108.689724ms","start":"2026-05-22T00:44:54.755563Z","end":"2026-05-22T00:44:54.864253Z","steps":["trace[184054120] 'agreement among raft nodes before linearized reading' (duration: 108.517339ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:55.916151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.412382ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-22T00:44:55.916368Z","caller":"traceutil/trace.go:171","msg":"trace[168770706] transaction","detail":"{read_only:false; response_revision:914; number_of_response:1; }","duration":"275.129288ms","start":"2026-05-22T00:44:55.641204Z","end":"2026-05-22T00:44:55.916334Z","steps":["trace[168770706] 'process raft request' (duration: 108.443058ms)","trace[168770706] 'compare' (duration: 166.30358ms)"],"step_count":2} {"level":"info","ts":"2026-05-22T00:44:55.916397Z","caller":"traceutil/trace.go:171","msg":"trace[702978151] transaction","detail":"{read_only:false; response_revision:915; number_of_response:1; }","duration":"274.880961ms","start":"2026-05-22T00:44:55.641487Z","end":"2026-05-22T00:44:55.916368Z","steps":["trace[702978151] 'process raft request' (duration: 274.761707ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:44:55.916602Z","caller":"traceutil/trace.go:171","msg":"trace[1281206860] transaction","detail":"{read_only:false; response_revision:916; number_of_response:1; }","duration":"274.48116ms","start":"2026-05-22T00:44:55.642058Z","end":"2026-05-22T00:44:55.916539Z","steps":["trace[1281206860] 'process raft request' (duration: 274.261664ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:44:56.129957Z","caller":"traceutil/trace.go:171","msg":"trace[1407773241] transaction","detail":"{read_only:false; response_revision:917; number_of_response:1; }","duration":"208.677455ms","start":"2026-05-22T00:44:55.921249Z","end":"2026-05-22T00:44:56.129927Z","steps":["trace[1407773241] 'process raft request' (duration: 167.256903ms)","trace[1407773241] 'compare' (duration: 41.201636ms)"],"step_count":2} {"level":"warn","ts":"2026-05-22T00:44:56.130081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.824826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-22T00:44:56.130163Z","caller":"traceutil/trace.go:171","msg":"trace[1873873041] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:0; response_revision:917; }","duration":"123.949689ms","start":"2026-05-22T00:44:56.006186Z","end":"2026-05-22T00:44:56.130135Z","steps":["trace[1873873041] 'agreement among raft nodes before linearized reading' (duration: 123.818385ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:44:56.130415Z","caller":"traceutil/trace.go:171","msg":"trace[987819575] linearizableReadLoop","detail":"{readStateIndex:953; appliedIndex:952; }","duration":"123.641331ms","start":"2026-05-22T00:44:56.006243Z","end":"2026-05-22T00:44:56.129884Z","steps":["trace[987819575] 'read index received' (duration: 82.303521ms)","trace[987819575] 'applied index is now lower than readState.Index' (duration: 41.33619ms)"],"step_count":2} {"level":"warn","ts":"2026-05-22T00:44:56.331233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.7067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-22T00:44:56.331339Z","caller":"traceutil/trace.go:171","msg":"trace[329881120] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:0; response_revision:917; }","duration":"100.879244ms","start":"2026-05-22T00:44:56.23044Z","end":"2026-05-22T00:44:56.331319Z","steps":["trace[329881120] 'range keys from in-memory index tree' (duration: 100.608957ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:44:57.288548Z","caller":"traceutil/trace.go:171","msg":"trace[775925081] linearizableReadLoop","detail":"{readStateIndex:954; appliedIndex:953; }","duration":"212.217997ms","start":"2026-05-22T00:44:57.076312Z","end":"2026-05-22T00:44:57.28853Z","steps":["trace[775925081] 'read index received' (duration: 212.091524ms)","trace[775925081] 'applied index is now lower than readState.Index' (duration: 125.603µs)"],"step_count":2} {"level":"info","ts":"2026-05-22T00:44:57.288592Z","caller":"traceutil/trace.go:171","msg":"trace[1543630857] transaction","detail":"{read_only:false; response_revision:918; number_of_response:1; }","duration":"773.876649ms","start":"2026-05-22T00:44:56.514684Z","end":"2026-05-22T00:44:57.288561Z","steps":["trace[1543630857] 'process raft request' (duration: 773.729555ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:44:57.288664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.335341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-22T00:44:57.288943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:44:56.51466Z","time spent":"774.211859ms","remote":"127.0.0.1:51080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":813,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-22T00:44:57.28897Z","caller":"traceutil/trace.go:171","msg":"trace[1911128177] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:918; }","duration":"212.707711ms","start":"2026-05-22T00:44:57.076253Z","end":"2026-05-22T00:44:57.288961Z","steps":["trace[1911128177] 'agreement among raft nodes before linearized reading' (duration: 212.346861ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:44:57.729062Z","caller":"traceutil/trace.go:171","msg":"trace[660759996] transaction","detail":"{read_only:false; response_revision:922; number_of_response:1; }","duration":"229.181325ms","start":"2026-05-22T00:44:57.499855Z","end":"2026-05-22T00:44:57.729036Z","steps":["trace[660759996] 'process raft request' (duration: 228.753963ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:44:57.729383Z","caller":"traceutil/trace.go:171","msg":"trace[226258668] transaction","detail":"{read_only:false; response_revision:921; number_of_response:1; }","duration":"229.524174ms","start":"2026-05-22T00:44:57.499841Z","end":"2026-05-22T00:44:57.729365Z","steps":["trace[226258668] 'process raft request' (duration: 228.66515ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:44:57.741182Z","caller":"traceutil/trace.go:171","msg":"trace[1122754880] transaction","detail":"{read_only:false; response_revision:923; number_of_response:1; }","duration":"237.109332ms","start":"2026-05-22T00:44:57.504059Z","end":"2026-05-22T00:44:57.741168Z","steps":["trace[1122754880] 'process raft request' (duration: 236.783704ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:45:12.147077Z","caller":"traceutil/trace.go:171","msg":"trace[576753293] linearizableReadLoop","detail":"{readStateIndex:1049; appliedIndex:1048; }","duration":"157.606579ms","start":"2026-05-22T00:45:11.989445Z","end":"2026-05-22T00:45:12.147051Z","steps":["trace[576753293] 'read index received' (duration: 157.393382ms)","trace[576753293] 'applied index is now lower than readState.Index' (duration: 211.937µs)"],"step_count":2} {"level":"info","ts":"2026-05-22T00:45:12.147134Z","caller":"traceutil/trace.go:171","msg":"trace[1884648915] transaction","detail":"{read_only:false; response_revision:1009; number_of_response:1; }","duration":"161.339533ms","start":"2026-05-22T00:45:11.985756Z","end":"2026-05-22T00:45:12.147096Z","steps":["trace[1884648915] 'process raft request' (duration: 161.130286ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:45:12.147307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.842876ms","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-22T00:45:12.147319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.834926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-22T00:45:12.147379Z","caller":"traceutil/trace.go:171","msg":"trace[350707174] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1009; }","duration":"157.915419ms","start":"2026-05-22T00:45:11.989446Z","end":"2026-05-22T00:45:12.147362Z","steps":["trace[350707174] 'agreement among raft nodes before linearized reading' (duration: 157.766934ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:45:12.147372Z","caller":"traceutil/trace.go:171","msg":"trace[2112478237] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1009; }","duration":"157.93636ms","start":"2026-05-22T00:45:11.98942Z","end":"2026-05-22T00:45:12.147356Z","steps":["trace[2112478237] 'agreement among raft nodes before linearized reading' (duration: 157.765714ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:45:12.147308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.267309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-22T00:45:12.147671Z","caller":"traceutil/trace.go:171","msg":"trace[944832343] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1009; }","duration":"117.653943ms","start":"2026-05-22T00:45:12.029996Z","end":"2026-05-22T00:45:12.14765Z","steps":["trace[944832343] 'agreement among raft nodes before linearized reading' (duration: 117.26186ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:45:14.345568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.215567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-22T00:45:14.345591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.879726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-22T00:45:14.345582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.898202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-22T00:45:14.345649Z","caller":"traceutil/trace.go:171","msg":"trace[352242000] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1014; }","duration":"192.983709ms","start":"2026-05-22T00:45:14.152654Z","end":"2026-05-22T00:45:14.345638Z","steps":["trace[352242000] 'range keys from in-memory index tree' (duration: 192.721801ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:45:14.34565Z","caller":"traceutil/trace.go:171","msg":"trace[1536493205] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1014; }","duration":"144.331351ms","start":"2026-05-22T00:45:14.201299Z","end":"2026-05-22T00:45:14.345631Z","steps":["trace[1536493205] 'range keys from in-memory index tree' (duration: 144.01472ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:45:14.345677Z","caller":"traceutil/trace.go:171","msg":"trace[234482786] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1014; }","duration":"315.065737ms","start":"2026-05-22T00:45:14.030589Z","end":"2026-05-22T00:45:14.345655Z","steps":["trace[234482786] 'range keys from in-memory index tree' (duration: 314.776557ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:45:14.345692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.97038ms","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-22T00:45:14.345737Z","caller":"traceutil/trace.go:171","msg":"trace[617993256] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1014; }","duration":"121.036571ms","start":"2026-05-22T00:45:14.224688Z","end":"2026-05-22T00:45:14.345724Z","steps":["trace[617993256] 'range keys from in-memory index tree' (duration: 120.865766ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:45:14.345733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:45:14.030566Z","time spent":"315.15586ms","remote":"127.0.0.1:51040","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-22T00:45:14.345803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.434289ms","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-22T00:45:14.346101Z","caller":"traceutil/trace.go:171","msg":"trace[1954412724] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1014; }","duration":"168.763069ms","start":"2026-05-22T00:45:14.177287Z","end":"2026-05-22T00:45:14.34605Z","steps":["trace[1954412724] 'range keys from in-memory index tree' (duration: 168.20824ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:45:14.475684Z","caller":"traceutil/trace.go:171","msg":"trace[1109019211] transaction","detail":"{read_only:false; response_revision:1015; number_of_response:1; }","duration":"125.809416ms","start":"2026-05-22T00:45:14.349845Z","end":"2026-05-22T00:45:14.475654Z","steps":["trace[1109019211] 'process raft request' (duration: 125.655571ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:45:14.512759Z","caller":"traceutil/trace.go:171","msg":"trace[1663640945] transaction","detail":"{read_only:false; response_revision:1017; number_of_response:1; }","duration":"162.317038ms","start":"2026-05-22T00:45:14.350428Z","end":"2026-05-22T00:45:14.512745Z","steps":["trace[1663640945] 'process raft request' (duration: 162.133422ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:45:14.512862Z","caller":"traceutil/trace.go:171","msg":"trace[135446893] transaction","detail":"{read_only:false; response_revision:1018; number_of_response:1; }","duration":"161.300553ms","start":"2026-05-22T00:45:14.351552Z","end":"2026-05-22T00:45:14.512852Z","steps":["trace[135446893] 'process raft request' (duration: 161.125837ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:45:14.512943Z","caller":"traceutil/trace.go:171","msg":"trace[313570841] transaction","detail":"{read_only:false; response_revision:1016; number_of_response:1; }","duration":"162.741203ms","start":"2026-05-22T00:45:14.349872Z","end":"2026-05-22T00:45:14.512613Z","steps":["trace[313570841] 'process raft request' (duration: 162.569408ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:45:14.986642Z","caller":"traceutil/trace.go:171","msg":"trace[1123028964] transaction","detail":"{read_only:false; response_revision:1020; number_of_response:1; }","duration":"240.564282ms","start":"2026-05-22T00:45:14.746052Z","end":"2026-05-22T00:45:14.986616Z","steps":["trace[1123028964] 'process raft request' (duration: 240.418907ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:45:15.704614Z","caller":"traceutil/trace.go:171","msg":"trace[428919175] transaction","detail":"{read_only:false; response_revision:1021; number_of_response:1; }","duration":"215.665212ms","start":"2026-05-22T00:45:15.488926Z","end":"2026-05-22T00:45:15.704591Z","steps":["trace[428919175] 'process raft request' (duration: 215.510407ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:45:16.067194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.598199ms","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-22T00:45:16.067301Z","caller":"traceutil/trace.go:171","msg":"trace[455367640] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1021; }","duration":"135.771404ms","start":"2026-05-22T00:45:15.931505Z","end":"2026-05-22T00:45:16.067276Z","steps":["trace[455367640] 'range keys from in-memory index tree' (duration: 135.309659ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:45:17.846211Z","caller":"traceutil/trace.go:171","msg":"trace[1059008944] transaction","detail":"{read_only:false; response_revision:1028; number_of_response:1; }","duration":"134.46947ms","start":"2026-05-22T00:45:17.711704Z","end":"2026-05-22T00:45:17.846173Z","steps":["trace[1059008944] 'process raft request' (duration: 120.296109ms)","trace[1059008944] 'compare' (duration: 13.905761ms)"],"step_count":2} {"level":"info","ts":"2026-05-22T00:45:19.200001Z","caller":"traceutil/trace.go:171","msg":"trace[1155792484] linearizableReadLoop","detail":"{readStateIndex:1076; appliedIndex:1075; }","duration":"171.249209ms","start":"2026-05-22T00:45:19.028718Z","end":"2026-05-22T00:45:19.199967Z","steps":["trace[1155792484] 'read index received' (duration: 170.989ms)","trace[1155792484] 'applied index is now lower than readState.Index' (duration: 258.649µs)"],"step_count":2} {"level":"info","ts":"2026-05-22T00:45:19.200118Z","caller":"traceutil/trace.go:171","msg":"trace[311694860] transaction","detail":"{read_only:false; response_revision:1035; number_of_response:1; }","duration":"186.229758ms","start":"2026-05-22T00:45:19.013851Z","end":"2026-05-22T00:45:19.20008Z","steps":["trace[311694860] 'process raft request' (duration: 185.873236ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:45:19.200174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.421576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-22T00:45:19.200222Z","caller":"traceutil/trace.go:171","msg":"trace[373356950] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1035; }","duration":"171.52148ms","start":"2026-05-22T00:45:19.028686Z","end":"2026-05-22T00:45:19.200208Z","steps":["trace[373356950] 'agreement among raft nodes before linearized reading' (duration: 171.409795ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:45:19.437433Z","caller":"traceutil/trace.go:171","msg":"trace[671910764] transaction","detail":"{read_only:false; response_revision:1036; number_of_response:1; }","duration":"221.513046ms","start":"2026-05-22T00:45:19.215892Z","end":"2026-05-22T00:45:19.437405Z","steps":["trace[671910764] 'process raft request' (duration: 218.935903ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:45:50.156876Z","caller":"traceutil/trace.go:171","msg":"trace[1958918481] transaction","detail":"{read_only:false; response_revision:1138; number_of_response:1; }","duration":"190.325102ms","start":"2026-05-22T00:45:49.966527Z","end":"2026-05-22T00:45:50.156852Z","steps":["trace[1958918481] 'process raft request' (duration: 190.165965ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:45:50.781078Z","caller":"traceutil/trace.go:171","msg":"trace[1733080883] transaction","detail":"{read_only:false; response_revision:1139; number_of_response:1; }","duration":"471.097491ms","start":"2026-05-22T00:45:50.309953Z","end":"2026-05-22T00:45:50.781051Z","steps":["trace[1733080883] 'process raft request' (duration: 470.83024ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:45:50.781226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:45:50.309941Z","time spent":"471.208516ms","remote":"127.0.0.1:51262","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-22T00:45:50.911999Z","caller":"traceutil/trace.go:171","msg":"trace[2030629437] transaction","detail":"{read_only:false; response_revision:1140; number_of_response:1; }","duration":"126.794355ms","start":"2026-05-22T00:45:50.785177Z","end":"2026-05-22T00:45:50.911971Z","steps":["trace[2030629437] 'process raft request' (duration: 98.735526ms)","trace[2030629437] 'compare' (duration: 27.732315ms)"],"step_count":2} {"level":"info","ts":"2026-05-22T00:45:50.912271Z","caller":"traceutil/trace.go:171","msg":"trace[1638250859] transaction","detail":"{read_only:false; response_revision:1143; number_of_response:1; }","duration":"125.31008ms","start":"2026-05-22T00:45:50.786932Z","end":"2026-05-22T00:45:50.912242Z","steps":["trace[1638250859] 'process raft request' (duration: 125.258958ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:45:50.91231Z","caller":"traceutil/trace.go:171","msg":"trace[404462517] transaction","detail":"{read_only:false; response_revision:1141; number_of_response:1; }","duration":"126.327685ms","start":"2026-05-22T00:45:50.785972Z","end":"2026-05-22T00:45:50.9123Z","steps":["trace[404462517] 'process raft request' (duration: 125.933658ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:45:50.912388Z","caller":"traceutil/trace.go:171","msg":"trace[864175127] transaction","detail":"{read_only:false; response_revision:1142; number_of_response:1; }","duration":"125.849554ms","start":"2026-05-22T00:45:50.786526Z","end":"2026-05-22T00:45:50.912376Z","steps":["trace[864175127] 'process raft request' (duration: 125.601283ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:46:03.053364Z","caller":"traceutil/trace.go:171","msg":"trace[983629357] transaction","detail":"{read_only:false; response_revision:1178; number_of_response:1; }","duration":"219.075397ms","start":"2026-05-22T00:46:02.834255Z","end":"2026-05-22T00:46:03.05333Z","steps":["trace[983629357] 'process raft request' (duration: 218.93263ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:46:03.213208Z","caller":"traceutil/trace.go:171","msg":"trace[681066443] transaction","detail":"{read_only:false; response_revision:1179; number_of_response:1; }","duration":"155.498853ms","start":"2026-05-22T00:46:03.057463Z","end":"2026-05-22T00:46:03.212962Z","steps":["trace[681066443] 'process raft request' (duration: 155.01788ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:46:03.223555Z","caller":"traceutil/trace.go:171","msg":"trace[1437503526] transaction","detail":"{read_only:false; response_revision:1180; number_of_response:1; }","duration":"165.978525ms","start":"2026-05-22T00:46:03.057552Z","end":"2026-05-22T00:46:03.22353Z","steps":["trace[1437503526] 'process raft request' (duration: 165.804477ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:46:03.223879Z","caller":"traceutil/trace.go:171","msg":"trace[1828396361] transaction","detail":"{read_only:false; response_revision:1181; number_of_response:1; }","duration":"165.890481ms","start":"2026-05-22T00:46:03.057969Z","end":"2026-05-22T00:46:03.223859Z","steps":["trace[1828396361] 'process raft request' (duration: 165.526054ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:46:03.223875Z","caller":"traceutil/trace.go:171","msg":"trace[859863010] transaction","detail":"{read_only:false; response_revision:1182; number_of_response:1; }","duration":"164.701136ms","start":"2026-05-22T00:46:03.059153Z","end":"2026-05-22T00:46:03.223854Z","steps":["trace[859863010] 'process raft request' (duration: 164.609971ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:46:05.168666Z","caller":"traceutil/trace.go:171","msg":"trace[1416095114] transaction","detail":"{read_only:false; response_revision:1185; number_of_response:1; }","duration":"107.465899ms","start":"2026-05-22T00:46:05.061175Z","end":"2026-05-22T00:46:05.168641Z","steps":["trace[1416095114] 'process raft request' (duration: 107.313182ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:46:07.424549Z","caller":"traceutil/trace.go:171","msg":"trace[475557458] linearizableReadLoop","detail":"{readStateIndex:1244; appliedIndex:1243; }","duration":"200.581816ms","start":"2026-05-22T00:46:07.223945Z","end":"2026-05-22T00:46:07.424527Z","steps":["trace[475557458] 'read index received' (duration: 200.475321ms)","trace[475557458] 'applied index is now lower than readState.Index' (duration: 105.455µs)"],"step_count":2} {"level":"info","ts":"2026-05-22T00:46:07.424624Z","caller":"traceutil/trace.go:171","msg":"trace[1203884576] transaction","detail":"{read_only:false; response_revision:1192; number_of_response:1; }","duration":"249.563377ms","start":"2026-05-22T00:46:07.175043Z","end":"2026-05-22T00:46:07.424606Z","steps":["trace[1203884576] 'process raft request' (duration: 249.361937ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:46:07.424737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.780486ms","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-22T00:46:07.424825Z","caller":"traceutil/trace.go:171","msg":"trace[1997061926] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1192; }","duration":"200.915512ms","start":"2026-05-22T00:46:07.223899Z","end":"2026-05-22T00:46:07.424814Z","steps":["trace[1997061926] 'agreement among raft nodes before linearized reading' (duration: 200.742464ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:46:07.4249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.578326ms","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-22T00:46:07.424947Z","caller":"traceutil/trace.go:171","msg":"trace[1159893944] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1192; }","duration":"182.651809ms","start":"2026-05-22T00:46:07.242281Z","end":"2026-05-22T00:46:07.424933Z","steps":["trace[1159893944] 'agreement among raft nodes before linearized reading' (duration: 182.46438ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:46:07.424971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.641495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-22T00:46:07.425062Z","caller":"traceutil/trace.go:171","msg":"trace[1103864367] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1192; }","duration":"177.7672ms","start":"2026-05-22T00:46:07.247272Z","end":"2026-05-22T00:46:07.425039Z","steps":["trace[1103864367] 'agreement among raft nodes before linearized reading' (duration: 177.524699ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:46:07.425159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.800482ms","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-22T00:46:07.42524Z","caller":"traceutil/trace.go:171","msg":"trace[518537051] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1192; }","duration":"177.919817ms","start":"2026-05-22T00:46:07.247301Z","end":"2026-05-22T00:46:07.425221Z","steps":["trace[518537051] 'agreement among raft nodes before linearized reading' (duration: 177.471487ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:46:07.425608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.064463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329948"} {"level":"info","ts":"2026-05-22T00:46:07.425663Z","caller":"traceutil/trace.go:171","msg":"trace[1257847543] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:1192; }","duration":"175.135497ms","start":"2026-05-22T00:46:07.250517Z","end":"2026-05-22T00:46:07.425652Z","steps":["trace[1257847543] 'agreement among raft nodes before linearized reading' (duration: 174.901736ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:46:33.775945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.572ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-22T00:46:33.776101Z","caller":"traceutil/trace.go:171","msg":"trace[61057265] transaction","detail":"{read_only:false; response_revision:1316; number_of_response:1; }","duration":"184.961149ms","start":"2026-05-22T00:46:33.591115Z","end":"2026-05-22T00:46:33.776076Z","steps":["trace[61057265] 'process raft request' (duration: 38.107063ms)","trace[61057265] 'compare' (duration: 146.282456ms)"],"step_count":2} {"level":"warn","ts":"2026-05-22T00:46:34.410924Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933265993572626601,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-22T00:46:34.525733Z","caller":"traceutil/trace.go:171","msg":"trace[1623127269] linearizableReadLoop","detail":"{readStateIndex:1378; appliedIndex:1375; }","duration":"615.058652ms","start":"2026-05-22T00:46:33.910651Z","end":"2026-05-22T00:46:34.525709Z","steps":["trace[1623127269] 'read index received' (duration: 587.399158ms)","trace[1623127269] 'applied index is now lower than readState.Index' (duration: 27.658474ms)"],"step_count":2} {"level":"info","ts":"2026-05-22T00:46:34.525764Z","caller":"traceutil/trace.go:171","msg":"trace[35268170] transaction","detail":"{read_only:false; response_revision:1318; number_of_response:1; }","duration":"934.370072ms","start":"2026-05-22T00:46:33.591364Z","end":"2026-05-22T00:46:34.525734Z","steps":["trace[35268170] 'process raft request' (duration: 934.258646ms)"],"step_count":1} {"level":"info","ts":"2026-05-22T00:46:34.525825Z","caller":"traceutil/trace.go:171","msg":"trace[563373720] transaction","detail":"{read_only:false; response_revision:1317; number_of_response:1; }","duration":"934.428474ms","start":"2026-05-22T00:46:33.591336Z","end":"2026-05-22T00:46:34.525764Z","steps":["trace[563373720] 'process raft request' (duration: 906.562849ms)","trace[563373720] 'compare' (duration: 27.300497ms)"],"step_count":2} {"level":"warn","ts":"2026-05-22T00:46:34.52602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"615.330125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-22T00:46:34.526082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:46:33.59132Z","time spent":"934.645695ms","remote":"127.0.0.1:51262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-22T00:46:34.526127Z","caller":"traceutil/trace.go:171","msg":"trace[1399154405] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1319; }","duration":"615.463272ms","start":"2026-05-22T00:46:33.910643Z","end":"2026-05-22T00:46:34.526106Z","steps":["trace[1399154405] 'agreement among raft nodes before linearized reading' (duration: 615.180418ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:46:34.526175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:46:33.910574Z","time spent":"615.592989ms","remote":"127.0.0.1:51240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "} {"level":"info","ts":"2026-05-22T00:46:34.525777Z","caller":"traceutil/trace.go:171","msg":"trace[1189464860] transaction","detail":"{read_only:false; response_revision:1319; number_of_response:1; }","duration":"933.416265ms","start":"2026-05-22T00:46:33.592337Z","end":"2026-05-22T00:46:34.525753Z","steps":["trace[1189464860] 'process raft request' (duration: 933.335831ms)"],"step_count":1} {"level":"warn","ts":"2026-05-22T00:46:34.526659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:46:33.591351Z","time spent":"934.587263ms","remote":"127.0.0.1:51262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-22T00:46:34.526837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-22T00:46:33.592319Z","time spent":"934.433016ms","remote":"127.0.0.1:51262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-22T00:46:34.538809Z","caller":"traceutil/trace.go:171","msg":"trace[2112961072] transaction","detail":"{read_only:false; response_revision:1320; number_of_response:1; }","duration":"108.430207ms","start":"2026-05-22T00:46:34.430361Z","end":"2026-05-22T00:46:34.538792Z","steps":["trace[2112961072] 'process raft request' (duration: 108.277129ms)"],"step_count":1}