{"level":"warn","ts":"2026-05-05T17:00:48.706177Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-05T17:00:48.706277Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.80: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.80:2380","--initial-cluster=instance=https://199.19.213.80:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.80:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.80:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-05T17:00:48.706359Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-05T17:00:48.706381Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.80:2380"]} {"level":"info","ts":"2026-05-05T17:00:48.706415Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-05T17:00:48.707309Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.80:2379"]} {"level":"info","ts":"2026-05-05T17:00:48.707429Z","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.80:2380"],"listen-peer-urls":["https://199.19.213.80:2380"],"advertise-client-urls":["https://199.19.213.80:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.80:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.80:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-05T17:00:48.758081Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"50.303081ms"} {"level":"info","ts":"2026-05-05T17:00:48.769711Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"95f079218969d088","cluster-id":"4cb7d1aa36c4178f"} {"level":"info","ts":"2026-05-05T17:00:48.769829Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"95f079218969d088 switched to configuration voters=()"} {"level":"info","ts":"2026-05-05T17:00:48.76987Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"95f079218969d088 became follower at term 0"} {"level":"info","ts":"2026-05-05T17:00:48.76991Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 95f079218969d088 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-05T17:00:48.769935Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"95f079218969d088 became follower at term 1"} {"level":"info","ts":"2026-05-05T17:00:48.769987Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"95f079218969d088 switched to configuration voters=(10804268691008114824)"} {"level":"warn","ts":"2026-05-05T17:00:48.778425Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-05T17:00:48.781767Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-05T17:00:48.783279Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-05T17:00:48.787823Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"95f079218969d088","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-05T17:00:48.788505Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"95f079218969d088","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-05T17:00:48.788576Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-05T17:00:48.78871Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-05T17:00:48.788983Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-05T17:00:48.789764Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"95f079218969d088 switched to configuration voters=(10804268691008114824)"} {"level":"info","ts":"2026-05-05T17:00:48.789979Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4cb7d1aa36c4178f","local-member-id":"95f079218969d088","added-peer-id":"95f079218969d088","added-peer-peer-urls":["https://199.19.213.80:2380"]} {"level":"info","ts":"2026-05-05T17:00:48.791625Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-05T17:00:48.791781Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.80:2380"} {"level":"info","ts":"2026-05-05T17:00:48.791813Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"95f079218969d088","initial-advertise-peer-urls":["https://199.19.213.80:2380"],"listen-peer-urls":["https://199.19.213.80:2380"],"advertise-client-urls":["https://199.19.213.80:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.80:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-05T17:00:48.791858Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-05T17:00:48.791823Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.80:2380"} {"level":"info","ts":"2026-05-05T17:00:49.771004Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"95f079218969d088 is starting a new election at term 1"} {"level":"info","ts":"2026-05-05T17:00:49.771181Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"95f079218969d088 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-05T17:00:49.771254Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"95f079218969d088 received MsgPreVoteResp from 95f079218969d088 at term 1"} {"level":"info","ts":"2026-05-05T17:00:49.771338Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"95f079218969d088 became candidate at term 2"} {"level":"info","ts":"2026-05-05T17:00:49.771354Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"95f079218969d088 received MsgVoteResp from 95f079218969d088 at term 2"} {"level":"info","ts":"2026-05-05T17:00:49.771371Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"95f079218969d088 became leader at term 2"} {"level":"info","ts":"2026-05-05T17:00:49.771418Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 95f079218969d088 elected leader 95f079218969d088 at term 2"} {"level":"info","ts":"2026-05-05T17:00:49.772521Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T17:00:49.774527Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4cb7d1aa36c4178f","local-member-id":"95f079218969d088","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T17:00:49.774628Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T17:00:49.774662Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T17:00:49.774701Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"95f079218969d088","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.80:2379]}","request-path":"/0/members/95f079218969d088/attributes","cluster-id":"4cb7d1aa36c4178f","publish-timeout":"7s"} {"level":"info","ts":"2026-05-05T17:00:49.774898Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-05T17:00:49.775282Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-05T17:00:49.77547Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-05T17:00:49.775493Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-05T17:00:49.777769Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.80:2379"} {"level":"info","ts":"2026-05-05T17:00:49.780142Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-05T17:01:09.148582Z","caller":"traceutil/trace.go:171","msg":"trace[1325334119] linearizableReadLoop","detail":"{readStateIndex:444; appliedIndex:443; }","duration":"260.640659ms","start":"2026-05-05T17:01:08.887915Z","end":"2026-05-05T17:01:09.148555Z","steps":["trace[1325334119] 'read index received' (duration: 260.433174ms)","trace[1325334119] 'applied index is now lower than readState.Index' (duration: 206.255µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:01:09.148728Z","caller":"traceutil/trace.go:171","msg":"trace[2125257203] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"271.707413ms","start":"2026-05-05T17:01:08.876987Z","end":"2026-05-05T17:01:09.148694Z","steps":["trace[2125257203] 'process raft request' (duration: 271.350155ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:09.148757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.813544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:01:09.148836Z","caller":"traceutil/trace.go:171","msg":"trace[630686423] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:430; }","duration":"260.930826ms","start":"2026-05-05T17:01:08.887888Z","end":"2026-05-05T17:01:09.148819Z","steps":["trace[630686423] 'agreement among raft nodes before linearized reading' (duration: 260.781423ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:01:16.651359Z","caller":"traceutil/trace.go:171","msg":"trace[1412302504] transaction","detail":"{read_only:false; response_revision:452; number_of_response:1; }","duration":"151.161387ms","start":"2026-05-05T17:01:16.500162Z","end":"2026-05-05T17:01:16.651323Z","steps":["trace[1412302504] 'process raft request' (duration: 151.009423ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:19.688722Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15026433849859835446,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-05T17:01:20.189743Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15026433849859835446,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-05T17:01:20.271566Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.191889332s","expected-duration":"1s"} {"level":"info","ts":"2026-05-05T17:01:20.274011Z","caller":"traceutil/trace.go:171","msg":"trace[1152466631] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"1.218721162s","start":"2026-05-05T17:01:19.055262Z","end":"2026-05-05T17:01:20.273983Z","steps":["trace[1152466631] 'process raft request' (duration: 1.21655036s)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:01:20.274049Z","caller":"traceutil/trace.go:171","msg":"trace[2089915661] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"1.202848063s","start":"2026-05-05T17:01:19.071184Z","end":"2026-05-05T17:01:20.274032Z","steps":["trace[2089915661] 'process raft request' (duration: 1.202819292s)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:01:20.274049Z","caller":"traceutil/trace.go:171","msg":"trace[342103715] transaction","detail":"{read_only:false; number_of_response:1; response_revision:504; }","duration":"1.209747089s","start":"2026-05-05T17:01:19.064267Z","end":"2026-05-05T17:01:20.274015Z","steps":["trace[342103715] 'process raft request' (duration: 1.209630226s)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:01:20.274115Z","caller":"traceutil/trace.go:171","msg":"trace[1144446561] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"1.204748119s","start":"2026-05-05T17:01:19.069358Z","end":"2026-05-05T17:01:20.274106Z","steps":["trace[1144446561] 'process raft request' (duration: 1.204621276s)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:01:20.274154Z","caller":"traceutil/trace.go:171","msg":"trace[788318631] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"1.20520933s","start":"2026-05-05T17:01:19.068887Z","end":"2026-05-05T17:01:20.274096Z","steps":["trace[788318631] 'process raft request' (duration: 1.205057026s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:20.274467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:19.055249Z","time spent":"1.218821165s","remote":"127.0.0.1:33534","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-05T17:01:20.274472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:19.071176Z","time spent":"1.202915535s","remote":"127.0.0.1:33534","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-05T17:01:20.274575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:19.069353Z","time spent":"1.20478279s","remote":"127.0.0.1:33534","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":980,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-05T17:01:20.274684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:19.068879Z","time spent":"1.205383324s","remote":"127.0.0.1:33534","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-05T17:01:20.274795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:19.064249Z","time spent":"1.209887132s","remote":"127.0.0.1:33070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":7366,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T17:01:20.281452Z","caller":"traceutil/trace.go:171","msg":"trace[1059925965] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"1.194129385s","start":"2026-05-05T17:01:19.087311Z","end":"2026-05-05T17:01:20.281441Z","steps":["trace[1059925965] 'process raft request' (duration: 1.194068004s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:20.28152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:19.087294Z","time spent":"1.194190627s","remote":"127.0.0.1:33070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T17:01:20.281591Z","caller":"traceutil/trace.go:171","msg":"trace[1720663582] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"1.201702216s","start":"2026-05-05T17:01:19.079873Z","end":"2026-05-05T17:01:20.281576Z","steps":["trace[1720663582] 'process raft request' (duration: 1.201408929s)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:01:20.281583Z","caller":"traceutil/trace.go:171","msg":"trace[610394183] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"1.201525452s","start":"2026-05-05T17:01:19.080036Z","end":"2026-05-05T17:01:20.281562Z","steps":["trace[610394183] 'process raft request' (duration: 1.201305157s)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:01:20.281637Z","caller":"traceutil/trace.go:171","msg":"trace[443054819] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"1.194233938s","start":"2026-05-05T17:01:19.087397Z","end":"2026-05-05T17:01:20.281631Z","steps":["trace[443054819] 'process raft request' (duration: 1.194013992s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:20.281638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:19.079859Z","time spent":"1.201759747s","remote":"127.0.0.1:33534","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-05T17:01:20.281687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:19.087392Z","time spent":"1.194270508s","remote":"127.0.0.1:33070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T17:01:20.281748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:19.080029Z","time spent":"1.201636644s","remote":"127.0.0.1:33070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T17:01:20.284656Z","caller":"traceutil/trace.go:171","msg":"trace[1540616773] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"1.196142063s","start":"2026-05-05T17:01:19.088488Z","end":"2026-05-05T17:01:20.28463Z","steps":["trace[1540616773] 'process raft request' (duration: 1.193110281s)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:01:20.286086Z","caller":"traceutil/trace.go:171","msg":"trace[1031081916] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"1.166463285s","start":"2026-05-05T17:01:19.119607Z","end":"2026-05-05T17:01:20.28607Z","steps":["trace[1031081916] 'process raft request' (duration: 1.164436557s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:20.28724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:19.119585Z","time spent":"1.167611512s","remote":"127.0.0.1:33070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7326,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T17:01:20.286553Z","caller":"traceutil/trace.go:171","msg":"trace[885447216] linearizableReadLoop","detail":"{readStateIndex:532; appliedIndex:519; }","duration":"1.098543266s","start":"2026-05-05T17:01:19.187979Z","end":"2026-05-05T17:01:20.286522Z","steps":["trace[885447216] 'read index received' (duration: 1.083900466s)","trace[885447216] 'applied index is now lower than readState.Index' (duration: 14.641979ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:01:20.286539Z","caller":"traceutil/trace.go:171","msg":"trace[42007432] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"1.166279101s","start":"2026-05-05T17:01:19.120241Z","end":"2026-05-05T17:01:20.28652Z","steps":["trace[42007432] 'process raft request' (duration: 1.164000157s)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:01:20.286571Z","caller":"traceutil/trace.go:171","msg":"trace[997151822] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"1.14150815s","start":"2026-05-05T17:01:19.145026Z","end":"2026-05-05T17:01:20.286535Z","steps":["trace[997151822] 'process raft request' (duration: 1.140803252s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:20.286655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.098676628s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-05T17:01:20.287444Z","caller":"traceutil/trace.go:171","msg":"trace[64416218] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:515; }","duration":"1.099502618s","start":"2026-05-05T17:01:19.187929Z","end":"2026-05-05T17:01:20.287432Z","steps":["trace[64416218] 'agreement among raft nodes before linearized reading' (duration: 1.098653948s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:20.287464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:19.145002Z","time spent":"1.142426512s","remote":"127.0.0.1:33070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-05T17:01:20.287239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:19.088469Z","time spent":"1.198609783s","remote":"127.0.0.1:33070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T17:01:20.287478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:19.187907Z","time spent":"1.099562529s","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-05T17:01:20.294076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.571082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:01:20.294113Z","caller":"traceutil/trace.go:171","msg":"trace[568714470] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:515; }","duration":"406.647514ms","start":"2026-05-05T17:01:19.887455Z","end":"2026-05-05T17:01:20.294103Z","steps":["trace[568714470] 'agreement among raft nodes before linearized reading' (duration: 400.079617ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:20.294148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:19.887431Z","time spent":"406.712435ms","remote":"127.0.0.1:33002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-05T17:01:20.294351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"843.350345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-05T17:01:20.294388Z","caller":"traceutil/trace.go:171","msg":"trace[1903382696] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:515; }","duration":"843.423286ms","start":"2026-05-05T17:01:19.450954Z","end":"2026-05-05T17:01:20.294378Z","steps":["trace[1903382696] 'agreement among raft nodes before linearized reading' (duration: 836.559273ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:20.294411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:19.450936Z","time spent":"843.471248ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-05T17:01:20.295912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:19.120227Z","time spent":"1.167171892s","remote":"127.0.0.1:33070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9125,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T17:01:24.442765Z","caller":"traceutil/trace.go:171","msg":"trace[1541866111] linearizableReadLoop","detail":"{readStateIndex:599; appliedIndex:598; }","duration":"117.701119ms","start":"2026-05-05T17:01:24.325Z","end":"2026-05-05T17:01:24.442701Z","steps":["trace[1541866111] 'read index received' (duration: 111.083001ms)","trace[1541866111] 'applied index is now lower than readState.Index' (duration: 6.616428ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:01:24.442834Z","caller":"traceutil/trace.go:171","msg":"trace[1859828932] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"446.034163ms","start":"2026-05-05T17:01:23.996761Z","end":"2026-05-05T17:01:24.442795Z","steps":["trace[1859828932] 'process raft request' (duration: 440.895441ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:24.442967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.955375ms","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-05-05T17:01:24.443074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:23.996741Z","time spent":"446.226978ms","remote":"127.0.0.1:33122","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036109,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T17:01:24.443112Z","caller":"traceutil/trace.go:171","msg":"trace[868179163] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:581; }","duration":"118.078858ms","start":"2026-05-05T17:01:24.324938Z","end":"2026-05-05T17:01:24.443017Z","steps":["trace[868179163] 'agreement among raft nodes before linearized reading' (duration: 117.851262ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:24.443293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.81552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-05T17:01:24.443752Z","caller":"traceutil/trace.go:171","msg":"trace[787981979] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:581; }","duration":"102.336753ms","start":"2026-05-05T17:01:24.341368Z","end":"2026-05-05T17:01:24.443705Z","steps":["trace[787981979] 'agreement among raft nodes before linearized reading' (duration: 101.786809ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:24.878358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.491389ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T17:01:24.878488Z","caller":"traceutil/trace.go:171","msg":"trace[1005784222] linearizableReadLoop","detail":"{readStateIndex:603; appliedIndex:602; }","duration":"114.39394ms","start":"2026-05-05T17:01:24.764075Z","end":"2026-05-05T17:01:24.878469Z","steps":["trace[1005784222] 'read index received' (duration: 43.552µs)","trace[1005784222] 'applied index is now lower than readState.Index' (duration: 114.349148ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:01:24.878569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.493372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-05T17:01:24.878627Z","caller":"traceutil/trace.go:171","msg":"trace[764405066] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"226.687259ms","start":"2026-05-05T17:01:24.65187Z","end":"2026-05-05T17:01:24.878557Z","steps":["trace[764405066] 'process raft request' (duration: 21.78008ms)","trace[764405066] 'compare' (duration: 204.363827ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:01:24.878684Z","caller":"traceutil/trace.go:171","msg":"trace[1548350395] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:585; }","duration":"114.629996ms","start":"2026-05-05T17:01:24.764026Z","end":"2026-05-05T17:01:24.878656Z","steps":["trace[1548350395] 'agreement among raft nodes before linearized reading' (duration: 114.494122ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:01:26.958486Z","caller":"traceutil/trace.go:171","msg":"trace[1991375750] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"101.86182ms","start":"2026-05-05T17:01:26.856591Z","end":"2026-05-05T17:01:26.958453Z","steps":["trace[1991375750] 'process raft request' (duration: 100.15591ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:01:27.666887Z","caller":"traceutil/trace.go:171","msg":"trace[1146317503] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"215.365979ms","start":"2026-05-05T17:01:27.451501Z","end":"2026-05-05T17:01:27.666867Z","steps":["trace[1146317503] 'process raft request' (duration: 214.724764ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:27.995186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.204942ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-05T17:01:27.995407Z","caller":"traceutil/trace.go:171","msg":"trace[1498937428] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"274.354097ms","start":"2026-05-05T17:01:27.720991Z","end":"2026-05-05T17:01:27.995345Z","steps":["trace[1498937428] 'process raft request' (duration: 69.912499ms)","trace[1498937428] 'compare' (duration: 203.855584ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:01:28.115445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.157258ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-05T17:01:28.115528Z","caller":"traceutil/trace.go:171","msg":"trace[141764233] linearizableReadLoop","detail":"{readStateIndex:621; appliedIndex:619; }","duration":"228.603585ms","start":"2026-05-05T17:01:27.886907Z","end":"2026-05-05T17:01:28.115511Z","steps":["trace[141764233] 'read index received' (duration: 24.688468ms)","trace[141764233] 'applied index is now lower than readState.Index' (duration: 203.913857ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:01:28.115634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.727847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:01:28.115668Z","caller":"traceutil/trace.go:171","msg":"trace[237569919] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:602; }","duration":"228.803339ms","start":"2026-05-05T17:01:27.886853Z","end":"2026-05-05T17:01:28.115656Z","steps":["trace[237569919] 'agreement among raft nodes before linearized reading' (duration: 228.744808ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:28.115813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.717173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:01:28.115905Z","caller":"traceutil/trace.go:171","msg":"trace[1961829188] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:602; }","duration":"108.847847ms","start":"2026-05-05T17:01:28.00704Z","end":"2026-05-05T17:01:28.115888Z","steps":["trace[1961829188] 'agreement among raft nodes before linearized reading' (duration: 108.596551ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:01:28.656414Z","caller":"traceutil/trace.go:171","msg":"trace[504980878] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"131.667082ms","start":"2026-05-05T17:01:28.524713Z","end":"2026-05-05T17:01:28.65638Z","steps":["trace[504980878] 'process raft request' (duration: 126.760476ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:29.012399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.976206ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-05T17:01:29.01257Z","caller":"traceutil/trace.go:171","msg":"trace[1915443305] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"298.151434ms","start":"2026-05-05T17:01:28.714375Z","end":"2026-05-05T17:01:29.012527Z","steps":["trace[1915443305] 'process raft request' (duration: 83.976334ms)","trace[1915443305] 'compare' (duration: 213.791061ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:01:29.012747Z","caller":"traceutil/trace.go:171","msg":"trace[1097823220] linearizableReadLoop","detail":"{readStateIndex:625; appliedIndex:624; }","duration":"123.924728ms","start":"2026-05-05T17:01:28.888805Z","end":"2026-05-05T17:01:29.01273Z","steps":["trace[1097823220] 'read index received' (duration: 51.131µs)","trace[1097823220] 'applied index is now lower than readState.Index' (duration: 123.871477ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:01:29.012759Z","caller":"traceutil/trace.go:171","msg":"trace[59807610] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"105.890147ms","start":"2026-05-05T17:01:28.906849Z","end":"2026-05-05T17:01:29.01274Z","steps":["trace[59807610] 'process raft request' (duration: 105.665731ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:29.012891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.073662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:01:29.012922Z","caller":"traceutil/trace.go:171","msg":"trace[1320430561] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:607; }","duration":"124.119453ms","start":"2026-05-05T17:01:28.888793Z","end":"2026-05-05T17:01:29.012912Z","steps":["trace[1320430561] 'agreement among raft nodes before linearized reading' (duration: 123.99261ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:01:29.38471Z","caller":"traceutil/trace.go:171","msg":"trace[1109556961] linearizableReadLoop","detail":"{readStateIndex:627; appliedIndex:626; }","duration":"353.855754ms","start":"2026-05-05T17:01:29.030836Z","end":"2026-05-05T17:01:29.384692Z","steps":["trace[1109556961] 'read index received' (duration: 268.869226ms)","trace[1109556961] 'applied index is now lower than readState.Index' (duration: 84.985948ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:01:29.384935Z","caller":"traceutil/trace.go:171","msg":"trace[208651901] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"355.861272ms","start":"2026-05-05T17:01:29.029065Z","end":"2026-05-05T17:01:29.384926Z","steps":["trace[208651901] 'process raft request' (duration: 270.727891ms)","trace[208651901] 'compare' (duration: 84.821434ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:01:29.384993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:29.029051Z","time spent":"355.906973ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-05T17:01:29.385304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.033516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:01:29.385372Z","caller":"traceutil/trace.go:171","msg":"trace[1335294432] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:608; }","duration":"136.133718ms","start":"2026-05-05T17:01:29.249224Z","end":"2026-05-05T17:01:29.385357Z","steps":["trace[1335294432] 'agreement among raft nodes before linearized reading' (duration: 135.949974ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:29.385381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.488974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T17:01:29.385518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.939616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T17:01:29.385419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.48555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-05-05T17:01:29.385561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.296512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:01:29.385566Z","caller":"traceutil/trace.go:171","msg":"trace[973963177] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:608; }","duration":"354.683824ms","start":"2026-05-05T17:01:29.030872Z","end":"2026-05-05T17:01:29.385556Z","steps":["trace[973963177] 'agreement among raft nodes before linearized reading' (duration: 354.282265ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:01:29.385588Z","caller":"traceutil/trace.go:171","msg":"trace[1648944815] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:608; }","duration":"136.330554ms","start":"2026-05-05T17:01:29.24925Z","end":"2026-05-05T17:01:29.385581Z","steps":["trace[1648944815] 'agreement among raft nodes before linearized reading' (duration: 136.295963ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:01:29.385568Z","caller":"traceutil/trace.go:171","msg":"trace[1180346371] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:608; }","duration":"170.019127ms","start":"2026-05-05T17:01:29.215533Z","end":"2026-05-05T17:01:29.385552Z","steps":["trace[1180346371] 'agreement among raft nodes before linearized reading' (duration: 169.925685ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:29.385723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:29.030867Z","time spent":"354.839838ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-05T17:01:29.385518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.470698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T17:01:29.385772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.823326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:01:29.385796Z","caller":"traceutil/trace.go:171","msg":"trace[965171782] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:608; }","duration":"170.865178ms","start":"2026-05-05T17:01:29.214924Z","end":"2026-05-05T17:01:29.385789Z","steps":["trace[965171782] 'agreement among raft nodes before linearized reading' (duration: 170.826177ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:01:29.385802Z","caller":"traceutil/trace.go:171","msg":"trace[1810399539] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:608; }","duration":"170.800655ms","start":"2026-05-05T17:01:29.214978Z","end":"2026-05-05T17:01:29.385779Z","steps":["trace[1810399539] 'agreement among raft nodes before linearized reading' (duration: 170.492978ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:01:29.385496Z","caller":"traceutil/trace.go:171","msg":"trace[202930055] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:608; }","duration":"135.641807ms","start":"2026-05-05T17:01:29.249833Z","end":"2026-05-05T17:01:29.385475Z","steps":["trace[202930055] 'agreement among raft nodes before linearized reading' (duration: 135.442333ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:29.386012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.138755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-05T17:01:29.386052Z","caller":"traceutil/trace.go:171","msg":"trace[1344514716] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:608; }","duration":"355.232317ms","start":"2026-05-05T17:01:29.03081Z","end":"2026-05-05T17:01:29.386042Z","steps":["trace[1344514716] 'agreement among raft nodes before linearized reading' (duration: 354.307594ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:29.386082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:29.030799Z","time spent":"355.274168ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-05T17:01:29.557105Z","caller":"traceutil/trace.go:171","msg":"trace[675165851] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"163.974884ms","start":"2026-05-05T17:01:29.393106Z","end":"2026-05-05T17:01:29.557081Z","steps":["trace[675165851] 'process raft request' (duration: 163.910172ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:01:29.55725Z","caller":"traceutil/trace.go:171","msg":"trace[2075479517] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"164.261901ms","start":"2026-05-05T17:01:29.392977Z","end":"2026-05-05T17:01:29.557239Z","steps":["trace[2075479517] 'process raft request' (duration: 163.990654ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:01:29.55712Z","caller":"traceutil/trace.go:171","msg":"trace[1555856162] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"164.177928ms","start":"2026-05-05T17:01:29.392924Z","end":"2026-05-05T17:01:29.557101Z","steps":["trace[1555856162] 'process raft request' (duration: 161.902344ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:01:29.557587Z","caller":"traceutil/trace.go:171","msg":"trace[1826211919] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"164.2715ms","start":"2026-05-05T17:01:29.393299Z","end":"2026-05-05T17:01:29.55757Z","steps":["trace[1826211919] 'process raft request' (duration: 163.744598ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:01:29.55769Z","caller":"traceutil/trace.go:171","msg":"trace[1197183366] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"163.777078ms","start":"2026-05-05T17:01:29.393906Z","end":"2026-05-05T17:01:29.557683Z","steps":["trace[1197183366] 'process raft request' (duration: 163.360478ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:31.074337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"800.850021ms","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-05-05T17:01:31.07442Z","caller":"traceutil/trace.go:171","msg":"trace[1815805353] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:616; }","duration":"800.987434ms","start":"2026-05-05T17:01:30.273414Z","end":"2026-05-05T17:01:31.074401Z","steps":["trace[1815805353] 'range keys from in-memory index tree' (duration: 800.738957ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:31.074408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"957.278943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T17:01:31.074469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:30.273396Z","time spent":"801.061757ms","remote":"127.0.0.1:57004","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-05-05T17:01:31.074454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"917.473435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:01:31.074502Z","caller":"traceutil/trace.go:171","msg":"trace[361627778] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:616; }","duration":"957.422057ms","start":"2026-05-05T17:01:30.11706Z","end":"2026-05-05T17:01:31.074482Z","steps":["trace[361627778] 'range keys from in-memory index tree' (duration: 957.199271ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:31.074556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:30.117042Z","time spent":"957.50189ms","remote":"127.0.0.1:56988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 "} {"level":"warn","ts":"2026-05-05T17:01:31.074592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"957.510559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:01:31.074646Z","caller":"traceutil/trace.go:171","msg":"trace[1533675952] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:616; }","duration":"957.580321ms","start":"2026-05-05T17:01:30.117051Z","end":"2026-05-05T17:01:31.074631Z","steps":["trace[1533675952] 'count revisions from in-memory index tree' (duration: 957.427017ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:31.074638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"956.66207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T17:01:31.074699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:30.117041Z","time spent":"957.647593ms","remote":"127.0.0.1:56988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"info","ts":"2026-05-05T17:01:31.074728Z","caller":"traceutil/trace.go:171","msg":"trace[1833422467] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:616; }","duration":"956.823304ms","start":"2026-05-05T17:01:30.117888Z","end":"2026-05-05T17:01:31.074712Z","steps":["trace[1833422467] 'range keys from in-memory index tree' (duration: 956.604738ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:31.074806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:30.117883Z","time spent":"956.883085ms","remote":"127.0.0.1:56988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 "} {"level":"warn","ts":"2026-05-05T17:01:31.074892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"800.726178ms","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":"warn","ts":"2026-05-05T17:01:31.074949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.023538116s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T17:01:31.07497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.002156484s","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-05-05T17:01:31.074987Z","caller":"traceutil/trace.go:171","msg":"trace[671703292] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:616; }","duration":"800.887182ms","start":"2026-05-05T17:01:30.274076Z","end":"2026-05-05T17:01:31.074963Z","steps":["trace[671703292] 'range keys from in-memory index tree' (duration: 800.637037ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:01:31.075012Z","caller":"traceutil/trace.go:171","msg":"trace[606013320] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:616; }","duration":"1.023613518s","start":"2026-05-05T17:01:30.051361Z","end":"2026-05-05T17:01:31.074975Z","steps":["trace[606013320] 'range keys from in-memory index tree' (duration: 1.023459274s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:31.075034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.002282468s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T17:01:31.075045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:30.274058Z","time spent":"800.974794ms","remote":"127.0.0.1:57004","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":"info","ts":"2026-05-05T17:01:31.075068Z","caller":"traceutil/trace.go:171","msg":"trace[1161110522] 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:616; }","duration":"1.002317479s","start":"2026-05-05T17:01:30.072743Z","end":"2026-05-05T17:01:31.07506Z","steps":["trace[1161110522] 'count revisions from in-memory index tree' (duration: 1.002219927s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:31.075087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:30.051341Z","time spent":"1.023698649s","remote":"127.0.0.1:56958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 "} {"level":"warn","ts":"2026-05-05T17:01:31.075128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:30.072732Z","time spent":"1.00237754s","remote":"127.0.0.1:56968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"warn","ts":"2026-05-05T17:01:31.075179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"778.988909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:01:31.07522Z","caller":"traceutil/trace.go:171","msg":"trace[1792433856] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:616; }","duration":"779.066881ms","start":"2026-05-05T17:01:30.296141Z","end":"2026-05-05T17:01:31.075208Z","steps":["trace[1792433856] 'count revisions from in-memory index tree' (duration: 778.930058ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:31.07526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:30.296129Z","time spent":"779.120222ms","remote":"127.0.0.1:57018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-05-05T17:01:31.075302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.002559514s","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-05-05T17:01:31.075347Z","caller":"traceutil/trace.go:171","msg":"trace[308634293] 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:616; }","duration":"1.002607025s","start":"2026-05-05T17:01:30.072731Z","end":"2026-05-05T17:01:31.075338Z","steps":["trace[308634293] 'range keys from in-memory index tree' (duration: 1.002458072s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:31.075382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:30.072677Z","time spent":"1.002695657s","remote":"127.0.0.1:56968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 "} {"level":"warn","ts":"2026-05-05T17:01:31.075362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.065121487s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T17:01:31.075391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.466511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-05T17:01:31.07543Z","caller":"traceutil/trace.go:171","msg":"trace[106577228] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:616; }","duration":"479.570164ms","start":"2026-05-05T17:01:30.595849Z","end":"2026-05-05T17:01:31.075419Z","steps":["trace[106577228] 'range keys from in-memory index tree' (duration: 479.268807ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:01:31.075427Z","caller":"traceutil/trace.go:171","msg":"trace[1715793125] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:616; }","duration":"1.06523306s","start":"2026-05-05T17:01:30.010179Z","end":"2026-05-05T17:01:31.075412Z","steps":["trace[1715793125] 'range keys from in-memory index tree' (duration: 1.065069356s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:31.075455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"779.296517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T17:01:31.075468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:30.595826Z","time spent":"479.634225ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-05T17:01:31.07549Z","caller":"traceutil/trace.go:171","msg":"trace[1131308985] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:616; }","duration":"779.351168ms","start":"2026-05-05T17:01:30.296129Z","end":"2026-05-05T17:01:31.07548Z","steps":["trace[1131308985] 'range keys from in-memory index tree' (duration: 779.187944ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:31.075512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:30.010165Z","time spent":"1.065333502s","remote":"127.0.0.1:56952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"warn","ts":"2026-05-05T17:01:31.075532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:30.296118Z","time spent":"779.405259ms","remote":"127.0.0.1:57018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-05-05T17:01:31.075644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.639306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-dk67h\" ","response":"range_response_count:1 size:16961"} {"level":"warn","ts":"2026-05-05T17:01:31.075664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"764.044793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:01:31.075684Z","caller":"traceutil/trace.go:171","msg":"trace[69546744] range","detail":"{range_begin:/registry/pods/kube-system/cilium-dk67h; range_end:; response_count:1; response_revision:616; }","duration":"417.701328ms","start":"2026-05-05T17:01:30.657973Z","end":"2026-05-05T17:01:31.075674Z","steps":["trace[69546744] 'range keys from in-memory index tree' (duration: 417.531983ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:01:31.075695Z","caller":"traceutil/trace.go:171","msg":"trace[1170880532] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:616; }","duration":"764.076223ms","start":"2026-05-05T17:01:30.31161Z","end":"2026-05-05T17:01:31.075686Z","steps":["trace[1170880532] 'range keys from in-memory index tree' (duration: 763.970361ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:31.075663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"840.022546ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T17:01:31.075712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:30.657956Z","time spent":"417.749339ms","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-dk67h\" "} {"level":"warn","ts":"2026-05-05T17:01:31.075705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.065448245s","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-05-05T17:01:31.075767Z","caller":"traceutil/trace.go:171","msg":"trace[290245063] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:616; }","duration":"840.128508ms","start":"2026-05-05T17:01:30.235628Z","end":"2026-05-05T17:01:31.075757Z","steps":["trace[290245063] 'range keys from in-memory index tree' (duration: 840.014866ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:31.075765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:30.3116Z","time spent":"764.155435ms","remote":"127.0.0.1:57026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"info","ts":"2026-05-05T17:01:31.075793Z","caller":"traceutil/trace.go:171","msg":"trace[1411779517] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:616; }","duration":"1.065566868s","start":"2026-05-05T17:01:30.010216Z","end":"2026-05-05T17:01:31.075783Z","steps":["trace[1411779517] 'count revisions from in-memory index tree' (duration: 1.065382843s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:31.076047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"985.717663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T17:01:31.076096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"745.91151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T17:01:31.076103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.026447024s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:01:31.076129Z","caller":"traceutil/trace.go:171","msg":"trace[83842552] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:616; }","duration":"745.964631ms","start":"2026-05-05T17:01:30.330154Z","end":"2026-05-05T17:01:31.076119Z","steps":["trace[83842552] 'range keys from in-memory index tree' (duration: 745.796497ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:01:31.076135Z","caller":"traceutil/trace.go:171","msg":"trace[1942586818] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:616; }","duration":"1.026502335s","start":"2026-05-05T17:01:30.049623Z","end":"2026-05-05T17:01:31.076125Z","steps":["trace[1942586818] 'count revisions from in-memory index tree' (duration: 1.026395033s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:31.076174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:30.33014Z","time spent":"746.024763ms","remote":"127.0.0.1:57028","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 "} {"level":"warn","ts":"2026-05-05T17:01:31.076179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:30.049606Z","time spent":"1.026564467s","remote":"127.0.0.1:56958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-05T17:01:31.076236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"986.737126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:01:31.076292Z","caller":"traceutil/trace.go:171","msg":"trace[1174399531] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:616; }","duration":"986.820388ms","start":"2026-05-05T17:01:30.089459Z","end":"2026-05-05T17:01:31.076279Z","steps":["trace[1174399531] 'range keys from in-memory index tree' (duration: 986.601293ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:31.076343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:30.089446Z","time spent":"986.879819ms","remote":"127.0.0.1:56978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-05-05T17:01:31.074922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"918.062908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:01:31.075002Z","caller":"traceutil/trace.go:171","msg":"trace[194023127] 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:616; }","duration":"1.002212156s","start":"2026-05-05T17:01:30.072779Z","end":"2026-05-05T17:01:31.074991Z","steps":["trace[194023127] 'range keys from in-memory index tree' (duration: 1.002096863s)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:01:31.076428Z","caller":"traceutil/trace.go:171","msg":"trace[1156973365] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:616; }","duration":"919.598284ms","start":"2026-05-05T17:01:30.156806Z","end":"2026-05-05T17:01:31.076404Z","steps":["trace[1156973365] 'range keys from in-memory index tree' (duration: 917.916035ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:31.076457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:30.07276Z","time spent":"1.003684781s","remote":"127.0.0.1:56968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 "} {"level":"warn","ts":"2026-05-05T17:01:31.076472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:30.156789Z","time spent":"919.670746ms","remote":"127.0.0.1:56990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-05-05T17:01:31.076181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"986.630284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:01:31.076553Z","caller":"traceutil/trace.go:171","msg":"trace[1490758429] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:616; }","duration":"987.015183ms","start":"2026-05-05T17:01:30.089528Z","end":"2026-05-05T17:01:31.076543Z","steps":["trace[1490758429] 'count revisions from in-memory index tree' (duration: 986.593163ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:31.076594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:30.089522Z","time spent":"987.061033ms","remote":"127.0.0.1:56978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"info","ts":"2026-05-05T17:01:31.076127Z","caller":"traceutil/trace.go:171","msg":"trace[103458880] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:616; }","duration":"985.842585ms","start":"2026-05-05T17:01:30.090264Z","end":"2026-05-05T17:01:31.076107Z","steps":["trace[103458880] 'range keys from in-memory index tree' (duration: 983.987651ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:31.076706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:30.090255Z","time spent":"986.437989ms","remote":"127.0.0.1:56978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 "} {"level":"warn","ts":"2026-05-05T17:01:31.075969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"763.465448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:01:31.076841Z","caller":"traceutil/trace.go:171","msg":"trace[1654344959] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:616; }","duration":"764.352789ms","start":"2026-05-05T17:01:30.312472Z","end":"2026-05-05T17:01:31.076825Z","steps":["trace[1654344959] 'range keys from in-memory index tree' (duration: 763.402057ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:31.076925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:30.312458Z","time spent":"764.449531ms","remote":"127.0.0.1:57018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 "} {"level":"warn","ts":"2026-05-05T17:01:31.075944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"891.691258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:01:31.077009Z","caller":"traceutil/trace.go:171","msg":"trace[785969950] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:616; }","duration":"892.780984ms","start":"2026-05-05T17:01:30.184216Z","end":"2026-05-05T17:01:31.076997Z","steps":["trace[785969950] 'range keys from in-memory index tree' (duration: 891.651318ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:31.077057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:30.18421Z","time spent":"892.835645ms","remote":"127.0.0.1:56996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-05-05T17:01:31.075984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"891.654487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:01:31.077208Z","caller":"traceutil/trace.go:171","msg":"trace[698657488] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:616; }","duration":"892.895598ms","start":"2026-05-05T17:01:30.184302Z","end":"2026-05-05T17:01:31.077197Z","steps":["trace[698657488] 'count revisions from in-memory index tree' (duration: 891.595966ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:31.077246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:30.184288Z","time spent":"892.946029ms","remote":"127.0.0.1:56996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-05-05T17:01:31.076015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"891.102945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:01:31.077334Z","caller":"traceutil/trace.go:171","msg":"trace[2131341540] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:616; }","duration":"892.464118ms","start":"2026-05-05T17:01:30.184861Z","end":"2026-05-05T17:01:31.077325Z","steps":["trace[2131341540] 'range keys from in-memory index tree' (duration: 891.060644ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:31.077374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:30.184852Z","time spent":"892.511469ms","remote":"127.0.0.1:56996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 "} {"level":"warn","ts":"2026-05-05T17:01:31.076029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"746.020262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:01:31.077452Z","caller":"traceutil/trace.go:171","msg":"trace[325923547] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:616; }","duration":"747.455507ms","start":"2026-05-05T17:01:30.329988Z","end":"2026-05-05T17:01:31.077444Z","steps":["trace[325923547] 'range keys from in-memory index tree' (duration: 745.985091ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:31.07749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:30.329978Z","time spent":"747.501938ms","remote":"127.0.0.1:57028","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 "} {"level":"warn","ts":"2026-05-05T17:01:31.076062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"745.848558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:01:31.077631Z","caller":"traceutil/trace.go:171","msg":"trace[926880306] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:616; }","duration":"747.458477ms","start":"2026-05-05T17:01:30.330152Z","end":"2026-05-05T17:01:31.077611Z","steps":["trace[926880306] 'count revisions from in-memory index tree' (duration: 745.769936ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:31.077688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:30.329909Z","time spent":"747.753064ms","remote":"127.0.0.1:57028","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-05-05T17:01:31.07607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.026343281s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:01:31.077852Z","caller":"traceutil/trace.go:171","msg":"trace[2116437050] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:616; }","duration":"1.028122624s","start":"2026-05-05T17:01:30.049718Z","end":"2026-05-05T17:01:31.077841Z","steps":["trace[2116437050] 'range keys from in-memory index tree' (duration: 1.02628968s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:31.077902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:30.049664Z","time spent":"1.028220286s","remote":"127.0.0.1:56958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-05-05T17:01:31.076047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.73936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-05T17:01:31.0781Z","caller":"traceutil/trace.go:171","msg":"trace[2017726492] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:616; }","duration":"417.848731ms","start":"2026-05-05T17:01:30.66024Z","end":"2026-05-05T17:01:31.078089Z","steps":["trace[2017726492] 'range keys from in-memory index tree' (duration: 415.570066ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:31.078285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:30.660201Z","time spent":"417.961584ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-05T17:01:31.075933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"764.243978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:01:31.078503Z","caller":"traceutil/trace.go:171","msg":"trace[20185511] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:616; }","duration":"766.803299ms","start":"2026-05-05T17:01:30.311678Z","end":"2026-05-05T17:01:31.078482Z","steps":["trace[20185511] 'count revisions from in-memory index tree' (duration: 764.177816ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:31.078577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:30.311623Z","time spent":"766.931452ms","remote":"127.0.0.1:57026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"info","ts":"2026-05-05T17:01:31.078775Z","caller":"traceutil/trace.go:171","msg":"trace[863074622] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:616; }","duration":"917.673239ms","start":"2026-05-05T17:01:30.156851Z","end":"2026-05-05T17:01:31.074524Z","steps":["trace[863074622] 'count revisions from in-memory index tree' (duration: 917.35459ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:31.075912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"802.210713ms","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-05-05T17:01:31.078839Z","caller":"traceutil/trace.go:171","msg":"trace[120452795] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:616; }","duration":"805.350888ms","start":"2026-05-05T17:01:30.27348Z","end":"2026-05-05T17:01:31.078831Z","steps":["trace[120452795] 'count revisions from in-memory index tree' (duration: 802.175823ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:31.078867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:30.273473Z","time spent":"805.384639ms","remote":"127.0.0.1:57004","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-05-05T17:01:31.079078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:30.15682Z","time spent":"921.984532ms","remote":"127.0.0.1:56990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-05-05T17:01:31.08177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:30.010196Z","time spent":"1.065913415s","remote":"127.0.0.1:56952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-05-05T17:01:32.062685Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15026433849859835706,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-05T17:01:32.524491Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.441457686s","expected-duration":"1s"} {"level":"info","ts":"2026-05-05T17:01:32.524745Z","caller":"traceutil/trace.go:171","msg":"trace[976417268] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"1.441781304s","start":"2026-05-05T17:01:31.082948Z","end":"2026-05-05T17:01:32.52473Z","steps":["trace[976417268] 'process raft request' (duration: 1.441684522s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:32.524843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:31.082933Z","time spent":"1.441860776s","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T17:01:33.587673Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.062621538s","expected-duration":"1s"} {"level":"info","ts":"2026-05-05T17:01:33.58818Z","caller":"traceutil/trace.go:171","msg":"trace[305800874] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"2.504968736s","start":"2026-05-05T17:01:31.083176Z","end":"2026-05-05T17:01:33.588145Z","steps":["trace[305800874] 'process raft request' (duration: 2.504674119s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:33.588334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:31.083164Z","time spent":"2.505085999s","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T17:01:33.588437Z","caller":"traceutil/trace.go:171","msg":"trace[145251709] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"2.499753551s","start":"2026-05-05T17:01:31.08865Z","end":"2026-05-05T17:01:33.588403Z","steps":["trace[145251709] 'process raft request' (duration: 2.499384272s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:33.588647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:31.08864Z","time spent":"2.499912905s","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T17:01:33.588719Z","caller":"traceutil/trace.go:171","msg":"trace[1001737713] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"1.925810645s","start":"2026-05-05T17:01:31.6629Z","end":"2026-05-05T17:01:33.58871Z","steps":["trace[1001737713] 'process raft request' (duration: 1.925351945s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:33.588781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:31.662877Z","time spent":"1.925872116s","remote":"127.0.0.1:33270","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-05-05T17:01:33.588499Z","caller":"traceutil/trace.go:171","msg":"trace[1224397132] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:636; }","duration":"2.026534929s","start":"2026-05-05T17:01:31.561953Z","end":"2026-05-05T17:01:33.588488Z","steps":["trace[1224397132] 'read index received' (duration: 962.823055ms)","trace[1224397132] 'applied index is now lower than readState.Index' (duration: 1.063710634s)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:01:33.589017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.0270283s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-05T17:01:33.589069Z","caller":"traceutil/trace.go:171","msg":"trace[810817789] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:620; }","duration":"2.027095332s","start":"2026-05-05T17:01:31.561957Z","end":"2026-05-05T17:01:33.589052Z","steps":["trace[810817789] 'agreement among raft nodes before linearized reading' (duration: 2.026941909s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:33.588685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.026739274s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-05-05T17:01:33.589112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:31.56189Z","time spent":"2.027214285s","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-05T17:01:33.589136Z","caller":"traceutil/trace.go:171","msg":"trace[14677421] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:620; }","duration":"2.027218625s","start":"2026-05-05T17:01:31.561895Z","end":"2026-05-05T17:01:33.589114Z","steps":["trace[14677421] 'agreement among raft nodes before linearized reading' (duration: 2.026624431s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:33.589188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"973.154582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.80\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-05-05T17:01:33.589224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.701645825s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:01:33.58924Z","caller":"traceutil/trace.go:171","msg":"trace[1750338596] range","detail":"{range_begin:/registry/masterleases/199.19.213.80; range_end:; response_count:1; response_revision:620; }","duration":"973.295536ms","start":"2026-05-05T17:01:32.615931Z","end":"2026-05-05T17:01:33.589226Z","steps":["trace[1750338596] 'agreement among raft nodes before linearized reading' (duration: 973.112901ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:33.58923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:31.561873Z","time spent":"2.027338068s","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-05T17:01:33.589252Z","caller":"traceutil/trace.go:171","msg":"trace[793065884] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:620; }","duration":"1.701709157s","start":"2026-05-05T17:01:31.887534Z","end":"2026-05-05T17:01:33.589243Z","steps":["trace[793065884] 'agreement among raft nodes before linearized reading' (duration: 1.701664036s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:33.589281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:31.887514Z","time spent":"1.701761089s","remote":"127.0.0.1:33002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-05T17:01:33.589307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:32.615911Z","time spent":"973.355877ms","remote":"127.0.0.1:33050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.19.213.80\" "} {"level":"warn","ts":"2026-05-05T17:01:34.478077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"806.678289ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"warn","ts":"2026-05-05T17:01:34.478167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:33.59073Z","time spent":"887.433397ms","remote":"127.0.0.1:33050","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-05-05T17:01:34.795208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.807314ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T17:01:34.795475Z","caller":"traceutil/trace.go:171","msg":"trace[2146221980] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:639; }","duration":"1.199197836s","start":"2026-05-05T17:01:33.596259Z","end":"2026-05-05T17:01:34.795457Z","steps":["trace[2146221980] 'read index received' (duration: 75.123733ms)","trace[2146221980] 'applied index is now lower than readState.Index' (duration: 1.124073213s)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:01:34.795569Z","caller":"traceutil/trace.go:171","msg":"trace[1283321040] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"1.199849641s","start":"2026-05-05T17:01:33.59571Z","end":"2026-05-05T17:01:34.795559Z","steps":["trace[1283321040] 'process raft request' (duration: 1.199587285s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:34.795625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:33.595698Z","time spent":"1.199897083s","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T17:01:34.7957Z","caller":"traceutil/trace.go:171","msg":"trace[283965696] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"1.201621954s","start":"2026-05-05T17:01:33.594043Z","end":"2026-05-05T17:01:34.795665Z","steps":["trace[283965696] 'process raft request' (duration: 1.028272887s)","trace[283965696] 'compare' (duration: 172.61488ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:01:34.795801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.199526844s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:01:34.795859Z","caller":"traceutil/trace.go:171","msg":"trace[590946390] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:623; }","duration":"1.199617396s","start":"2026-05-05T17:01:33.596229Z","end":"2026-05-05T17:01:34.795847Z","steps":["trace[590946390] 'agreement among raft nodes before linearized reading' (duration: 1.199374881s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:34.795866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.320578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-05-05T17:01:34.795885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:33.596194Z","time spent":"1.199685538s","remote":"127.0.0.1:33002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-05T17:01:34.795908Z","caller":"traceutil/trace.go:171","msg":"trace[1364134742] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:623; }","duration":"267.40229ms","start":"2026-05-05T17:01:34.528493Z","end":"2026-05-05T17:01:34.795896Z","steps":["trace[1364134742] 'agreement among raft nodes before linearized reading' (duration: 267.166595ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:34.795922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:33.594023Z","time spent":"1.201786748s","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T17:01:34.795953Z","caller":"traceutil/trace.go:171","msg":"trace[874715378] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"316.936633ms","start":"2026-05-05T17:01:34.479005Z","end":"2026-05-05T17:01:34.795942Z","steps":["trace[874715378] 'process raft request' (duration: 316.413331ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:34.79601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:34.478977Z","time spent":"317.002994ms","remote":"127.0.0.1:33050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T17:01:35.132484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.117567ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T17:01:35.132625Z","caller":"traceutil/trace.go:171","msg":"trace[1041669621] linearizableReadLoop","detail":"{readStateIndex:644; appliedIndex:643; }","duration":"328.667943ms","start":"2026-05-05T17:01:34.803934Z","end":"2026-05-05T17:01:35.132602Z","steps":["trace[1041669621] 'read index received' (duration: 107.318061ms)","trace[1041669621] 'applied index is now lower than readState.Index' (duration: 221.348712ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:01:35.13269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.762595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:01:35.132728Z","caller":"traceutil/trace.go:171","msg":"trace[43338705] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:624; }","duration":"328.806246ms","start":"2026-05-05T17:01:34.803906Z","end":"2026-05-05T17:01:35.132712Z","steps":["trace[43338705] 'agreement among raft nodes before linearized reading' (duration: 328.749424ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:01:35.132706Z","caller":"traceutil/trace.go:171","msg":"trace[1721605889] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"331.255265ms","start":"2026-05-05T17:01:34.801426Z","end":"2026-05-05T17:01:35.132681Z","steps":["trace[1721605889] 'process raft request' (duration: 109.80201ms)","trace[1721605889] 'compare' (duration: 220.965624ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:01:35.132769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:34.803895Z","time spent":"328.867108ms","remote":"127.0.0.1:33002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-05T17:01:35.132888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:34.801405Z","time spent":"331.388378ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T17:01:37.708892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.116083367s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-05T17:01:37.708945Z","caller":"traceutil/trace.go:171","msg":"trace[4461666] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:624; }","duration":"2.116178179s","start":"2026-05-05T17:01:35.592754Z","end":"2026-05-05T17:01:37.708933Z","steps":["trace[4461666] 'range keys from in-memory index tree' (duration: 2.115954414s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:37.70897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:35.592716Z","time spent":"2.116249031s","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-05T17:01:37.709278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.331767639s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T17:01:37.709351Z","caller":"traceutil/trace.go:171","msg":"trace[693073649] linearizableReadLoop","detail":"{readStateIndex:645; appliedIndex:644; }","duration":"1.822042569s","start":"2026-05-05T17:01:35.887296Z","end":"2026-05-05T17:01:37.709339Z","steps":["trace[693073649] 'read index received' (duration: 490.057773ms)","trace[693073649] 'applied index is now lower than readState.Index' (duration: 1.331983726s)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:01:37.7095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.822211593s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:01:37.709533Z","caller":"traceutil/trace.go:171","msg":"trace[1745075999] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:625; }","duration":"1.822243484s","start":"2026-05-05T17:01:35.88728Z","end":"2026-05-05T17:01:37.709524Z","steps":["trace[1745075999] 'agreement among raft nodes before linearized reading' (duration: 1.822147692s)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:01:37.709461Z","caller":"traceutil/trace.go:171","msg":"trace[767420784] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"1.99136592s","start":"2026-05-05T17:01:35.71799Z","end":"2026-05-05T17:01:37.709356Z","steps":["trace[767420784] 'process raft request' (duration: 659.451767ms)","trace[767420784] 'compare' (duration: 1.331318979s)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:01:37.709663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"909.196976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-05T17:01:37.709699Z","caller":"traceutil/trace.go:171","msg":"trace[1390817055] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:625; }","duration":"909.272328ms","start":"2026-05-05T17:01:36.800418Z","end":"2026-05-05T17:01:37.709691Z","steps":["trace[1390817055] 'agreement among raft nodes before linearized reading' (duration: 909.173786ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:37.709724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:36.800397Z","time spent":"909.321308ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-05T17:01:37.709756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:35.717967Z","time spent":"1.991671738s","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T17:01:37.70995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"573.187598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-05T17:01:37.709987Z","caller":"traceutil/trace.go:171","msg":"trace[366215114] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:625; }","duration":"573.247549ms","start":"2026-05-05T17:01:37.136731Z","end":"2026-05-05T17:01:37.709978Z","steps":["trace[366215114] 'agreement among raft nodes before linearized reading' (duration: 573.154426ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:37.709569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:35.887212Z","time spent":"1.822350486s","remote":"127.0.0.1:33002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-05T17:01:37.710081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"909.023472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-05T17:01:37.710111Z","caller":"traceutil/trace.go:171","msg":"trace[1571908202] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:625; }","duration":"909.067883ms","start":"2026-05-05T17:01:36.801035Z","end":"2026-05-05T17:01:37.710103Z","steps":["trace[1571908202] 'agreement among raft nodes before linearized reading' (duration: 908.998361ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:37.710139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:36.801027Z","time spent":"909.107583ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-05T17:01:37.710016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:37.136716Z","time spent":"573.2908ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-05T17:01:37.82952Z","caller":"traceutil/trace.go:171","msg":"trace[1123711252] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"115.419114ms","start":"2026-05-05T17:01:37.714077Z","end":"2026-05-05T17:01:37.829496Z","steps":["trace[1123711252] 'process raft request' (duration: 107.012863ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:01:38.083581Z","caller":"traceutil/trace.go:171","msg":"trace[696804181] linearizableReadLoop","detail":"{readStateIndex:649; appliedIndex:645; }","duration":"366.079376ms","start":"2026-05-05T17:01:37.717482Z","end":"2026-05-05T17:01:38.083561Z","steps":["trace[696804181] 'read index received' (duration: 103.584302ms)","trace[696804181] 'applied index is now lower than readState.Index' (duration: 262.494284ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:01:38.083595Z","caller":"traceutil/trace.go:171","msg":"trace[1540161657] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"369.453696ms","start":"2026-05-05T17:01:37.714118Z","end":"2026-05-05T17:01:38.083571Z","steps":["trace[1540161657] 'process raft request' (duration: 367.946099ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:01:38.0837Z","caller":"traceutil/trace.go:171","msg":"trace[736820440] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"368.047093ms","start":"2026-05-05T17:01:37.715619Z","end":"2026-05-05T17:01:38.083666Z","steps":["trace[736820440] 'process raft request' (duration: 367.91249ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:38.083752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:37.714098Z","time spent":"369.556449ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T17:01:38.083774Z","caller":"traceutil/trace.go:171","msg":"trace[964156608] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"369.091497ms","start":"2026-05-05T17:01:37.714669Z","end":"2026-05-05T17:01:38.08376Z","steps":["trace[964156608] 'process raft request' (duration: 368.829011ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:38.083842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:37.714655Z","time spent":"369.15763ms","remote":"127.0.0.1:33270","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-05-05T17:01:38.083919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:37.715604Z","time spent":"368.211467ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T17:01:38.084986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.379213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:01:38.085148Z","caller":"traceutil/trace.go:171","msg":"trace[336949044] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:629; }","duration":"367.690773ms","start":"2026-05-05T17:01:37.717438Z","end":"2026-05-05T17:01:38.085129Z","steps":["trace[336949044] 'agreement among raft nodes before linearized reading' (duration: 366.327941ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:38.085233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:37.717429Z","time spent":"367.790406ms","remote":"127.0.0.1:33002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-05T17:01:39.764821Z","caller":"traceutil/trace.go:171","msg":"trace[1300883696] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"162.954519ms","start":"2026-05-05T17:01:39.601845Z","end":"2026-05-05T17:01:39.764799Z","steps":["trace[1300883696] 'process raft request' (duration: 162.805275ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:41.1979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.7279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:01:41.197972Z","caller":"traceutil/trace.go:171","msg":"trace[1766102534] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:645; }","duration":"311.808212ms","start":"2026-05-05T17:01:40.886146Z","end":"2026-05-05T17:01:41.197954Z","steps":["trace[1766102534] 'range keys from in-memory index tree' (duration: 311.628288ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:41.198013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:40.8861Z","time spent":"311.902104ms","remote":"127.0.0.1:33002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-05T17:01:49.705126Z","caller":"traceutil/trace.go:171","msg":"trace[342388412] transaction","detail":"{read_only:false; response_revision:743; number_of_response:1; }","duration":"147.961946ms","start":"2026-05-05T17:01:49.557141Z","end":"2026-05-05T17:01:49.705102Z","steps":["trace[342388412] 'process raft request' (duration: 147.832723ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:49.828553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.236121ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-05T17:01:49.828757Z","caller":"traceutil/trace.go:171","msg":"trace[210815364] transaction","detail":"{read_only:false; response_revision:744; number_of_response:1; }","duration":"119.064955ms","start":"2026-05-05T17:01:49.709658Z","end":"2026-05-05T17:01:49.828723Z","steps":["trace[210815364] 'process raft request' (duration: 17.590588ms)","trace[210815364] 'compare' (duration: 100.979136ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:01:49.828965Z","caller":"traceutil/trace.go:171","msg":"trace[1867942234] transaction","detail":"{read_only:false; response_revision:745; number_of_response:1; }","duration":"116.108767ms","start":"2026-05-05T17:01:49.712795Z","end":"2026-05-05T17:01:49.828904Z","steps":["trace[1867942234] 'process raft request' (duration: 115.860941ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:01:53.502222Z","caller":"traceutil/trace.go:171","msg":"trace[831970637] transaction","detail":"{read_only:false; response_revision:774; number_of_response:1; }","duration":"142.776436ms","start":"2026-05-05T17:01:53.359421Z","end":"2026-05-05T17:01:53.502197Z","steps":["trace[831970637] 'process raft request' (duration: 142.608231ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:57.387662Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15026433849859836065,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-05T17:01:57.888223Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15026433849859836065,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-05T17:01:58.306833Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.509799238s","expected-duration":"1s"} {"level":"info","ts":"2026-05-05T17:01:58.307224Z","caller":"traceutil/trace.go:171","msg":"trace[683547184] linearizableReadLoop","detail":"{readStateIndex:820; appliedIndex:819; }","duration":"1.420540005s","start":"2026-05-05T17:01:56.886659Z","end":"2026-05-05T17:01:58.307199Z","steps":["trace[683547184] 'read index received' (duration: 1.420452053s)","trace[683547184] 'applied index is now lower than readState.Index' (duration: 86.982µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:01:58.307258Z","caller":"traceutil/trace.go:171","msg":"trace[1495007685] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"1.510414173s","start":"2026-05-05T17:01:56.796817Z","end":"2026-05-05T17:01:58.307232Z","steps":["trace[1495007685] 'process raft request' (duration: 1.510247169s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:58.307385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.420706169s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T17:01:58.307394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:56.796785Z","time spent":"1.510537036s","remote":"127.0.0.1:33198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4024,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T17:01:58.307418Z","caller":"traceutil/trace.go:171","msg":"trace[1278426440] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:794; }","duration":"1.420799422s","start":"2026-05-05T17:01:56.886609Z","end":"2026-05-05T17:01:58.307408Z","steps":["trace[1278426440] 'agreement among raft nodes before linearized reading' (duration: 1.42070779s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:58.30745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:56.886587Z","time spent":"1.420856463s","remote":"127.0.0.1:33002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-05T17:01:58.329799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.264348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:01:58.329877Z","caller":"traceutil/trace.go:171","msg":"trace[1802542140] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:795; }","duration":"549.38475ms","start":"2026-05-05T17:01:57.780475Z","end":"2026-05-05T17:01:58.32986Z","steps":["trace[1802542140] 'agreement among raft nodes before linearized reading' (duration: 549.239827ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:01:58.329879Z","caller":"traceutil/trace.go:171","msg":"trace[1821674057] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"193.932014ms","start":"2026-05-05T17:01:58.13593Z","end":"2026-05-05T17:01:58.329862Z","steps":["trace[1821674057] 'process raft request' (duration: 193.645138ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:58.329921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:57.780459Z","time spent":"549.452372ms","remote":"127.0.0.1:33146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":28,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "} {"level":"warn","ts":"2026-05-05T17:01:58.329834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"814.827246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-05T17:01:58.329998Z","caller":"traceutil/trace.go:171","msg":"trace[52172101] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:795; }","duration":"815.042661ms","start":"2026-05-05T17:01:57.514942Z","end":"2026-05-05T17:01:58.329985Z","steps":["trace[52172101] 'agreement among raft nodes before linearized reading' (duration: 814.775205ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:58.329995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.71444ms","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":"info","ts":"2026-05-05T17:01:58.330074Z","caller":"traceutil/trace.go:171","msg":"trace[1127917128] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:795; }","duration":"320.827663ms","start":"2026-05-05T17:01:58.009231Z","end":"2026-05-05T17:01:58.330059Z","steps":["trace[1127917128] 'agreement among raft nodes before linearized reading' (duration: 320.674619ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:58.330119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:58.009213Z","time spent":"320.894454ms","remote":"127.0.0.1:33532","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":94,"response size":30,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-05-05T17:01:58.32982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.104742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-05-05T17:01:58.330198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.016670065s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-05T17:01:58.330224Z","caller":"traceutil/trace.go:171","msg":"trace[957097604] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:795; }","duration":"1.016699375s","start":"2026-05-05T17:01:57.313518Z","end":"2026-05-05T17:01:58.330217Z","steps":["trace[957097604] 'agreement among raft nodes before linearized reading' (duration: 1.016651594s)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:01:58.33023Z","caller":"traceutil/trace.go:171","msg":"trace[2055265483] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:795; }","duration":"229.565122ms","start":"2026-05-05T17:01:58.100649Z","end":"2026-05-05T17:01:58.330215Z","steps":["trace[2055265483] 'agreement among raft nodes before linearized reading' (duration: 229.03764ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:01:58.330249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:57.313493Z","time spent":"1.016751167s","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":7,"response size":30,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"warn","ts":"2026-05-05T17:01:58.330082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:01:57.514919Z","time spent":"815.152434ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-05T17:02:01.985136Z","caller":"traceutil/trace.go:171","msg":"trace[278970626] transaction","detail":"{read_only:false; response_revision:810; number_of_response:1; }","duration":"122.400314ms","start":"2026-05-05T17:02:01.862702Z","end":"2026-05-05T17:02:01.985102Z","steps":["trace[278970626] 'process raft request' (duration: 122.151678ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:02:13.004584Z","caller":"traceutil/trace.go:171","msg":"trace[616384835] linearizableReadLoop","detail":"{readStateIndex:967; appliedIndex:966; }","duration":"117.951339ms","start":"2026-05-05T17:02:12.886606Z","end":"2026-05-05T17:02:13.004557Z","steps":["trace[616384835] 'read index received' (duration: 117.728504ms)","trace[616384835] 'applied index is now lower than readState.Index' (duration: 221.925µs)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:02:13.004728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.104793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:02:13.004772Z","caller":"traceutil/trace.go:171","msg":"trace[1249671982] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:937; }","duration":"118.189125ms","start":"2026-05-05T17:02:12.886569Z","end":"2026-05-05T17:02:13.004758Z","steps":["trace[1249671982] 'agreement among raft nodes before linearized reading' (duration: 118.104493ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:02:13.004741Z","caller":"traceutil/trace.go:171","msg":"trace[857235139] transaction","detail":"{read_only:false; response_revision:937; number_of_response:1; }","duration":"145.93073ms","start":"2026-05-05T17:02:12.858681Z","end":"2026-05-05T17:02:13.004611Z","steps":["trace[857235139] 'process raft request' (duration: 145.742595ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:02:31.189938Z","caller":"traceutil/trace.go:171","msg":"trace[1368445995] transaction","detail":"{read_only:false; response_revision:1000; number_of_response:1; }","duration":"143.088044ms","start":"2026-05-05T17:02:31.046826Z","end":"2026-05-05T17:02:31.189914Z","steps":["trace[1368445995] 'process raft request' (duration: 140.176926ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:02:31.391532Z","caller":"traceutil/trace.go:171","msg":"trace[1436690044] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1002; }","duration":"157.944589ms","start":"2026-05-05T17:02:31.233374Z","end":"2026-05-05T17:02:31.391319Z","steps":["trace[1436690044] 'process raft request' (duration: 78.459642ms)","trace[1436690044] 'compare' (duration: 79.349124ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:02:32.746116Z","caller":"traceutil/trace.go:171","msg":"trace[1346396528] transaction","detail":"{read_only:false; response_revision:1006; number_of_response:1; }","duration":"131.476094ms","start":"2026-05-05T17:02:32.614631Z","end":"2026-05-05T17:02:32.746107Z","steps":["trace[1346396528] 'process raft request' (duration: 75.552245ms)","trace[1346396528] 'compare' (duration: 55.634432ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:02:32.745895Z","caller":"traceutil/trace.go:171","msg":"trace[1001987140] linearizableReadLoop","detail":"{readStateIndex:1039; appliedIndex:1037; }","duration":"129.17069ms","start":"2026-05-05T17:02:32.616708Z","end":"2026-05-05T17:02:32.745878Z","steps":["trace[1001987140] 'read index received' (duration: 22.36262ms)","trace[1001987140] 'applied index is now lower than readState.Index' (duration: 106.80739ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:02:32.745995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.274583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-05T17:02:32.746292Z","caller":"traceutil/trace.go:171","msg":"trace[51465674] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1006; }","duration":"129.59879ms","start":"2026-05-05T17:02:32.616687Z","end":"2026-05-05T17:02:32.746286Z","steps":["trace[51465674] 'agreement among raft nodes before linearized reading' (duration: 129.213671ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:02:32.746398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.203037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.80\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-05T17:02:32.746438Z","caller":"traceutil/trace.go:171","msg":"trace[482527575] range","detail":"{range_begin:/registry/masterleases/199.19.213.80; range_end:; response_count:1; response_revision:1006; }","duration":"128.273959ms","start":"2026-05-05T17:02:32.618147Z","end":"2026-05-05T17:02:32.746421Z","steps":["trace[482527575] 'agreement among raft nodes before linearized reading' (duration: 128.121755ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:02:32.93794Z","caller":"traceutil/trace.go:171","msg":"trace[1546268118] transaction","detail":"{read_only:false; response_revision:1007; number_of_response:1; }","duration":"187.995786ms","start":"2026-05-05T17:02:32.749924Z","end":"2026-05-05T17:02:32.93792Z","steps":["trace[1546268118] 'process raft request' (duration: 184.329131ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:02:32.938034Z","caller":"traceutil/trace.go:171","msg":"trace[1890870265] transaction","detail":"{read_only:false; response_revision:1008; number_of_response:1; }","duration":"186.731948ms","start":"2026-05-05T17:02:32.751283Z","end":"2026-05-05T17:02:32.938015Z","steps":["trace[1890870265] 'process raft request' (duration: 186.610145ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:02:32.95092Z","caller":"traceutil/trace.go:171","msg":"trace[220036616] transaction","detail":"{read_only:false; response_revision:1009; number_of_response:1; }","duration":"163.243731ms","start":"2026-05-05T17:02:32.787661Z","end":"2026-05-05T17:02:32.950905Z","steps":["trace[220036616] 'process raft request' (duration: 163.141459ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:02:34.136788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"992.999405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-05T17:02:34.136865Z","caller":"traceutil/trace.go:171","msg":"trace[1084175271] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:1009; }","duration":"993.134658ms","start":"2026-05-05T17:02:33.143712Z","end":"2026-05-05T17:02:34.136846Z","steps":["trace[1084175271] 'count revisions from in-memory index tree' (duration: 992.884302ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:02:34.137079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:02:33.143694Z","time spent":"993.200789ms","remote":"127.0.0.1:33478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":2,"response size":30,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "} {"level":"warn","ts":"2026-05-05T17:02:34.137322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"655.2579ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T17:02:34.137416Z","caller":"traceutil/trace.go:171","msg":"trace[1302108281] linearizableReadLoop","detail":"{readStateIndex:1044; appliedIndex:1043; }","duration":"358.115949ms","start":"2026-05-05T17:02:33.779284Z","end":"2026-05-05T17:02:34.1374Z","steps":["trace[1302108281] 'read index received' (duration: 18.211µs)","trace[1302108281] 'applied index is now lower than readState.Index' (duration: 358.096608ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:02:34.137498Z","caller":"traceutil/trace.go:171","msg":"trace[89834098] transaction","detail":"{read_only:false; response_revision:1010; number_of_response:1; }","duration":"712.253064ms","start":"2026-05-05T17:02:33.425234Z","end":"2026-05-05T17:02:34.137487Z","steps":["trace[89834098] 'process raft request' (duration: 56.751508ms)","trace[89834098] 'compare' (duration: 654.710907ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:02:34.137553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:02:33.425206Z","time spent":"712.316324ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T17:02:34.137742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.450426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:02:34.137771Z","caller":"traceutil/trace.go:171","msg":"trace[2132874471] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1010; }","duration":"358.506657ms","start":"2026-05-05T17:02:33.779255Z","end":"2026-05-05T17:02:34.137761Z","steps":["trace[2132874471] 'agreement among raft nodes before linearized reading' (duration: 358.453686ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:02:34.137803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:02:33.779241Z","time spent":"358.554299ms","remote":"127.0.0.1:56912","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-05T17:02:34.137948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.827826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:02:34.137974Z","caller":"traceutil/trace.go:171","msg":"trace[496788897] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1010; }","duration":"250.890727ms","start":"2026-05-05T17:02:33.887075Z","end":"2026-05-05T17:02:34.137966Z","steps":["trace[496788897] 'agreement among raft nodes before linearized reading' (duration: 250.853736ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:02:34.965283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:02:34.331161Z","time spent":"634.115338ms","remote":"127.0.0.1:46998","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-05-05T17:02:34.965334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.691065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-05T17:02:34.965393Z","caller":"traceutil/trace.go:171","msg":"trace[338648971] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1010; }","duration":"381.805478ms","start":"2026-05-05T17:02:34.583571Z","end":"2026-05-05T17:02:34.965376Z","steps":["trace[338648971] 'count revisions from in-memory index tree' (duration: 381.635083ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:02:34.965425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:02:34.583556Z","time spent":"381.86254ms","remote":"127.0.0.1:33206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":3,"response size":30,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "} {"level":"warn","ts":"2026-05-05T17:02:34.965618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.523263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-05-05T17:02:34.965644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.280044ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T17:02:34.965702Z","caller":"traceutil/trace.go:171","msg":"trace[543804308] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1010; }","duration":"335.643616ms","start":"2026-05-05T17:02:34.630041Z","end":"2026-05-05T17:02:34.965685Z","steps":["trace[543804308] 'range keys from in-memory index tree' (duration: 335.404131ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:02:34.965723Z","caller":"traceutil/trace.go:171","msg":"trace[1699146907] linearizableReadLoop","detail":"{readStateIndex:1045; appliedIndex:1044; }","duration":"323.025714ms","start":"2026-05-05T17:02:34.642685Z","end":"2026-05-05T17:02:34.96571Z","steps":["trace[1699146907] 'read index received' (duration: 202.605817ms)","trace[1699146907] 'applied index is now lower than readState.Index' (duration: 120.418647ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:02:34.965752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:02:34.630032Z","time spent":"335.712668ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-05T17:02:34.965735Z","caller":"traceutil/trace.go:171","msg":"trace[940095597] transaction","detail":"{read_only:false; response_revision:1011; number_of_response:1; }","duration":"334.814367ms","start":"2026-05-05T17:02:34.630899Z","end":"2026-05-05T17:02:34.965714Z","steps":["trace[940095597] 'process raft request' (duration: 214.39508ms)","trace[940095597] 'compare' (duration: 120.068259ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:02:34.965843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:02:34.630889Z","time spent":"334.898679ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T17:02:34.965894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.213308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-05T17:02:34.965904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.822327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-05T17:02:34.965915Z","caller":"traceutil/trace.go:171","msg":"trace[1029543392] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1011; }","duration":"323.266639ms","start":"2026-05-05T17:02:34.642642Z","end":"2026-05-05T17:02:34.965908Z","steps":["trace[1029543392] 'agreement among raft nodes before linearized reading' (duration: 323.147957ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:02:34.965937Z","caller":"traceutil/trace.go:171","msg":"trace[752130233] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1011; }","duration":"216.900039ms","start":"2026-05-05T17:02:34.749026Z","end":"2026-05-05T17:02:34.965926Z","steps":["trace[752130233] 'agreement among raft nodes before linearized reading' (duration: 216.771216ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:02:34.965941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:02:34.642625Z","time spent":"323.31049ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-05T17:02:35.415393Z","caller":"traceutil/trace.go:171","msg":"trace[1691564549] transaction","detail":"{read_only:false; response_revision:1012; number_of_response:1; }","duration":"446.265366ms","start":"2026-05-05T17:02:34.969102Z","end":"2026-05-05T17:02:35.415367Z","steps":["trace[1691564549] 'process raft request' (duration: 436.334636ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:02:35.415552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:02:34.969077Z","time spent":"446.397998ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T17:02:35.418018Z","caller":"traceutil/trace.go:171","msg":"trace[673512517] transaction","detail":"{read_only:false; response_revision:1013; number_of_response:1; }","duration":"447.707019ms","start":"2026-05-05T17:02:34.970287Z","end":"2026-05-05T17:02:35.417994Z","steps":["trace[673512517] 'process raft request' (duration: 447.548855ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:02:35.418159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:02:34.970269Z","time spent":"447.815842ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T17:02:35.418301Z","caller":"traceutil/trace.go:171","msg":"trace[1172618591] transaction","detail":"{read_only:false; response_revision:1014; number_of_response:1; }","duration":"447.875103ms","start":"2026-05-05T17:02:34.970404Z","end":"2026-05-05T17:02:35.418279Z","steps":["trace[1172618591] 'process raft request' (duration: 447.531336ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:02:35.418417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:02:34.970399Z","time spent":"447.953865ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T17:02:35.418453Z","caller":"traceutil/trace.go:171","msg":"trace[1786900348] transaction","detail":"{read_only:false; response_revision:1015; number_of_response:1; }","duration":"447.523275ms","start":"2026-05-05T17:02:34.970898Z","end":"2026-05-05T17:02:35.418422Z","steps":["trace[1786900348] 'process raft request' (duration: 447.291259ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:02:35.41853Z","caller":"traceutil/trace.go:171","msg":"trace[1958696973] transaction","detail":"{read_only:false; response_revision:1016; number_of_response:1; }","duration":"446.561102ms","start":"2026-05-05T17:02:34.97195Z","end":"2026-05-05T17:02:35.418511Z","steps":["trace[1958696973] 'process raft request' (duration: 446.424479ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:02:35.418624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:02:34.971936Z","time spent":"446.641704ms","remote":"127.0.0.1:33270","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-05-05T17:02:35.418641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:02:34.970891Z","time spent":"447.616808ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T17:02:56.441153Z","caller":"traceutil/trace.go:171","msg":"trace[12099485] transaction","detail":"{read_only:false; response_revision:1083; number_of_response:1; }","duration":"151.608992ms","start":"2026-05-05T17:02:56.289519Z","end":"2026-05-05T17:02:56.441128Z","steps":["trace[12099485] 'process raft request' (duration: 151.474269ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:02:57.27977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.948901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:02:57.279843Z","caller":"traceutil/trace.go:171","msg":"trace[467776414] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1083; }","duration":"391.085385ms","start":"2026-05-05T17:02:56.88874Z","end":"2026-05-05T17:02:57.279825Z","steps":["trace[467776414] 'range keys from in-memory index tree' (duration: 390.88387ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:02:57.279882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:02:56.888722Z","time spent":"391.149416ms","remote":"127.0.0.1:33002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-05T17:02:57.93406Z","caller":"traceutil/trace.go:171","msg":"trace[1165990786] transaction","detail":"{read_only:false; response_revision:1084; number_of_response:1; }","duration":"371.442108ms","start":"2026-05-05T17:02:57.562603Z","end":"2026-05-05T17:02:57.934045Z","steps":["trace[1165990786] 'process raft request' (duration: 371.270914ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:02:57.93403Z","caller":"traceutil/trace.go:171","msg":"trace[1733314611] linearizableReadLoop","detail":"{readStateIndex:1122; appliedIndex:1121; }","duration":"370.483796ms","start":"2026-05-05T17:02:57.563523Z","end":"2026-05-05T17:02:57.934007Z","steps":["trace[1733314611] 'read index received' (duration: 370.423114ms)","trace[1733314611] 'applied index is now lower than readState.Index' (duration: 59.752µs)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:02:57.934208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:02:57.562579Z","time spent":"371.547351ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T17:02:57.934755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.198342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-05T17:02:57.934804Z","caller":"traceutil/trace.go:171","msg":"trace[1842295522] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1084; }","duration":"371.306205ms","start":"2026-05-05T17:02:57.563486Z","end":"2026-05-05T17:02:57.934792Z","steps":["trace[1842295522] 'agreement among raft nodes before linearized reading' (duration: 370.615109ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:02:57.934855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:02:57.563467Z","time spent":"371.365626ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-05T17:02:58.430568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.657935ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T17:02:58.43095Z","caller":"traceutil/trace.go:171","msg":"trace[953574669] transaction","detail":"{read_only:false; response_revision:1085; number_of_response:1; }","duration":"866.318071ms","start":"2026-05-05T17:02:57.564605Z","end":"2026-05-05T17:02:58.430924Z","steps":["trace[953574669] 'process raft request' (duration: 729.217417ms)","trace[953574669] 'compare' (duration: 136.189113ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:02:58.431087Z","caller":"traceutil/trace.go:171","msg":"trace[438320450] linearizableReadLoop","detail":"{readStateIndex:1123; appliedIndex:1122; }","duration":"496.633885ms","start":"2026-05-05T17:02:57.934426Z","end":"2026-05-05T17:02:58.43106Z","steps":["trace[438320450] 'read index received' (duration: 359.421878ms)","trace[438320450] 'applied index is now lower than readState.Index' (duration: 137.209487ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:02:58.431036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:02:57.564593Z","time spent":"866.406824ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T17:02:58.431988Z","caller":"traceutil/trace.go:171","msg":"trace[2000360531] transaction","detail":"{read_only:false; response_revision:1086; number_of_response:1; }","duration":"492.812626ms","start":"2026-05-05T17:02:57.939123Z","end":"2026-05-05T17:02:58.431936Z","steps":["trace[2000360531] 'process raft request' (duration: 491.542377ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:02:58.432101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:02:57.939103Z","time spent":"492.93755ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T17:02:58.583174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.01823102s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-05T17:02:58.58327Z","caller":"traceutil/trace.go:171","msg":"trace[6342332] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1086; }","duration":"1.018336693s","start":"2026-05-05T17:02:57.564912Z","end":"2026-05-05T17:02:58.583249Z","steps":["trace[6342332] 'agreement among raft nodes before linearized reading' (duration: 866.738221ms)","trace[6342332] 'range keys from in-memory index tree' (duration: 151.134211ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:02:58.583329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.013314066s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-05T17:02:58.583439Z","caller":"traceutil/trace.go:171","msg":"trace[141712366] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1086; }","duration":"1.013437079s","start":"2026-05-05T17:02:57.569937Z","end":"2026-05-05T17:02:58.583374Z","steps":["trace[141712366] 'agreement among raft nodes before linearized reading' (duration: 861.589942ms)","trace[141712366] 'range keys from in-memory index tree' (duration: 151.300785ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:02:58.58333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:02:57.564894Z","time spent":"1.018426995s","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-05T17:02:58.583499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:02:57.569928Z","time spent":"1.013560542s","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-05T17:02:58.583168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.319495ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-05T17:02:58.583759Z","caller":"traceutil/trace.go:171","msg":"trace[728856446] transaction","detail":"{read_only:false; response_revision:1087; number_of_response:1; }","duration":"138.002007ms","start":"2026-05-05T17:02:58.445744Z","end":"2026-05-05T17:02:58.583746Z","steps":["trace[728856446] 'process raft request' (duration: 137.877203ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:02:58.583819Z","caller":"traceutil/trace.go:171","msg":"trace[1546451891] linearizableReadLoop","detail":"{readStateIndex:1125; appliedIndex:1124; }","duration":"152.159665ms","start":"2026-05-05T17:02:58.431549Z","end":"2026-05-05T17:02:58.583709Z","steps":["trace[1546451891] 'read index received' (duration: 594.534µs)","trace[1546451891] 'applied index is now lower than readState.Index' (duration: 151.555911ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:02:58.583873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.865828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-05T17:02:58.583912Z","caller":"traceutil/trace.go:171","msg":"trace[78506223] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1087; }","duration":"386.929578ms","start":"2026-05-05T17:02:58.196971Z","end":"2026-05-05T17:02:58.583901Z","steps":["trace[78506223] 'agreement among raft nodes before linearized reading' (duration: 386.864147ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:02:58.58391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.80018ms","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":"warn","ts":"2026-05-05T17:02:58.583948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:02:58.19696Z","time spent":"386.97953ms","remote":"127.0.0.1:33430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":30,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"info","ts":"2026-05-05T17:02:58.583954Z","caller":"traceutil/trace.go:171","msg":"trace[1042388311] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1087; }","duration":"493.881942ms","start":"2026-05-05T17:02:58.090059Z","end":"2026-05-05T17:02:58.583941Z","steps":["trace[1042388311] 'agreement among raft nodes before linearized reading' (duration: 493.819111ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:02:58.583961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.020424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-05T17:02:58.584038Z","caller":"traceutil/trace.go:171","msg":"trace[962647687] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:1087; }","duration":"388.160517ms","start":"2026-05-05T17:02:58.195859Z","end":"2026-05-05T17:02:58.58402Z","steps":["trace[962647687] 'agreement among raft nodes before linearized reading' (duration: 387.990243ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:02:58.584052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.893558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T17:02:58.584076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:02:58.195838Z","time spent":"388.231618ms","remote":"127.0.0.1:33458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":3,"response size":30,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true "} {"level":"info","ts":"2026-05-05T17:02:58.584094Z","caller":"traceutil/trace.go:171","msg":"trace[819283460] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1087; }","duration":"129.983941ms","start":"2026-05-05T17:02:58.454095Z","end":"2026-05-05T17:02:58.584079Z","steps":["trace[819283460] 'agreement among raft nodes before linearized reading' (duration: 129.875038ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:02:58.583986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:02:58.090039Z","time spent":"493.939164ms","remote":"127.0.0.1:56952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-05-05T17:02:58.958067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.452943ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T17:02:58.958175Z","caller":"traceutil/trace.go:171","msg":"trace[971182943] transaction","detail":"{read_only:false; response_revision:1088; number_of_response:1; }","duration":"367.183179ms","start":"2026-05-05T17:02:58.590975Z","end":"2026-05-05T17:02:58.958158Z","steps":["trace[971182943] 'process raft request' (duration: 229.565632ms)","trace[971182943] 'compare' (duration: 137.238808ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:02:58.958244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:02:58.590963Z","time spent":"367.25522ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T17:02:58.959978Z","caller":"traceutil/trace.go:171","msg":"trace[935648995] transaction","detail":"{read_only:false; response_revision:1089; number_of_response:1; }","duration":"368.505269ms","start":"2026-05-05T17:02:58.591461Z","end":"2026-05-05T17:02:58.959967Z","steps":["trace[935648995] 'process raft request' (duration: 368.142431ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:02:58.960033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:02:58.591443Z","time spent":"368.565421ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T17:03:00.112666Z","caller":"traceutil/trace.go:171","msg":"trace[1756900462] transaction","detail":"{read_only:false; response_revision:1091; number_of_response:1; }","duration":"170.653674ms","start":"2026-05-05T17:02:59.941975Z","end":"2026-05-05T17:03:00.112629Z","steps":["trace[1756900462] 'process raft request' (duration: 170.421239ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:03:01.344419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.107799831s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T17:03:01.344589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"906.415596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-05T17:03:01.344608Z","caller":"traceutil/trace.go:171","msg":"trace[478578701] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1091; }","duration":"1.108002236s","start":"2026-05-05T17:03:00.236583Z","end":"2026-05-05T17:03:01.344585Z","steps":["trace[478578701] 'range keys from in-memory index tree' (duration: 1.107781991s)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:03:01.344636Z","caller":"traceutil/trace.go:171","msg":"trace[89654163] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1091; }","duration":"906.504817ms","start":"2026-05-05T17:03:00.438118Z","end":"2026-05-05T17:03:01.344623Z","steps":["trace[89654163] 'range keys from in-memory index tree' (duration: 906.262662ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:03:01.345099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"905.674547ms","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":"warn","ts":"2026-05-05T17:03:01.345129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:03:00.438097Z","time spent":"906.997609ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-05T17:03:01.34515Z","caller":"traceutil/trace.go:171","msg":"trace[668029949] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1091; }","duration":"905.751479ms","start":"2026-05-05T17:03:00.439384Z","end":"2026-05-05T17:03:01.345135Z","steps":["trace[668029949] 'range keys from in-memory index tree' (duration: 905.565195ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:03:01.345216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:03:00.439371Z","time spent":"905.831081ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-05T17:03:01.34567Z","caller":"traceutil/trace.go:171","msg":"trace[261587728] linearizableReadLoop","detail":"{readStateIndex:1131; appliedIndex:1130; }","duration":"457.742613ms","start":"2026-05-05T17:03:00.887887Z","end":"2026-05-05T17:03:01.34563Z","steps":["trace[261587728] 'read index received' (duration: 367.881456ms)","trace[261587728] 'applied index is now lower than readState.Index' (duration: 89.859007ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:03:01.345778Z","caller":"traceutil/trace.go:171","msg":"trace[184206989] transaction","detail":"{read_only:false; response_revision:1092; number_of_response:1; }","duration":"751.945797ms","start":"2026-05-05T17:03:00.593815Z","end":"2026-05-05T17:03:01.345761Z","steps":["trace[184206989] 'process raft request' (duration: 662.016168ms)","trace[184206989] 'compare' (duration: 89.518049ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:03:01.345892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:03:00.593791Z","time spent":"752.029868ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T17:03:01.346125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.242455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:03:01.346165Z","caller":"traceutil/trace.go:171","msg":"trace[1384010628] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1092; }","duration":"458.308226ms","start":"2026-05-05T17:03:00.887847Z","end":"2026-05-05T17:03:01.346155Z","steps":["trace[1384010628] 'agreement among raft nodes before linearized reading' (duration: 458.250735ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:03:01.346192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:03:00.887832Z","time spent":"458.354358ms","remote":"127.0.0.1:33000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-05T17:03:01.346733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.6833ms","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-05-05T17:03:01.346767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.934592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-05T17:03:01.346788Z","caller":"traceutil/trace.go:171","msg":"trace[2102503247] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1092; }","duration":"382.777942ms","start":"2026-05-05T17:03:00.963995Z","end":"2026-05-05T17:03:01.346773Z","steps":["trace[2102503247] 'agreement among raft nodes before linearized reading' (duration: 382.609588ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:03:01.346841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:03:00.963975Z","time spent":"382.859103ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-05T17:03:01.346848Z","caller":"traceutil/trace.go:171","msg":"trace[774598304] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1092; }","duration":"385.116936ms","start":"2026-05-05T17:03:00.961711Z","end":"2026-05-05T17:03:01.346828Z","steps":["trace[774598304] 'agreement among raft nodes before linearized reading' (duration: 384.891591ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:03:01.346892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:03:00.961691Z","time spent":"385.192649ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-05T17:03:01.540119Z","caller":"traceutil/trace.go:171","msg":"trace[2123347296] transaction","detail":"{read_only:false; response_revision:1094; number_of_response:1; }","duration":"188.483818ms","start":"2026-05-05T17:03:01.351609Z","end":"2026-05-05T17:03:01.540093Z","steps":["trace[2123347296] 'process raft request' (duration: 188.295384ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:03:01.540445Z","caller":"traceutil/trace.go:171","msg":"trace[242459586] transaction","detail":"{read_only:false; response_revision:1095; number_of_response:1; }","duration":"188.607431ms","start":"2026-05-05T17:03:01.351798Z","end":"2026-05-05T17:03:01.540406Z","steps":["trace[242459586] 'process raft request' (duration: 188.258543ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:03:01.54049Z","caller":"traceutil/trace.go:171","msg":"trace[1485990123] transaction","detail":"{read_only:false; response_revision:1096; number_of_response:1; }","duration":"187.339612ms","start":"2026-05-05T17:03:01.353133Z","end":"2026-05-05T17:03:01.540473Z","steps":["trace[1485990123] 'process raft request' (duration: 187.136237ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:03:03.704712Z","caller":"traceutil/trace.go:171","msg":"trace[98516638] linearizableReadLoop","detail":"{readStateIndex:1139; appliedIndex:1138; }","duration":"341.438771ms","start":"2026-05-05T17:03:03.363253Z","end":"2026-05-05T17:03:03.704692Z","steps":["trace[98516638] 'read index received' (duration: 341.271597ms)","trace[98516638] 'applied index is now lower than readState.Index' (duration: 166.264µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:03:03.704793Z","caller":"traceutil/trace.go:171","msg":"trace[1963745598] transaction","detail":"{read_only:false; response_revision:1099; number_of_response:1; }","duration":"353.252947ms","start":"2026-05-05T17:03:03.351497Z","end":"2026-05-05T17:03:03.70475Z","steps":["trace[1963745598] 'process raft request' (duration: 353.078812ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:03:03.705009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.267236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-05-05T17:03:03.705022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:03:03.35147Z","time spent":"353.4142ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T17:03:03.705013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.750878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-05T17:03:03.705063Z","caller":"traceutil/trace.go:171","msg":"trace[1552856861] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1099; }","duration":"161.379179ms","start":"2026-05-05T17:03:03.543676Z","end":"2026-05-05T17:03:03.705055Z","steps":["trace[1552856861] 'agreement among raft nodes before linearized reading' (duration: 161.230355ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:03:03.705119Z","caller":"traceutil/trace.go:171","msg":"trace[2053513194] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1099; }","duration":"341.897272ms","start":"2026-05-05T17:03:03.363196Z","end":"2026-05-05T17:03:03.705093Z","steps":["trace[2053513194] 'agreement among raft nodes before linearized reading' (duration: 341.600795ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:03:03.705014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.836382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-05-05T17:03:03.705206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:03:03.363154Z","time spent":"342.030785ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-05T17:03:03.705214Z","caller":"traceutil/trace.go:171","msg":"trace[2095297147] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1099; }","duration":"160.065158ms","start":"2026-05-05T17:03:03.545135Z","end":"2026-05-05T17:03:03.7052Z","steps":["trace[2095297147] 'agreement among raft nodes before linearized reading' (duration: 159.786182ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:03:03.705435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.872857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-05T17:03:03.70553Z","caller":"traceutil/trace.go:171","msg":"trace[808075397] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1099; }","duration":"160.98025ms","start":"2026-05-05T17:03:03.544525Z","end":"2026-05-05T17:03:03.705506Z","steps":["trace[808075397] 'agreement among raft nodes before linearized reading' (duration: 160.510539ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:03:04.03688Z","caller":"traceutil/trace.go:171","msg":"trace[1060457814] transaction","detail":"{read_only:false; response_revision:1101; number_of_response:1; }","duration":"327.905417ms","start":"2026-05-05T17:03:03.70895Z","end":"2026-05-05T17:03:04.036855Z","steps":["trace[1060457814] 'process raft request' (duration: 327.823765ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:03:04.036909Z","caller":"traceutil/trace.go:171","msg":"trace[1420793426] transaction","detail":"{read_only:false; response_revision:1100; number_of_response:1; }","duration":"327.970768ms","start":"2026-05-05T17:03:03.708902Z","end":"2026-05-05T17:03:04.036873Z","steps":["trace[1420793426] 'process raft request' (duration: 327.733593ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:03:04.03703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:03:03.708933Z","time spent":"328.02099ms","remote":"127.0.0.1:33270","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-05-05T17:03:04.037068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:03:03.70884Z","time spent":"328.142182ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T17:03:04.037738Z","caller":"traceutil/trace.go:171","msg":"trace[903310113] transaction","detail":"{read_only:false; response_revision:1102; number_of_response:1; }","duration":"328.394178ms","start":"2026-05-05T17:03:03.709091Z","end":"2026-05-05T17:03:04.037485Z","steps":["trace[903310113] 'process raft request' (duration: 327.728013ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:03:04.03782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:03:03.709083Z","time spent":"328.699095ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T17:03:04.217514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.897551ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T17:03:04.217612Z","caller":"traceutil/trace.go:171","msg":"trace[861342669] linearizableReadLoop","detail":"{readStateIndex:1143; appliedIndex:1139; }","duration":"329.555145ms","start":"2026-05-05T17:03:03.88804Z","end":"2026-05-05T17:03:04.217595Z","steps":["trace[861342669] 'read index received' (duration: 148.608892ms)","trace[861342669] 'applied index is now lower than readState.Index' (duration: 180.944963ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:03:04.217687Z","caller":"traceutil/trace.go:171","msg":"trace[1240504425] transaction","detail":"{read_only:false; response_revision:1103; number_of_response:1; }","duration":"505.238847ms","start":"2026-05-05T17:03:03.712415Z","end":"2026-05-05T17:03:04.217653Z","steps":["trace[1240504425] 'process raft request' (duration: 371.120331ms)","trace[1240504425] 'compare' (duration: 133.773488ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:03:04.217865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:03:03.712404Z","time spent":"505.37688ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T17:03:04.217733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.689408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:03:04.218023Z","caller":"traceutil/trace.go:171","msg":"trace[2049890293] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1103; }","duration":"330.014886ms","start":"2026-05-05T17:03:03.887997Z","end":"2026-05-05T17:03:04.218012Z","steps":["trace[2049890293] 'agreement among raft nodes before linearized reading' (duration: 329.700079ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:03:04.218064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:03:03.887976Z","time spent":"330.078548ms","remote":"127.0.0.1:33002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-05T17:03:18.3627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.917887ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-05T17:03:18.36336Z","caller":"traceutil/trace.go:171","msg":"trace[360438804] transaction","detail":"{read_only:false; response_revision:1207; number_of_response:1; }","duration":"237.949967ms","start":"2026-05-05T17:03:18.125387Z","end":"2026-05-05T17:03:18.363337Z","steps":["trace[360438804] 'process raft request' (duration: 237.556058ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:03:18.363775Z","caller":"traceutil/trace.go:171","msg":"trace[1230232317] transaction","detail":"{read_only:false; response_revision:1208; number_of_response:1; }","duration":"237.419634ms","start":"2026-05-05T17:03:18.1263Z","end":"2026-05-05T17:03:18.363719Z","steps":["trace[1230232317] 'process raft request' (duration: 236.780579ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:03:18.36379Z","caller":"traceutil/trace.go:171","msg":"trace[486770638] transaction","detail":"{read_only:false; response_revision:1209; number_of_response:1; }","duration":"237.353343ms","start":"2026-05-05T17:03:18.126402Z","end":"2026-05-05T17:03:18.363755Z","steps":["trace[486770638] 'process raft request' (duration: 236.724298ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:03:20.785305Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15026433849859837006,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-05T17:03:20.874809Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.026137186s","expected-duration":"1s"} {"level":"info","ts":"2026-05-05T17:03:20.877804Z","caller":"traceutil/trace.go:171","msg":"trace[175602151] transaction","detail":"{read_only:false; response_revision:1212; number_of_response:1; }","duration":"1.029205037s","start":"2026-05-05T17:03:19.848572Z","end":"2026-05-05T17:03:20.877777Z","steps":["trace[175602151] 'process raft request' (duration: 1.026553645s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:03:20.878044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:03:19.848548Z","time spent":"1.029357461s","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T17:03:22.396114Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.481228246s","expected-duration":"1s"} {"level":"info","ts":"2026-05-05T17:03:22.39643Z","caller":"traceutil/trace.go:171","msg":"trace[283216772] linearizableReadLoop","detail":"{readStateIndex:1258; appliedIndex:1256; }","duration":"2.111300531s","start":"2026-05-05T17:03:20.2851Z","end":"2026-05-05T17:03:22.396401Z","steps":["trace[283216772] 'read index received' (duration: 589.946003ms)","trace[283216772] 'applied index is now lower than readState.Index' (duration: 1.521353378s)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:03:22.396558Z","caller":"traceutil/trace.go:171","msg":"trace[1729696650] transaction","detail":"{read_only:false; response_revision:1213; number_of_response:1; }","duration":"2.54776492s","start":"2026-05-05T17:03:19.848778Z","end":"2026-05-05T17:03:22.396543Z","steps":["trace[1729696650] 'process raft request' (duration: 2.547477613s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:03:22.396684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:03:19.848767Z","time spent":"2.547836802s","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T17:03:22.39687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.026648335s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-05T17:03:22.396953Z","caller":"traceutil/trace.go:171","msg":"trace[549568635] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1213; }","duration":"2.026759117s","start":"2026-05-05T17:03:20.370175Z","end":"2026-05-05T17:03:22.396934Z","steps":["trace[549568635] 'agreement among raft nodes before linearized reading' (duration: 2.026547012s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:03:22.396999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:03:20.370159Z","time spent":"2.026827719s","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-05T17:03:22.397153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.507121527s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:03:22.39722Z","caller":"traceutil/trace.go:171","msg":"trace[990252291] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1213; }","duration":"1.507257351s","start":"2026-05-05T17:03:20.889948Z","end":"2026-05-05T17:03:22.397206Z","steps":["trace[990252291] 'agreement among raft nodes before linearized reading' (duration: 1.507132848s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:03:22.397271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:03:20.889931Z","time spent":"1.507328472s","remote":"127.0.0.1:33002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-05T17:03:22.397309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.025312324s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-05T17:03:22.397356Z","caller":"traceutil/trace.go:171","msg":"trace[1687965514] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1213; }","duration":"2.025395526s","start":"2026-05-05T17:03:20.371946Z","end":"2026-05-05T17:03:22.397341Z","steps":["trace[1687965514] 'agreement among raft nodes before linearized reading' (duration: 2.025271813s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:03:22.397393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:03:20.371926Z","time spent":"2.025457077s","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-05T17:03:22.397524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.112409447s","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-05-05T17:03:22.39757Z","caller":"traceutil/trace.go:171","msg":"trace[915229033] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:1213; }","duration":"2.112485459s","start":"2026-05-05T17:03:20.285071Z","end":"2026-05-05T17:03:22.397556Z","steps":["trace[915229033] 'agreement among raft nodes before linearized reading' (duration: 2.112401377s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:03:22.397642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:03:20.285057Z","time spent":"2.11254274s","remote":"127.0.0.1:55712","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-05-05T17:03:22.397847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"668.926097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:03:22.3979Z","caller":"traceutil/trace.go:171","msg":"trace[2136889635] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:1213; }","duration":"669.031379ms","start":"2026-05-05T17:03:21.728854Z","end":"2026-05-05T17:03:22.397886Z","steps":["trace[2136889635] 'agreement among raft nodes before linearized reading' (duration: 668.934457ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:03:22.397955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:03:21.72883Z","time spent":"669.106491ms","remote":"127.0.0.1:56852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "} {"level":"warn","ts":"2026-05-05T17:03:22.398177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.51438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-05T17:03:22.398224Z","caller":"traceutil/trace.go:171","msg":"trace[448915461] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1213; }","duration":"455.597833ms","start":"2026-05-05T17:03:21.942611Z","end":"2026-05-05T17:03:22.398209Z","steps":["trace[448915461] 'agreement among raft nodes before linearized reading' (duration: 455.52337ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:03:22.398266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:03:21.942593Z","time spent":"455.660135ms","remote":"127.0.0.1:43956","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":4,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "} {"level":"warn","ts":"2026-05-05T17:03:22.398938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.028374625s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-05T17:03:22.399Z","caller":"traceutil/trace.go:171","msg":"trace[648667736] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1213; }","duration":"2.028456986s","start":"2026-05-05T17:03:20.370525Z","end":"2026-05-05T17:03:22.398982Z","steps":["trace[648667736] 'agreement among raft nodes before linearized reading' (duration: 2.028306713s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:03:22.399044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:03:20.370512Z","time spent":"2.028519649s","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-05T17:03:22.399075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.028732183s","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-05-05T17:03:22.399127Z","caller":"traceutil/trace.go:171","msg":"trace[1418580318] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1213; }","duration":"2.028797094s","start":"2026-05-05T17:03:20.370316Z","end":"2026-05-05T17:03:22.399113Z","steps":["trace[1418580318] 'agreement among raft nodes before linearized reading' (duration: 2.028660711s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:03:22.399171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:03:20.37031Z","time spent":"2.028849615s","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-05T17:03:22.399284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.027477174s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-05T17:03:22.399331Z","caller":"traceutil/trace.go:171","msg":"trace[2054842157] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1213; }","duration":"2.027535216s","start":"2026-05-05T17:03:20.371783Z","end":"2026-05-05T17:03:22.399318Z","steps":["trace[2054842157] 'agreement among raft nodes before linearized reading' (duration: 2.025770225s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:03:22.399373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:03:20.371765Z","time spent":"2.027596787s","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-05T17:03:34.773611Z","caller":"traceutil/trace.go:171","msg":"trace[556239629] linearizableReadLoop","detail":"{readStateIndex:1306; appliedIndex:1302; }","duration":"124.529163ms","start":"2026-05-05T17:03:34.64906Z","end":"2026-05-05T17:03:34.77359Z","steps":["trace[556239629] 'read index received' (duration: 1.763381ms)","trace[556239629] 'applied index is now lower than readState.Index' (duration: 122.764972ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:03:34.773733Z","caller":"traceutil/trace.go:171","msg":"trace[1088388532] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"159.238589ms","start":"2026-05-05T17:03:34.614464Z","end":"2026-05-05T17:03:34.773702Z","steps":["trace[1088388532] 'process raft request' (duration: 158.932182ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:03:34.773783Z","caller":"traceutil/trace.go:171","msg":"trace[850140668] transaction","detail":"{read_only:false; response_revision:1257; number_of_response:1; }","duration":"159.197818ms","start":"2026-05-05T17:03:34.614547Z","end":"2026-05-05T17:03:34.773745Z","steps":["trace[850140668] 'process raft request' (duration: 158.963103ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:03:34.773826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.754097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-05T17:03:34.773815Z","caller":"traceutil/trace.go:171","msg":"trace[266674298] transaction","detail":"{read_only:false; response_revision:1258; number_of_response:1; }","duration":"159.107717ms","start":"2026-05-05T17:03:34.614656Z","end":"2026-05-05T17:03:34.773764Z","steps":["trace[266674298] 'process raft request' (duration: 158.902772ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:03:34.773884Z","caller":"traceutil/trace.go:171","msg":"trace[984551017] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1258; }","duration":"124.826289ms","start":"2026-05-05T17:03:34.649047Z","end":"2026-05-05T17:03:34.773873Z","steps":["trace[984551017] 'agreement among raft nodes before linearized reading' (duration: 124.630365ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:03:39.688016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.137563093s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-05T17:03:39.68827Z","caller":"traceutil/trace.go:171","msg":"trace[1255838034] linearizableReadLoop","detail":"{readStateIndex:1332; appliedIndex:1331; }","duration":"1.087750826s","start":"2026-05-05T17:03:38.600497Z","end":"2026-05-05T17:03:39.688248Z","steps":["trace[1255838034] 'read index received' (duration: 45.381µs)","trace[1255838034] 'applied index is now lower than readState.Index' (duration: 1.087704105s)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:03:39.688721Z","caller":"traceutil/trace.go:171","msg":"trace[1558813517] transaction","detail":"{read_only:false; response_revision:1284; number_of_response:1; }","duration":"1.038515632s","start":"2026-05-05T17:03:38.650173Z","end":"2026-05-05T17:03:39.688688Z","steps":["trace[1558813517] 'process raft request' (duration: 1.037963959s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:03:39.688881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:03:38.650137Z","time spent":"1.038655546s","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T17:03:39.689474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.088152206s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-05-05T17:03:39.689544Z","caller":"traceutil/trace.go:171","msg":"trace[167855786] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1283; }","duration":"1.089070837s","start":"2026-05-05T17:03:38.600456Z","end":"2026-05-05T17:03:39.689527Z","steps":["trace[167855786] 'agreement among raft nodes before linearized reading' (duration: 1.088062484s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:03:39.689586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:03:38.600436Z","time spent":"1.089136848s","remote":"127.0.0.1:33532","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":139,"response size":31,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-05-05T17:03:39.868288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"981.681813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T17:03:39.868352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.202700038s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-05-05T17:03:39.868388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.082615707s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-05T17:03:39.868432Z","caller":"traceutil/trace.go:171","msg":"trace[1174798581] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1284; }","duration":"1.202847801s","start":"2026-05-05T17:03:38.665563Z","end":"2026-05-05T17:03:39.86841Z","steps":["trace[1174798581] 'agreement among raft nodes before linearized reading' (duration: 1.023078325s)","trace[1174798581] 'range keys from in-memory index tree' (duration: 179.580971ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:03:39.868471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.075548613s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-05T17:03:39.868469Z","caller":"traceutil/trace.go:171","msg":"trace[460604387] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1284; }","duration":"1.082715649s","start":"2026-05-05T17:03:38.785726Z","end":"2026-05-05T17:03:39.868442Z","steps":["trace[460604387] 'agreement among raft nodes before linearized reading' (duration: 903.019205ms)","trace[460604387] 'range keys from in-memory index tree' (duration: 179.464798ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:03:39.868483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:03:38.665551Z","time spent":"1.202922972s","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-05T17:03:39.868377Z","caller":"traceutil/trace.go:171","msg":"trace[926854397] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1284; }","duration":"981.807516ms","start":"2026-05-05T17:03:38.886543Z","end":"2026-05-05T17:03:39.86835Z","steps":["trace[926854397] 'agreement among raft nodes before linearized reading' (duration: 802.191184ms)","trace[926854397] 'range keys from in-memory index tree' (duration: 179.48536ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:03:39.868524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:03:38.785722Z","time spent":"1.082792051s","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-05T17:03:39.868293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.080718543s","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-05-05T17:03:39.868555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:03:38.886525Z","time spent":"982.00553ms","remote":"127.0.0.1:33002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-05T17:03:39.86858Z","caller":"traceutil/trace.go:171","msg":"trace[1463822940] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1284; }","duration":"1.08102644s","start":"2026-05-05T17:03:38.787545Z","end":"2026-05-05T17:03:39.868571Z","steps":["trace[1463822940] 'agreement among raft nodes before linearized reading' (duration: 901.153732ms)","trace[1463822940] 'range keys from in-memory index tree' (duration: 179.448938ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:03:39.868624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:03:38.78754Z","time spent":"1.081072091s","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-05T17:03:39.86853Z","caller":"traceutil/trace.go:171","msg":"trace[954040372] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1284; }","duration":"1.075597674s","start":"2026-05-05T17:03:38.792901Z","end":"2026-05-05T17:03:39.868499Z","steps":["trace[954040372] 'agreement among raft nodes before linearized reading' (duration: 895.846228ms)","trace[954040372] 'range keys from in-memory index tree' (duration: 179.428978ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:03:39.868775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:03:38.792896Z","time spent":"1.07587215s","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-05T17:03:39.869059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.084079711s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-05T17:03:39.869109Z","caller":"traceutil/trace.go:171","msg":"trace[106849853] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1284; }","duration":"1.084150702s","start":"2026-05-05T17:03:38.784946Z","end":"2026-05-05T17:03:39.869096Z","steps":["trace[106849853] 'agreement among raft nodes before linearized reading' (duration: 903.813414ms)","trace[106849853] 'range keys from in-memory index tree' (duration: 179.365336ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:03:39.86914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:03:38.784933Z","time spent":"1.084200154s","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-05T17:03:40.098468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.419437ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T17:03:40.098771Z","caller":"traceutil/trace.go:171","msg":"trace[95711418] transaction","detail":"{read_only:false; response_revision:1286; number_of_response:1; }","duration":"225.644702ms","start":"2026-05-05T17:03:39.873072Z","end":"2026-05-05T17:03:40.098717Z","steps":["trace[95711418] 'process raft request' (duration: 98.792296ms)","trace[95711418] 'compare' (duration: 126.258862ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:03:40.098845Z","caller":"traceutil/trace.go:171","msg":"trace[1293173605] transaction","detail":"{read_only:false; response_revision:1289; number_of_response:1; }","duration":"224.420332ms","start":"2026-05-05T17:03:39.8744Z","end":"2026-05-05T17:03:40.09882Z","steps":["trace[1293173605] 'process raft request' (duration: 224.345971ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:03:40.099022Z","caller":"traceutil/trace.go:171","msg":"trace[861530728] transaction","detail":"{read_only:false; response_revision:1287; number_of_response:1; }","duration":"225.865127ms","start":"2026-05-05T17:03:39.873133Z","end":"2026-05-05T17:03:40.098998Z","steps":["trace[861530728] 'process raft request' (duration: 225.466307ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:03:40.099064Z","caller":"traceutil/trace.go:171","msg":"trace[1171510003] transaction","detail":"{read_only:false; response_revision:1288; number_of_response:1; }","duration":"224.662438ms","start":"2026-05-05T17:03:39.874376Z","end":"2026-05-05T17:03:40.099038Z","steps":["trace[1171510003] 'process raft request' (duration: 224.320701ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:03:41.939751Z","caller":"traceutil/trace.go:171","msg":"trace[1534921974] transaction","detail":"{read_only:false; response_revision:1293; number_of_response:1; }","duration":"400.928923ms","start":"2026-05-05T17:03:41.53878Z","end":"2026-05-05T17:03:41.939709Z","steps":["trace[1534921974] 'process raft request' (duration: 400.767199ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:03:41.940058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:03:41.538757Z","time spent":"401.204629ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T17:03:42.065493Z","caller":"traceutil/trace.go:171","msg":"trace[785362703] linearizableReadLoop","detail":"{readStateIndex:1343; appliedIndex:1341; }","duration":"176.924699ms","start":"2026-05-05T17:03:41.888542Z","end":"2026-05-05T17:03:42.065467Z","steps":["trace[785362703] 'read index received' (duration: 50.988554ms)","trace[785362703] 'applied index is now lower than readState.Index' (duration: 125.934945ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:03:42.065617Z","caller":"traceutil/trace.go:171","msg":"trace[1938642952] transaction","detail":"{read_only:false; response_revision:1294; number_of_response:1; }","duration":"370.877385ms","start":"2026-05-05T17:03:41.694727Z","end":"2026-05-05T17:03:42.065604Z","steps":["trace[1938642952] 'process raft request' (duration: 329.230377ms)","trace[1938642952] 'compare' (duration: 41.363391ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:03:42.066112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:03:41.694708Z","time spent":"371.320904ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T17:03:42.065794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.479256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-05T17:03:42.066176Z","caller":"traceutil/trace.go:171","msg":"trace[506894152] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1294; }","duration":"163.894466ms","start":"2026-05-05T17:03:41.902269Z","end":"2026-05-05T17:03:42.066164Z","steps":["trace[506894152] 'agreement among raft nodes before linearized reading' (duration: 163.394485ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:03:42.065921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.356869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:03:42.066328Z","caller":"traceutil/trace.go:171","msg":"trace[528073037] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1294; }","duration":"177.790099ms","start":"2026-05-05T17:03:41.888489Z","end":"2026-05-05T17:03:42.066279Z","steps":["trace[528073037] 'agreement among raft nodes before linearized reading' (duration: 177.331819ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:03:42.227928Z","caller":"traceutil/trace.go:171","msg":"trace[1330451666] transaction","detail":"{read_only:false; response_revision:1296; number_of_response:1; }","duration":"121.064061ms","start":"2026-05-05T17:03:42.106835Z","end":"2026-05-05T17:03:42.227899Z","steps":["trace[1330451666] 'process raft request' (duration: 64.484627ms)","trace[1330451666] 'compare' (duration: 55.718485ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:03:42.228065Z","caller":"traceutil/trace.go:171","msg":"trace[1563054773] transaction","detail":"{read_only:false; response_revision:1297; number_of_response:1; }","duration":"120.811636ms","start":"2026-05-05T17:03:42.107227Z","end":"2026-05-05T17:03:42.228039Z","steps":["trace[1563054773] 'process raft request' (duration: 120.593871ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:03:42.228222Z","caller":"traceutil/trace.go:171","msg":"trace[712338393] transaction","detail":"{read_only:false; response_revision:1298; number_of_response:1; }","duration":"120.857077ms","start":"2026-05-05T17:03:42.107328Z","end":"2026-05-05T17:03:42.228185Z","steps":["trace[712338393] 'process raft request' (duration: 120.56117ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:03:42.228332Z","caller":"traceutil/trace.go:171","msg":"trace[295214524] linearizableReadLoop","detail":"{readStateIndex:1348; appliedIndex:1344; }","duration":"107.419245ms","start":"2026-05-05T17:03:42.1209Z","end":"2026-05-05T17:03:42.22832Z","steps":["trace[295214524] 'read index received' (duration: 50.857751ms)","trace[295214524] 'applied index is now lower than readState.Index' (duration: 56.560824ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:03:42.228418Z","caller":"traceutil/trace.go:171","msg":"trace[396901818] transaction","detail":"{read_only:false; response_revision:1299; number_of_response:1; }","duration":"120.957659ms","start":"2026-05-05T17:03:42.10745Z","end":"2026-05-05T17:03:42.228408Z","steps":["trace[396901818] 'process raft request' (duration: 120.534149ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:03:42.228562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.64034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-05T17:03:42.228607Z","caller":"traceutil/trace.go:171","msg":"trace[1393055089] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:1299; }","duration":"107.715251ms","start":"2026-05-05T17:03:42.120881Z","end":"2026-05-05T17:03:42.228596Z","steps":["trace[1393055089] 'agreement among raft nodes before linearized reading' (duration: 107.482946ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:03:44.354238Z","caller":"traceutil/trace.go:171","msg":"trace[970652617] linearizableReadLoop","detail":"{readStateIndex:1352; appliedIndex:1351; }","duration":"121.809549ms","start":"2026-05-05T17:03:44.232405Z","end":"2026-05-05T17:03:44.354214Z","steps":["trace[970652617] 'read index received' (duration: 117.606422ms)","trace[970652617] 'applied index is now lower than readState.Index' (duration: 4.202147ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:03:44.35429Z","caller":"traceutil/trace.go:171","msg":"trace[1786231516] transaction","detail":"{read_only:false; response_revision:1302; number_of_response:1; }","duration":"202.713808ms","start":"2026-05-05T17:03:44.151546Z","end":"2026-05-05T17:03:44.35426Z","steps":["trace[1786231516] 'process raft request' (duration: 198.650004ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:03:44.354468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.005954ms","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-05-05T17:03:44.354522Z","caller":"traceutil/trace.go:171","msg":"trace[154847669] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1302; }","duration":"122.109376ms","start":"2026-05-05T17:03:44.232402Z","end":"2026-05-05T17:03:44.354511Z","steps":["trace[154847669] 'agreement among raft nodes before linearized reading' (duration: 121.948282ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:03:44.354483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.251816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-05T17:03:44.354606Z","caller":"traceutil/trace.go:171","msg":"trace[2100744414] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1302; }","duration":"121.376699ms","start":"2026-05-05T17:03:44.233185Z","end":"2026-05-05T17:03:44.354562Z","steps":["trace[2100744414] 'agreement among raft nodes before linearized reading' (duration: 121.176595ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:03:44.354855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.906982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-05-05T17:03:44.354884Z","caller":"traceutil/trace.go:171","msg":"trace[1668287709] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1302; }","duration":"121.981873ms","start":"2026-05-05T17:03:44.232894Z","end":"2026-05-05T17:03:44.354876Z","steps":["trace[1668287709] 'agreement among raft nodes before linearized reading' (duration: 121.645046ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:03:44.354465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.039264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-05T17:03:44.354921Z","caller":"traceutil/trace.go:171","msg":"trace[648191103] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1302; }","duration":"122.555506ms","start":"2026-05-05T17:03:44.232351Z","end":"2026-05-05T17:03:44.354906Z","steps":["trace[648191103] 'agreement among raft nodes before linearized reading' (duration: 121.967363ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:03:44.943338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.57193ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T17:03:44.943617Z","caller":"traceutil/trace.go:171","msg":"trace[1457572167] transaction","detail":"{read_only:false; response_revision:1305; number_of_response:1; }","duration":"584.774882ms","start":"2026-05-05T17:03:44.358823Z","end":"2026-05-05T17:03:44.943598Z","steps":["trace[1457572167] 'process raft request' (duration: 584.71475ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:03:44.943684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:03:44.358801Z","time spent":"584.850524ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T17:03:44.943701Z","caller":"traceutil/trace.go:171","msg":"trace[873938405] transaction","detail":"{read_only:false; response_revision:1303; number_of_response:1; }","duration":"585.474309ms","start":"2026-05-05T17:03:44.358201Z","end":"2026-05-05T17:03:44.943675Z","steps":["trace[873938405] 'process raft request' (duration: 142.463748ms)","trace[873938405] 'compare' (duration: 442.427986ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:03:44.943715Z","caller":"traceutil/trace.go:171","msg":"trace[567006839] transaction","detail":"{read_only:false; response_revision:1304; number_of_response:1; }","duration":"585.130531ms","start":"2026-05-05T17:03:44.358554Z","end":"2026-05-05T17:03:44.943685Z","steps":["trace[567006839] 'process raft request' (duration: 584.887744ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:03:44.94386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:03:44.358172Z","time spent":"585.602272ms","remote":"127.0.0.1:33270","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-05-05T17:03:44.943882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:03:44.358539Z","time spent":"585.268395ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T17:03:44.943998Z","caller":"traceutil/trace.go:171","msg":"trace[325020393] transaction","detail":"{read_only:false; response_revision:1306; number_of_response:1; }","duration":"583.598246ms","start":"2026-05-05T17:03:44.360392Z","end":"2026-05-05T17:03:44.94399Z","steps":["trace[325020393] 'process raft request' (duration: 583.174425ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:03:44.944043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:03:44.360384Z","time spent":"583.636207ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T17:03:47.217222Z","caller":"traceutil/trace.go:171","msg":"trace[1234783035] transaction","detail":"{read_only:false; response_revision:1344; number_of_response:1; }","duration":"264.656446ms","start":"2026-05-05T17:03:46.952516Z","end":"2026-05-05T17:03:47.217173Z","steps":["trace[1234783035] 'process raft request' (duration: 264.497183ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:03:47.73497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.772211ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T17:03:47.735581Z","caller":"traceutil/trace.go:171","msg":"trace[448160777] transaction","detail":"{read_only:false; response_revision:1345; number_of_response:1; }","duration":"781.285897ms","start":"2026-05-05T17:03:46.954264Z","end":"2026-05-05T17:03:47.73555Z","steps":["trace[448160777] 'process raft request' (duration: 338.855571ms)","trace[448160777] 'compare' (duration: 441.571336ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:03:47.735893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:03:46.954255Z","time spent":"781.541054ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T17:03:47.736215Z","caller":"traceutil/trace.go:171","msg":"trace[1972856384] transaction","detail":"{read_only:false; response_revision:1346; number_of_response:1; }","duration":"781.766718ms","start":"2026-05-05T17:03:46.954408Z","end":"2026-05-05T17:03:47.736175Z","steps":["trace[1972856384] 'process raft request' (duration: 780.677133ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:03:47.736275Z","caller":"traceutil/trace.go:171","msg":"trace[1403553433] linearizableReadLoop","detail":"{readStateIndex:1397; appliedIndex:1394; }","duration":"367.071386ms","start":"2026-05-05T17:03:47.369186Z","end":"2026-05-05T17:03:47.736257Z","steps":["trace[1403553433] 'read index received' (duration: 40.251µs)","trace[1403553433] 'applied index is now lower than readState.Index' (duration: 367.029985ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:03:47.736373Z","caller":"traceutil/trace.go:171","msg":"trace[45894645] transaction","detail":"{read_only:false; response_revision:1347; number_of_response:1; }","duration":"781.897822ms","start":"2026-05-05T17:03:46.954461Z","end":"2026-05-05T17:03:47.736359Z","steps":["trace[45894645] 'process raft request' (duration: 781.686807ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:03:47.736381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:03:46.954402Z","time spent":"781.892641ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T17:03:47.736468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:03:46.954455Z","time spent":"781.961573ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T17:03:47.736482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.290721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-05T17:03:47.736552Z","caller":"traceutil/trace.go:171","msg":"trace[1499977115] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:1347; }","duration":"367.380333ms","start":"2026-05-05T17:03:47.369135Z","end":"2026-05-05T17:03:47.736516Z","steps":["trace[1499977115] 'agreement among raft nodes before linearized reading' (duration: 367.21823ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:03:47.73663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:03:47.369082Z","time spent":"367.505116ms","remote":"127.0.0.1:33338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":71,"response size":30,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "} {"level":"warn","ts":"2026-05-05T17:03:48.211603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.64111ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"warn","ts":"2026-05-05T17:03:48.21197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"738.058463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-05T17:03:48.212061Z","caller":"traceutil/trace.go:171","msg":"trace[227418153] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1347; }","duration":"738.175015ms","start":"2026-05-05T17:03:47.473846Z","end":"2026-05-05T17:03:48.212021Z","steps":["trace[227418153] 'agreement among raft nodes before linearized reading' (duration: 738.056983ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:03:48.212102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:03:47.473826Z","time spent":"738.266058ms","remote":"127.0.0.1:33444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"info","ts":"2026-05-05T17:03:48.211842Z","caller":"traceutil/trace.go:171","msg":"trace[512733738] linearizableReadLoop","detail":"{readStateIndex:1398; appliedIndex:1397; }","duration":"475.470244ms","start":"2026-05-05T17:03:47.736316Z","end":"2026-05-05T17:03:48.211787Z","steps":["trace[512733738] 'read index received' (duration: 54.589348ms)","trace[512733738] 'applied index is now lower than readState.Index' (duration: 420.878856ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:03:48.290194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.448729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:03:48.290362Z","caller":"traceutil/trace.go:171","msg":"trace[2002867784] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1348; }","duration":"402.674634ms","start":"2026-05-05T17:03:47.887668Z","end":"2026-05-05T17:03:48.290343Z","steps":["trace[2002867784] 'agreement among raft nodes before linearized reading' (duration: 402.453449ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:03:48.290201Z","caller":"traceutil/trace.go:171","msg":"trace[880576403] transaction","detail":"{read_only:false; response_revision:1348; number_of_response:1; }","duration":"128.788422ms","start":"2026-05-05T17:03:48.161367Z","end":"2026-05-05T17:03:48.290155Z","steps":["trace[880576403] 'process raft request' (duration: 128.587117ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:03:48.290462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:03:47.887647Z","time spent":"402.771516ms","remote":"127.0.0.1:33002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-05T17:03:48.290878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.068051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:621"} {"level":"info","ts":"2026-05-05T17:03:48.29147Z","caller":"traceutil/trace.go:171","msg":"trace[1081352189] range","detail":"{range_begin:/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1348; }","duration":"127.433959ms","start":"2026-05-05T17:03:48.163706Z","end":"2026-05-05T17:03:48.29114Z","steps":["trace[1081352189] 'agreement among raft nodes before linearized reading' (duration: 126.545779ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:04:07.410734Z","caller":"traceutil/trace.go:171","msg":"trace[1382091027] transaction","detail":"{read_only:false; response_revision:1447; number_of_response:1; }","duration":"111.257653ms","start":"2026-05-05T17:04:07.299452Z","end":"2026-05-05T17:04:07.410709Z","steps":["trace[1382091027] 'process raft request' (duration: 111.121999ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:04:07.946268Z","caller":"traceutil/trace.go:171","msg":"trace[780959710] transaction","detail":"{read_only:false; response_revision:1449; number_of_response:1; }","duration":"106.745348ms","start":"2026-05-05T17:04:07.839496Z","end":"2026-05-05T17:04:07.946241Z","steps":["trace[780959710] 'process raft request' (duration: 85.495359ms)","trace[780959710] 'compare' (duration: 21.080375ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:04:07.946548Z","caller":"traceutil/trace.go:171","msg":"trace[586686861] transaction","detail":"{read_only:false; response_revision:1450; number_of_response:1; }","duration":"107.010485ms","start":"2026-05-05T17:04:07.83951Z","end":"2026-05-05T17:04:07.946521Z","steps":["trace[586686861] 'process raft request' (duration: 106.691167ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:04:42.672029Z","caller":"traceutil/trace.go:171","msg":"trace[549469038] transaction","detail":"{read_only:false; response_revision:1624; number_of_response:1; }","duration":"140.291942ms","start":"2026-05-05T17:04:42.531716Z","end":"2026-05-05T17:04:42.672008Z","steps":["trace[549469038] 'process raft request' (duration: 140.068467ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:06:30.82043Z","caller":"traceutil/trace.go:171","msg":"trace[454071061] linearizableReadLoop","detail":"{readStateIndex:2254; appliedIndex:2253; }","duration":"102.714299ms","start":"2026-05-05T17:06:30.717688Z","end":"2026-05-05T17:06:30.820402Z","steps":["trace[454071061] 'read index received' (duration: 102.558276ms)","trace[454071061] 'applied index is now lower than readState.Index' (duration: 146.963µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:06:30.820538Z","caller":"traceutil/trace.go:171","msg":"trace[274199699] transaction","detail":"{read_only:false; response_revision:2171; number_of_response:1; }","duration":"186.446079ms","start":"2026-05-05T17:06:30.63406Z","end":"2026-05-05T17:06:30.820506Z","steps":["trace[274199699] 'process raft request' (duration: 186.170772ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:06:30.820834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.087488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-05T17:06:30.820885Z","caller":"traceutil/trace.go:171","msg":"trace[1612107812] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2171; }","duration":"103.227991ms","start":"2026-05-05T17:06:30.717641Z","end":"2026-05-05T17:06:30.820869Z","steps":["trace[1612107812] 'agreement among raft nodes before linearized reading' (duration: 102.915284ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:06:55.204909Z","caller":"traceutil/trace.go:171","msg":"trace[505963793] transaction","detail":"{read_only:false; response_revision:2319; number_of_response:1; }","duration":"249.4195ms","start":"2026-05-05T17:06:54.955463Z","end":"2026-05-05T17:06:55.204882Z","steps":["trace[505963793] 'process raft request' (duration: 249.229916ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:06:55.285806Z","caller":"traceutil/trace.go:171","msg":"trace[318160874] transaction","detail":"{read_only:false; response_revision:2321; number_of_response:1; }","duration":"327.898184ms","start":"2026-05-05T17:06:54.957883Z","end":"2026-05-05T17:06:55.285781Z","steps":["trace[318160874] 'process raft request' (duration: 327.850332ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:06:55.285818Z","caller":"traceutil/trace.go:171","msg":"trace[1136710518] transaction","detail":"{read_only:false; response_revision:2320; number_of_response:1; }","duration":"328.014526ms","start":"2026-05-05T17:06:54.957773Z","end":"2026-05-05T17:06:55.285788Z","steps":["trace[1136710518] 'process raft request' (duration: 327.815781ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:06:55.286001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:06:54.957871Z","time spent":"328.038787ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T17:06:55.286107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:06:54.957755Z","time spent":"328.254472ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T17:07:01.59646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.645178ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T17:07:01.596567Z","caller":"traceutil/trace.go:171","msg":"trace[1425299043] linearizableReadLoop","detail":"{readStateIndex:2445; appliedIndex:2444; }","duration":"248.338866ms","start":"2026-05-05T17:07:01.348211Z","end":"2026-05-05T17:07:01.59655Z","steps":["trace[1425299043] 'read index received' (duration: 106.524915ms)","trace[1425299043] 'applied index is now lower than readState.Index' (duration: 141.812531ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:07:01.596652Z","caller":"traceutil/trace.go:171","msg":"trace[1935536087] transaction","detail":"{read_only:false; response_revision:2355; number_of_response:1; }","duration":"253.612335ms","start":"2026-05-05T17:07:01.342982Z","end":"2026-05-05T17:07:01.596595Z","steps":["trace[1935536087] 'process raft request' (duration: 111.724452ms)","trace[1935536087] 'compare' (duration: 141.471664ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:07:01.596752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.53794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-05T17:07:01.596781Z","caller":"traceutil/trace.go:171","msg":"trace[1185243853] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2355; }","duration":"248.599022ms","start":"2026-05-05T17:07:01.348173Z","end":"2026-05-05T17:07:01.596772Z","steps":["trace[1185243853] 'agreement among raft nodes before linearized reading' (duration: 248.463449ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:07:01.59704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.020107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-05-05T17:07:01.597073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.540913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"warn","ts":"2026-05-05T17:07:01.597126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.037414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-05-05T17:07:01.59711Z","caller":"traceutil/trace.go:171","msg":"trace[1289340960] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2355; }","duration":"220.13945ms","start":"2026-05-05T17:07:01.376952Z","end":"2026-05-05T17:07:01.597092Z","steps":["trace[1289340960] 'agreement among raft nodes before linearized reading' (duration: 219.884914ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:07:01.597187Z","caller":"traceutil/trace.go:171","msg":"trace[681049962] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2355; }","duration":"160.138095ms","start":"2026-05-05T17:07:01.437035Z","end":"2026-05-05T17:07:01.597173Z","steps":["trace[681049962] 'agreement among raft nodes before linearized reading' (duration: 159.90502ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:07:01.597133Z","caller":"traceutil/trace.go:171","msg":"trace[550452736] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2355; }","duration":"113.635205ms","start":"2026-05-05T17:07:01.483481Z","end":"2026-05-05T17:07:01.597117Z","steps":["trace[550452736] 'agreement among raft nodes before linearized reading' (duration: 113.363589ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:07:02.0131Z","caller":"traceutil/trace.go:171","msg":"trace[488431580] transaction","detail":"{read_only:false; response_revision:2357; number_of_response:1; }","duration":"411.04559ms","start":"2026-05-05T17:07:01.602027Z","end":"2026-05-05T17:07:02.013072Z","steps":["trace[488431580] 'process raft request' (duration: 410.819615ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:07:02.013254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:07:01.602018Z","time spent":"411.160642ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T17:07:02.013423Z","caller":"traceutil/trace.go:171","msg":"trace[1470906774] transaction","detail":"{read_only:false; response_revision:2358; number_of_response:1; }","duration":"411.329876ms","start":"2026-05-05T17:07:01.602024Z","end":"2026-05-05T17:07:02.013354Z","steps":["trace[1470906774] 'process raft request' (duration: 410.976798ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:07:02.013471Z","caller":"traceutil/trace.go:171","msg":"trace[1717384176] transaction","detail":"{read_only:false; response_revision:2359; number_of_response:1; }","duration":"411.402228ms","start":"2026-05-05T17:07:01.602043Z","end":"2026-05-05T17:07:02.013445Z","steps":["trace[1717384176] 'process raft request' (duration: 411.212004ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:07:02.013691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:07:01.60203Z","time spent":"411.557851ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T17:07:02.013713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:07:01.602001Z","time spent":"411.589872ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T17:07:02.390642Z","caller":"traceutil/trace.go:171","msg":"trace[1861501165] linearizableReadLoop","detail":"{readStateIndex:2451; appliedIndex:2449; }","duration":"123.243902ms","start":"2026-05-05T17:07:02.267369Z","end":"2026-05-05T17:07:02.390613Z","steps":["trace[1861501165] 'read index received' (duration: 3.504179ms)","trace[1861501165] 'applied index is now lower than readState.Index' (duration: 119.738803ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:07:02.390822Z","caller":"traceutil/trace.go:171","msg":"trace[1811105023] transaction","detail":"{read_only:false; response_revision:2361; number_of_response:1; }","duration":"196.805532ms","start":"2026-05-05T17:07:02.19398Z","end":"2026-05-05T17:07:02.390786Z","steps":["trace[1811105023] 'process raft request' (duration: 107.405594ms)","trace[1811105023] 'compare' (duration: 89.110592ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:07:02.390924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.538129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:528"} {"level":"info","ts":"2026-05-05T17:07:02.390971Z","caller":"traceutil/trace.go:171","msg":"trace[644194314] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2361; }","duration":"123.633911ms","start":"2026-05-05T17:07:02.267324Z","end":"2026-05-05T17:07:02.390958Z","steps":["trace[644194314] 'agreement among raft nodes before linearized reading' (duration: 123.455917ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:07:03.006391Z","caller":"traceutil/trace.go:171","msg":"trace[1585505414] linearizableReadLoop","detail":"{readStateIndex:2453; appliedIndex:2452; }","duration":"496.235364ms","start":"2026-05-05T17:07:02.510132Z","end":"2026-05-05T17:07:03.006367Z","steps":["trace[1585505414] 'read index received' (duration: 496.08076ms)","trace[1585505414] 'applied index is now lower than readState.Index' (duration: 153.424µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:07:03.006457Z","caller":"traceutil/trace.go:171","msg":"trace[1041105394] transaction","detail":"{read_only:false; response_revision:2363; number_of_response:1; }","duration":"611.050586ms","start":"2026-05-05T17:07:02.395373Z","end":"2026-05-05T17:07:03.006424Z","steps":["trace[1041105394] 'process raft request' (duration: 610.845501ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:07:03.006645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.726506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:621"} {"level":"warn","ts":"2026-05-05T17:07:03.006662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:07:02.39534Z","time spent":"611.184659ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T17:07:03.00671Z","caller":"traceutil/trace.go:171","msg":"trace[2022824152] range","detail":"{range_begin:/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2363; }","duration":"450.811017ms","start":"2026-05-05T17:07:02.555882Z","end":"2026-05-05T17:07:03.006693Z","steps":["trace[2022824152] 'agreement among raft nodes before linearized reading' (duration: 450.646344ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:07:03.006748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:07:02.55587Z","time spent":"450.870239ms","remote":"127.0.0.1:33130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":644,"request content":"key:\"/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-05-05T17:07:03.006637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.316164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T17:07:03.006752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.586802ms","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":"warn","ts":"2026-05-05T17:07:03.006789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.649699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.80\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-05T17:07:03.006859Z","caller":"traceutil/trace.go:171","msg":"trace[573674299] range","detail":"{range_begin:/registry/masterleases/199.19.213.80; range_end:; response_count:1; response_revision:2363; }","duration":"370.806402ms","start":"2026-05-05T17:07:02.63604Z","end":"2026-05-05T17:07:03.006847Z","steps":["trace[573674299] 'agreement among raft nodes before linearized reading' (duration: 370.559846ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:07:03.0068Z","caller":"traceutil/trace.go:171","msg":"trace[1496655533] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2363; }","duration":"119.525328ms","start":"2026-05-05T17:07:02.887259Z","end":"2026-05-05T17:07:03.006785Z","steps":["trace[1496655533] 'agreement among raft nodes before linearized reading' (duration: 119.300153ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:07:03.006917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:07:02.636014Z","time spent":"370.889534ms","remote":"127.0.0.1:33050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.19.213.80\" "} {"level":"info","ts":"2026-05-05T17:07:03.00696Z","caller":"traceutil/trace.go:171","msg":"trace[1058744037] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:2363; }","duration":"496.700105ms","start":"2026-05-05T17:07:02.51009Z","end":"2026-05-05T17:07:03.00679Z","steps":["trace[1058744037] 'agreement among raft nodes before linearized reading' (duration: 496.409868ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:07:03.007008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:07:02.510067Z","time spent":"496.925309ms","remote":"127.0.0.1:33310","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-05-05T17:07:03.428291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.345737ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-05-05T17:07:03.428391Z","caller":"traceutil/trace.go:171","msg":"trace[244637019] linearizableReadLoop","detail":"{readStateIndex:2454; appliedIndex:2453; }","duration":"418.084129ms","start":"2026-05-05T17:07:03.010289Z","end":"2026-05-05T17:07:03.428373Z","steps":["trace[244637019] 'read index received' (duration: 122.640709ms)","trace[244637019] 'applied index is now lower than readState.Index' (duration: 295.44202ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:07:03.428419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:07:03.008402Z","time spent":"420.009283ms","remote":"127.0.0.1:33050","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-05-05T17:07:03.428568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.272243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:529"} {"level":"info","ts":"2026-05-05T17:07:03.428602Z","caller":"traceutil/trace.go:171","msg":"trace[891420589] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2363; }","duration":"418.348245ms","start":"2026-05-05T17:07:03.010245Z","end":"2026-05-05T17:07:03.428593Z","steps":["trace[891420589] 'agreement among raft nodes before linearized reading' (duration: 418.211862ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:07:03.428634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:07:03.010229Z","time spent":"418.397856ms","remote":"127.0.0.1:33270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":552,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-05-05T17:07:03.710387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.583302ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T17:07:03.710655Z","caller":"traceutil/trace.go:171","msg":"trace[47237959] transaction","detail":"{read_only:false; response_revision:2365; number_of_response:1; }","duration":"277.536896ms","start":"2026-05-05T17:07:03.433073Z","end":"2026-05-05T17:07:03.71061Z","steps":["trace[47237959] 'process raft request' (duration: 164.639288ms)","trace[47237959] 'compare' (duration: 112.435398ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:07:03.711044Z","caller":"traceutil/trace.go:171","msg":"trace[375862078] linearizableReadLoop","detail":"{readStateIndex:2457; appliedIndex:2455; }","duration":"187.39198ms","start":"2026-05-05T17:07:03.523628Z","end":"2026-05-05T17:07:03.711019Z","steps":["trace[375862078] 'read index received' (duration: 74.029421ms)","trace[375862078] 'applied index is now lower than readState.Index' (duration: 113.361089ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:07:03.711078Z","caller":"traceutil/trace.go:171","msg":"trace[2807417] transaction","detail":"{read_only:false; response_revision:2366; number_of_response:1; }","duration":"277.413083ms","start":"2026-05-05T17:07:03.433641Z","end":"2026-05-05T17:07:03.711054Z","steps":["trace[2807417] 'process raft request' (duration: 276.862341ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:07:03.711201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.561655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"} {"level":"info","ts":"2026-05-05T17:07:03.711246Z","caller":"traceutil/trace.go:171","msg":"trace[1072916806] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:2366; }","duration":"187.633626ms","start":"2026-05-05T17:07:03.523598Z","end":"2026-05-05T17:07:03.711232Z","steps":["trace[1072916806] 'agreement among raft nodes before linearized reading' (duration: 187.544034ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:07:03.728164Z","caller":"traceutil/trace.go:171","msg":"trace[2007702702] transaction","detail":"{read_only:false; response_revision:2367; number_of_response:1; }","duration":"126.336703ms","start":"2026-05-05T17:07:03.601802Z","end":"2026-05-05T17:07:03.728139Z","steps":["trace[2007702702] 'process raft request' (duration: 126.22299ms)"],"step_count":1}