{"level":"warn","ts":"2026-07-15T14:24:02.481738Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-15T14:24:02.481849Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.119:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.119:2380","--initial-cluster=instance=https://199.19.213.119:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.119:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.119: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-07-15T14:24:02.481934Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-15T14:24:02.481948Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.119:2380"]} {"level":"info","ts":"2026-07-15T14:24:02.481972Z","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-07-15T14:24:02.482943Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.119:2379"]} {"level":"info","ts":"2026-07-15T14:24:02.483084Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.119:2380"],"listen-peer-urls":["https://199.19.213.119:2380"],"advertise-client-urls":["https://199.19.213.119:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.119:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.119: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-07-15T14:24:02.488819Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.417871ms"} {"level":"info","ts":"2026-07-15T14:24:02.496074Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ec9077c81c499df2","cluster-id":"7e82d3f5f740d3fb"} {"level":"info","ts":"2026-07-15T14:24:02.496193Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ec9077c81c499df2 switched to configuration voters=()"} {"level":"info","ts":"2026-07-15T14:24:02.496231Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ec9077c81c499df2 became follower at term 0"} {"level":"info","ts":"2026-07-15T14:24:02.49625Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ec9077c81c499df2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-15T14:24:02.496284Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ec9077c81c499df2 became follower at term 1"} {"level":"info","ts":"2026-07-15T14:24:02.496341Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ec9077c81c499df2 switched to configuration voters=(17046256290949078514)"} {"level":"warn","ts":"2026-07-15T14:24:02.503779Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-15T14:24:02.506348Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-15T14:24:02.508245Z","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-07-15T14:24:02.512104Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ec9077c81c499df2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-15T14:24:02.512761Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ec9077c81c499df2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-15T14:24:02.514109Z","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-07-15T14:24:02.514437Z","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-07-15T14:24:02.514496Z","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-07-15T14:24:02.514573Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ec9077c81c499df2 switched to configuration voters=(17046256290949078514)"} {"level":"info","ts":"2026-07-15T14:24:02.514692Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"7e82d3f5f740d3fb","local-member-id":"ec9077c81c499df2","added-peer-id":"ec9077c81c499df2","added-peer-peer-urls":["https://199.19.213.119:2380"]} {"level":"info","ts":"2026-07-15T14:24:02.521559Z","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-07-15T14:24:02.521839Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ec9077c81c499df2","initial-advertise-peer-urls":["https://199.19.213.119:2380"],"listen-peer-urls":["https://199.19.213.119:2380"],"advertise-client-urls":["https://199.19.213.119:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.119:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-15T14:24:02.521889Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-15T14:24:02.521912Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.119:2380"} {"level":"info","ts":"2026-07-15T14:24:02.521984Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.119:2380"} {"level":"info","ts":"2026-07-15T14:24:02.796609Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ec9077c81c499df2 is starting a new election at term 1"} {"level":"info","ts":"2026-07-15T14:24:02.796703Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ec9077c81c499df2 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-15T14:24:02.796737Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ec9077c81c499df2 received MsgPreVoteResp from ec9077c81c499df2 at term 1"} {"level":"info","ts":"2026-07-15T14:24:02.796765Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ec9077c81c499df2 became candidate at term 2"} {"level":"info","ts":"2026-07-15T14:24:02.796789Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ec9077c81c499df2 received MsgVoteResp from ec9077c81c499df2 at term 2"} {"level":"info","ts":"2026-07-15T14:24:02.79682Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ec9077c81c499df2 became leader at term 2"} {"level":"info","ts":"2026-07-15T14:24:02.796847Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ec9077c81c499df2 elected leader ec9077c81c499df2 at term 2"} {"level":"info","ts":"2026-07-15T14:24:02.798228Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ec9077c81c499df2","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.119:2379]}","request-path":"/0/members/ec9077c81c499df2/attributes","cluster-id":"7e82d3f5f740d3fb","publish-timeout":"7s"} {"level":"info","ts":"2026-07-15T14:24:02.798316Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-15T14:24:02.798364Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-15T14:24:02.798942Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-15T14:24:02.798985Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-15T14:24:02.798405Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-15T14:24:02.801027Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.119:2379"} {"level":"info","ts":"2026-07-15T14:24:02.801258Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"7e82d3f5f740d3fb","local-member-id":"ec9077c81c499df2","cluster-version":"3.5"} {"level":"info","ts":"2026-07-15T14:24:02.802284Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-15T14:24:02.802329Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-15T14:24:02.803554Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-07-15T14:24:04.695413Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11381334469455233141,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-15T14:24:04.800231Z","caller":"traceutil/trace.go:171","msg":"trace[189760877] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"604.914162ms","start":"2026-07-15T14:24:04.19529Z","end":"2026-07-15T14:24:04.800204Z","steps":["trace[189760877] 'process raft request' (duration: 604.686653ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:24:04.800798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:24:04.195281Z","time spent":"605.026786ms","remote":"127.0.0.1:56782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-15T14:24:05.078936Z","caller":"traceutil/trace.go:171","msg":"trace[1450383860] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"883.515573ms","start":"2026-07-15T14:24:04.195394Z","end":"2026-07-15T14:24:05.07891Z","steps":["trace[1450383860] 'process raft request' (duration: 883.301825ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:24:05.079136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:24:04.195389Z","time spent":"883.653068ms","remote":"127.0.0.1:56774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-15T14:24:05.079685Z","caller":"traceutil/trace.go:171","msg":"trace[809485538] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"803.638915ms","start":"2026-07-15T14:24:04.27597Z","end":"2026-07-15T14:24:05.079608Z","steps":["trace[809485538] 'process raft request' (duration: 802.872186ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:24:05.079876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:24:04.275946Z","time spent":"803.838251ms","remote":"127.0.0.1:57164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-15T14:24:05.079875Z","caller":"traceutil/trace.go:171","msg":"trace[1173775620] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"793.39693ms","start":"2026-07-15T14:24:04.286425Z","end":"2026-07-15T14:24:05.079822Z","steps":["trace[1173775620] 'process raft request' (duration: 793.192972ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:24:05.080011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:24:04.28637Z","time spent":"793.577208ms","remote":"127.0.0.1:56886","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3159,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-15T14:24:05.080216Z","caller":"traceutil/trace.go:171","msg":"trace[170719323] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"788.740761ms","start":"2026-07-15T14:24:04.291445Z","end":"2026-07-15T14:24:05.080185Z","steps":["trace[170719323] 'process raft request' (duration: 788.247851ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:24:05.080333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:24:04.291427Z","time spent":"788.849075ms","remote":"127.0.0.1:57232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-15T14:24:05.080885Z","caller":"traceutil/trace.go:171","msg":"trace[308149301] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"789.327113ms","start":"2026-07-15T14:24:04.291523Z","end":"2026-07-15T14:24:05.08085Z","steps":["trace[308149301] 'process raft request' (duration: 788.21315ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:24:05.081043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:24:04.291514Z","time spent":"789.478889ms","remote":"127.0.0.1:57232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-15T14:24:05.081058Z","caller":"traceutil/trace.go:171","msg":"trace[1256009104] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"789.301272ms","start":"2026-07-15T14:24:04.291684Z","end":"2026-07-15T14:24:05.080986Z","steps":["trace[1256009104] 'process raft request' (duration: 789.058923ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:24:05.081185Z","caller":"traceutil/trace.go:171","msg":"trace[1344854973] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"788.953009ms","start":"2026-07-15T14:24:04.292219Z","end":"2026-07-15T14:24:05.081172Z","steps":["trace[1344854973] 'process raft request' (duration: 788.755381ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:24:05.081244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:24:04.292208Z","time spent":"789.009251ms","remote":"127.0.0.1:57232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-15T14:24:05.081343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:24:04.291662Z","time spent":"789.50503ms","remote":"127.0.0.1:57232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-15T14:24:05.081423Z","caller":"traceutil/trace.go:171","msg":"trace[242386996] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"789.644875ms","start":"2026-07-15T14:24:04.291767Z","end":"2026-07-15T14:24:05.081411Z","steps":["trace[242386996] 'process raft request' (duration: 789.020201ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:24:05.081554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:24:04.291745Z","time spent":"789.77258ms","remote":"127.0.0.1:57232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-15T14:24:05.081079Z","caller":"traceutil/trace.go:171","msg":"trace[1346223451] linearizableReadLoop","detail":"{readStateIndex:14; appliedIndex:4; }","duration":"885.692187ms","start":"2026-07-15T14:24:04.195368Z","end":"2026-07-15T14:24:05.08106Z","steps":["trace[1346223451] 'read index received' (duration: 604.745176ms)","trace[1346223451] 'applied index is now lower than readState.Index' (duration: 280.945981ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T14:24:05.081739Z","caller":"traceutil/trace.go:171","msg":"trace[1901511415] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"786.261085ms","start":"2026-07-15T14:24:04.295463Z","end":"2026-07-15T14:24:05.081724Z","steps":["trace[1901511415] 'process raft request' (duration: 785.560648ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:24:05.081968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:24:04.295451Z","time spent":"786.323528ms","remote":"127.0.0.1:56958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-15T14:24:05.081965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"885.911205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3171"} {"level":"info","ts":"2026-07-15T14:24:05.08206Z","caller":"traceutil/trace.go:171","msg":"trace[1837146025] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:11; }","duration":"886.03456ms","start":"2026-07-15T14:24:04.196002Z","end":"2026-07-15T14:24:05.082037Z","steps":["trace[1837146025] 'agreement among raft nodes before linearized reading' (duration: 885.817271ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:24:05.082535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"748.880144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-15T14:24:05.082601Z","caller":"traceutil/trace.go:171","msg":"trace[442290848] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"748.954176ms","start":"2026-07-15T14:24:04.333628Z","end":"2026-07-15T14:24:05.082582Z","steps":["trace[442290848] 'agreement among raft nodes before linearized reading' (duration: 748.831132ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:24:05.082632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:24:04.333614Z","time spent":"749.011338ms","remote":"127.0.0.1:56830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-07-15T14:24:05.082778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"736.576679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-15T14:24:05.082825Z","caller":"traceutil/trace.go:171","msg":"trace[591143475] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"736.659653ms","start":"2026-07-15T14:24:04.346158Z","end":"2026-07-15T14:24:05.082817Z","steps":["trace[591143475] 'agreement among raft nodes before linearized reading' (duration: 736.586001ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:24:05.082845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:24:04.34614Z","time spent":"736.700044ms","remote":"127.0.0.1:56830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-07-15T14:24:05.083327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"802.536142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-15T14:24:05.083432Z","caller":"traceutil/trace.go:171","msg":"trace[1448973437] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"802.672067ms","start":"2026-07-15T14:24:04.28075Z","end":"2026-07-15T14:24:05.083422Z","steps":["trace[1448973437] 'agreement among raft nodes before linearized reading' (duration: 802.535922ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:24:05.083459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:24:04.280724Z","time spent":"802.727039ms","remote":"127.0.0.1:56830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-07-15T14:24:05.083619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"791.539858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-15T14:24:05.083655Z","caller":"traceutil/trace.go:171","msg":"trace[1372934103] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"791.600351ms","start":"2026-07-15T14:24:04.292041Z","end":"2026-07-15T14:24:05.083641Z","steps":["trace[1372934103] 'agreement among raft nodes before linearized reading' (duration: 791.557629ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:24:05.083678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:24:04.29203Z","time spent":"791.642322ms","remote":"127.0.0.1:56790","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"warn","ts":"2026-07-15T14:24:05.084408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"810.56008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.119\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-15T14:24:05.084722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:24:04.195998Z","time spent":"886.097842ms","remote":"127.0.0.1:56886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3194,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-07-15T14:24:05.084793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"889.401618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3171"} {"level":"info","ts":"2026-07-15T14:24:05.084872Z","caller":"traceutil/trace.go:171","msg":"trace[2143975985] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:11; }","duration":"889.497893ms","start":"2026-07-15T14:24:04.195357Z","end":"2026-07-15T14:24:05.084855Z","steps":["trace[2143975985] 'agreement among raft nodes before linearized reading' (duration: 885.75594ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:24:05.084924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:24:04.195351Z","time spent":"889.563245ms","remote":"127.0.0.1:56886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3194,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-07-15T14:24:05.084708Z","caller":"traceutil/trace.go:171","msg":"trace[1033350910] range","detail":"{range_begin:/registry/masterleases/199.19.213.119; range_end:; response_count:0; response_revision:11; }","duration":"810.898593ms","start":"2026-07-15T14:24:04.273791Z","end":"2026-07-15T14:24:05.084689Z","steps":["trace[1033350910] 'agreement among raft nodes before linearized reading' (duration: 809.626005ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:24:05.085128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:24:04.273768Z","time spent":"811.34104ms","remote":"127.0.0.1:56748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/199.19.213.119\" "} {"level":"info","ts":"2026-07-15T14:24:11.601984Z","caller":"traceutil/trace.go:171","msg":"trace[930141663] transaction","detail":"{read_only:false; response_revision:294; number_of_response:1; }","duration":"214.510113ms","start":"2026-07-15T14:24:11.387444Z","end":"2026-07-15T14:24:11.601954Z","steps":["trace[930141663] 'process raft request' (duration: 208.066503ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:24:39.833599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.287797ms","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":"warn","ts":"2026-07-15T14:24:39.833653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.896306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-15T14:24:39.833739Z","caller":"traceutil/trace.go:171","msg":"trace[1489178266] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:485; }","duration":"264.03382ms","start":"2026-07-15T14:24:39.569679Z","end":"2026-07-15T14:24:39.833713Z","steps":["trace[1489178266] 'range keys from in-memory index tree' (duration: 263.788202ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:24:39.833699Z","caller":"traceutil/trace.go:171","msg":"trace[907136607] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:485; }","duration":"146.431202ms","start":"2026-07-15T14:24:39.687246Z","end":"2026-07-15T14:24:39.833678Z","steps":["trace[907136607] 'range keys from in-memory index tree' (duration: 146.219155ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:24:40.470423Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11381334469455234122,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-15T14:24:40.529096Z","caller":"traceutil/trace.go:171","msg":"trace[769327060] linearizableReadLoop","detail":"{readStateIndex:510; appliedIndex:509; }","duration":"559.183908ms","start":"2026-07-15T14:24:39.969886Z","end":"2026-07-15T14:24:40.52907Z","steps":["trace[769327060] 'read index received' (duration: 558.926829ms)","trace[769327060] 'applied index is now lower than readState.Index' (duration: 255.989µs)"],"step_count":2} {"level":"info","ts":"2026-07-15T14:24:40.529147Z","caller":"traceutil/trace.go:171","msg":"trace[492072920] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"691.934187ms","start":"2026-07-15T14:24:39.837163Z","end":"2026-07-15T14:24:40.529097Z","steps":["trace[492072920] 'process raft request' (duration: 691.760491ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:24:40.529278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"559.366654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T14:24:40.529322Z","caller":"traceutil/trace.go:171","msg":"trace[500018601] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:486; }","duration":"559.426636ms","start":"2026-07-15T14:24:39.969882Z","end":"2026-07-15T14:24:40.529308Z","steps":["trace[500018601] 'agreement among raft nodes before linearized reading' (duration: 559.332963ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:24:40.529321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:24:39.837142Z","time spent":"692.087301ms","remote":"127.0.0.1:56974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-15T14:24:40.529361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:24:39.969833Z","time spent":"559.519789ms","remote":"127.0.0.1:56712","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-07-15T14:24:42.255452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.818701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:151236"} {"level":"info","ts":"2026-07-15T14:24:42.255556Z","caller":"traceutil/trace.go:171","msg":"trace[1880451267] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:561; }","duration":"194.978175ms","start":"2026-07-15T14:24:42.060558Z","end":"2026-07-15T14:24:42.255537Z","steps":["trace[1880451267] 'range keys from in-memory index tree' (duration: 194.649805ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:24:42.255773Z","caller":"traceutil/trace.go:171","msg":"trace[787577362] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"157.675454ms","start":"2026-07-15T14:24:42.098083Z","end":"2026-07-15T14:24:42.255758Z","steps":["trace[787577362] 'process raft request' (duration: 156.499257ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:24:42.974186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.953947ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-15T14:24:42.974263Z","caller":"traceutil/trace.go:171","msg":"trace[927244342] linearizableReadLoop","detail":"{readStateIndex:595; appliedIndex:594; }","duration":"660.783827ms","start":"2026-07-15T14:24:42.313468Z","end":"2026-07-15T14:24:42.974252Z","steps":["trace[927244342] 'read index received' (duration: 158.475519ms)","trace[927244342] 'applied index is now lower than readState.Index' (duration: 502.307578ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T14:24:42.974469Z","caller":"traceutil/trace.go:171","msg":"trace[441145595] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"664.377522ms","start":"2026-07-15T14:24:42.310083Z","end":"2026-07-15T14:24:42.974461Z","steps":["trace[441145595] 'process raft request' (duration: 162.000472ms)","trace[441145595] 'compare' (duration: 501.871215ms)"],"step_count":2} {"level":"warn","ts":"2026-07-15T14:24:42.974509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:24:42.31007Z","time spent":"664.418164ms","remote":"127.0.0.1:56764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":15673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-15T14:24:42.974649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"661.180211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/tcproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:31145"} {"level":"info","ts":"2026-07-15T14:24:42.974664Z","caller":"traceutil/trace.go:171","msg":"trace[2092633295] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/tcproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:563; }","duration":"661.218012ms","start":"2026-07-15T14:24:42.31344Z","end":"2026-07-15T14:24:42.974658Z","steps":["trace[2092633295] 'agreement among raft nodes before linearized reading' (duration: 661.15193ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:24:42.974677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:24:42.31341Z","time spent":"661.264663ms","remote":"127.0.0.1:56764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":31168,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/tcproutes.gateway.networking.k8s.io\" "} {"level":"warn","ts":"2026-07-15T14:24:42.974873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.780032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-15T14:24:42.974907Z","caller":"traceutil/trace.go:171","msg":"trace[466873116] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:563; }","duration":"439.854584ms","start":"2026-07-15T14:24:42.535043Z","end":"2026-07-15T14:24:42.974898Z","steps":["trace[466873116] 'agreement among raft nodes before linearized reading' (duration: 439.775202ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:24:42.974935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:24:42.534992Z","time spent":"439.937386ms","remote":"127.0.0.1:56974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-15T14:24:42.975731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.477626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T14:24:42.975761Z","caller":"traceutil/trace.go:171","msg":"trace[1118939781] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:563; }","duration":"130.517717ms","start":"2026-07-15T14:24:42.845234Z","end":"2026-07-15T14:24:42.975752Z","steps":["trace[1118939781] 'agreement among raft nodes before linearized reading' (duration: 130.472956ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:24:42.975978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.405016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T14:24:42.976008Z","caller":"traceutil/trace.go:171","msg":"trace[1312103083] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:563; }","duration":"131.440117ms","start":"2026-07-15T14:24:42.844557Z","end":"2026-07-15T14:24:42.975997Z","steps":["trace[1312103083] 'agreement among raft nodes before linearized reading' (duration: 131.396936ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:24:42.976109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.55573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T14:24:42.976131Z","caller":"traceutil/trace.go:171","msg":"trace[1483395602] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:563; }","duration":"131.599382ms","start":"2026-07-15T14:24:42.844525Z","end":"2026-07-15T14:24:42.976125Z","steps":["trace[1483395602] 'agreement among raft nodes before linearized reading' (duration: 131.564471ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:24:42.976221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.042774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T14:24:42.976245Z","caller":"traceutil/trace.go:171","msg":"trace[1944786969] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:563; }","duration":"157.081016ms","start":"2026-07-15T14:24:42.819156Z","end":"2026-07-15T14:24:42.976237Z","steps":["trace[1944786969] 'agreement among raft nodes before linearized reading' (duration: 157.046355ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:24:42.976358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.261572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T14:24:42.97638Z","caller":"traceutil/trace.go:171","msg":"trace[195849063] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:563; }","duration":"158.308174ms","start":"2026-07-15T14:24:42.818065Z","end":"2026-07-15T14:24:42.976373Z","steps":["trace[195849063] 'agreement among raft nodes before linearized reading' (duration: 158.274063ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:24:42.976474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.399197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T14:24:42.976496Z","caller":"traceutil/trace.go:171","msg":"trace[1608220010] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:563; }","duration":"158.444999ms","start":"2026-07-15T14:24:42.818044Z","end":"2026-07-15T14:24:42.976489Z","steps":["trace[1608220010] 'agreement among raft nodes before linearized reading' (duration: 158.411617ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:24:42.976597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.382327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-15T14:24:42.976617Z","caller":"traceutil/trace.go:171","msg":"trace[1136379834] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:563; }","duration":"438.402727ms","start":"2026-07-15T14:24:42.538208Z","end":"2026-07-15T14:24:42.976611Z","steps":["trace[1136379834] 'agreement among raft nodes before linearized reading' (duration: 438.362116ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:24:42.976637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:24:42.538177Z","time spent":"438.454269ms","remote":"127.0.0.1:56974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-15T14:24:47.203589Z","caller":"traceutil/trace.go:171","msg":"trace[247335680] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"339.252104ms","start":"2026-07-15T14:24:46.864314Z","end":"2026-07-15T14:24:47.203566Z","steps":["trace[247335680] 'process raft request' (duration: 339.076378ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:24:47.20373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:24:46.864297Z","time spent":"339.365617ms","remote":"127.0.0.1:56896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-15T14:24:47.266708Z","caller":"traceutil/trace.go:171","msg":"trace[1687131234] linearizableReadLoop","detail":"{readStateIndex:622; appliedIndex:620; }","duration":"296.424292ms","start":"2026-07-15T14:24:46.970266Z","end":"2026-07-15T14:24:47.26669Z","steps":["trace[1687131234] 'read index received' (duration: 233.181359ms)","trace[1687131234] 'applied index is now lower than readState.Index' (duration: 63.242083ms)"],"step_count":2} {"level":"warn","ts":"2026-07-15T14:24:47.266979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.68938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T14:24:47.266985Z","caller":"traceutil/trace.go:171","msg":"trace[2039874115] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"344.731745ms","start":"2026-07-15T14:24:46.922224Z","end":"2026-07-15T14:24:47.266956Z","steps":["trace[2039874115] 'process raft request' (duration: 343.441885ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:24:47.267102Z","caller":"traceutil/trace.go:171","msg":"trace[1275174209] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:589; }","duration":"296.857466ms","start":"2026-07-15T14:24:46.970207Z","end":"2026-07-15T14:24:47.267064Z","steps":["trace[1275174209] 'agreement among raft nodes before linearized reading' (duration: 296.68331ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:24:47.267206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.118541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:503"} {"level":"warn","ts":"2026-07-15T14:24:47.267218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:24:46.922188Z","time spent":"344.941193ms","remote":"127.0.0.1:56804","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036229,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-15T14:24:47.267235Z","caller":"traceutil/trace.go:171","msg":"trace[902916105] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:589; }","duration":"257.188284ms","start":"2026-07-15T14:24:47.010038Z","end":"2026-07-15T14:24:47.267227Z","steps":["trace[902916105] 'agreement among raft nodes before linearized reading' (duration: 257.07236ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:24:47.267403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.138217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-15T14:24:47.267426Z","caller":"traceutil/trace.go:171","msg":"trace[1597061764] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:589; }","duration":"253.198299ms","start":"2026-07-15T14:24:47.01422Z","end":"2026-07-15T14:24:47.267418Z","steps":["trace[1597061764] 'agreement among raft nodes before linearized reading' (duration: 253.134897ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:24:47.267594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.859041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-07-15T14:24:47.26763Z","caller":"traceutil/trace.go:171","msg":"trace[1290178180] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:589; }","duration":"254.915012ms","start":"2026-07-15T14:24:47.012705Z","end":"2026-07-15T14:24:47.26762Z","steps":["trace[1290178180] 'agreement among raft nodes before linearized reading' (duration: 254.818269ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:24:47.973589Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11381334469455234353,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-15T14:24:48.474273Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11381334469455234353,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-15T14:24:48.775845Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.504942499s","expected-duration":"1s"} {"level":"warn","ts":"2026-07-15T14:24:48.883037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.829418ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-15T14:24:48.883223Z","caller":"traceutil/trace.go:171","msg":"trace[1684370586] linearizableReadLoop","detail":"{readStateIndex:626; appliedIndex:622; }","duration":"1.409701873s","start":"2026-07-15T14:24:47.473508Z","end":"2026-07-15T14:24:48.88321Z","steps":["trace[1684370586] 'read index received' (duration: 1.302605777s)","trace[1684370586] 'applied index is now lower than readState.Index' (duration: 107.095316ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T14:24:48.88339Z","caller":"traceutil/trace.go:171","msg":"trace[916175184] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"1.564312046s","start":"2026-07-15T14:24:47.319068Z","end":"2026-07-15T14:24:48.88338Z","steps":["trace[916175184] 'process raft request' (duration: 1.56411051s)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:24:48.883433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:24:47.319043Z","time spent":"1.564368808s","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1092,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-15T14:24:48.883505Z","caller":"traceutil/trace.go:171","msg":"trace[1567494106] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"1.612706606s","start":"2026-07-15T14:24:47.270761Z","end":"2026-07-15T14:24:48.883468Z","steps":["trace[1567494106] 'process raft request' (duration: 1.505342761s)","trace[1567494106] 'compare' (duration: 106.732536ms)"],"step_count":2} {"level":"warn","ts":"2026-07-15T14:24:48.883646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:24:47.270739Z","time spent":"1.61283618s","remote":"127.0.0.1:56974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-15T14:24:48.883648Z","caller":"traceutil/trace.go:171","msg":"trace[808908279] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"1.612180939s","start":"2026-07-15T14:24:47.271428Z","end":"2026-07-15T14:24:48.883609Z","steps":["trace[808908279] 'process raft request' (duration: 1.611723975s)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:24:48.883681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.410158028s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-15T14:24:48.883761Z","caller":"traceutil/trace.go:171","msg":"trace[1617658267] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:593; }","duration":"1.410270401s","start":"2026-07-15T14:24:47.473468Z","end":"2026-07-15T14:24:48.883738Z","steps":["trace[1617658267] 'agreement among raft nodes before linearized reading' (duration: 1.410008403s)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:24:48.883788Z","caller":"traceutil/trace.go:171","msg":"trace[1646650817] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"1.612669025s","start":"2026-07-15T14:24:47.271083Z","end":"2026-07-15T14:24:48.883752Z","steps":["trace[1646650817] 'process raft request' (duration: 1.612029805s)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:24:48.883818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:24:47.271408Z","time spent":"1.612333144s","remote":"127.0.0.1:56974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-15T14:24:48.883818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:24:47.47345Z","time spent":"1.410354193s","remote":"127.0.0.1:56974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-15T14:24:48.883931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:24:47.271062Z","time spent":"1.612799919s","remote":"127.0.0.1:56974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-15T14:24:48.899581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"928.86105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T14:24:48.899658Z","caller":"traceutil/trace.go:171","msg":"trace[1435413984] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:594; }","duration":"928.980333ms","start":"2026-07-15T14:24:47.970659Z","end":"2026-07-15T14:24:48.899639Z","steps":["trace[1435413984] 'agreement among raft nodes before linearized reading' (duration: 928.852699ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:24:48.899749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:24:47.970637Z","time spent":"929.100737ms","remote":"127.0.0.1:56712","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-07-15T14:24:50.395407Z","caller":"traceutil/trace.go:171","msg":"trace[1618680217] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"104.755433ms","start":"2026-07-15T14:24:50.290598Z","end":"2026-07-15T14:24:50.395353Z","steps":["trace[1618680217] 'process raft request' (duration: 103.554826ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:00.796608Z","caller":"traceutil/trace.go:171","msg":"trace[94257566] transaction","detail":"{read_only:false; response_revision:726; number_of_response:1; }","duration":"127.742018ms","start":"2026-07-15T14:25:00.66884Z","end":"2026-07-15T14:25:00.796582Z","steps":["trace[94257566] 'process raft request' (duration: 127.591864ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:01.173239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.993632ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-15T14:25:01.173579Z","caller":"traceutil/trace.go:171","msg":"trace[72731138] transaction","detail":"{read_only:false; response_revision:729; number_of_response:1; }","duration":"184.30364ms","start":"2026-07-15T14:25:00.98923Z","end":"2026-07-15T14:25:01.173533Z","steps":["trace[72731138] 'process raft request' (duration: 59.916487ms)","trace[72731138] 'compare' (duration: 123.838318ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T14:25:01.173807Z","caller":"traceutil/trace.go:171","msg":"trace[378100857] transaction","detail":"{read_only:false; response_revision:730; number_of_response:1; }","duration":"183.92734ms","start":"2026-07-15T14:25:00.989851Z","end":"2026-07-15T14:25:01.173778Z","steps":["trace[378100857] 'process raft request' (duration: 183.58499ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:02.153596Z","caller":"traceutil/trace.go:171","msg":"trace[507649272] transaction","detail":"{read_only:false; response_revision:735; number_of_response:1; }","duration":"169.502137ms","start":"2026-07-15T14:25:01.984072Z","end":"2026-07-15T14:25:02.153575Z","steps":["trace[507649272] 'process raft request' (duration: 169.366813ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:02.389375Z","caller":"traceutil/trace.go:171","msg":"trace[163446071] transaction","detail":"{read_only:false; response_revision:740; number_of_response:1; }","duration":"126.062097ms","start":"2026-07-15T14:25:02.263285Z","end":"2026-07-15T14:25:02.389347Z","steps":["trace[163446071] 'process raft request' (duration: 82.978221ms)","trace[163446071] 'compare' (duration: 42.953102ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T14:25:02.389758Z","caller":"traceutil/trace.go:171","msg":"trace[274318306] transaction","detail":"{read_only:false; response_revision:741; number_of_response:1; }","duration":"124.031637ms","start":"2026-07-15T14:25:02.265696Z","end":"2026-07-15T14:25:02.389728Z","steps":["trace[274318306] 'process raft request' (duration: 123.715218ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:02.515234Z","caller":"traceutil/trace.go:171","msg":"trace[1250547904] transaction","detail":"{read_only:false; response_revision:742; number_of_response:1; }","duration":"118.223248ms","start":"2026-07-15T14:25:02.396984Z","end":"2026-07-15T14:25:02.515207Z","steps":["trace[1250547904] 'process raft request' (duration: 109.072921ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:05.450111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.1011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-07-15T14:25:05.450178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.11349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-07-15T14:25:05.450206Z","caller":"traceutil/trace.go:171","msg":"trace[1771446863] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:750; }","duration":"208.204224ms","start":"2026-07-15T14:25:05.241967Z","end":"2026-07-15T14:25:05.450171Z","steps":["trace[1771446863] 'range keys from in-memory index tree' (duration: 207.969967ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:05.450244Z","caller":"traceutil/trace.go:171","msg":"trace[192459727] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:750; }","duration":"209.224684ms","start":"2026-07-15T14:25:05.241002Z","end":"2026-07-15T14:25:05.450227Z","steps":["trace[192459727] 'range keys from in-memory index tree' (duration: 208.959225ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:05.698708Z","caller":"traceutil/trace.go:171","msg":"trace[948090689] transaction","detail":"{read_only:false; response_revision:751; number_of_response:1; }","duration":"244.20234ms","start":"2026-07-15T14:25:05.454481Z","end":"2026-07-15T14:25:05.698683Z","steps":["trace[948090689] 'process raft request' (duration: 243.994494ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:05.735863Z","caller":"traceutil/trace.go:171","msg":"trace[2141236318] transaction","detail":"{read_only:false; response_revision:752; number_of_response:1; }","duration":"281.259457ms","start":"2026-07-15T14:25:05.454588Z","end":"2026-07-15T14:25:05.735848Z","steps":["trace[2141236318] 'process raft request' (duration: 281.179204ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:06.286817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.620749ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-15T14:25:06.2869Z","caller":"traceutil/trace.go:171","msg":"trace[1762184316] linearizableReadLoop","detail":"{readStateIndex:791; appliedIndex:790; }","duration":"246.809195ms","start":"2026-07-15T14:25:06.040079Z","end":"2026-07-15T14:25:06.286888Z","steps":["trace[1762184316] 'read index received' (duration: 30.00206ms)","trace[1762184316] 'applied index is now lower than readState.Index' (duration: 216.806275ms)"],"step_count":2} {"level":"warn","ts":"2026-07-15T14:25:06.28696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.879697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T14:25:06.286981Z","caller":"traceutil/trace.go:171","msg":"trace[1093334659] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:753; }","duration":"246.919877ms","start":"2026-07-15T14:25:06.040056Z","end":"2026-07-15T14:25:06.286976Z","steps":["trace[1093334659] 'agreement among raft nodes before linearized reading' (duration: 246.861885ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:06.287035Z","caller":"traceutil/trace.go:171","msg":"trace[2127937396] transaction","detail":"{read_only:false; response_revision:753; number_of_response:1; }","duration":"247.117583ms","start":"2026-07-15T14:25:06.039874Z","end":"2026-07-15T14:25:06.286992Z","steps":["trace[2127937396] 'process raft request' (duration: 30.254037ms)","trace[2127937396] 'compare' (duration: 216.495115ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T14:25:07.044197Z","caller":"traceutil/trace.go:171","msg":"trace[752593674] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"192.694888ms","start":"2026-07-15T14:25:06.851468Z","end":"2026-07-15T14:25:07.044162Z","steps":["trace[752593674] 'process raft request' (duration: 192.457991ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:07.463744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.106958ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-15T14:25:07.463952Z","caller":"traceutil/trace.go:171","msg":"trace[1155870922] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"532.117476ms","start":"2026-07-15T14:25:06.931792Z","end":"2026-07-15T14:25:07.463909Z","steps":["trace[1155870922] 'process raft request' (duration: 418.70955ms)","trace[1155870922] 'compare' (duration: 112.896052ms)"],"step_count":2} {"level":"warn","ts":"2026-07-15T14:25:07.464125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.939978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-15T14:25:07.464183Z","caller":"traceutil/trace.go:171","msg":"trace[1424030057] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:755; }","duration":"424.046191ms","start":"2026-07-15T14:25:07.040124Z","end":"2026-07-15T14:25:07.46417Z","steps":["trace[1424030057] 'agreement among raft nodes before linearized reading' (duration: 423.884487ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:07.464209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:25:07.040104Z","time spent":"424.100363ms","remote":"127.0.0.1:56974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-15T14:25:07.464192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:25:06.93175Z","time spent":"532.315851ms","remote":"127.0.0.1:56974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-15T14:25:07.464038Z","caller":"traceutil/trace.go:171","msg":"trace[1035823511] linearizableReadLoop","detail":"{readStateIndex:793; appliedIndex:791; }","duration":"423.716732ms","start":"2026-07-15T14:25:07.040166Z","end":"2026-07-15T14:25:07.463882Z","steps":["trace[1035823511] 'read index received' (duration: 3.718456ms)","trace[1035823511] 'applied index is now lower than readState.Index' (duration: 419.996596ms)"],"step_count":2} {"level":"warn","ts":"2026-07-15T14:25:07.465102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.244743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-07-15T14:25:07.465188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.074507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-15T14:25:07.465324Z","caller":"traceutil/trace.go:171","msg":"trace[1722549105] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:755; }","duration":"380.238163ms","start":"2026-07-15T14:25:07.085042Z","end":"2026-07-15T14:25:07.46528Z","steps":["trace[1722549105] 'agreement among raft nodes before linearized reading' (duration: 380.059638ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:07.465693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:25:07.085018Z","time spent":"380.541711ms","remote":"127.0.0.1:56804","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":5,"response size":30,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "} {"level":"info","ts":"2026-07-15T14:25:07.465915Z","caller":"traceutil/trace.go:171","msg":"trace[1975714655] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:755; }","duration":"386.365417ms","start":"2026-07-15T14:25:07.078783Z","end":"2026-07-15T14:25:07.465148Z","steps":["trace[1975714655] 'agreement among raft nodes before linearized reading' (duration: 386.164671ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:07.466106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:25:07.078753Z","time spent":"387.329513ms","remote":"127.0.0.1:56974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-15T14:25:07.636896Z","caller":"traceutil/trace.go:171","msg":"trace[698731123] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"167.664295ms","start":"2026-07-15T14:25:07.469197Z","end":"2026-07-15T14:25:07.636861Z","steps":["trace[698731123] 'process raft request' (duration: 119.964754ms)","trace[698731123] 'compare' (duration: 47.417303ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T14:25:09.184238Z","caller":"traceutil/trace.go:171","msg":"trace[191807868] transaction","detail":"{read_only:false; response_revision:761; number_of_response:1; }","duration":"110.887467ms","start":"2026-07-15T14:25:09.073326Z","end":"2026-07-15T14:25:09.184213Z","steps":["trace[191807868] 'process raft request' (duration: 101.166293ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:09.400759Z","caller":"traceutil/trace.go:171","msg":"trace[44759195] transaction","detail":"{read_only:false; response_revision:762; number_of_response:1; }","duration":"264.081584ms","start":"2026-07-15T14:25:09.13665Z","end":"2026-07-15T14:25:09.400732Z","steps":["trace[44759195] 'process raft request' (duration: 192.082176ms)","trace[44759195] 'compare' (duration: 71.884814ms)"],"step_count":2} {"level":"warn","ts":"2026-07-15T14:25:09.700234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.831005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-07-15T14:25:09.700294Z","caller":"traceutil/trace.go:171","msg":"trace[335084839] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:762; }","duration":"158.929768ms","start":"2026-07-15T14:25:09.541351Z","end":"2026-07-15T14:25:09.700281Z","steps":["trace[335084839] 'range keys from in-memory index tree' (duration: 158.468535ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:09.823208Z","caller":"traceutil/trace.go:171","msg":"trace[459807893] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"117.737362ms","start":"2026-07-15T14:25:09.705449Z","end":"2026-07-15T14:25:09.823186Z","steps":["trace[459807893] 'process raft request' (duration: 115.428986ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:10.079355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.904965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T14:25:10.079419Z","caller":"traceutil/trace.go:171","msg":"trace[1199347661] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:766; }","duration":"108.028989ms","start":"2026-07-15T14:25:09.971375Z","end":"2026-07-15T14:25:10.079404Z","steps":["trace[1199347661] 'range keys from in-memory index tree' (duration: 107.802852ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:11.344981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.00073ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-15T14:25:11.345104Z","caller":"traceutil/trace.go:171","msg":"trace[434450802] linearizableReadLoop","detail":"{readStateIndex:805; appliedIndex:804; }","duration":"156.607804ms","start":"2026-07-15T14:25:11.188468Z","end":"2026-07-15T14:25:11.345075Z","steps":["trace[434450802] 'read index received' (duration: 39.681µs)","trace[434450802] 'applied index is now lower than readState.Index' (duration: 156.566413ms)"],"step_count":2} {"level":"warn","ts":"2026-07-15T14:25:11.345333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.854251ms","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-07-15T14:25:11.345409Z","caller":"traceutil/trace.go:171","msg":"trace[1479005737] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:766; }","duration":"156.976305ms","start":"2026-07-15T14:25:11.188415Z","end":"2026-07-15T14:25:11.345392Z","steps":["trace[1479005737] 'agreement among raft nodes before linearized reading' (duration: 156.769759ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:14.33685Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11381334469455234735,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-15T14:25:14.837726Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11381334469455234735,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-15T14:25:15.338113Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11381334469455234735,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-15T14:25:15.35474Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.416211152s","expected-duration":"1s"} {"level":"info","ts":"2026-07-15T14:25:15.355283Z","caller":"traceutil/trace.go:171","msg":"trace[1978296034] linearizableReadLoop","detail":"{readStateIndex:821; appliedIndex:820; }","duration":"1.519400403s","start":"2026-07-15T14:25:13.835855Z","end":"2026-07-15T14:25:15.355255Z","steps":["trace[1978296034] 'read index received' (duration: 1.519041834s)","trace[1978296034] 'applied index is now lower than readState.Index' (duration: 357.359µs)"],"step_count":2} {"level":"info","ts":"2026-07-15T14:25:15.355325Z","caller":"traceutil/trace.go:171","msg":"trace[807146021] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"1.534060951s","start":"2026-07-15T14:25:13.821248Z","end":"2026-07-15T14:25:15.355309Z","steps":["trace[807146021] 'process raft request' (duration: 1.533858275s)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:15.35544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:25:13.821225Z","time spent":"1.534137533s","remote":"127.0.0.1:56974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-15T14:25:15.355575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.410617237s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T14:25:15.355612Z","caller":"traceutil/trace.go:171","msg":"trace[2025793353] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:781; }","duration":"1.410667378s","start":"2026-07-15T14:25:13.944934Z","end":"2026-07-15T14:25:15.355602Z","steps":["trace[2025793353] 'agreement among raft nodes before linearized reading' (duration: 1.410603936s)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:15.355641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:25:13.944925Z","time spent":"1.410706789s","remote":"127.0.0.1:53544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:500 "} {"level":"warn","ts":"2026-07-15T14:25:15.355677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.44240393s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T14:25:15.355775Z","caller":"traceutil/trace.go:171","msg":"trace[25996153] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:781; }","duration":"1.442482643s","start":"2026-07-15T14:25:13.913238Z","end":"2026-07-15T14:25:15.355721Z","steps":["trace[25996153] 'agreement among raft nodes before linearized reading' (duration: 1.44235528s)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:15.356662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:25:13.913231Z","time spent":"1.443403739s","remote":"127.0.0.1:53530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:10000 "} {"level":"warn","ts":"2026-07-15T14:25:15.35572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.483135534s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-15T14:25:15.356847Z","caller":"traceutil/trace.go:171","msg":"trace[699148884] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:781; }","duration":"1.484280497s","start":"2026-07-15T14:25:13.872498Z","end":"2026-07-15T14:25:15.356779Z","steps":["trace[699148884] 'agreement among raft nodes before linearized reading' (duration: 1.48297411s)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:15.356983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:25:13.872478Z","time spent":"1.484455551s","remote":"127.0.0.1:56974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-15T14:25:15.355822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.384241013s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T14:25:15.357161Z","caller":"traceutil/trace.go:171","msg":"trace[1562277826] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:781; }","duration":"1.385575101s","start":"2026-07-15T14:25:13.971571Z","end":"2026-07-15T14:25:15.357146Z","steps":["trace[1562277826] 'agreement among raft nodes before linearized reading' (duration: 1.384222433s)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:15.357242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:25:13.971522Z","time spent":"1.385675843s","remote":"127.0.0.1:56712","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-07-15T14:25:15.355801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.4110864s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T14:25:15.357303Z","caller":"traceutil/trace.go:171","msg":"trace[108078024] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:781; }","duration":"1.412667624s","start":"2026-07-15T14:25:13.944621Z","end":"2026-07-15T14:25:15.357289Z","steps":["trace[108078024] 'agreement among raft nodes before linearized reading' (duration: 1.411030988s)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:15.357349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:25:13.944597Z","time spent":"1.412738195s","remote":"127.0.0.1:53544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:10000 "} {"level":"warn","ts":"2026-07-15T14:25:15.355866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.398984604s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T14:25:15.357421Z","caller":"traceutil/trace.go:171","msg":"trace[1320320457] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:781; }","duration":"1.400544447s","start":"2026-07-15T14:25:13.956861Z","end":"2026-07-15T14:25:15.357405Z","steps":["trace[1320320457] 'agreement among raft nodes before linearized reading' (duration: 1.398980354s)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:15.357462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:25:13.95685Z","time spent":"1.400600758s","remote":"127.0.0.1:53546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:10000 "} {"level":"warn","ts":"2026-07-15T14:25:15.35587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.380576421s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-x4kzq\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-07-15T14:25:15.357594Z","caller":"traceutil/trace.go:171","msg":"trace[1636876805] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-x4kzq; range_end:; response_count:1; response_revision:781; }","duration":"1.38235482s","start":"2026-07-15T14:25:13.975228Z","end":"2026-07-15T14:25:15.357582Z","steps":["trace[1636876805] 'agreement among raft nodes before linearized reading' (duration: 1.380373615s)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:15.357634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:25:13.975221Z","time spent":"1.382402062s","remote":"127.0.0.1:56896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3988,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-x4kzq\" "} {"level":"warn","ts":"2026-07-15T14:25:15.355892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.458860439s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T14:25:15.357813Z","caller":"traceutil/trace.go:171","msg":"trace[1375727704] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:781; }","duration":"1.460803523s","start":"2026-07-15T14:25:13.896964Z","end":"2026-07-15T14:25:15.357768Z","steps":["trace[1375727704] 'agreement among raft nodes before linearized reading' (duration: 1.458850399s)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:15.357857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:25:13.896959Z","time spent":"1.460884755s","remote":"127.0.0.1:53514","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 "} {"level":"warn","ts":"2026-07-15T14:25:15.355917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.411241935s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T14:25:15.357969Z","caller":"traceutil/trace.go:171","msg":"trace[763203300] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:781; }","duration":"1.413322491s","start":"2026-07-15T14:25:13.944635Z","end":"2026-07-15T14:25:15.357958Z","steps":["trace[763203300] 'agreement among raft nodes before linearized reading' (duration: 1.411246274s)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:15.358051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:25:13.94461Z","time spent":"1.413402753s","remote":"127.0.0.1:53544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "} {"level":"warn","ts":"2026-07-15T14:25:15.355924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.398631925s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T14:25:15.358096Z","caller":"traceutil/trace.go:171","msg":"trace[783341466] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:781; }","duration":"1.400843534s","start":"2026-07-15T14:25:13.957242Z","end":"2026-07-15T14:25:15.358085Z","steps":["trace[783341466] 'agreement among raft nodes before linearized reading' (duration: 1.398604203s)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:15.358136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:25:13.957224Z","time spent":"1.400900376s","remote":"127.0.0.1:53546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "} {"level":"warn","ts":"2026-07-15T14:25:15.355952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.459665102s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T14:25:15.358258Z","caller":"traceutil/trace.go:171","msg":"trace[1447798279] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:781; }","duration":"1.461974215s","start":"2026-07-15T14:25:13.896275Z","end":"2026-07-15T14:25:15.358249Z","steps":["trace[1447798279] 'agreement among raft nodes before linearized reading' (duration: 1.459648031s)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:15.358308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:25:13.896255Z","time spent":"1.462024416s","remote":"127.0.0.1:53514","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-15T14:25:15.355968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.37979741s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T14:25:15.358523Z","caller":"traceutil/trace.go:171","msg":"trace[2003960852] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:781; }","duration":"1.38234244s","start":"2026-07-15T14:25:13.976163Z","end":"2026-07-15T14:25:15.358505Z","steps":["trace[2003960852] 'agreement among raft nodes before linearized reading' (duration: 1.37978437s)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:15.355988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.252614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-15T14:25:15.358618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:25:13.976117Z","time spent":"1.382470013s","remote":"127.0.0.1:53556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true "} {"level":"info","ts":"2026-07-15T14:25:15.358772Z","caller":"traceutil/trace.go:171","msg":"trace[487337849] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:781; }","duration":"479.02038ms","start":"2026-07-15T14:25:14.879726Z","end":"2026-07-15T14:25:15.358747Z","steps":["trace[487337849] 'agreement among raft nodes before linearized reading' (duration: 476.192682ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:15.358839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:25:14.879654Z","time spent":"479.163394ms","remote":"127.0.0.1:57226","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":72,"response size":30,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-07-15T14:25:15.356001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.459990291s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T14:25:15.359155Z","caller":"traceutil/trace.go:171","msg":"trace[1200878805] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:781; }","duration":"1.463161399s","start":"2026-07-15T14:25:13.895978Z","end":"2026-07-15T14:25:15.359139Z","steps":["trace[1200878805] 'agreement among raft nodes before linearized reading' (duration: 1.459996722s)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:15.3593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:25:13.895965Z","time spent":"1.46322483s","remote":"127.0.0.1:53514","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 "} {"level":"warn","ts":"2026-07-15T14:25:15.356018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.379676446s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T14:25:15.359382Z","caller":"traceutil/trace.go:171","msg":"trace[1960889947] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:781; }","duration":"1.38305908s","start":"2026-07-15T14:25:13.976303Z","end":"2026-07-15T14:25:15.359362Z","steps":["trace[1960889947] 'agreement among raft nodes before linearized reading' (duration: 1.379681197s)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:15.35946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:25:13.976296Z","time spent":"1.383137562s","remote":"127.0.0.1:53556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:500 "} {"level":"warn","ts":"2026-07-15T14:25:15.356003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.398587763s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T14:25:15.359804Z","caller":"traceutil/trace.go:171","msg":"trace[247064335] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:781; }","duration":"1.402333416s","start":"2026-07-15T14:25:13.957391Z","end":"2026-07-15T14:25:15.359725Z","steps":["trace[247064335] 'agreement among raft nodes before linearized reading' (duration: 1.398576843s)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:15.359909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:25:13.957385Z","time spent":"1.40250203s","remote":"127.0.0.1:53546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:500 "} {"level":"warn","ts":"2026-07-15T14:25:15.356027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.380035147s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T14:25:15.360124Z","caller":"traceutil/trace.go:171","msg":"trace[20573083] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:781; }","duration":"1.38416361s","start":"2026-07-15T14:25:13.975934Z","end":"2026-07-15T14:25:15.360098Z","steps":["trace[20573083] 'agreement among raft nodes before linearized reading' (duration: 1.380069638s)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:15.360196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:25:13.975919Z","time spent":"1.384254732s","remote":"127.0.0.1:53556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-07-15T14:25:15.356028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.441903327s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T14:25:15.360414Z","caller":"traceutil/trace.go:171","msg":"trace[292214488] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:781; }","duration":"1.446296668s","start":"2026-07-15T14:25:13.9141Z","end":"2026-07-15T14:25:15.360397Z","steps":["trace[292214488] 'agreement among raft nodes before linearized reading' (duration: 1.441899458s)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:15.356064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.442629277s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-15T14:25:15.356119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.479921275s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-07-15T14:25:15.356112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.520267087s","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-07-15T14:25:15.360882Z","caller":"traceutil/trace.go:171","msg":"trace[1707239705] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:781; }","duration":"1.44745539s","start":"2026-07-15T14:25:13.913411Z","end":"2026-07-15T14:25:15.360866Z","steps":["trace[1707239705] 'agreement among raft nodes before linearized reading' (duration: 1.442626068s)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:15.360921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:25:13.914092Z","time spent":"1.446815272s","remote":"127.0.0.1:53530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:500 "} {"level":"warn","ts":"2026-07-15T14:25:15.360948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:25:13.913404Z","time spent":"1.447522651s","remote":"127.0.0.1:53530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true "} {"level":"info","ts":"2026-07-15T14:25:15.361046Z","caller":"traceutil/trace.go:171","msg":"trace[750607549] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:781; }","duration":"1.525234713s","start":"2026-07-15T14:25:13.8358Z","end":"2026-07-15T14:25:15.361034Z","steps":["trace[750607549] 'agreement among raft nodes before linearized reading' (duration: 1.519576608s)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:15.361088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:25:13.835776Z","time spent":"1.525300486s","remote":"127.0.0.1:56974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-15T14:25:15.361084Z","caller":"traceutil/trace.go:171","msg":"trace[1853084575] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:781; }","duration":"1.484906312s","start":"2026-07-15T14:25:13.876165Z","end":"2026-07-15T14:25:15.361071Z","steps":["trace[1853084575] 'agreement among raft nodes before linearized reading' (duration: 1.479832753s)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:15.361128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:25:13.876155Z","time spent":"1.484960314s","remote":"127.0.0.1:56974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-15T14:25:15.529033Z","caller":"traceutil/trace.go:171","msg":"trace[1658798622] transaction","detail":"{read_only:false; response_revision:782; number_of_response:1; }","duration":"163.752608ms","start":"2026-07-15T14:25:15.365252Z","end":"2026-07-15T14:25:15.529005Z","steps":["trace[1658798622] 'process raft request' (duration: 71.290507ms)","trace[1658798622] 'compare' (duration: 92.358138ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T14:25:15.530847Z","caller":"traceutil/trace.go:171","msg":"trace[2087121976] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"163.854132ms","start":"2026-07-15T14:25:15.366959Z","end":"2026-07-15T14:25:15.530813Z","steps":["trace[2087121976] 'process raft request' (duration: 163.647146ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:15.530946Z","caller":"traceutil/trace.go:171","msg":"trace[670584197] transaction","detail":"{read_only:false; response_revision:785; number_of_response:1; }","duration":"162.840793ms","start":"2026-07-15T14:25:15.368088Z","end":"2026-07-15T14:25:15.530929Z","steps":["trace[670584197] 'process raft request' (duration: 162.701719ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:15.530916Z","caller":"traceutil/trace.go:171","msg":"trace[109450849] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"163.530792ms","start":"2026-07-15T14:25:15.36736Z","end":"2026-07-15T14:25:15.530891Z","steps":["trace[109450849] 'process raft request' (duration: 163.380598ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:15.530866Z","caller":"traceutil/trace.go:171","msg":"trace[992578115] linearizableReadLoop","detail":"{readStateIndex:824; appliedIndex:821; }","duration":"162.75ms","start":"2026-07-15T14:25:15.368087Z","end":"2026-07-15T14:25:15.530837Z","steps":["trace[992578115] 'read index received' (duration: 68.594052ms)","trace[992578115] 'applied index is now lower than readState.Index' (duration: 94.154788ms)"],"step_count":2} {"level":"warn","ts":"2026-07-15T14:25:15.531221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.108971ms","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-07-15T14:25:15.531382Z","caller":"traceutil/trace.go:171","msg":"trace[1170275931] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:785; }","duration":"163.323857ms","start":"2026-07-15T14:25:15.368047Z","end":"2026-07-15T14:25:15.531371Z","steps":["trace[1170275931] 'agreement among raft nodes before linearized reading' (duration: 162.879625ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:15.531583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.933346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-15T14:25:15.531584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.019968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T14:25:15.531616Z","caller":"traceutil/trace.go:171","msg":"trace[1080094441] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:785; }","duration":"158.982187ms","start":"2026-07-15T14:25:15.372626Z","end":"2026-07-15T14:25:15.531608Z","steps":["trace[1080094441] 'agreement among raft nodes before linearized reading' (duration: 158.915155ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:15.53164Z","caller":"traceutil/trace.go:171","msg":"trace[945848847] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:785; }","duration":"163.09343ms","start":"2026-07-15T14:25:15.368528Z","end":"2026-07-15T14:25:15.531622Z","steps":["trace[945848847] 'agreement among raft nodes before linearized reading' (duration: 162.902434ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:17.450983Z","caller":"traceutil/trace.go:171","msg":"trace[725032858] transaction","detail":"{read_only:false; number_of_response:1; response_revision:789; }","duration":"176.883519ms","start":"2026-07-15T14:25:17.274074Z","end":"2026-07-15T14:25:17.450957Z","steps":["trace[725032858] 'process raft request' (duration: 176.727595ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:22.637111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.124984ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-15T14:25:22.637298Z","caller":"traceutil/trace.go:171","msg":"trace[1367321273] linearizableReadLoop","detail":"{readStateIndex:898; appliedIndex:895; }","duration":"196.62387ms","start":"2026-07-15T14:25:22.440661Z","end":"2026-07-15T14:25:22.637285Z","steps":["trace[1367321273] 'read index received' (duration: 96.27997ms)","trace[1367321273] 'applied index is now lower than readState.Index' (duration: 100.34318ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T14:25:22.637362Z","caller":"traceutil/trace.go:171","msg":"trace[1885415549] transaction","detail":"{read_only:false; response_revision:855; number_of_response:1; }","duration":"236.007297ms","start":"2026-07-15T14:25:22.401316Z","end":"2026-07-15T14:25:22.637324Z","steps":["trace[1885415549] 'process raft request' (duration: 235.886174ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:22.637395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.732083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-67659f764b-2hrjz\" ","response":"range_response_count:1 size:3871"} {"level":"info","ts":"2026-07-15T14:25:22.637425Z","caller":"traceutil/trace.go:171","msg":"trace[650526513] range","detail":"{range_begin:/registry/pods/kube-system/coredns-67659f764b-2hrjz; range_end:; response_count:1; response_revision:856; }","duration":"196.774493ms","start":"2026-07-15T14:25:22.440642Z","end":"2026-07-15T14:25:22.637417Z","steps":["trace[650526513] 'agreement among raft nodes before linearized reading' (duration: 196.682341ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:22.637369Z","caller":"traceutil/trace.go:171","msg":"trace[422770103] transaction","detail":"{read_only:false; response_revision:856; number_of_response:1; }","duration":"196.792364ms","start":"2026-07-15T14:25:22.440562Z","end":"2026-07-15T14:25:22.637354Z","steps":["trace[422770103] 'process raft request' (duration: 196.691131ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:22.637423Z","caller":"traceutil/trace.go:171","msg":"trace[1619624348] transaction","detail":"{read_only:false; response_revision:854; number_of_response:1; }","duration":"236.961552ms","start":"2026-07-15T14:25:22.400365Z","end":"2026-07-15T14:25:22.637327Z","steps":["trace[1619624348] 'process raft request' (duration: 136.559401ms)","trace[1619624348] 'compare' (duration: 100.043192ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T14:25:22.949233Z","caller":"traceutil/trace.go:171","msg":"trace[1246425142] linearizableReadLoop","detail":"{readStateIndex:900; appliedIndex:898; }","duration":"301.1182ms","start":"2026-07-15T14:25:22.648095Z","end":"2026-07-15T14:25:22.949213Z","steps":["trace[1246425142] 'read index received' (duration: 28.147294ms)","trace[1246425142] 'applied index is now lower than readState.Index' (duration: 272.970286ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T14:25:22.949304Z","caller":"traceutil/trace.go:171","msg":"trace[764181087] transaction","detail":"{read_only:false; response_revision:858; number_of_response:1; }","duration":"303.7212ms","start":"2026-07-15T14:25:22.645556Z","end":"2026-07-15T14:25:22.949277Z","steps":["trace[764181087] 'process raft request' (duration: 295.598502ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:22.949361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.246084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/coredns\" ","response":"range_response_count:1 size:179"} {"level":"info","ts":"2026-07-15T14:25:22.949405Z","caller":"traceutil/trace.go:171","msg":"trace[1783880140] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/coredns; range_end:; response_count:1; response_revision:858; }","duration":"301.327876ms","start":"2026-07-15T14:25:22.648067Z","end":"2026-07-15T14:25:22.949395Z","steps":["trace[1783880140] 'agreement among raft nodes before linearized reading' (duration: 301.245304ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:22.949463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:25:22.648057Z","time spent":"301.397008ms","remote":"127.0.0.1:56914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":202,"request content":"key:\"/registry/serviceaccounts/kube-system/coredns\" "} {"level":"warn","ts":"2026-07-15T14:25:22.949484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:25:22.645523Z","time spent":"303.833693ms","remote":"127.0.0.1:56896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4762,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-15T14:25:23.489269Z","caller":"traceutil/trace.go:171","msg":"trace[1165283486] transaction","detail":"{read_only:false; response_revision:861; number_of_response:1; }","duration":"111.500647ms","start":"2026-07-15T14:25:23.377739Z","end":"2026-07-15T14:25:23.48924Z","steps":["trace[1165283486] 'process raft request' (duration: 111.333352ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:27.042609Z","caller":"traceutil/trace.go:171","msg":"trace[235986388] transaction","detail":"{read_only:false; response_revision:915; number_of_response:1; }","duration":"100.755073ms","start":"2026-07-15T14:25:26.941829Z","end":"2026-07-15T14:25:27.042584Z","steps":["trace[235986388] 'process raft request' (duration: 100.6179ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:27.389176Z","caller":"traceutil/trace.go:171","msg":"trace[1022623344] transaction","detail":"{read_only:false; response_revision:919; number_of_response:1; }","duration":"186.209511ms","start":"2026-07-15T14:25:27.20293Z","end":"2026-07-15T14:25:27.38914Z","steps":["trace[1022623344] 'process raft request' (duration: 111.805616ms)","trace[1022623344] 'compare' (duration: 74.20563ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T14:25:27.415403Z","caller":"traceutil/trace.go:171","msg":"trace[439803692] transaction","detail":"{read_only:false; response_revision:920; number_of_response:1; }","duration":"211.906346ms","start":"2026-07-15T14:25:27.203469Z","end":"2026-07-15T14:25:27.415375Z","steps":["trace[439803692] 'process raft request' (duration: 211.605398ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:27.41542Z","caller":"traceutil/trace.go:171","msg":"trace[1291794158] linearizableReadLoop","detail":"{readStateIndex:965; appliedIndex:961; }","duration":"204.293316ms","start":"2026-07-15T14:25:27.211103Z","end":"2026-07-15T14:25:27.415396Z","steps":["trace[1291794158] 'read index received' (duration: 103.723464ms)","trace[1291794158] 'applied index is now lower than readState.Index' (duration: 100.568922ms)"],"step_count":2} {"level":"warn","ts":"2026-07-15T14:25:27.415614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.476351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-15T14:25:27.415722Z","caller":"traceutil/trace.go:171","msg":"trace[1546599143] transaction","detail":"{read_only:false; response_revision:922; number_of_response:1; }","duration":"210.069028ms","start":"2026-07-15T14:25:27.20542Z","end":"2026-07-15T14:25:27.415489Z","steps":["trace[1546599143] 'process raft request' (duration: 209.928684ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:27.41584Z","caller":"traceutil/trace.go:171","msg":"trace[1120759203] transaction","detail":"{read_only:false; response_revision:921; number_of_response:1; }","duration":"210.373646ms","start":"2026-07-15T14:25:27.205127Z","end":"2026-07-15T14:25:27.415501Z","steps":["trace[1120759203] 'process raft request' (duration: 210.073568ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:27.415925Z","caller":"traceutil/trace.go:171","msg":"trace[1090717214] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:922; }","duration":"204.591064ms","start":"2026-07-15T14:25:27.211083Z","end":"2026-07-15T14:25:27.415674Z","steps":["trace[1090717214] 'agreement among raft nodes before linearized reading' (duration: 204.424759ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:27.55042Z","caller":"traceutil/trace.go:171","msg":"trace[743737067] transaction","detail":"{read_only:false; response_revision:924; number_of_response:1; }","duration":"130.53046ms","start":"2026-07-15T14:25:27.419861Z","end":"2026-07-15T14:25:27.550391Z","steps":["trace[743737067] 'process raft request' (duration: 121.465201ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:27.550448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.898183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:3696"} {"level":"info","ts":"2026-07-15T14:25:27.55053Z","caller":"traceutil/trace.go:171","msg":"trace[554834865] range","detail":"{range_begin:/registry/deployments/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:924; }","duration":"130.020217ms","start":"2026-07-15T14:25:27.420487Z","end":"2026-07-15T14:25:27.550507Z","steps":["trace[554834865] 'agreement among raft nodes before linearized reading' (duration: 129.78322ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:27.595834Z","caller":"traceutil/trace.go:171","msg":"trace[750229723] transaction","detail":"{read_only:false; response_revision:925; number_of_response:1; }","duration":"131.468573ms","start":"2026-07-15T14:25:27.464346Z","end":"2026-07-15T14:25:27.595815Z","steps":["trace[750229723] 'process raft request' (duration: 131.34815ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:27.748247Z","caller":"traceutil/trace.go:171","msg":"trace[1992018284] linearizableReadLoop","detail":"{readStateIndex:969; appliedIndex:967; }","duration":"164.42814ms","start":"2026-07-15T14:25:27.583794Z","end":"2026-07-15T14:25:27.748222Z","steps":["trace[1992018284] 'read index received' (duration: 11.899633ms)","trace[1992018284] 'applied index is now lower than readState.Index' (duration: 152.527547ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T14:25:27.748363Z","caller":"traceutil/trace.go:171","msg":"trace[4794478] transaction","detail":"{read_only:false; response_revision:926; number_of_response:1; }","duration":"191.030388ms","start":"2026-07-15T14:25:27.557322Z","end":"2026-07-15T14:25:27.748353Z","steps":["trace[4794478] 'process raft request' (duration: 151.179541ms)","trace[4794478] 'compare' (duration: 39.613281ms)"],"step_count":2} {"level":"warn","ts":"2026-07-15T14:25:27.748503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.692576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:897"} {"level":"info","ts":"2026-07-15T14:25:27.748535Z","caller":"traceutil/trace.go:171","msg":"trace[819408594] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:926; }","duration":"164.769608ms","start":"2026-07-15T14:25:27.583755Z","end":"2026-07-15T14:25:27.748525Z","steps":["trace[819408594] 'agreement among raft nodes before linearized reading' (duration: 164.650025ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:27.748596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.587894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-15T14:25:27.748664Z","caller":"traceutil/trace.go:171","msg":"trace[140303934] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:926; }","duration":"148.688496ms","start":"2026-07-15T14:25:27.599959Z","end":"2026-07-15T14:25:27.748648Z","steps":["trace[140303934] 'agreement among raft nodes before linearized reading' (duration: 148.45623ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:27.990719Z","caller":"traceutil/trace.go:171","msg":"trace[1513394710] transaction","detail":"{read_only:false; response_revision:928; number_of_response:1; }","duration":"238.970268ms","start":"2026-07-15T14:25:27.75171Z","end":"2026-07-15T14:25:27.99068Z","steps":["trace[1513394710] 'process raft request' (duration: 229.380846ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:27.991033Z","caller":"traceutil/trace.go:171","msg":"trace[1250128358] linearizableReadLoop","detail":"{readStateIndex:972; appliedIndex:969; }","duration":"219.62206ms","start":"2026-07-15T14:25:27.771358Z","end":"2026-07-15T14:25:27.99098Z","steps":["trace[1250128358] 'read index received' (duration: 45.963268ms)","trace[1250128358] 'applied index is now lower than readState.Index' (duration: 173.657842ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T14:25:27.991147Z","caller":"traceutil/trace.go:171","msg":"trace[1180661673] transaction","detail":"{read_only:false; response_revision:929; number_of_response:1; }","duration":"239.213895ms","start":"2026-07-15T14:25:27.751918Z","end":"2026-07-15T14:25:27.991132Z","steps":["trace[1180661673] 'process raft request' (duration: 238.875546ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:27.991247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.877276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-15T14:25:27.991281Z","caller":"traceutil/trace.go:171","msg":"trace[1434220994] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:929; }","duration":"219.955318ms","start":"2026-07-15T14:25:27.771317Z","end":"2026-07-15T14:25:27.991273Z","steps":["trace[1434220994] 'agreement among raft nodes before linearized reading' (duration: 219.854646ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:28.07038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.939727ms","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-07-15T14:25:28.070459Z","caller":"traceutil/trace.go:171","msg":"trace[1896316262] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:930; }","duration":"299.031099ms","start":"2026-07-15T14:25:27.771412Z","end":"2026-07-15T14:25:28.070443Z","steps":["trace[1896316262] 'agreement among raft nodes before linearized reading' (duration: 298.814824ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:28.070492Z","caller":"traceutil/trace.go:171","msg":"trace[366413325] transaction","detail":"{read_only:false; response_revision:930; number_of_response:1; }","duration":"134.832035ms","start":"2026-07-15T14:25:27.935635Z","end":"2026-07-15T14:25:28.070467Z","steps":["trace[366413325] 'process raft request' (duration: 134.447035ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:28.171052Z","caller":"traceutil/trace.go:171","msg":"trace[1849195016] transaction","detail":"{read_only:false; response_revision:931; number_of_response:1; }","duration":"175.150484ms","start":"2026-07-15T14:25:27.995787Z","end":"2026-07-15T14:25:28.170937Z","steps":["trace[1849195016] 'process raft request' (duration: 117.254859ms)","trace[1849195016] 'compare' (duration: 57.70716ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T14:25:28.76916Z","caller":"traceutil/trace.go:171","msg":"trace[532118142] transaction","detail":"{read_only:false; response_revision:935; number_of_response:1; }","duration":"208.520906ms","start":"2026-07-15T14:25:28.560616Z","end":"2026-07-15T14:25:28.769137Z","steps":["trace[532118142] 'process raft request' (duration: 208.387363ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:29.865579Z","caller":"traceutil/trace.go:171","msg":"trace[1382725926] transaction","detail":"{read_only:false; response_revision:938; number_of_response:1; }","duration":"531.601104ms","start":"2026-07-15T14:25:29.333957Z","end":"2026-07-15T14:25:29.865559Z","steps":["trace[1382725926] 'process raft request' (duration: 473.90953ms)","trace[1382725926] 'compare' (duration: 57.430137ms)"],"step_count":2} {"level":"warn","ts":"2026-07-15T14:25:29.865681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:25:29.333937Z","time spent":"531.690886ms","remote":"127.0.0.1:56896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5469,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-15T14:25:30.192642Z","caller":"traceutil/trace.go:171","msg":"trace[1524612520] transaction","detail":"{read_only:false; response_revision:939; number_of_response:1; }","duration":"321.594882ms","start":"2026-07-15T14:25:29.871023Z","end":"2026-07-15T14:25:30.192618Z","steps":["trace[1524612520] 'process raft request' (duration: 321.441168ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:30.192801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:25:29.870989Z","time spent":"321.728965ms","remote":"127.0.0.1:56974","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-07-15T14:25:30.402056Z","caller":"traceutil/trace.go:171","msg":"trace[1106246990] transaction","detail":"{read_only:false; response_revision:940; number_of_response:1; }","duration":"530.516324ms","start":"2026-07-15T14:25:29.871512Z","end":"2026-07-15T14:25:30.402028Z","steps":["trace[1106246990] 'process raft request' (duration: 524.450417ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:30.402131Z","caller":"traceutil/trace.go:171","msg":"trace[2087619539] linearizableReadLoop","detail":"{readStateIndex:985; appliedIndex:981; }","duration":"495.595354ms","start":"2026-07-15T14:25:29.906512Z","end":"2026-07-15T14:25:30.402108Z","steps":["trace[2087619539] 'read index received' (duration: 286.031395ms)","trace[2087619539] 'applied index is now lower than readState.Index' (duration: 209.562809ms)"],"step_count":2} {"level":"warn","ts":"2026-07-15T14:25:30.402216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:25:29.871483Z","time spent":"530.655239ms","remote":"127.0.0.1:56976","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-15T14:25:30.402091Z","caller":"traceutil/trace.go:171","msg":"trace[1205339930] transaction","detail":"{read_only:false; response_revision:941; number_of_response:1; }","duration":"529.990021ms","start":"2026-07-15T14:25:29.872075Z","end":"2026-07-15T14:25:30.402065Z","steps":["trace[1205339930] 'process raft request' (duration: 529.812617ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:30.402438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:25:29.872061Z","time spent":"530.336911ms","remote":"127.0.0.1:56872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1104,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-15T14:25:30.402513Z","caller":"traceutil/trace.go:171","msg":"trace[140461922] transaction","detail":"{read_only:false; response_revision:942; number_of_response:1; }","duration":"527.703852ms","start":"2026-07-15T14:25:29.874794Z","end":"2026-07-15T14:25:30.402498Z","steps":["trace[140461922] 'process raft request' (duration: 527.189628ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:30.402627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:25:29.874784Z","time spent":"527.768394ms","remote":"127.0.0.1:57192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5192,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-15T14:25:30.402725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.398814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T14:25:30.402767Z","caller":"traceutil/trace.go:171","msg":"trace[157851958] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:943; }","duration":"433.472186ms","start":"2026-07-15T14:25:29.969282Z","end":"2026-07-15T14:25:30.402754Z","steps":["trace[157851958] 'agreement among raft nodes before linearized reading' (duration: 433.363993ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:30.402803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:25:29.969265Z","time spent":"433.531087ms","remote":"127.0.0.1:56712","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-07-15T14:25:30.403028Z","caller":"traceutil/trace.go:171","msg":"trace[1555298759] transaction","detail":"{read_only:false; response_revision:943; number_of_response:1; }","duration":"355.60232ms","start":"2026-07-15T14:25:30.047358Z","end":"2026-07-15T14:25:30.402961Z","steps":["trace[1555298759] 'process raft request' (duration: 354.674305ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:30.403091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:25:30.047333Z","time spent":"355.723294ms","remote":"127.0.0.1:56788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":862,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-15T14:25:30.403197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.766109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-15T14:25:30.403254Z","caller":"traceutil/trace.go:171","msg":"trace[1569318231] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:943; }","duration":"228.858011ms","start":"2026-07-15T14:25:30.174381Z","end":"2026-07-15T14:25:30.403239Z","steps":["trace[1569318231] 'agreement among raft nodes before linearized reading' (duration: 228.691237ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:30.403335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.537536ms","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-07-15T14:25:30.403387Z","caller":"traceutil/trace.go:171","msg":"trace[65758955] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:943; }","duration":"408.607698ms","start":"2026-07-15T14:25:29.99475Z","end":"2026-07-15T14:25:30.403358Z","steps":["trace[65758955] 'agreement among raft nodes before linearized reading' (duration: 408.481535ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:30.40342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:25:29.99473Z","time spent":"408.68174ms","remote":"127.0.0.1:56974","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-07-15T14:25:30.403508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.962469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T14:25:30.403558Z","caller":"traceutil/trace.go:171","msg":"trace[1992816034] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:943; }","duration":"497.067152ms","start":"2026-07-15T14:25:29.906475Z","end":"2026-07-15T14:25:30.403542Z","steps":["trace[1992816034] 'agreement among raft nodes before linearized reading' (duration: 496.96899ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:30.403591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:25:29.906461Z","time spent":"497.121254ms","remote":"127.0.0.1:57024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true "} {"level":"warn","ts":"2026-07-15T14:25:30.403606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.875925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-15T14:25:30.403637Z","caller":"traceutil/trace.go:171","msg":"trace[667815777] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:943; }","duration":"408.904415ms","start":"2026-07-15T14:25:29.994723Z","end":"2026-07-15T14:25:30.403627Z","steps":["trace[667815777] 'agreement among raft nodes before linearized reading' (duration: 408.818663ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:30.40368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:25:29.994677Z","time spent":"408.995557ms","remote":"127.0.0.1:56974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-15T14:25:30.403775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.340234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-07-15T14:25:30.403794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.744105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T14:25:30.403809Z","caller":"traceutil/trace.go:171","msg":"trace[338802134] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:943; }","duration":"229.416345ms","start":"2026-07-15T14:25:30.174383Z","end":"2026-07-15T14:25:30.403799Z","steps":["trace[338802134] 'agreement among raft nodes before linearized reading' (duration: 229.301082ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:30.403825Z","caller":"traceutil/trace.go:171","msg":"trace[1455928630] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:943; }","duration":"137.816127ms","start":"2026-07-15T14:25:30.265999Z","end":"2026-07-15T14:25:30.403815Z","steps":["trace[1455928630] 'agreement among raft nodes before linearized reading' (duration: 137.766156ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:31.350437Z","caller":"traceutil/trace.go:171","msg":"trace[463246590] transaction","detail":"{read_only:false; response_revision:953; number_of_response:1; }","duration":"241.162105ms","start":"2026-07-15T14:25:31.109253Z","end":"2026-07-15T14:25:31.350415Z","steps":["trace[463246590] 'process raft request' (duration: 241.022212ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:38.756008Z","caller":"traceutil/trace.go:171","msg":"trace[676257805] transaction","detail":"{read_only:false; response_revision:988; number_of_response:1; }","duration":"225.354101ms","start":"2026-07-15T14:25:38.530623Z","end":"2026-07-15T14:25:38.755977Z","steps":["trace[676257805] 'process raft request' (duration: 210.161958ms)","trace[676257805] 'compare' (duration: 14.999437ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T14:25:38.756383Z","caller":"traceutil/trace.go:171","msg":"trace[28140834] transaction","detail":"{read_only:false; response_revision:991; number_of_response:1; }","duration":"185.718065ms","start":"2026-07-15T14:25:38.570644Z","end":"2026-07-15T14:25:38.756362Z","steps":["trace[28140834] 'process raft request' (duration: 185.663683ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:38.756491Z","caller":"traceutil/trace.go:171","msg":"trace[1988458003] transaction","detail":"{read_only:false; response_revision:989; number_of_response:1; }","duration":"225.505464ms","start":"2026-07-15T14:25:38.530972Z","end":"2026-07-15T14:25:38.756477Z","steps":["trace[1988458003] 'process raft request' (duration: 224.951481ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:38.756582Z","caller":"traceutil/trace.go:171","msg":"trace[1262935015] transaction","detail":"{read_only:false; response_revision:990; number_of_response:1; }","duration":"225.076794ms","start":"2026-07-15T14:25:38.531495Z","end":"2026-07-15T14:25:38.756572Z","steps":["trace[1262935015] 'process raft request' (duration: 224.703314ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:44.935674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.629748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-15T14:25:44.935749Z","caller":"traceutil/trace.go:171","msg":"trace[913933548] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1008; }","duration":"142.863964ms","start":"2026-07-15T14:25:44.79287Z","end":"2026-07-15T14:25:44.935734Z","steps":["trace[913933548] 'range keys from in-memory index tree' (duration: 142.491225ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:44.935736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.675855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-07-15T14:25:44.935728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.925595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-15T14:25:44.935814Z","caller":"traceutil/trace.go:171","msg":"trace[1742818660] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1008; }","duration":"141.791858ms","start":"2026-07-15T14:25:44.794004Z","end":"2026-07-15T14:25:44.935796Z","steps":["trace[1742818660] 'range keys from in-memory index tree' (duration: 141.402478ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:44.935833Z","caller":"traceutil/trace.go:171","msg":"trace[391110645] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1008; }","duration":"145.078059ms","start":"2026-07-15T14:25:44.790736Z","end":"2026-07-15T14:25:44.935814Z","steps":["trace[391110645] 'range keys from in-memory index tree' (duration: 144.7364ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:46.917275Z","caller":"traceutil/trace.go:171","msg":"trace[1780625865] transaction","detail":"{read_only:false; response_revision:1015; number_of_response:1; }","duration":"131.543682ms","start":"2026-07-15T14:25:46.785696Z","end":"2026-07-15T14:25:46.91724Z","steps":["trace[1780625865] 'process raft request' (duration: 33.810916ms)","trace[1780625865] 'compare' (duration: 97.634474ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T14:25:51.052701Z","caller":"traceutil/trace.go:171","msg":"trace[1727552653] transaction","detail":"{read_only:false; response_revision:1033; number_of_response:1; }","duration":"120.477476ms","start":"2026-07-15T14:25:50.932204Z","end":"2026-07-15T14:25:51.052682Z","steps":["trace[1727552653] 'process raft request' (duration: 120.027115ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:53.315039Z","caller":"traceutil/trace.go:171","msg":"trace[1318932571] linearizableReadLoop","detail":"{readStateIndex:1089; appliedIndex:1088; }","duration":"237.881621ms","start":"2026-07-15T14:25:53.077092Z","end":"2026-07-15T14:25:53.314974Z","steps":["trace[1318932571] 'read index received' (duration: 237.784889ms)","trace[1318932571] 'applied index is now lower than readState.Index' (duration: 95.652µs)"],"step_count":2} {"level":"warn","ts":"2026-07-15T14:25:53.315244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.124467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"warn","ts":"2026-07-15T14:25:53.315311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.252884ms","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-07-15T14:25:53.315327Z","caller":"traceutil/trace.go:171","msg":"trace[1389510982] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1039; }","duration":"238.25869ms","start":"2026-07-15T14:25:53.077052Z","end":"2026-07-15T14:25:53.315311Z","steps":["trace[1389510982] 'agreement among raft nodes before linearized reading' (duration: 238.053406ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:53.315359Z","caller":"traceutil/trace.go:171","msg":"trace[313538033] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1039; }","duration":"194.350266ms","start":"2026-07-15T14:25:53.120996Z","end":"2026-07-15T14:25:53.315346Z","steps":["trace[313538033] 'agreement among raft nodes before linearized reading' (duration: 194.184612ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:25:53.315272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.000254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-07-15T14:25:53.315517Z","caller":"traceutil/trace.go:171","msg":"trace[255631424] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1039; }","duration":"188.270181ms","start":"2026-07-15T14:25:53.127233Z","end":"2026-07-15T14:25:53.315504Z","steps":["trace[255631424] 'agreement among raft nodes before linearized reading' (duration: 187.970434ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:25:53.31508Z","caller":"traceutil/trace.go:171","msg":"trace[1119732106] transaction","detail":"{read_only:false; response_revision:1039; number_of_response:1; }","duration":"258.696937ms","start":"2026-07-15T14:25:53.056356Z","end":"2026-07-15T14:25:53.315053Z","steps":["trace[1119732106] 'process raft request' (duration: 258.460072ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:26:01.339406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.345001ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-15T14:26:09.277429Z","caller":"traceutil/trace.go:171","msg":"trace[1949104404] transaction","detail":"{read_only:false; response_revision:1091; number_of_response:1; }","duration":"259.534074ms","start":"2026-07-15T14:26:09.017868Z","end":"2026-07-15T14:26:09.277402Z","steps":["trace[1949104404] 'process raft request' (duration: 258.274205ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:26:19.697835Z","caller":"traceutil/trace.go:171","msg":"trace[47671735] transaction","detail":"{read_only:false; response_revision:1126; number_of_response:1; }","duration":"155.226332ms","start":"2026-07-15T14:26:19.542592Z","end":"2026-07-15T14:26:19.697819Z","steps":["trace[47671735] 'process raft request' (duration: 155.082589ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:26:37.129566Z","caller":"traceutil/trace.go:171","msg":"trace[1334340185] transaction","detail":"{read_only:false; response_revision:1182; number_of_response:1; }","duration":"111.963049ms","start":"2026-07-15T14:26:37.017584Z","end":"2026-07-15T14:26:37.129547Z","steps":["trace[1334340185] 'process raft request' (duration: 111.840946ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:26:53.45428Z","caller":"traceutil/trace.go:171","msg":"trace[1646240878] transaction","detail":"{read_only:false; response_revision:1235; number_of_response:1; }","duration":"234.360288ms","start":"2026-07-15T14:26:53.219883Z","end":"2026-07-15T14:26:53.454244Z","steps":["trace[1646240878] 'process raft request' (duration: 234.208455ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:27:09.920863Z","caller":"traceutil/trace.go:171","msg":"trace[772100159] linearizableReadLoop","detail":"{readStateIndex:1387; appliedIndex:1386; }","duration":"108.678795ms","start":"2026-07-15T14:27:09.812158Z","end":"2026-07-15T14:27:09.920836Z","steps":["trace[772100159] 'read index received' (duration: 108.533011ms)","trace[772100159] 'applied index is now lower than readState.Index' (duration: 144.784µs)"],"step_count":2} {"level":"warn","ts":"2026-07-15T14:27:09.921008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.834567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T14:27:09.921074Z","caller":"traceutil/trace.go:171","msg":"trace[492899651] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1320; }","duration":"108.95894ms","start":"2026-07-15T14:27:09.812102Z","end":"2026-07-15T14:27:09.921061Z","steps":["trace[492899651] 'agreement among raft nodes before linearized reading' (duration: 108.843468ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:27:09.921888Z","caller":"traceutil/trace.go:171","msg":"trace[1793078067] transaction","detail":"{read_only:false; response_revision:1320; number_of_response:1; }","duration":"125.676056ms","start":"2026-07-15T14:27:09.795213Z","end":"2026-07-15T14:27:09.920889Z","steps":["trace[1793078067] 'process raft request' (duration: 125.471871ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T14:27:16.818496Z","caller":"traceutil/trace.go:171","msg":"trace[2003513072] transaction","detail":"{read_only:false; response_revision:1351; number_of_response:1; }","duration":"411.64475ms","start":"2026-07-15T14:27:16.406826Z","end":"2026-07-15T14:27:16.818471Z","steps":["trace[2003513072] 'process raft request' (duration: 411.475657ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:27:16.818661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:27:16.406802Z","time spent":"411.772272ms","remote":"127.0.0.1:56974","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-07-15T14:27:16.846431Z","caller":"traceutil/trace.go:171","msg":"trace[1993479788] transaction","detail":"{read_only:false; response_revision:1352; number_of_response:1; }","duration":"438.375787ms","start":"2026-07-15T14:27:16.408031Z","end":"2026-07-15T14:27:16.846407Z","steps":["trace[1993479788] 'process raft request' (duration: 438.130142ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T14:27:16.846568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T14:27:16.408021Z","time spent":"438.477728ms","remote":"127.0.0.1:56974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"}