{"level":"warn","ts":"2026-05-27T05:57:07.009041Z","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-27T05:57:07.009244Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.228: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.228:2380","--initial-cluster=instance=https://199.19.213.228:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.228:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.228: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-27T05:57:07.00936Z","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-27T05:57:07.009379Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.228:2380"]} {"level":"info","ts":"2026-05-27T05:57:07.009412Z","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-27T05:57:07.010302Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.228:2379"]} {"level":"info","ts":"2026-05-27T05:57:07.010401Z","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.228:2380"],"listen-peer-urls":["https://199.19.213.228:2380"],"advertise-client-urls":["https://199.19.213.228:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.228:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.228: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-27T05:57:07.014355Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.596722ms"} {"level":"info","ts":"2026-05-27T05:57:07.023145Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"db79120667ce701f","cluster-id":"793c581eb68f3646"} {"level":"info","ts":"2026-05-27T05:57:07.023241Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db79120667ce701f switched to configuration voters=()"} {"level":"info","ts":"2026-05-27T05:57:07.023267Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db79120667ce701f became follower at term 0"} {"level":"info","ts":"2026-05-27T05:57:07.023286Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft db79120667ce701f [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-27T05:57:07.023298Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db79120667ce701f became follower at term 1"} {"level":"info","ts":"2026-05-27T05:57:07.023336Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db79120667ce701f switched to configuration voters=(15814691385208893471)"} {"level":"warn","ts":"2026-05-27T05:57:07.031802Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-27T05:57:07.033233Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-27T05:57:07.034291Z","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-27T05:57:07.037324Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"db79120667ce701f","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-27T05:57:07.037606Z","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-27T05:57:07.037686Z","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-27T05:57:07.037609Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"db79120667ce701f","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-27T05:57:07.037742Z","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-27T05:57:07.0383Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db79120667ce701f switched to configuration voters=(15814691385208893471)"} {"level":"info","ts":"2026-05-27T05:57:07.038403Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"793c581eb68f3646","local-member-id":"db79120667ce701f","added-peer-id":"db79120667ce701f","added-peer-peer-urls":["https://199.19.213.228:2380"]} {"level":"info","ts":"2026-05-27T05:57:07.043688Z","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-27T05:57:07.043865Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.228:2380"} {"level":"info","ts":"2026-05-27T05:57:07.043907Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.228:2380"} {"level":"info","ts":"2026-05-27T05:57:07.046161Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"db79120667ce701f","initial-advertise-peer-urls":["https://199.19.213.228:2380"],"listen-peer-urls":["https://199.19.213.228:2380"],"advertise-client-urls":["https://199.19.213.228:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.228:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-27T05:57:07.046195Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-27T05:57:07.524437Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db79120667ce701f is starting a new election at term 1"} {"level":"info","ts":"2026-05-27T05:57:07.524496Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db79120667ce701f became pre-candidate at term 1"} {"level":"info","ts":"2026-05-27T05:57:07.524541Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db79120667ce701f received MsgPreVoteResp from db79120667ce701f at term 1"} {"level":"info","ts":"2026-05-27T05:57:07.524566Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db79120667ce701f became candidate at term 2"} {"level":"info","ts":"2026-05-27T05:57:07.524582Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db79120667ce701f received MsgVoteResp from db79120667ce701f at term 2"} {"level":"info","ts":"2026-05-27T05:57:07.524603Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db79120667ce701f became leader at term 2"} {"level":"info","ts":"2026-05-27T05:57:07.52462Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: db79120667ce701f elected leader db79120667ce701f at term 2"} {"level":"info","ts":"2026-05-27T05:57:07.531387Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"db79120667ce701f","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.228:2379]}","request-path":"/0/members/db79120667ce701f/attributes","cluster-id":"793c581eb68f3646","publish-timeout":"7s"} {"level":"info","ts":"2026-05-27T05:57:07.531457Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-27T05:57:07.532024Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T05:57:07.532198Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-27T05:57:07.535925Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-27T05:57:07.536181Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.228:2379"} {"level":"info","ts":"2026-05-27T05:57:07.536392Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-27T05:57:07.536418Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-27T05:57:07.537757Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"793c581eb68f3646","local-member-id":"db79120667ce701f","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T05:57:07.537863Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T05:57:07.537903Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T05:57:09.1784Z","caller":"traceutil/trace.go:171","msg":"trace[1539267489] linearizableReadLoop","detail":"{readStateIndex:45; appliedIndex:44; }","duration":"108.983971ms","start":"2026-05-27T05:57:09.069382Z","end":"2026-05-27T05:57:09.178366Z","steps":["trace[1539267489] 'read index received' (duration: 77.302381ms)","trace[1539267489] 'applied index is now lower than readState.Index' (duration: 31.6802ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T05:57:09.178679Z","caller":"traceutil/trace.go:171","msg":"trace[618463366] transaction","detail":"{read_only:false; response_revision:41; number_of_response:1; }","duration":"164.078665ms","start":"2026-05-27T05:57:09.014568Z","end":"2026-05-27T05:57:09.178646Z","steps":["trace[618463366] 'process raft request' (duration: 132.158128ms)","trace[618463366] 'compare' (duration: 31.419642ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T05:57:09.178706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.304261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-27T05:57:09.178777Z","caller":"traceutil/trace.go:171","msg":"trace[942130002] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:41; }","duration":"109.442745ms","start":"2026-05-27T05:57:09.069316Z","end":"2026-05-27T05:57:09.178759Z","steps":["trace[942130002] 'agreement among raft nodes before linearized reading' (duration: 109.225918ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:57:09.64471Z","caller":"traceutil/trace.go:171","msg":"trace[836280022] transaction","detail":"{read_only:false; response_revision:59; number_of_response:1; }","duration":"237.147127ms","start":"2026-05-27T05:57:09.407539Z","end":"2026-05-27T05:57:09.644686Z","steps":["trace[836280022] 'process raft request' (duration: 237.074125ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:57:09.644977Z","caller":"traceutil/trace.go:171","msg":"trace[1575399041] transaction","detail":"{read_only:false; response_revision:58; number_of_response:1; }","duration":"276.808353ms","start":"2026-05-27T05:57:09.368116Z","end":"2026-05-27T05:57:09.644925Z","steps":["trace[1575399041] 'process raft request' (duration: 178.847683ms)","trace[1575399041] 'compare' (duration: 97.220318ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T05:57:16.620526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.163873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-05-27T05:57:16.620614Z","caller":"traceutil/trace.go:171","msg":"trace[316832111] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:302; }","duration":"225.282697ms","start":"2026-05-27T05:57:16.395314Z","end":"2026-05-27T05:57:16.620597Z","steps":["trace[316832111] 'range keys from in-memory index tree' (duration: 224.74748ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:16.620841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.492331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-05-27T05:57:16.62093Z","caller":"traceutil/trace.go:171","msg":"trace[2023168769] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:302; }","duration":"176.616934ms","start":"2026-05-27T05:57:16.444293Z","end":"2026-05-27T05:57:16.620909Z","steps":["trace[2023168769] 'range keys from in-memory index tree' (duration: 175.772659ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:16.621012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.056774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-05-27T05:57:16.621097Z","caller":"traceutil/trace.go:171","msg":"trace[535704040] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:302; }","duration":"126.132336ms","start":"2026-05-27T05:57:16.494941Z","end":"2026-05-27T05:57:16.621073Z","steps":["trace[535704040] 'range keys from in-memory index tree' (duration: 125.137056ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:57:22.983507Z","caller":"traceutil/trace.go:171","msg":"trace[1266253207] linearizableReadLoop","detail":"{readStateIndex:377; appliedIndex:376; }","duration":"413.139428ms","start":"2026-05-27T05:57:22.570346Z","end":"2026-05-27T05:57:22.983485Z","steps":["trace[1266253207] 'read index received' (duration: 412.942602ms)","trace[1266253207] 'applied index is now lower than readState.Index' (duration: 195.886µs)"],"step_count":2} {"level":"warn","ts":"2026-05-27T05:57:22.983649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.285233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T05:57:22.983631Z","caller":"traceutil/trace.go:171","msg":"trace[985641413] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"454.698764ms","start":"2026-05-27T05:57:22.528894Z","end":"2026-05-27T05:57:22.983593Z","steps":["trace[985641413] 'process raft request' (duration: 454.469477ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:57:22.983675Z","caller":"traceutil/trace.go:171","msg":"trace[948944454] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:366; }","duration":"413.365895ms","start":"2026-05-27T05:57:22.570302Z","end":"2026-05-27T05:57:22.983668Z","steps":["trace[948944454] 'agreement among raft nodes before linearized reading' (duration: 413.307063ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:22.983883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:57:22.57027Z","time spent":"413.604282ms","remote":"127.0.0.1:39730","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-27T05:57:22.983733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.506964ms","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-27T05:57:22.984039Z","caller":"traceutil/trace.go:171","msg":"trace[662184273] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:366; }","duration":"333.863245ms","start":"2026-05-27T05:57:22.650155Z","end":"2026-05-27T05:57:22.984019Z","steps":["trace[662184273] 'agreement among raft nodes before linearized reading' (duration: 333.501944ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:22.984085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:57:22.650135Z","time spent":"333.936077ms","remote":"127.0.0.1:33250","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-27T05:57:22.984229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:57:22.528861Z","time spent":"454.850508ms","remote":"127.0.0.1:33250","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-27T05:57:24.868015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.439289946s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T05:57:24.868134Z","caller":"traceutil/trace.go:171","msg":"trace[1988915955] linearizableReadLoop","detail":"{readStateIndex:378; appliedIndex:377; }","duration":"1.8560595s","start":"2026-05-27T05:57:23.012054Z","end":"2026-05-27T05:57:24.868114Z","steps":["trace[1988915955] 'read index received' (duration: 416.362533ms)","trace[1988915955] 'applied index is now lower than readState.Index' (duration: 1.439695257s)"],"step_count":2} {"level":"info","ts":"2026-05-27T05:57:24.868228Z","caller":"traceutil/trace.go:171","msg":"trace[1899236346] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"1.871788939s","start":"2026-05-27T05:57:22.996424Z","end":"2026-05-27T05:57:24.868213Z","steps":["trace[1899236346] 'process raft request' (duration: 432.052331ms)","trace[1899236346] 'compare' (duration: 1.439167941s)"],"step_count":2} {"level":"warn","ts":"2026-05-27T05:57:24.868297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:57:22.996406Z","time spent":"1.871855321s","remote":"127.0.0.1:33250","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-27T05:57:24.868501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.856447492s","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-27T05:57:24.868585Z","caller":"traceutil/trace.go:171","msg":"trace[1538321012] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:367; }","duration":"1.856547605s","start":"2026-05-27T05:57:23.012023Z","end":"2026-05-27T05:57:24.868571Z","steps":["trace[1538321012] 'agreement among raft nodes before linearized reading' (duration: 1.856439322s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:24.868642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:57:23.012009Z","time spent":"1.856618087s","remote":"127.0.0.1:33250","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-27T05:57:24.868821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.687823763s","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-27T05:57:24.868858Z","caller":"traceutil/trace.go:171","msg":"trace[660272633] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:367; }","duration":"1.687897875s","start":"2026-05-27T05:57:23.180951Z","end":"2026-05-27T05:57:24.868849Z","steps":["trace[660272633] 'agreement among raft nodes before linearized reading' (duration: 1.687834004s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:24.868886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:57:23.180928Z","time spent":"1.687951517s","remote":"127.0.0.1:33250","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-27T05:57:24.869259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.298519353s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T05:57:24.869337Z","caller":"traceutil/trace.go:171","msg":"trace[1237047740] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:367; }","duration":"1.298635787s","start":"2026-05-27T05:57:23.570684Z","end":"2026-05-27T05:57:24.86932Z","steps":["trace[1237047740] 'agreement among raft nodes before linearized reading' (duration: 1.29841217s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:24.869377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:57:23.570668Z","time spent":"1.298700449s","remote":"127.0.0.1:39730","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-27T05:57:24.870059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"956.626815ms","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-27T05:57:24.870182Z","caller":"traceutil/trace.go:171","msg":"trace[575829337] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:367; }","duration":"957.495942ms","start":"2026-05-27T05:57:23.912641Z","end":"2026-05-27T05:57:24.870137Z","steps":["trace[575829337] 'agreement among raft nodes before linearized reading' (duration: 956.614555ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:24.870282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:57:23.912624Z","time spent":"957.640186ms","remote":"127.0.0.1:33250","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-27T05:57:24.869299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.756593ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T05:57:24.8707Z","caller":"traceutil/trace.go:171","msg":"trace[620241858] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:367; }","duration":"109.170056ms","start":"2026-05-27T05:57:24.761513Z","end":"2026-05-27T05:57:24.870683Z","steps":["trace[620241858] 'agreement among raft nodes before linearized reading' (duration: 107.726012ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:57:31.142111Z","caller":"traceutil/trace.go:171","msg":"trace[163680742] transaction","detail":"{read_only:false; response_revision:384; number_of_response:1; }","duration":"108.200664ms","start":"2026-05-27T05:57:31.033875Z","end":"2026-05-27T05:57:31.142076Z","steps":["trace[163680742] 'process raft request' (duration: 107.148802ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:57:32.940303Z","caller":"traceutil/trace.go:171","msg":"trace[14138251] transaction","detail":"{read_only:false; response_revision:389; number_of_response:1; }","duration":"183.343935ms","start":"2026-05-27T05:57:32.756938Z","end":"2026-05-27T05:57:32.940282Z","steps":["trace[14138251] 'process raft request' (duration: 114.862131ms)","trace[14138251] 'compare' (duration: 68.391361ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T05:57:33.214531Z","caller":"traceutil/trace.go:171","msg":"trace[570618546] transaction","detail":"{read_only:false; response_revision:394; number_of_response:1; }","duration":"189.813825ms","start":"2026-05-27T05:57:33.024692Z","end":"2026-05-27T05:57:33.214505Z","steps":["trace[570618546] 'process raft request' (duration: 95.219917ms)","trace[570618546] 'compare' (duration: 94.421203ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T05:57:33.214857Z","caller":"traceutil/trace.go:171","msg":"trace[76099070] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"190.055882ms","start":"2026-05-27T05:57:33.024786Z","end":"2026-05-27T05:57:33.214842Z","steps":["trace[76099070] 'process raft request' (duration: 189.674801ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:57:33.215231Z","caller":"traceutil/trace.go:171","msg":"trace[608675975] transaction","detail":"{read_only:false; response_revision:396; number_of_response:1; }","duration":"190.384062ms","start":"2026-05-27T05:57:33.024829Z","end":"2026-05-27T05:57:33.215213Z","steps":["trace[608675975] 'process raft request' (duration: 189.916518ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:57:33.215419Z","caller":"traceutil/trace.go:171","msg":"trace[1763597234] transaction","detail":"{read_only:false; response_revision:397; number_of_response:1; }","duration":"190.147465ms","start":"2026-05-27T05:57:33.025252Z","end":"2026-05-27T05:57:33.215399Z","steps":["trace[1763597234] 'process raft request' (duration: 189.868846ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:57:33.216644Z","caller":"traceutil/trace.go:171","msg":"trace[360544286] linearizableReadLoop","detail":"{readStateIndex:411; appliedIndex:406; }","duration":"184.083273ms","start":"2026-05-27T05:57:33.032538Z","end":"2026-05-27T05:57:33.216621Z","steps":["trace[360544286] 'read index received' (duration: 3.952389ms)","trace[360544286] 'applied index is now lower than readState.Index' (duration: 180.129874ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T05:57:33.216747Z","caller":"traceutil/trace.go:171","msg":"trace[764672164] transaction","detail":"{read_only:false; response_revision:398; number_of_response:1; }","duration":"190.605368ms","start":"2026-05-27T05:57:33.026134Z","end":"2026-05-27T05:57:33.216739Z","steps":["trace[764672164] 'process raft request' (duration: 189.124494ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:33.21692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.367051ms","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-27T05:57:33.216949Z","caller":"traceutil/trace.go:171","msg":"trace[964085253] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:398; }","duration":"184.421602ms","start":"2026-05-27T05:57:33.032518Z","end":"2026-05-27T05:57:33.216939Z","steps":["trace[964085253] 'agreement among raft nodes before linearized reading' (duration: 184.35255ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:57:33.454707Z","caller":"traceutil/trace.go:171","msg":"trace[1215851943] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"195.583178ms","start":"2026-05-27T05:57:33.259078Z","end":"2026-05-27T05:57:33.454662Z","steps":["trace[1215851943] 'process raft request' (duration: 131.616232ms)","trace[1215851943] 'compare' (duration: 63.740589ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T05:57:33.454776Z","caller":"traceutil/trace.go:171","msg":"trace[752854302] transaction","detail":"{read_only:false; response_revision:407; number_of_response:1; }","duration":"191.246898ms","start":"2026-05-27T05:57:33.263514Z","end":"2026-05-27T05:57:33.454761Z","steps":["trace[752854302] 'process raft request' (duration: 191.079553ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:57:33.454721Z","caller":"traceutil/trace.go:171","msg":"trace[1309083038] transaction","detail":"{read_only:false; number_of_response:1; response_revision:408; }","duration":"143.82781ms","start":"2026-05-27T05:57:33.310873Z","end":"2026-05-27T05:57:33.454701Z","steps":["trace[1309083038] 'process raft request' (duration: 143.785899ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:57:46.150147Z","caller":"traceutil/trace.go:171","msg":"trace[1306251215] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"235.37828ms","start":"2026-05-27T05:57:45.914742Z","end":"2026-05-27T05:57:46.15012Z","steps":["trace[1306251215] 'process raft request' (duration: 223.672622ms)","trace[1306251215] 'compare' (duration: 11.508372ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T05:57:46.15017Z","caller":"traceutil/trace.go:171","msg":"trace[935663541] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"216.944661ms","start":"2026-05-27T05:57:45.933206Z","end":"2026-05-27T05:57:46.15015Z","steps":["trace[935663541] 'process raft request' (duration: 216.826388ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:57:46.150291Z","caller":"traceutil/trace.go:171","msg":"trace[2054026146] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"106.014997ms","start":"2026-05-27T05:57:46.044266Z","end":"2026-05-27T05:57:46.150281Z","steps":["trace[2054026146] 'process raft request' (duration: 105.838802ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:57:46.760961Z","caller":"traceutil/trace.go:171","msg":"trace[770441495] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"539.206383ms","start":"2026-05-27T05:57:46.221716Z","end":"2026-05-27T05:57:46.760922Z","steps":["trace[770441495] 'process raft request' (duration: 537.991687ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:46.761198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:57:46.221695Z","time spent":"539.353078ms","remote":"127.0.0.1:39770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65190,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T05:57:46.769601Z","caller":"traceutil/trace.go:171","msg":"trace[2046460153] linearizableReadLoop","detail":"{readStateIndex:546; appliedIndex:543; }","duration":"485.987159ms","start":"2026-05-27T05:57:46.283593Z","end":"2026-05-27T05:57:46.76958Z","steps":["trace[2046460153] 'read index received' (duration: 476.162707ms)","trace[2046460153] 'applied index is now lower than readState.Index' (duration: 9.823742ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T05:57:46.769774Z","caller":"traceutil/trace.go:171","msg":"trace[355307900] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"541.667247ms","start":"2026-05-27T05:57:46.228015Z","end":"2026-05-27T05:57:46.769682Z","steps":["trace[355307900] 'process raft request' (duration: 541.172793ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:46.769878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.256947ms","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-27T05:57:46.76992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:57:46.227991Z","time spent":"541.814481ms","remote":"127.0.0.1:39770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31111,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T05:57:46.769951Z","caller":"traceutil/trace.go:171","msg":"trace[759841227] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:528; }","duration":"486.37036ms","start":"2026-05-27T05:57:46.283566Z","end":"2026-05-27T05:57:46.769937Z","steps":["trace[759841227] 'agreement among raft nodes before linearized reading' (duration: 486.226676ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:46.769999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:57:46.283551Z","time spent":"486.436762ms","remote":"127.0.0.1:44700","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-27T05:57:46.770209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.547305ms","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":"warn","ts":"2026-05-27T05:57:46.770373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.476045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T05:57:46.770421Z","caller":"traceutil/trace.go:171","msg":"trace[1629436030] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:528; }","duration":"394.578747ms","start":"2026-05-27T05:57:46.37583Z","end":"2026-05-27T05:57:46.770409Z","steps":["trace[1629436030] 'agreement among raft nodes before linearized reading' (duration: 394.509845ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:46.770459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:57:46.375825Z","time spent":"394.625138ms","remote":"127.0.0.1:44742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 "} {"level":"warn","ts":"2026-05-27T05:57:46.770622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.451901ms","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":"info","ts":"2026-05-27T05:57:46.770658Z","caller":"traceutil/trace.go:171","msg":"trace[1783980279] 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:528; }","duration":"144.496432ms","start":"2026-05-27T05:57:46.626153Z","end":"2026-05-27T05:57:46.770649Z","steps":["trace[1783980279] 'agreement among raft nodes before linearized reading' (duration: 144.445521ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:57:46.770695Z","caller":"traceutil/trace.go:171","msg":"trace[1980894216] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:528; }","duration":"486.622278ms","start":"2026-05-27T05:57:46.283631Z","end":"2026-05-27T05:57:46.770253Z","steps":["trace[1980894216] 'agreement among raft nodes before linearized reading' (duration: 486.34526ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:46.770807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.317907ms","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-27T05:57:46.770843Z","caller":"traceutil/trace.go:171","msg":"trace[631032234] 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:528; }","duration":"145.356958ms","start":"2026-05-27T05:57:46.625478Z","end":"2026-05-27T05:57:46.770835Z","steps":["trace[631032234] 'agreement among raft nodes before linearized reading' (duration: 145.306946ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:46.770931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.638029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-27T05:57:46.770974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.618746ms","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-27T05:57:46.771004Z","caller":"traceutil/trace.go:171","msg":"trace[866635811] 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:528; }","duration":"145.659527ms","start":"2026-05-27T05:57:46.625336Z","end":"2026-05-27T05:57:46.770996Z","steps":["trace[866635811] 'agreement among raft nodes before linearized reading' (duration: 145.615135ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:46.771133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.785767ms","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-27T05:57:46.771165Z","caller":"traceutil/trace.go:171","msg":"trace[865209002] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:528; }","duration":"161.835418ms","start":"2026-05-27T05:57:46.609322Z","end":"2026-05-27T05:57:46.771158Z","steps":["trace[865209002] 'agreement among raft nodes before linearized reading' (duration: 161.784047ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:57:46.771196Z","caller":"traceutil/trace.go:171","msg":"trace[769476687] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:528; }","duration":"395.705431ms","start":"2026-05-27T05:57:46.375262Z","end":"2026-05-27T05:57:46.770968Z","steps":["trace[769476687] 'agreement among raft nodes before linearized reading' (duration: 395.608088ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:46.771251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:57:46.375255Z","time spent":"395.981049ms","remote":"127.0.0.1:44742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-05-27T05:57:46.771312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.096127ms","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-27T05:57:46.771352Z","caller":"traceutil/trace.go:171","msg":"trace[1648866876] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:528; }","duration":"162.148448ms","start":"2026-05-27T05:57:46.609194Z","end":"2026-05-27T05:57:46.771342Z","steps":["trace[1648866876] 'agreement among raft nodes before linearized reading' (duration: 162.095186ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:46.771356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.936889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-27T05:57:46.77137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.339395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T05:57:46.771403Z","caller":"traceutil/trace.go:171","msg":"trace[1943557495] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:528; }","duration":"460.378186ms","start":"2026-05-27T05:57:46.311015Z","end":"2026-05-27T05:57:46.771393Z","steps":["trace[1943557495] 'agreement among raft nodes before linearized reading' (duration: 460.310174ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:46.771426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:57:46.310981Z","time spent":"460.440178ms","remote":"127.0.0.1:44714","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-05-27T05:57:46.771431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.203775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T05:57:46.771449Z","caller":"traceutil/trace.go:171","msg":"trace[1934730030] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:528; }","duration":"396.234107ms","start":"2026-05-27T05:57:46.375209Z","end":"2026-05-27T05:57:46.771443Z","steps":["trace[1934730030] 'agreement among raft nodes before linearized reading' (duration: 396.207236ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:46.771478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:57:46.375202Z","time spent":"396.266748ms","remote":"127.0.0.1:44742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 "} {"level":"warn","ts":"2026-05-27T05:57:46.771497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.421746ms","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-27T05:57:46.771542Z","caller":"traceutil/trace.go:171","msg":"trace[357800394] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:528; }","duration":"162.481858ms","start":"2026-05-27T05:57:46.609051Z","end":"2026-05-27T05:57:46.771533Z","steps":["trace[357800394] 'agreement among raft nodes before linearized reading' (duration: 162.417106ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:46.771561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.29294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T05:57:46.771581Z","caller":"traceutil/trace.go:171","msg":"trace[937026139] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:528; }","duration":"434.335811ms","start":"2026-05-27T05:57:46.33724Z","end":"2026-05-27T05:57:46.771575Z","steps":["trace[937026139] 'agreement among raft nodes before linearized reading' (duration: 434.30318ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:46.771596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.432969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-27T05:57:46.771625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.676741ms","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":"warn","ts":"2026-05-27T05:57:46.771603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:57:46.337229Z","time spent":"434.369543ms","remote":"127.0.0.1:44714","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 "} {"level":"info","ts":"2026-05-27T05:57:46.771644Z","caller":"traceutil/trace.go:171","msg":"trace[1224905664] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:528; }","duration":"434.755684ms","start":"2026-05-27T05:57:46.336884Z","end":"2026-05-27T05:57:46.771639Z","steps":["trace[1224905664] 'agreement among raft nodes before linearized reading' (duration: 434.729853ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:46.771663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:57:46.336868Z","time spent":"434.791154ms","remote":"127.0.0.1:44728","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-27T05:57:46.771682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.809036ms","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-27T05:57:46.771402Z","caller":"traceutil/trace.go:171","msg":"trace[1885613874] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:528; }","duration":"434.040532ms","start":"2026-05-27T05:57:46.337347Z","end":"2026-05-27T05:57:46.771388Z","steps":["trace[1885613874] 'agreement among raft nodes before linearized reading' (duration: 433.946509ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:46.771747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:57:46.337326Z","time spent":"434.415134ms","remote":"127.0.0.1:44728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-05-27T05:57:46.771759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.832301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-27T05:57:46.771776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.920829ms","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-27T05:57:46.77179Z","caller":"traceutil/trace.go:171","msg":"trace[84851427] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:528; }","duration":"411.880482ms","start":"2026-05-27T05:57:46.359902Z","end":"2026-05-27T05:57:46.771783Z","steps":["trace[84851427] 'agreement among raft nodes before linearized reading' (duration: 411.834081ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:57:46.771719Z","caller":"traceutil/trace.go:171","msg":"trace[667428208] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:528; }","duration":"173.875898ms","start":"2026-05-27T05:57:46.597835Z","end":"2026-05-27T05:57:46.771711Z","steps":["trace[667428208] 'agreement among raft nodes before linearized reading' (duration: 173.818046ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:57:46.771815Z","caller":"traceutil/trace.go:171","msg":"trace[1534432316] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:528; }","duration":"173.96673ms","start":"2026-05-27T05:57:46.597831Z","end":"2026-05-27T05:57:46.771798Z","steps":["trace[1534432316] 'agreement among raft nodes before linearized reading' (duration: 173.907489ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:46.770842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:57:46.283627Z","time spent":"487.153644ms","remote":"127.0.0.1:44700","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":"warn","ts":"2026-05-27T05:57:46.771991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.553102ms","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-27T05:57:46.772011Z","caller":"traceutil/trace.go:171","msg":"trace[1282619678] 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:528; }","duration":"370.592684ms","start":"2026-05-27T05:57:46.401413Z","end":"2026-05-27T05:57:46.772005Z","steps":["trace[1282619678] 'agreement among raft nodes before linearized reading' (duration: 370.562663ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:46.771837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.096768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-27T05:57:46.772026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:57:46.401408Z","time spent":"370.614424ms","remote":"127.0.0.1:44754","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":"info","ts":"2026-05-27T05:57:46.77205Z","caller":"traceutil/trace.go:171","msg":"trace[627012378] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:528; }","duration":"412.321685ms","start":"2026-05-27T05:57:46.359712Z","end":"2026-05-27T05:57:46.772033Z","steps":["trace[627012378] 'agreement among raft nodes before linearized reading' (duration: 412.112729ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:46.772112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:57:46.359699Z","time spent":"412.392688ms","remote":"127.0.0.1:44732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-05-27T05:57:46.772142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.032236ms","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-27T05:57:46.772166Z","caller":"traceutil/trace.go:171","msg":"trace[951166393] 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:528; }","duration":"371.067117ms","start":"2026-05-27T05:57:46.401094Z","end":"2026-05-27T05:57:46.772161Z","steps":["trace[951166393] 'agreement among raft nodes before linearized reading' (duration: 371.027376ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:46.772183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:57:46.40109Z","time spent":"371.088218ms","remote":"127.0.0.1:44754","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-27T05:57:46.772226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.181721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T05:57:46.772257Z","caller":"traceutil/trace.go:171","msg":"trace[1175353151] 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:528; }","duration":"371.230013ms","start":"2026-05-27T05:57:46.40102Z","end":"2026-05-27T05:57:46.77225Z","steps":["trace[1175353151] 'agreement among raft nodes before linearized reading' (duration: 371.184812ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:46.772281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:57:46.401012Z","time spent":"371.263184ms","remote":"127.0.0.1:44754","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-27T05:57:46.772443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.646848ms","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":"info","ts":"2026-05-27T05:57:46.772473Z","caller":"traceutil/trace.go:171","msg":"trace[421927063] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:528; }","duration":"488.72479ms","start":"2026-05-27T05:57:46.283741Z","end":"2026-05-27T05:57:46.772466Z","steps":["trace[421927063] 'agreement among raft nodes before linearized reading' (duration: 488.677599ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:46.772486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.463709ms","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":"warn","ts":"2026-05-27T05:57:46.772498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:57:46.283723Z","time spent":"488.767202ms","remote":"127.0.0.1:44700","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":"info","ts":"2026-05-27T05:57:46.772506Z","caller":"traceutil/trace.go:171","msg":"trace[774672426] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"530.839075ms","start":"2026-05-27T05:57:46.241647Z","end":"2026-05-27T05:57:46.772487Z","steps":["trace[774672426] 'process raft request' (duration: 527.743133ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:57:46.771626Z","caller":"traceutil/trace.go:171","msg":"trace[902619838] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:528; }","duration":"411.47721ms","start":"2026-05-27T05:57:46.360141Z","end":"2026-05-27T05:57:46.771618Z","steps":["trace[902619838] 'agreement among raft nodes before linearized reading' (duration: 411.434269ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:46.77257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:57:46.360134Z","time spent":"412.426289ms","remote":"127.0.0.1:44732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-05-27T05:57:46.771814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:57:46.359896Z","time spent":"411.912714ms","remote":"127.0.0.1:44732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-27T05:57:46.772635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:57:46.241625Z","time spent":"530.939037ms","remote":"127.0.0.1:39770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":150480,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T05:57:46.772521Z","caller":"traceutil/trace.go:171","msg":"trace[1935509449] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:528; }","duration":"461.537471ms","start":"2026-05-27T05:57:46.310975Z","end":"2026-05-27T05:57:46.772513Z","steps":["trace[1935509449] 'agreement among raft nodes before linearized reading' (duration: 461.487079ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:46.772809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:57:46.310953Z","time spent":"461.786959ms","remote":"127.0.0.1:44714","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":"info","ts":"2026-05-27T05:57:46.769717Z","caller":"traceutil/trace.go:171","msg":"trace[1640890231] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"485.400802ms","start":"2026-05-27T05:57:46.284294Z","end":"2026-05-27T05:57:46.769694Z","steps":["trace[1640890231] 'process raft request' (duration: 485.248417ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:46.773886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:57:46.284279Z","time spent":"489.582766ms","remote":"127.0.0.1:39770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97665,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T05:57:47.814679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.404549ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-27T05:57:47.814932Z","caller":"traceutil/trace.go:171","msg":"trace[1198296278] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"414.967235ms","start":"2026-05-27T05:57:47.399925Z","end":"2026-05-27T05:57:47.814892Z","steps":["trace[1198296278] 'process raft request' (duration: 161.264348ms)","trace[1198296278] 'compare' (duration: 253.245394ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T05:57:47.815091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:57:47.399907Z","time spent":"415.11664ms","remote":"127.0.0.1:39770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14661,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T05:57:47.817115Z","caller":"traceutil/trace.go:171","msg":"trace[1745198360] linearizableReadLoop","detail":"{readStateIndex:574; appliedIndex:572; }","duration":"239.923328ms","start":"2026-05-27T05:57:47.577169Z","end":"2026-05-27T05:57:47.817093Z","steps":["trace[1745198360] 'read index received' (duration: 237.387622ms)","trace[1745198360] 'applied index is now lower than readState.Index' (duration: 2.534696ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T05:57:47.817242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.066343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T05:57:47.817227Z","caller":"traceutil/trace.go:171","msg":"trace[1769585148] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"321.322979ms","start":"2026-05-27T05:57:47.495851Z","end":"2026-05-27T05:57:47.817174Z","steps":["trace[1769585148] 'process raft request' (duration: 319.602838ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:57:47.817277Z","caller":"traceutil/trace.go:171","msg":"trace[1188828794] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:555; }","duration":"240.150175ms","start":"2026-05-27T05:57:47.577112Z","end":"2026-05-27T05:57:47.817262Z","steps":["trace[1188828794] 'agreement among raft nodes before linearized reading' (duration: 240.089363ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:47.817423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:57:47.495829Z","time spent":"321.501585ms","remote":"127.0.0.1:39770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570081,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T05:57:49.444294Z","caller":"traceutil/trace.go:171","msg":"trace[1427732398] linearizableReadLoop","detail":"{readStateIndex:581; appliedIndex:580; }","duration":"113.145481ms","start":"2026-05-27T05:57:49.33108Z","end":"2026-05-27T05:57:49.444225Z","steps":["trace[1427732398] 'read index received' (duration: 112.695868ms)","trace[1427732398] 'applied index is now lower than readState.Index' (duration: 448.673µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T05:57:49.444677Z","caller":"traceutil/trace.go:171","msg":"trace[1894607390] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"113.887093ms","start":"2026-05-27T05:57:49.330772Z","end":"2026-05-27T05:57:49.444659Z","steps":["trace[1894607390] 'process raft request' (duration: 113.092029ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:49.444925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.838882ms","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-27T05:57:49.444966Z","caller":"traceutil/trace.go:171","msg":"trace[387814586] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:562; }","duration":"113.904684ms","start":"2026-05-27T05:57:49.331048Z","end":"2026-05-27T05:57:49.444953Z","steps":["trace[387814586] 'agreement among raft nodes before linearized reading' (duration: 113.817221ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:49.445198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.216664ms","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-27T05:57:49.445243Z","caller":"traceutil/trace.go:171","msg":"trace[1612203043] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:562; }","duration":"113.271985ms","start":"2026-05-27T05:57:49.331958Z","end":"2026-05-27T05:57:49.44523Z","steps":["trace[1612203043] 'agreement among raft nodes before linearized reading' (duration: 113.139531ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:49.445477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.225494ms","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-27T05:57:49.445517Z","caller":"traceutil/trace.go:171","msg":"trace[363463011] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:562; }","duration":"113.272555ms","start":"2026-05-27T05:57:49.332233Z","end":"2026-05-27T05:57:49.445506Z","steps":["trace[363463011] 'agreement among raft nodes before linearized reading' (duration: 113.208413ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:49.674149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.405111ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T05:57:49.67443Z","caller":"traceutil/trace.go:171","msg":"trace[1329177819] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"224.699696ms","start":"2026-05-27T05:57:49.449523Z","end":"2026-05-27T05:57:49.674223Z","steps":["trace[1329177819] 'process raft request' (duration: 116.145811ms)","trace[1329177819] 'compare' (duration: 108.249666ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T05:57:49.707261Z","caller":"traceutil/trace.go:171","msg":"trace[202839706] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"257.536991ms","start":"2026-05-27T05:57:49.449708Z","end":"2026-05-27T05:57:49.707245Z","steps":["trace[202839706] 'process raft request' (duration: 257.414377ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:57:49.707402Z","caller":"traceutil/trace.go:171","msg":"trace[1727360898] linearizableReadLoop","detail":"{readStateIndex:584; appliedIndex:582; }","duration":"135.959049ms","start":"2026-05-27T05:57:49.571426Z","end":"2026-05-27T05:57:49.707385Z","steps":["trace[1727360898] 'read index received' (duration: 135.587868ms)","trace[1727360898] 'applied index is now lower than readState.Index' (duration: 370.041µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T05:57:49.707503Z","caller":"traceutil/trace.go:171","msg":"trace[2086673635] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"257.674535ms","start":"2026-05-27T05:57:49.449806Z","end":"2026-05-27T05:57:49.707481Z","steps":["trace[2086673635] 'process raft request' (duration: 257.407067ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:49.707543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.152465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T05:57:49.707614Z","caller":"traceutil/trace.go:171","msg":"trace[1532096949] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:565; }","duration":"136.257807ms","start":"2026-05-27T05:57:49.571342Z","end":"2026-05-27T05:57:49.7076Z","steps":["trace[1532096949] 'agreement among raft nodes before linearized reading' (duration: 136.152154ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:49.707544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.786937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T05:57:49.707733Z","caller":"traceutil/trace.go:171","msg":"trace[1174967828] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway; range_end:; response_count:0; response_revision:565; }","duration":"125.002124ms","start":"2026-05-27T05:57:49.582714Z","end":"2026-05-27T05:57:49.707716Z","steps":["trace[1174967828] 'agreement among raft nodes before linearized reading' (duration: 124.791018ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:57:49.885685Z","caller":"traceutil/trace.go:171","msg":"trace[1849562615] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"141.558645ms","start":"2026-05-27T05:57:49.744099Z","end":"2026-05-27T05:57:49.885658Z","steps":["trace[1849562615] 'process raft request' (duration: 135.752552ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:57:50.065657Z","caller":"traceutil/trace.go:171","msg":"trace[285985608] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"175.714998ms","start":"2026-05-27T05:57:49.88992Z","end":"2026-05-27T05:57:50.065635Z","steps":["trace[285985608] 'process raft request' (duration: 143.834682ms)","trace[285985608] 'compare' (duration: 31.273448ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T05:57:51.419411Z","caller":"traceutil/trace.go:171","msg":"trace[1121558977] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"146.829156ms","start":"2026-05-27T05:57:51.272564Z","end":"2026-05-27T05:57:51.419394Z","steps":["trace[1121558977] 'process raft request' (duration: 145.712723ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:57:51.59991Z","caller":"traceutil/trace.go:171","msg":"trace[1767667142] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"147.001431ms","start":"2026-05-27T05:57:51.452883Z","end":"2026-05-27T05:57:51.599884Z","steps":["trace[1767667142] 'process raft request' (duration: 119.909628ms)","trace[1767667142] 'compare' (duration: 26.875267ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T05:57:51.599988Z","caller":"traceutil/trace.go:171","msg":"trace[824088797] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"127.251935ms","start":"2026-05-27T05:57:51.47271Z","end":"2026-05-27T05:57:51.599962Z","steps":["trace[824088797] 'process raft request' (duration: 127.074979ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:57:53.217297Z","caller":"traceutil/trace.go:171","msg":"trace[2002778994] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"178.58618ms","start":"2026-05-27T05:57:53.038654Z","end":"2026-05-27T05:57:53.21724Z","steps":["trace[2002778994] 'process raft request' (duration: 174.136279ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:54.075745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"733.037211ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-27T05:57:54.076068Z","caller":"traceutil/trace.go:171","msg":"trace[885871414] linearizableReadLoop","detail":"{readStateIndex:605; appliedIndex:604; }","duration":"508.310216ms","start":"2026-05-27T05:57:53.567712Z","end":"2026-05-27T05:57:54.076022Z","steps":["trace[885871414] 'read index received' (duration: 57.642µs)","trace[885871414] 'applied index is now lower than readState.Index' (duration: 508.249803ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T05:57:54.076109Z","caller":"traceutil/trace.go:171","msg":"trace[106527038] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"803.675494ms","start":"2026-05-27T05:57:53.272388Z","end":"2026-05-27T05:57:54.076064Z","steps":["trace[106527038] 'process raft request' (duration: 70.243061ms)","trace[106527038] 'compare' (duration: 732.871076ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T05:57:54.076238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:57:53.272371Z","time spent":"803.800828ms","remote":"127.0.0.1:33354","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T05:57:54.076272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.548582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T05:57:54.076321Z","caller":"traceutil/trace.go:171","msg":"trace[527824295] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:586; }","duration":"508.639095ms","start":"2026-05-27T05:57:53.567665Z","end":"2026-05-27T05:57:54.076304Z","steps":["trace[527824295] 'agreement among raft nodes before linearized reading' (duration: 508.544342ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:54.076361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:57:53.567648Z","time spent":"508.703897ms","remote":"127.0.0.1:39714","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-27T05:57:54.076572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.801223ms","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-27T05:57:54.076631Z","caller":"traceutil/trace.go:171","msg":"trace[1101135052] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:586; }","duration":"473.886246ms","start":"2026-05-27T05:57:53.602723Z","end":"2026-05-27T05:57:54.076609Z","steps":["trace[1101135052] 'agreement among raft nodes before linearized reading' (duration: 473.720071ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:54.076637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.152026ms","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-27T05:57:54.076654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.089545ms","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-27T05:57:54.076651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.381202ms","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-27T05:57:54.076691Z","caller":"traceutil/trace.go:171","msg":"trace[188503475] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:586; }","duration":"282.249139ms","start":"2026-05-27T05:57:53.794427Z","end":"2026-05-27T05:57:54.076676Z","steps":["trace[188503475] 'agreement among raft nodes before linearized reading' (duration: 282.095154ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:54.07669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:57:53.60271Z","time spent":"473.967248ms","remote":"127.0.0.1:33250","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-27T05:57:54.076695Z","caller":"traceutil/trace.go:171","msg":"trace[1240779975] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:586; }","duration":"306.164287ms","start":"2026-05-27T05:57:53.770518Z","end":"2026-05-27T05:57:54.076682Z","steps":["trace[1240779975] 'agreement among raft nodes before linearized reading' (duration: 306.031223ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:57:54.076712Z","caller":"traceutil/trace.go:171","msg":"trace[183478288] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:586; }","duration":"285.471424ms","start":"2026-05-27T05:57:53.791222Z","end":"2026-05-27T05:57:54.076694Z","steps":["trace[183478288] 'agreement among raft nodes before linearized reading' (duration: 285.295319ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:54.076732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:57:53.7705Z","time spent":"306.224989ms","remote":"127.0.0.1:33250","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-27T05:57:54.870985Z","caller":"traceutil/trace.go:171","msg":"trace[1792744266] linearizableReadLoop","detail":"{readStateIndex:615; appliedIndex:614; }","duration":"300.264968ms","start":"2026-05-27T05:57:54.570698Z","end":"2026-05-27T05:57:54.870963Z","steps":["trace[1792744266] 'read index received' (duration: 299.429093ms)","trace[1792744266] 'applied index is now lower than readState.Index' (duration: 834.795µs)"],"step_count":2} {"level":"warn","ts":"2026-05-27T05:57:54.8711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.391312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T05:57:54.871139Z","caller":"traceutil/trace.go:171","msg":"trace[1181478716] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"400.150705ms","start":"2026-05-27T05:57:54.470874Z","end":"2026-05-27T05:57:54.871025Z","steps":["trace[1181478716] 'process raft request' (duration: 399.492615ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:57:54.87121Z","caller":"traceutil/trace.go:171","msg":"trace[231928899] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:595; }","duration":"300.490875ms","start":"2026-05-27T05:57:54.570634Z","end":"2026-05-27T05:57:54.871125Z","steps":["trace[231928899] 'agreement among raft nodes before linearized reading' (duration: 300.415172ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:54.871255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:57:54.570611Z","time spent":"300.633629ms","remote":"127.0.0.1:39714","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-27T05:57:54.871374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:57:54.470847Z","time spent":"400.411013ms","remote":"127.0.0.1:39826","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T05:57:55.496388Z","caller":"traceutil/trace.go:171","msg":"trace[1662405489] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"546.678973ms","start":"2026-05-27T05:57:54.949683Z","end":"2026-05-27T05:57:55.496362Z","steps":["trace[1662405489] 'process raft request' (duration: 454.498716ms)","trace[1662405489] 'compare' (duration: 91.990121ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T05:57:55.496509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:57:54.949665Z","time spent":"546.788046ms","remote":"127.0.0.1:33484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T05:57:56.586283Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8079350426074567674,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T05:57:57.062757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.453691609s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"warn","ts":"2026-05-27T05:57:57.086608Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8079350426074567674,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T05:57:57.587018Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8079350426074567674,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T05:57:58.08806Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8079350426074567674,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T05:57:58.262721Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.328978979s","expected-duration":"1s"} {"level":"info","ts":"2026-05-27T05:57:58.264527Z","caller":"traceutil/trace.go:171","msg":"trace[1832072046] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"2.352963338s","start":"2026-05-27T05:57:55.911527Z","end":"2026-05-27T05:57:58.26449Z","steps":["trace[1832072046] 'process raft request' (duration: 2.351735052s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:58.264688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:57:55.911502Z","time spent":"2.353098752s","remote":"127.0.0.1:39826","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T05:57:58.264688Z","caller":"traceutil/trace.go:171","msg":"trace[1369436233] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:617; }","duration":"2.178748276s","start":"2026-05-27T05:57:56.085908Z","end":"2026-05-27T05:57:58.264656Z","steps":["trace[1369436233] 'read index received' (duration: 2.176965453s)","trace[1369436233] 'applied index is now lower than readState.Index' (duration: 1.778533ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T05:57:58.265018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.179086937s","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-27T05:57:58.265073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.694137211s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T05:57:58.265115Z","caller":"traceutil/trace.go:171","msg":"trace[1879865430] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:597; }","duration":"1.694213113s","start":"2026-05-27T05:57:56.570889Z","end":"2026-05-27T05:57:58.265102Z","steps":["trace[1879865430] 'agreement among raft nodes before linearized reading' (duration: 1.694137271s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:58.265181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:57:56.570869Z","time spent":"1.694305356s","remote":"127.0.0.1:39730","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-27T05:57:58.265169Z","caller":"traceutil/trace.go:171","msg":"trace[1416089579] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:597; }","duration":"2.179241851s","start":"2026-05-27T05:57:56.085857Z","end":"2026-05-27T05:57:58.265099Z","steps":["trace[1416089579] 'agreement among raft nodes before linearized reading' (duration: 2.178955363s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:58.265245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:57:56.085838Z","time spent":"2.179390186s","remote":"127.0.0.1:33250","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-27T05:57:58.265298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.177248072s","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-27T05:57:58.265387Z","caller":"traceutil/trace.go:171","msg":"trace[1176997423] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:597; }","duration":"2.177370466s","start":"2026-05-27T05:57:56.087993Z","end":"2026-05-27T05:57:58.265363Z","steps":["trace[1176997423] 'agreement among raft nodes before linearized reading' (duration: 2.176966084s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:58.265436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:57:56.087981Z","time spent":"2.177446638s","remote":"127.0.0.1:33250","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-27T05:57:58.265426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.176736797s","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-27T05:57:58.265486Z","caller":"traceutil/trace.go:171","msg":"trace[1277871487] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:597; }","duration":"2.17683849s","start":"2026-05-27T05:57:56.088632Z","end":"2026-05-27T05:57:58.265471Z","steps":["trace[1277871487] 'agreement among raft nodes before linearized reading' (duration: 2.176634374s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:58.265532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:57:56.088598Z","time spent":"2.176925393s","remote":"127.0.0.1:33250","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-27T05:57:58.265579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.176031546s","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-27T05:57:58.265685Z","caller":"traceutil/trace.go:171","msg":"trace[1770986709] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:597; }","duration":"2.176211752s","start":"2026-05-27T05:57:56.089455Z","end":"2026-05-27T05:57:58.265667Z","steps":["trace[1770986709] 'agreement among raft nodes before linearized reading' (duration: 2.17580806s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:57:58.265747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:57:56.089441Z","time spent":"2.176294074s","remote":"127.0.0.1:33250","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-27T05:57:59.52974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.75702ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T05:57:59.529847Z","caller":"traceutil/trace.go:171","msg":"trace[983974149] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"141.899707ms","start":"2026-05-27T05:57:59.387932Z","end":"2026-05-27T05:57:59.529832Z","steps":["trace[983974149] 'process raft request' (duration: 34.977212ms)","trace[983974149] 'compare' (duration: 106.634566ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T05:58:01.568103Z","caller":"traceutil/trace.go:171","msg":"trace[973085956] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"175.268845ms","start":"2026-05-27T05:58:01.392817Z","end":"2026-05-27T05:58:01.568086Z","steps":["trace[973085956] 'process raft request' (duration: 175.158992ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:02.964132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.960202ms","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-27T05:58:02.964208Z","caller":"traceutil/trace.go:171","msg":"trace[1944480482] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:625; }","duration":"485.088696ms","start":"2026-05-27T05:58:02.479102Z","end":"2026-05-27T05:58:02.96419Z","steps":["trace[1944480482] 'range keys from in-memory index tree' (duration: 484.797367ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:02.964218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"576.047154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-lsr7j\" ","response":"range_response_count:1 size:17790"} {"level":"warn","ts":"2026-05-27T05:58:02.964253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:58:02.479073Z","time spent":"485.170148ms","remote":"127.0.0.1:33250","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-27T05:58:02.964266Z","caller":"traceutil/trace.go:171","msg":"trace[1506715283] range","detail":"{range_begin:/registry/pods/kube-system/cilium-lsr7j; range_end:; response_count:1; response_revision:625; }","duration":"576.124396ms","start":"2026-05-27T05:58:02.388128Z","end":"2026-05-27T05:58:02.964252Z","steps":["trace[1506715283] 'range keys from in-memory index tree' (duration: 575.932351ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:02.964269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.89116ms","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-27T05:58:02.964348Z","caller":"traceutil/trace.go:171","msg":"trace[1163078266] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:625; }","duration":"485.031954ms","start":"2026-05-27T05:58:02.479298Z","end":"2026-05-27T05:58:02.96433Z","steps":["trace[1163078266] 'range keys from in-memory index tree' (duration: 484.696904ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:02.964373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.311518ms","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-27T05:58:02.964403Z","caller":"traceutil/trace.go:171","msg":"trace[345332580] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:625; }","duration":"529.378899ms","start":"2026-05-27T05:58:02.435013Z","end":"2026-05-27T05:58:02.964392Z","steps":["trace[345332580] 'range keys from in-memory index tree' (duration: 529.191573ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:02.964438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:58:02.434993Z","time spent":"529.439262ms","remote":"127.0.0.1:33250","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-27T05:58:02.964407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:58:02.479281Z","time spent":"485.113026ms","remote":"127.0.0.1:33250","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-27T05:58:02.964299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:58:02.388112Z","time spent":"576.179957ms","remote":"127.0.0.1:39912","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":17813,"request content":"key:\"/registry/pods/kube-system/cilium-lsr7j\" "} {"level":"warn","ts":"2026-05-27T05:58:02.965425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.992584ms","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-27T05:58:02.965475Z","caller":"traceutil/trace.go:171","msg":"trace[503184812] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:625; }","duration":"464.066916ms","start":"2026-05-27T05:58:02.501395Z","end":"2026-05-27T05:58:02.965462Z","steps":["trace[503184812] 'range keys from in-memory index tree' (duration: 462.950323ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:02.965519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:58:02.50138Z","time spent":"464.130238ms","remote":"127.0.0.1:33250","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-27T05:58:03.151272Z","caller":"traceutil/trace.go:171","msg":"trace[1070390004] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"182.720248ms","start":"2026-05-27T05:58:02.968511Z","end":"2026-05-27T05:58:03.151232Z","steps":["trace[1070390004] 'process raft request' (duration: 182.529462ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:03.151444Z","caller":"traceutil/trace.go:171","msg":"trace[1242972399] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"182.888873ms","start":"2026-05-27T05:58:02.968525Z","end":"2026-05-27T05:58:03.151414Z","steps":["trace[1242972399] 'process raft request' (duration: 182.664227ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:03.353361Z","caller":"traceutil/trace.go:171","msg":"trace[2082265294] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"384.709923ms","start":"2026-05-27T05:58:02.968627Z","end":"2026-05-27T05:58:03.353337Z","steps":["trace[2082265294] 'process raft request' (duration: 384.453226ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:03.353523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:58:02.968605Z","time spent":"384.834757ms","remote":"127.0.0.1:33250","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-27T05:58:03.353722Z","caller":"traceutil/trace.go:171","msg":"trace[1452654943] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"383.792026ms","start":"2026-05-27T05:58:02.969919Z","end":"2026-05-27T05:58:03.353711Z","steps":["trace[1452654943] 'process raft request' (duration: 383.374694ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:03.353701Z","caller":"traceutil/trace.go:171","msg":"trace[1381716328] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"375.693537ms","start":"2026-05-27T05:58:02.977984Z","end":"2026-05-27T05:58:03.353677Z","steps":["trace[1381716328] 'process raft request' (duration: 375.561353ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:03.353785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:58:02.969907Z","time spent":"383.847347ms","remote":"127.0.0.1:33250","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-27T05:58:03.353854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:58:02.977976Z","time spent":"375.79604ms","remote":"127.0.0.1:39912","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17959,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T05:58:03.603783Z","caller":"traceutil/trace.go:171","msg":"trace[1058556820] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"138.063023ms","start":"2026-05-27T05:58:03.465681Z","end":"2026-05-27T05:58:03.603744Z","steps":["trace[1058556820] 'process raft request' (duration: 109.443661ms)","trace[1058556820] 'compare' (duration: 28.448217ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T05:58:04.509296Z","caller":"traceutil/trace.go:171","msg":"trace[1622046445] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"123.297307ms","start":"2026-05-27T05:58:04.385968Z","end":"2026-05-27T05:58:04.509265Z","steps":["trace[1622046445] 'process raft request' (duration: 123.06803ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:04.593037Z","caller":"traceutil/trace.go:171","msg":"trace[1885569698] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"164.101677ms","start":"2026-05-27T05:58:04.428916Z","end":"2026-05-27T05:58:04.593017Z","steps":["trace[1885569698] 'process raft request' (duration: 136.709011ms)","trace[1885569698] 'compare' (duration: 26.578312ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T05:58:05.314302Z","caller":"traceutil/trace.go:171","msg":"trace[1997460295] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"155.985465ms","start":"2026-05-27T05:58:05.15829Z","end":"2026-05-27T05:58:05.314276Z","steps":["trace[1997460295] 'process raft request' (duration: 155.78786ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:05.325466Z","caller":"traceutil/trace.go:171","msg":"trace[545363698] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"166.643939ms","start":"2026-05-27T05:58:05.158805Z","end":"2026-05-27T05:58:05.325449Z","steps":["trace[545363698] 'process raft request' (duration: 166.527156ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:06.252759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.667383ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-27T05:58:06.252921Z","caller":"traceutil/trace.go:171","msg":"trace[1204072896] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"334.307984ms","start":"2026-05-27T05:58:05.918599Z","end":"2026-05-27T05:58:06.252907Z","steps":["trace[1204072896] 'process raft request' (duration: 334.260822ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:06.252966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:58:05.918583Z","time spent":"334.364575ms","remote":"127.0.0.1:39770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3104,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T05:58:06.253223Z","caller":"traceutil/trace.go:171","msg":"trace[1064962000] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"369.835848ms","start":"2026-05-27T05:58:05.883362Z","end":"2026-05-27T05:58:06.253197Z","steps":["trace[1064962000] 'process raft request' (duration: 66.66042ms)","trace[1064962000] 'compare' (duration: 302.55863ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T05:58:06.253352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:58:05.883341Z","time spent":"369.939701ms","remote":"127.0.0.1:39810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":716,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T05:58:06.320358Z","caller":"traceutil/trace.go:171","msg":"trace[267710576] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"200.003646ms","start":"2026-05-27T05:58:06.120333Z","end":"2026-05-27T05:58:06.320337Z","steps":["trace[267710576] 'process raft request' (duration: 199.874552ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:06.445664Z","caller":"traceutil/trace.go:171","msg":"trace[1940181604] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"121.998784ms","start":"2026-05-27T05:58:06.323638Z","end":"2026-05-27T05:58:06.445637Z","steps":["trace[1940181604] 'process raft request' (duration: 121.929722ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:06.445733Z","caller":"traceutil/trace.go:171","msg":"trace[1552688831] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"124.967772ms","start":"2026-05-27T05:58:06.320727Z","end":"2026-05-27T05:58:06.445695Z","steps":["trace[1552688831] 'process raft request' (duration: 72.472779ms)","trace[1552688831] 'compare' (duration: 52.224395ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T05:58:06.447334Z","caller":"traceutil/trace.go:171","msg":"trace[841949398] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"115.816953ms","start":"2026-05-27T05:58:06.331508Z","end":"2026-05-27T05:58:06.447325Z","steps":["trace[841949398] 'process raft request' (duration: 115.792782ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:06.447538Z","caller":"traceutil/trace.go:171","msg":"trace[508419611] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"116.575464ms","start":"2026-05-27T05:58:06.330908Z","end":"2026-05-27T05:58:06.447483Z","steps":["trace[508419611] 'process raft request' (duration: 116.331137ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:06.577494Z","caller":"traceutil/trace.go:171","msg":"trace[1371804602] linearizableReadLoop","detail":"{readStateIndex:681; appliedIndex:679; }","duration":"101.056049ms","start":"2026-05-27T05:58:06.47642Z","end":"2026-05-27T05:58:06.577476Z","steps":["trace[1371804602] 'read index received' (duration: 40.021745ms)","trace[1371804602] 'applied index is now lower than readState.Index' (duration: 61.033414ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T05:58:06.577678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.235425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-fp586\" ","response":"range_response_count:1 size:4683"} {"level":"info","ts":"2026-05-27T05:58:06.577702Z","caller":"traceutil/trace.go:171","msg":"trace[1899759452] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"124.855129ms","start":"2026-05-27T05:58:06.452825Z","end":"2026-05-27T05:58:06.57768Z","steps":["trace[1899759452] 'process raft request' (duration: 123.966043ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:06.577748Z","caller":"traceutil/trace.go:171","msg":"trace[1903651490] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-fp586; range_end:; response_count:1; response_revision:659; }","duration":"101.339897ms","start":"2026-05-27T05:58:06.476397Z","end":"2026-05-27T05:58:06.577737Z","steps":["trace[1903651490] 'agreement among raft nodes before linearized reading' (duration: 101.179043ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:06.791289Z","caller":"traceutil/trace.go:171","msg":"trace[1104359735] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"205.732125ms","start":"2026-05-27T05:58:06.585532Z","end":"2026-05-27T05:58:06.791264Z","steps":["trace[1104359735] 'process raft request' (duration: 110.115376ms)","trace[1104359735] 'compare' (duration: 95.32458ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T05:58:06.791432Z","caller":"traceutil/trace.go:171","msg":"trace[309431459] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"201.930713ms","start":"2026-05-27T05:58:06.589484Z","end":"2026-05-27T05:58:06.791415Z","steps":["trace[309431459] 'process raft request' (duration: 201.703517ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:07.000721Z","caller":"traceutil/trace.go:171","msg":"trace[954175489] transaction","detail":"{read_only:false; response_revision:665; number_of_response:1; }","duration":"195.234426ms","start":"2026-05-27T05:58:06.805454Z","end":"2026-05-27T05:58:07.000689Z","steps":["trace[954175489] 'process raft request' (duration: 106.313793ms)","trace[954175489] 'compare' (duration: 88.761318ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T05:58:07.089178Z","caller":"traceutil/trace.go:171","msg":"trace[1402684274] transaction","detail":"{read_only:false; response_revision:667; number_of_response:1; }","duration":"272.051421ms","start":"2026-05-27T05:58:06.817103Z","end":"2026-05-27T05:58:07.089154Z","steps":["trace[1402684274] 'process raft request' (duration: 271.962289ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:07.08921Z","caller":"traceutil/trace.go:171","msg":"trace[2121350131] transaction","detail":"{read_only:false; response_revision:666; number_of_response:1; }","duration":"275.379789ms","start":"2026-05-27T05:58:06.813799Z","end":"2026-05-27T05:58:07.089179Z","steps":["trace[2121350131] 'process raft request' (duration: 274.802612ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:07.189507Z","caller":"traceutil/trace.go:171","msg":"trace[2049541062] transaction","detail":"{read_only:false; response_revision:668; number_of_response:1; }","duration":"267.776464ms","start":"2026-05-27T05:58:06.921692Z","end":"2026-05-27T05:58:07.189469Z","steps":["trace[2049541062] 'process raft request' (duration: 267.413693ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:07.189747Z","caller":"traceutil/trace.go:171","msg":"trace[401306829] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"161.212023ms","start":"2026-05-27T05:58:07.028336Z","end":"2026-05-27T05:58:07.189548Z","steps":["trace[401306829] 'process raft request' (duration: 161.008077ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:07.261662Z","caller":"traceutil/trace.go:171","msg":"trace[58489292] transaction","detail":"{read_only:false; response_revision:670; number_of_response:1; }","duration":"167.435307ms","start":"2026-05-27T05:58:07.094197Z","end":"2026-05-27T05:58:07.261632Z","steps":["trace[58489292] 'process raft request' (duration: 167.126378ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:07.261966Z","caller":"traceutil/trace.go:171","msg":"trace[1969327223] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"166.87971ms","start":"2026-05-27T05:58:07.09507Z","end":"2026-05-27T05:58:07.26195Z","steps":["trace[1969327223] 'process raft request' (duration: 166.440597ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:07.262139Z","caller":"traceutil/trace.go:171","msg":"trace[1811961513] transaction","detail":"{read_only:false; response_revision:672; number_of_response:1; }","duration":"143.538115ms","start":"2026-05-27T05:58:07.118586Z","end":"2026-05-27T05:58:07.262124Z","steps":["trace[1811961513] 'process raft request' (duration: 143.258717ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:07.500496Z","caller":"traceutil/trace.go:171","msg":"trace[2145309295] transaction","detail":"{read_only:false; response_revision:673; number_of_response:1; }","duration":"303.542293ms","start":"2026-05-27T05:58:07.196926Z","end":"2026-05-27T05:58:07.500468Z","steps":["trace[2145309295] 'process raft request' (duration: 303.375678ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:07.500613Z","caller":"traceutil/trace.go:171","msg":"trace[324100443] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"299.929757ms","start":"2026-05-27T05:58:07.200667Z","end":"2026-05-27T05:58:07.500597Z","steps":["trace[324100443] 'process raft request' (duration: 299.743691ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:07.500744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:58:07.200643Z","time spent":"300.02723ms","remote":"127.0.0.1:39770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9296,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T05:58:07.500766Z","caller":"traceutil/trace.go:171","msg":"trace[1822621828] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"295.167617ms","start":"2026-05-27T05:58:07.205575Z","end":"2026-05-27T05:58:07.500742Z","steps":["trace[1822621828] 'process raft request' (duration: 294.92887ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:07.500926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:58:07.19691Z","time spent":"303.760419ms","remote":"127.0.0.1:39810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":696,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T05:58:07.78989Z","caller":"traceutil/trace.go:171","msg":"trace[1826922828] linearizableReadLoop","detail":"{readStateIndex:699; appliedIndex:696; }","duration":"471.137134ms","start":"2026-05-27T05:58:07.318735Z","end":"2026-05-27T05:58:07.789872Z","steps":["trace[1826922828] 'read index received' (duration: 181.664534ms)","trace[1826922828] 'applied index is now lower than readState.Index' (duration: 289.47186ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T05:58:07.78998Z","caller":"traceutil/trace.go:171","msg":"trace[158159173] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"469.004622ms","start":"2026-05-27T05:58:07.320968Z","end":"2026-05-27T05:58:07.789973Z","steps":["trace[158159173] 'process raft request' (duration: 468.852167ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:07.790068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:58:07.320945Z","time spent":"469.059102ms","remote":"127.0.0.1:39770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9343,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T05:58:07.789915Z","caller":"traceutil/trace.go:171","msg":"trace[1174344114] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"517.839815ms","start":"2026-05-27T05:58:07.272051Z","end":"2026-05-27T05:58:07.789891Z","steps":["trace[1174344114] 'process raft request' (duration: 517.602948ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:07.790169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:58:07.272016Z","time spent":"518.107163ms","remote":"127.0.0.1:33450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4694,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T05:58:07.790611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.860725ms","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-27T05:58:07.790705Z","caller":"traceutil/trace.go:171","msg":"trace[401158662] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:677; }","duration":"472.005929ms","start":"2026-05-27T05:58:07.318682Z","end":"2026-05-27T05:58:07.790688Z","steps":["trace[401158662] 'agreement among raft nodes before linearized reading' (duration: 471.395472ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:07.790754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:58:07.318664Z","time spent":"472.081392ms","remote":"127.0.0.1:33250","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-27T05:58:08.170186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.666807ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T05:58:08.17048Z","caller":"traceutil/trace.go:171","msg":"trace[610879075] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"660.889412ms","start":"2026-05-27T05:58:07.50957Z","end":"2026-05-27T05:58:08.170459Z","steps":["trace[610879075] 'process raft request' (duration: 660.732908ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:08.170492Z","caller":"traceutil/trace.go:171","msg":"trace[573556415] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"662.18114ms","start":"2026-05-27T05:58:07.508271Z","end":"2026-05-27T05:58:08.170453Z","steps":["trace[573556415] 'process raft request' (duration: 473.148042ms)","trace[573556415] 'compare' (duration: 188.362798ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T05:58:08.170598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:58:07.509551Z","time spent":"660.992725ms","remote":"127.0.0.1:39770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T05:58:08.170688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:58:07.508243Z","time spent":"662.333435ms","remote":"127.0.0.1:39770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T05:58:08.170709Z","caller":"traceutil/trace.go:171","msg":"trace[1525211218] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"649.657952ms","start":"2026-05-27T05:58:07.521024Z","end":"2026-05-27T05:58:08.170682Z","steps":["trace[1525211218] 'process raft request' (duration: 649.382584ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:08.171437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:58:07.521005Z","time spent":"650.167147ms","remote":"127.0.0.1:39770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23277,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T05:58:08.170851Z","caller":"traceutil/trace.go:171","msg":"trace[696160996] linearizableReadLoop","detail":"{readStateIndex:704; appliedIndex:700; }","duration":"380.822378ms","start":"2026-05-27T05:58:07.789948Z","end":"2026-05-27T05:58:08.17077Z","steps":["trace[696160996] 'read index received' (duration: 191.531353ms)","trace[696160996] 'applied index is now lower than readState.Index' (duration: 189.289895ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T05:58:08.170868Z","caller":"traceutil/trace.go:171","msg":"trace[924983007] transaction","detail":"{read_only:false; response_revision:681; number_of_response:1; }","duration":"405.75542ms","start":"2026-05-27T05:58:07.765084Z","end":"2026-05-27T05:58:08.17084Z","steps":["trace[924983007] 'process raft request' (duration: 405.528224ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:08.171705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:58:07.765067Z","time spent":"406.586945ms","remote":"127.0.0.1:39770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187455,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T05:58:08.170921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"707.544012ms","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-27T05:58:08.171875Z","caller":"traceutil/trace.go:171","msg":"trace[1813602524] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:681; }","duration":"708.51776ms","start":"2026-05-27T05:58:07.463338Z","end":"2026-05-27T05:58:08.171856Z","steps":["trace[1813602524] 'agreement among raft nodes before linearized reading' (duration: 707.49875ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:08.171938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:58:07.463328Z","time spent":"708.594443ms","remote":"127.0.0.1:33250","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-27T05:58:08.170942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"665.487697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-lsr7j\" ","response":"range_response_count:1 size:18516"} {"level":"info","ts":"2026-05-27T05:58:08.172111Z","caller":"traceutil/trace.go:171","msg":"trace[726847591] range","detail":"{range_begin:/registry/pods/kube-system/cilium-lsr7j; range_end:; response_count:1; response_revision:681; }","duration":"666.699253ms","start":"2026-05-27T05:58:07.505392Z","end":"2026-05-27T05:58:08.172091Z","steps":["trace[726847591] 'agreement among raft nodes before linearized reading' (duration: 665.410545ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:08.172181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:58:07.505373Z","time spent":"666.789545ms","remote":"127.0.0.1:39912","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":18539,"request content":"key:\"/registry/pods/kube-system/cilium-lsr7j\" "} {"level":"warn","ts":"2026-05-27T05:58:08.171016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"714.168417ms","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-27T05:58:08.172408Z","caller":"traceutil/trace.go:171","msg":"trace[1488343100] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:681; }","duration":"715.584858ms","start":"2026-05-27T05:58:07.456809Z","end":"2026-05-27T05:58:08.172393Z","steps":["trace[1488343100] 'agreement among raft nodes before linearized reading' (duration: 714.171266ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:08.172463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:58:07.456792Z","time spent":"715.657781ms","remote":"127.0.0.1:33250","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-27T05:58:08.171013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"842.428473ms","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-27T05:58:08.172713Z","caller":"traceutil/trace.go:171","msg":"trace[1085088226] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:681; }","duration":"844.151663ms","start":"2026-05-27T05:58:07.328546Z","end":"2026-05-27T05:58:08.172698Z","steps":["trace[1085088226] 'agreement among raft nodes before linearized reading' (duration: 842.34483ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:08.172769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:58:07.328536Z","time spent":"844.218075ms","remote":"127.0.0.1:33250","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-27T05:58:08.171101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.342817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-27T05:58:08.173151Z","caller":"traceutil/trace.go:171","msg":"trace[12980969] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:681; }","duration":"535.419328ms","start":"2026-05-27T05:58:07.63768Z","end":"2026-05-27T05:58:08.173099Z","steps":["trace[12980969] 'agreement among raft nodes before linearized reading' (duration: 533.253334ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:08.173216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:58:07.637649Z","time spent":"535.548991ms","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-27T05:58:08.367517Z","caller":"traceutil/trace.go:171","msg":"trace[974824259] transaction","detail":"{read_only:false; response_revision:682; number_of_response:1; }","duration":"572.690819ms","start":"2026-05-27T05:58:07.794789Z","end":"2026-05-27T05:58:08.36748Z","steps":["trace[974824259] 'process raft request' (duration: 479.625968ms)","trace[974824259] 'compare' (duration: 92.784973ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T05:58:08.367576Z","caller":"traceutil/trace.go:171","msg":"trace[698323847] linearizableReadLoop","detail":"{readStateIndex:706; appliedIndex:704; }","duration":"195.956221ms","start":"2026-05-27T05:58:08.171578Z","end":"2026-05-27T05:58:08.367534Z","steps":["trace[698323847] 'read index received' (duration: 102.847428ms)","trace[698323847] 'applied index is now lower than readState.Index' (duration: 93.107722ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T05:58:08.36784Z","caller":"traceutil/trace.go:171","msg":"trace[923366788] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"419.750319ms","start":"2026-05-27T05:58:07.948079Z","end":"2026-05-27T05:58:08.367829Z","steps":["trace[923366788] 'process raft request' (duration: 419.231764ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:08.367905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:58:07.948042Z","time spent":"419.835322ms","remote":"127.0.0.1:39770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187246,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T05:58:08.367679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:58:07.794771Z","time spent":"572.817243ms","remote":"127.0.0.1:33250","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-27T05:58:08.368096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.02742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"warn","ts":"2026-05-27T05:58:08.368121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.064708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:1 size:4083"} {"level":"info","ts":"2026-05-27T05:58:08.368145Z","caller":"traceutil/trace.go:171","msg":"trace[721551599] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:683; }","duration":"307.073821ms","start":"2026-05-27T05:58:08.061059Z","end":"2026-05-27T05:58:08.368133Z","steps":["trace[721551599] 'agreement among raft nodes before linearized reading' (duration: 306.972808ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:08.368174Z","caller":"traceutil/trace.go:171","msg":"trace[870095587] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:683; }","duration":"251.164101ms","start":"2026-05-27T05:58:08.116995Z","end":"2026-05-27T05:58:08.368159Z","steps":["trace[870095587] 'agreement among raft nodes before linearized reading' (duration: 250.989076ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:08.36818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:58:08.06104Z","time spent":"307.132563ms","remote":"127.0.0.1:39844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-05-27T05:58:08.42247Z","caller":"traceutil/trace.go:171","msg":"trace[1300549091] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"243.480955ms","start":"2026-05-27T05:58:08.178965Z","end":"2026-05-27T05:58:08.422446Z","steps":["trace[1300549091] 'process raft request' (duration: 243.31222ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:08.4228Z","caller":"traceutil/trace.go:171","msg":"trace[2047605963] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"243.746823ms","start":"2026-05-27T05:58:08.179033Z","end":"2026-05-27T05:58:08.42278Z","steps":["trace[2047605963] 'process raft request' (duration: 243.373002ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:08.42291Z","caller":"traceutil/trace.go:171","msg":"trace[1301288929] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"243.814345ms","start":"2026-05-27T05:58:08.179065Z","end":"2026-05-27T05:58:08.42288Z","steps":["trace[1301288929] 'process raft request' (duration: 243.557747ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:08.424157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.49905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-27T05:58:08.424218Z","caller":"traceutil/trace.go:171","msg":"trace[2143814801] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:690; }","duration":"221.600503ms","start":"2026-05-27T05:58:08.202606Z","end":"2026-05-27T05:58:08.424206Z","steps":["trace[2143814801] 'agreement among raft nodes before linearized reading' (duration: 221.4892ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:08.424461Z","caller":"traceutil/trace.go:171","msg":"trace[1329604878] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"244.215637ms","start":"2026-05-27T05:58:08.180235Z","end":"2026-05-27T05:58:08.424451Z","steps":["trace[1329604878] 'process raft request' (duration: 242.480256ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:08.424674Z","caller":"traceutil/trace.go:171","msg":"trace[1003564513] transaction","detail":"{read_only:false; response_revision:688; number_of_response:1; }","duration":"244.322ms","start":"2026-05-27T05:58:08.180342Z","end":"2026-05-27T05:58:08.424664Z","steps":["trace[1003564513] 'process raft request' (duration: 243.579748ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:08.424836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.753043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:1 size:5586"} {"level":"info","ts":"2026-05-27T05:58:08.424883Z","caller":"traceutil/trace.go:171","msg":"trace[1626946549] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:690; }","duration":"106.839945ms","start":"2026-05-27T05:58:08.318028Z","end":"2026-05-27T05:58:08.424868Z","steps":["trace[1626946549] 'agreement among raft nodes before linearized reading' (duration: 106.65328ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:08.424887Z","caller":"traceutil/trace.go:171","msg":"trace[311269706] transaction","detail":"{read_only:false; response_revision:690; number_of_response:1; }","duration":"237.560571ms","start":"2026-05-27T05:58:08.187314Z","end":"2026-05-27T05:58:08.424874Z","steps":["trace[311269706] 'process raft request' (duration: 236.715797ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:08.425072Z","caller":"traceutil/trace.go:171","msg":"trace[1226602889] transaction","detail":"{read_only:false; response_revision:689; number_of_response:1; }","duration":"242.738714ms","start":"2026-05-27T05:58:08.182317Z","end":"2026-05-27T05:58:08.425056Z","steps":["trace[1226602889] 'process raft request' (duration: 241.668582ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:08.689411Z","caller":"traceutil/trace.go:171","msg":"trace[1360608168] transaction","detail":"{read_only:false; response_revision:691; number_of_response:1; }","duration":"252.104949ms","start":"2026-05-27T05:58:08.437284Z","end":"2026-05-27T05:58:08.689389Z","steps":["trace[1360608168] 'process raft request' (duration: 251.980775ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:08.74726Z","caller":"traceutil/trace.go:171","msg":"trace[1925252908] transaction","detail":"{read_only:false; response_revision:692; number_of_response:1; }","duration":"308.952447ms","start":"2026-05-27T05:58:08.438284Z","end":"2026-05-27T05:58:08.747236Z","steps":["trace[1925252908] 'process raft request' (duration: 308.760971ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:08.747473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:58:08.438264Z","time spent":"309.06704ms","remote":"127.0.0.1:39770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":24220,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T05:58:08.747682Z","caller":"traceutil/trace.go:171","msg":"trace[1180371081] transaction","detail":"{read_only:false; response_revision:693; number_of_response:1; }","duration":"179.449776ms","start":"2026-05-27T05:58:08.568221Z","end":"2026-05-27T05:58:08.747671Z","steps":["trace[1180371081] 'process raft request' (duration: 178.975833ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:08.747729Z","caller":"traceutil/trace.go:171","msg":"trace[175530117] transaction","detail":"{read_only:false; response_revision:694; number_of_response:1; }","duration":"176.057626ms","start":"2026-05-27T05:58:08.571648Z","end":"2026-05-27T05:58:08.747705Z","steps":["trace[175530117] 'process raft request' (duration: 175.84414ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:08.747683Z","caller":"traceutil/trace.go:171","msg":"trace[961515412] linearizableReadLoop","detail":"{readStateIndex:715; appliedIndex:714; }","duration":"272.992972ms","start":"2026-05-27T05:58:08.474589Z","end":"2026-05-27T05:58:08.747582Z","steps":["trace[961515412] 'read index received' (duration: 214.940758ms)","trace[961515412] 'applied index is now lower than readState.Index' (duration: 58.051304ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T05:58:08.747861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.229638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T05:58:08.748113Z","caller":"traceutil/trace.go:171","msg":"trace[993720776] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:694; }","duration":"273.586289ms","start":"2026-05-27T05:58:08.474509Z","end":"2026-05-27T05:58:08.748096Z","steps":["trace[993720776] 'agreement among raft nodes before linearized reading' (duration: 273.218538ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:08.748348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.463647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T05:58:08.748411Z","caller":"traceutil/trace.go:171","msg":"trace[1830217195] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:694; }","duration":"179.56122ms","start":"2026-05-27T05:58:08.568834Z","end":"2026-05-27T05:58:08.748396Z","steps":["trace[1830217195] 'agreement among raft nodes before linearized reading' (duration: 179.466797ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:08.748512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.502165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:1 size:4180"} {"level":"warn","ts":"2026-05-27T05:58:08.748363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.263046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-27T05:58:08.748583Z","caller":"traceutil/trace.go:171","msg":"trace[1441914692] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:1; response_revision:694; }","duration":"230.599318ms","start":"2026-05-27T05:58:08.51797Z","end":"2026-05-27T05:58:08.74857Z","steps":["trace[1441914692] 'agreement among raft nodes before linearized reading' (duration: 230.421063ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:08.748607Z","caller":"traceutil/trace.go:171","msg":"trace[753479092] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:694; }","duration":"262.559575ms","start":"2026-05-27T05:58:08.486031Z","end":"2026-05-27T05:58:08.748591Z","steps":["trace[753479092] 'agreement among raft nodes before linearized reading' (duration: 262.253576ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:08.965513Z","caller":"traceutil/trace.go:171","msg":"trace[86239039] transaction","detail":"{read_only:false; response_revision:696; number_of_response:1; }","duration":"207.560332ms","start":"2026-05-27T05:58:08.757928Z","end":"2026-05-27T05:58:08.965488Z","steps":["trace[86239039] 'process raft request' (duration: 182.224618ms)","trace[86239039] 'compare' (duration: 25.184319ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T05:58:09.025553Z","caller":"traceutil/trace.go:171","msg":"trace[399275091] transaction","detail":"{read_only:false; response_revision:697; number_of_response:1; }","duration":"258.930749ms","start":"2026-05-27T05:58:08.76661Z","end":"2026-05-27T05:58:09.025541Z","steps":["trace[399275091] 'process raft request' (duration: 258.716692ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:09.025872Z","caller":"traceutil/trace.go:171","msg":"trace[1379591292] transaction","detail":"{read_only:false; response_revision:698; number_of_response:1; }","duration":"227.254739ms","start":"2026-05-27T05:58:08.798608Z","end":"2026-05-27T05:58:09.025863Z","steps":["trace[1379591292] 'process raft request' (duration: 226.994991ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:09.025868Z","caller":"traceutil/trace.go:171","msg":"trace[526049871] linearizableReadLoop","detail":"{readStateIndex:721; appliedIndex:718; }","duration":"107.434043ms","start":"2026-05-27T05:58:08.918409Z","end":"2026-05-27T05:58:09.025843Z","steps":["trace[526049871] 'read index received' (duration: 21.836761ms)","trace[526049871] 'applied index is now lower than readState.Index' (duration: 85.595801ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T05:58:09.026115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.693301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:1 size:5177"} {"level":"info","ts":"2026-05-27T05:58:09.026206Z","caller":"traceutil/trace.go:171","msg":"trace[1965523581] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:1; response_revision:698; }","duration":"107.831965ms","start":"2026-05-27T05:58:08.918356Z","end":"2026-05-27T05:58:09.026148Z","steps":["trace[1965523581] 'agreement among raft nodes before linearized reading' (duration: 107.608678ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:09.196079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.771378ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T05:58:09.196242Z","caller":"traceutil/trace.go:171","msg":"trace[742469936] transaction","detail":"{read_only:false; response_revision:700; number_of_response:1; }","duration":"225.079742ms","start":"2026-05-27T05:58:08.971147Z","end":"2026-05-27T05:58:09.196227Z","steps":["trace[742469936] 'process raft request' (duration: 225.02629ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:09.196437Z","caller":"traceutil/trace.go:171","msg":"trace[1745401082] transaction","detail":"{read_only:false; response_revision:699; number_of_response:1; }","duration":"226.594166ms","start":"2026-05-27T05:58:08.969821Z","end":"2026-05-27T05:58:09.196415Z","steps":["trace[1745401082] 'process raft request' (duration: 99.410226ms)","trace[1745401082] 'compare' (duration: 126.645735ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T05:58:09.222044Z","caller":"traceutil/trace.go:171","msg":"trace[123143613] linearizableReadLoop","detail":"{readStateIndex:724; appliedIndex:723; }","duration":"104.742032ms","start":"2026-05-27T05:58:09.117282Z","end":"2026-05-27T05:58:09.222024Z","steps":["trace[123143613] 'read index received' (duration: 104.614599ms)","trace[123143613] 'applied index is now lower than readState.Index' (duration: 126.553µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T05:58:09.222109Z","caller":"traceutil/trace.go:171","msg":"trace[1080166152] transaction","detail":"{read_only:false; response_revision:701; number_of_response:1; }","duration":"114.206799ms","start":"2026-05-27T05:58:09.107883Z","end":"2026-05-27T05:58:09.22209Z","steps":["trace[1080166152] 'process raft request' (duration: 113.942772ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:09.222297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.993989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:1 size:9320"} {"level":"info","ts":"2026-05-27T05:58:09.222496Z","caller":"traceutil/trace.go:171","msg":"trace[105727966] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:701; }","duration":"105.248977ms","start":"2026-05-27T05:58:09.117224Z","end":"2026-05-27T05:58:09.222473Z","steps":["trace[105727966] 'agreement among raft nodes before linearized reading' (duration: 104.902296ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:09.400444Z","caller":"traceutil/trace.go:171","msg":"trace[820750282] transaction","detail":"{read_only:false; response_revision:702; number_of_response:1; }","duration":"281.565698ms","start":"2026-05-27T05:58:09.118861Z","end":"2026-05-27T05:58:09.400427Z","steps":["trace[820750282] 'process raft request' (duration: 281.2915ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:09.400461Z","caller":"traceutil/trace.go:171","msg":"trace[766841984] linearizableReadLoop","detail":"{readStateIndex:726; appliedIndex:724; }","duration":"178.341201ms","start":"2026-05-27T05:58:09.222105Z","end":"2026-05-27T05:58:09.400446Z","steps":["trace[766841984] 'read index received' (duration: 177.9761ms)","trace[766841984] 'applied index is now lower than readState.Index' (duration: 364.42µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T05:58:09.400586Z","caller":"traceutil/trace.go:171","msg":"trace[677501750] transaction","detail":"{read_only:false; response_revision:703; number_of_response:1; }","duration":"199.002247ms","start":"2026-05-27T05:58:09.201556Z","end":"2026-05-27T05:58:09.400558Z","steps":["trace[677501750] 'process raft request' (duration: 198.76849ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:09.40066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.187142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-lbwjf\" ","response":"range_response_count:1 size:3043"} {"level":"info","ts":"2026-05-27T05:58:09.400704Z","caller":"traceutil/trace.go:171","msg":"trace[993062673] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-lbwjf; range_end:; response_count:1; response_revision:703; }","duration":"199.275345ms","start":"2026-05-27T05:58:09.201412Z","end":"2026-05-27T05:58:09.400687Z","steps":["trace[993062673] 'agreement among raft nodes before linearized reading' (duration: 199.11894ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:09.64397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.647523ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T05:58:09.644069Z","caller":"traceutil/trace.go:171","msg":"trace[2145802373] transaction","detail":"{read_only:false; response_revision:704; number_of_response:1; }","duration":"238.663461ms","start":"2026-05-27T05:58:09.405387Z","end":"2026-05-27T05:58:09.644051Z","steps":["trace[2145802373] 'process raft request' (duration: 94.852323ms)","trace[2145802373] 'compare' (duration: 143.383555ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T05:58:09.899165Z","caller":"traceutil/trace.go:171","msg":"trace[958758029] transaction","detail":"{read_only:false; response_revision:705; number_of_response:1; }","duration":"493.458243ms","start":"2026-05-27T05:58:09.405669Z","end":"2026-05-27T05:58:09.899127Z","steps":["trace[958758029] 'process raft request' (duration: 419.922567ms)","trace[958758029] 'compare' (duration: 73.301769ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T05:58:09.899231Z","caller":"traceutil/trace.go:171","msg":"trace[543740179] transaction","detail":"{read_only:false; response_revision:706; number_of_response:1; }","duration":"424.537381ms","start":"2026-05-27T05:58:09.474669Z","end":"2026-05-27T05:58:09.899206Z","steps":["trace[543740179] 'process raft request' (duration: 424.403697ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:09.899186Z","caller":"traceutil/trace.go:171","msg":"trace[1942769420] linearizableReadLoop","detail":"{readStateIndex:729; appliedIndex:727; }","duration":"381.388246ms","start":"2026-05-27T05:58:09.517782Z","end":"2026-05-27T05:58:09.89917Z","steps":["trace[1942769420] 'read index received' (duration: 307.814399ms)","trace[1942769420] 'applied index is now lower than readState.Index' (duration: 73.573297ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T05:58:09.899375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:58:09.405647Z","time spent":"493.640609ms","remote":"127.0.0.1:39810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":819,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T05:58:09.899411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:58:09.474641Z","time spent":"424.676096ms","remote":"127.0.0.1:39770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188237,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T05:58:09.899462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.665614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:1 size:10377"} {"level":"info","ts":"2026-05-27T05:58:09.899604Z","caller":"traceutil/trace.go:171","msg":"trace[201369663] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:706; }","duration":"381.85304ms","start":"2026-05-27T05:58:09.517741Z","end":"2026-05-27T05:58:09.899594Z","steps":["trace[201369663] 'agreement among raft nodes before linearized reading' (duration: 381.481749ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:09.899635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:58:09.517725Z","time spent":"381.901671ms","remote":"127.0.0.1:39770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":1,"response size":10400,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" "} {"level":"warn","ts":"2026-05-27T05:58:09.89991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.585069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-zv2vm\" ","response":"range_response_count:1 size:3835"} {"level":"info","ts":"2026-05-27T05:58:09.899945Z","caller":"traceutil/trace.go:171","msg":"trace[182604488] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-zv2vm; range_end:; response_count:1; response_revision:706; }","duration":"252.656231ms","start":"2026-05-27T05:58:09.647281Z","end":"2026-05-27T05:58:09.899937Z","steps":["trace[182604488] 'agreement among raft nodes before linearized reading' (duration: 252.549928ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:09.899926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.024329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:1 size:24244"} {"level":"info","ts":"2026-05-27T05:58:09.899994Z","caller":"traceutil/trace.go:171","msg":"trace[207503209] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:1; response_revision:706; }","duration":"182.131982ms","start":"2026-05-27T05:58:09.717843Z","end":"2026-05-27T05:58:09.899975Z","steps":["trace[207503209] 'agreement among raft nodes before linearized reading' (duration: 181.943486ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:09.899667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.220756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T05:58:09.900103Z","caller":"traceutil/trace.go:171","msg":"trace[1831424802] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:706; }","duration":"329.69323ms","start":"2026-05-27T05:58:09.57039Z","end":"2026-05-27T05:58:09.900084Z","steps":["trace[1831424802] 'agreement among raft nodes before linearized reading' (duration: 329.150264ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:09.900145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:58:09.570372Z","time spent":"329.759232ms","remote":"127.0.0.1:39730","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-27T05:58:10.070299Z","caller":"traceutil/trace.go:171","msg":"trace[496497077] linearizableReadLoop","detail":"{readStateIndex:730; appliedIndex:729; }","duration":"153.248123ms","start":"2026-05-27T05:58:09.917029Z","end":"2026-05-27T05:58:10.070277Z","steps":["trace[496497077] 'read index received' (duration: 109.347836ms)","trace[496497077] 'applied index is now lower than readState.Index' (duration: 43.899407ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T05:58:10.070598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.47493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188495"} {"level":"info","ts":"2026-05-27T05:58:10.070642Z","caller":"traceutil/trace.go:171","msg":"trace[1760198524] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:707; }","duration":"153.629864ms","start":"2026-05-27T05:58:09.917Z","end":"2026-05-27T05:58:10.070629Z","steps":["trace[1760198524] 'agreement among raft nodes before linearized reading' (duration: 153.364956ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:10.070626Z","caller":"traceutil/trace.go:171","msg":"trace[1027307029] transaction","detail":"{read_only:false; response_revision:707; number_of_response:1; }","duration":"163.664319ms","start":"2026-05-27T05:58:09.906734Z","end":"2026-05-27T05:58:10.070398Z","steps":["trace[1027307029] 'process raft request' (duration: 119.634798ms)","trace[1027307029] 'compare' (duration: 43.810334ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T05:58:10.627259Z","caller":"traceutil/trace.go:171","msg":"trace[626252992] transaction","detail":"{read_only:false; response_revision:713; number_of_response:1; }","duration":"125.081637ms","start":"2026-05-27T05:58:10.502146Z","end":"2026-05-27T05:58:10.627227Z","steps":["trace[626252992] 'process raft request' (duration: 64.197153ms)","trace[626252992] 'compare' (duration: 60.74068ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T05:58:10.627339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.748514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T05:58:10.627456Z","caller":"traceutil/trace.go:171","msg":"trace[127972582] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:714; }","duration":"100.899677ms","start":"2026-05-27T05:58:10.526539Z","end":"2026-05-27T05:58:10.627438Z","steps":["trace[127972582] 'agreement among raft nodes before linearized reading' (duration: 100.735573ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:10.627783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.509857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T05:58:10.627833Z","caller":"traceutil/trace.go:171","msg":"trace[858145540] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:714; }","duration":"100.584688ms","start":"2026-05-27T05:58:10.527234Z","end":"2026-05-27T05:58:10.627818Z","steps":["trace[858145540] 'agreement among raft nodes before linearized reading' (duration: 100.002161ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:10.628051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.419733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T05:58:10.628224Z","caller":"traceutil/trace.go:171","msg":"trace[1684513661] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:714; }","duration":"101.616188ms","start":"2026-05-27T05:58:10.526578Z","end":"2026-05-27T05:58:10.628194Z","steps":["trace[1684513661] 'agreement among raft nodes before linearized reading' (duration: 100.684241ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:12.796557Z","caller":"traceutil/trace.go:171","msg":"trace[347980813] transaction","detail":"{read_only:false; response_revision:727; number_of_response:1; }","duration":"182.070131ms","start":"2026-05-27T05:58:12.61444Z","end":"2026-05-27T05:58:12.796511Z","steps":["trace[347980813] 'process raft request' (duration: 144.367577ms)","trace[347980813] 'compare' (duration: 37.320383ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T05:58:13.236462Z","caller":"traceutil/trace.go:171","msg":"trace[745333098] transaction","detail":"{read_only:false; response_revision:732; number_of_response:1; }","duration":"166.636677ms","start":"2026-05-27T05:58:13.069794Z","end":"2026-05-27T05:58:13.236431Z","steps":["trace[745333098] 'process raft request' (duration: 71.40329ms)","trace[745333098] 'compare' (duration: 94.960959ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T05:58:13.236482Z","caller":"traceutil/trace.go:171","msg":"trace[1565731824] transaction","detail":"{read_only:false; response_revision:733; number_of_response:1; }","duration":"163.361322ms","start":"2026-05-27T05:58:13.073092Z","end":"2026-05-27T05:58:13.236454Z","steps":["trace[1565731824] 'process raft request' (duration: 163.271859ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:14.046745Z","caller":"traceutil/trace.go:171","msg":"trace[934506741] transaction","detail":"{read_only:false; response_revision:735; number_of_response:1; }","duration":"129.068647ms","start":"2026-05-27T05:58:13.91766Z","end":"2026-05-27T05:58:14.046728Z","steps":["trace[934506741] 'process raft request' (duration: 128.967614ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:14.67128Z","caller":"traceutil/trace.go:171","msg":"trace[1903573086] linearizableReadLoop","detail":"{readStateIndex:761; appliedIndex:760; }","duration":"153.725787ms","start":"2026-05-27T05:58:14.517536Z","end":"2026-05-27T05:58:14.671261Z","steps":["trace[1903573086] 'read index received' (duration: 153.560462ms)","trace[1903573086] 'applied index is now lower than readState.Index' (duration: 164.775µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T05:58:14.67138Z","caller":"traceutil/trace.go:171","msg":"trace[803470386] transaction","detail":"{read_only:false; response_revision:736; number_of_response:1; }","duration":"176.634787ms","start":"2026-05-27T05:58:14.494706Z","end":"2026-05-27T05:58:14.671341Z","steps":["trace[803470386] 'process raft request' (duration: 176.445222ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:14.671469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.926703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-27T05:58:14.67152Z","caller":"traceutil/trace.go:171","msg":"trace[1685884610] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:736; }","duration":"154.016246ms","start":"2026-05-27T05:58:14.517468Z","end":"2026-05-27T05:58:14.671484Z","steps":["trace[1685884610] 'agreement among raft nodes before linearized reading' (duration: 153.890892ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:14.671752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.053976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-27T05:58:14.671758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.440248ms","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-27T05:58:14.671811Z","caller":"traceutil/trace.go:171","msg":"trace[1231875910] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:736; }","duration":"101.17696ms","start":"2026-05-27T05:58:14.570621Z","end":"2026-05-27T05:58:14.671798Z","steps":["trace[1231875910] 'agreement among raft nodes before linearized reading' (duration: 101.068997ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:14.671873Z","caller":"traceutil/trace.go:171","msg":"trace[1580463372] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:736; }","duration":"114.616103ms","start":"2026-05-27T05:58:14.557231Z","end":"2026-05-27T05:58:14.671847Z","steps":["trace[1580463372] 'agreement among raft nodes before linearized reading' (duration: 114.261093ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:14.860764Z","caller":"traceutil/trace.go:171","msg":"trace[52968431] transaction","detail":"{read_only:false; response_revision:737; number_of_response:1; }","duration":"184.348703ms","start":"2026-05-27T05:58:14.676389Z","end":"2026-05-27T05:58:14.860738Z","steps":["trace[52968431] 'process raft request' (duration: 115.55498ms)","trace[52968431] 'compare' (duration: 68.675429ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T05:58:14.893461Z","caller":"traceutil/trace.go:171","msg":"trace[198257117] transaction","detail":"{read_only:false; response_revision:738; number_of_response:1; }","duration":"216.948396ms","start":"2026-05-27T05:58:14.676487Z","end":"2026-05-27T05:58:14.893436Z","steps":["trace[198257117] 'process raft request' (duration: 216.71973ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:14.893501Z","caller":"traceutil/trace.go:171","msg":"trace[1009884696] transaction","detail":"{read_only:false; response_revision:739; number_of_response:1; }","duration":"216.659028ms","start":"2026-05-27T05:58:14.676816Z","end":"2026-05-27T05:58:14.893475Z","steps":["trace[1009884696] 'process raft request' (duration: 216.535125ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:14.893691Z","caller":"traceutil/trace.go:171","msg":"trace[1875948187] transaction","detail":"{read_only:false; response_revision:741; number_of_response:1; }","duration":"183.984522ms","start":"2026-05-27T05:58:14.709689Z","end":"2026-05-27T05:58:14.893674Z","steps":["trace[1875948187] 'process raft request' (duration: 183.747695ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:14.8935Z","caller":"traceutil/trace.go:171","msg":"trace[63853315] transaction","detail":"{read_only:false; response_revision:740; number_of_response:1; }","duration":"216.426552ms","start":"2026-05-27T05:58:14.677051Z","end":"2026-05-27T05:58:14.893478Z","steps":["trace[63853315] 'process raft request' (duration: 216.344999ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:16.628413Z","caller":"traceutil/trace.go:171","msg":"trace[2040489256] transaction","detail":"{read_only:false; response_revision:746; number_of_response:1; }","duration":"104.222666ms","start":"2026-05-27T05:58:16.524173Z","end":"2026-05-27T05:58:16.628396Z","steps":["trace[2040489256] 'process raft request' (duration: 104.001669ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:16.825751Z","caller":"traceutil/trace.go:171","msg":"trace[1818874955] linearizableReadLoop","detail":"{readStateIndex:774; appliedIndex:773; }","duration":"192.232188ms","start":"2026-05-27T05:58:16.633496Z","end":"2026-05-27T05:58:16.825728Z","steps":["trace[1818874955] 'read index received' (duration: 192.090564ms)","trace[1818874955] 'applied index is now lower than readState.Index' (duration: 140.514µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T05:58:16.825836Z","caller":"traceutil/trace.go:171","msg":"trace[443583594] transaction","detail":"{read_only:false; response_revision:747; number_of_response:1; }","duration":"192.407133ms","start":"2026-05-27T05:58:16.633394Z","end":"2026-05-27T05:58:16.825801Z","steps":["trace[443583594] 'process raft request' (duration: 192.178116ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:16.826125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.599968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-zv2vm\" ","response":"range_response_count:1 size:5050"} {"level":"info","ts":"2026-05-27T05:58:16.826187Z","caller":"traceutil/trace.go:171","msg":"trace[1094207127] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-zv2vm; range_end:; response_count:1; response_revision:747; }","duration":"192.719522ms","start":"2026-05-27T05:58:16.633455Z","end":"2026-05-27T05:58:16.826174Z","steps":["trace[1094207127] 'agreement among raft nodes before linearized reading' (duration: 192.390832ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:16.828375Z","caller":"traceutil/trace.go:171","msg":"trace[379958652] transaction","detail":"{read_only:false; response_revision:748; number_of_response:1; }","duration":"193.111523ms","start":"2026-05-27T05:58:16.635243Z","end":"2026-05-27T05:58:16.828354Z","steps":["trace[379958652] 'process raft request' (duration: 192.99437ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:16.828701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.941689ms","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-27T05:58:16.82885Z","caller":"traceutil/trace.go:171","msg":"trace[921104083] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:748; }","duration":"153.112094ms","start":"2026-05-27T05:58:16.675688Z","end":"2026-05-27T05:58:16.8288Z","steps":["trace[921104083] 'agreement among raft nodes before linearized reading' (duration: 152.660541ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:17.07752Z","caller":"traceutil/trace.go:171","msg":"trace[1369648419] transaction","detail":"{read_only:false; response_revision:753; number_of_response:1; }","duration":"210.332546ms","start":"2026-05-27T05:58:16.867172Z","end":"2026-05-27T05:58:17.077505Z","steps":["trace[1369648419] 'process raft request' (duration: 210.280094ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:17.077961Z","caller":"traceutil/trace.go:171","msg":"trace[615298845] transaction","detail":"{read_only:false; response_revision:752; number_of_response:1; }","duration":"212.442287ms","start":"2026-05-27T05:58:16.865513Z","end":"2026-05-27T05:58:17.077955Z","steps":["trace[615298845] 'process raft request' (duration: 211.85126ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:17.078309Z","caller":"traceutil/trace.go:171","msg":"trace[1845238398] linearizableReadLoop","detail":"{readStateIndex:780; appliedIndex:780; }","duration":"146.82994ms","start":"2026-05-27T05:58:16.931471Z","end":"2026-05-27T05:58:17.078301Z","steps":["trace[1845238398] 'read index received' (duration: 146.82639ms)","trace[1845238398] 'applied index is now lower than readState.Index' (duration: 3.03µs)"],"step_count":2} {"level":"warn","ts":"2026-05-27T05:58:17.078444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.258497ms","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-27T05:58:17.078485Z","caller":"traceutil/trace.go:171","msg":"trace[1916892448] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:753; }","duration":"180.331209ms","start":"2026-05-27T05:58:16.898147Z","end":"2026-05-27T05:58:17.078478Z","steps":["trace[1916892448] 'agreement among raft nodes before linearized reading' (duration: 180.205405ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:17.078624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.880725ms","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-27T05:58:17.078642Z","caller":"traceutil/trace.go:171","msg":"trace[1253970257] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:753; }","duration":"180.933057ms","start":"2026-05-27T05:58:16.897705Z","end":"2026-05-27T05:58:17.078638Z","steps":["trace[1253970257] 'agreement among raft nodes before linearized reading' (duration: 180.868705ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:17.078802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.936697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-27T05:58:17.078866Z","caller":"traceutil/trace.go:171","msg":"trace[1080445294] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:753; }","duration":"181.05895ms","start":"2026-05-27T05:58:16.897796Z","end":"2026-05-27T05:58:17.078855Z","steps":["trace[1080445294] 'agreement among raft nodes before linearized reading' (duration: 180.630358ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:17.086251Z","caller":"traceutil/trace.go:171","msg":"trace[1209492559] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"150.996712ms","start":"2026-05-27T05:58:16.935244Z","end":"2026-05-27T05:58:17.08624Z","steps":["trace[1209492559] 'process raft request' (duration: 150.93729ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:17.086435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.869266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T05:58:17.086468Z","caller":"traceutil/trace.go:171","msg":"trace[325690330] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:754; }","duration":"153.940837ms","start":"2026-05-27T05:58:16.93252Z","end":"2026-05-27T05:58:17.086461Z","steps":["trace[325690330] 'agreement among raft nodes before linearized reading' (duration: 153.873065ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:17.08646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.114433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-27T05:58:17.086438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.137054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T05:58:17.086509Z","caller":"traceutil/trace.go:171","msg":"trace[547502817] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:754; }","duration":"154.211405ms","start":"2026-05-27T05:58:16.932287Z","end":"2026-05-27T05:58:17.086498Z","steps":["trace[547502817] 'agreement among raft nodes before linearized reading' (duration: 154.120363ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:17.086548Z","caller":"traceutil/trace.go:171","msg":"trace[1106816634] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:754; }","duration":"153.273808ms","start":"2026-05-27T05:58:16.933251Z","end":"2026-05-27T05:58:17.086525Z","steps":["trace[1106816634] 'agreement among raft nodes before linearized reading' (duration: 153.131144ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:17.198753Z","caller":"traceutil/trace.go:171","msg":"trace[977243960] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"110.712044ms","start":"2026-05-27T05:58:17.088024Z","end":"2026-05-27T05:58:17.198736Z","steps":["trace[977243960] 'process raft request' (duration: 98.25553ms)","trace[977243960] 'compare' (duration: 12.34032ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T05:58:17.198967Z","caller":"traceutil/trace.go:171","msg":"trace[146451823] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"107.434468ms","start":"2026-05-27T05:58:17.091517Z","end":"2026-05-27T05:58:17.198951Z","steps":["trace[146451823] 'process raft request' (duration: 107.194951ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:17.199252Z","caller":"traceutil/trace.go:171","msg":"trace[1854124408] transaction","detail":"{read_only:false; response_revision:758; number_of_response:1; }","duration":"105.982926ms","start":"2026-05-27T05:58:17.093242Z","end":"2026-05-27T05:58:17.199225Z","steps":["trace[1854124408] 'process raft request' (duration: 105.640066ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:19.861184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.959021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T05:58:19.861269Z","caller":"traceutil/trace.go:171","msg":"trace[995369349] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:763; }","duration":"291.092435ms","start":"2026-05-27T05:58:19.570158Z","end":"2026-05-27T05:58:19.86125Z","steps":["trace[995369349] 'range keys from in-memory index tree' (duration: 290.851718ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:21.213795Z","caller":"traceutil/trace.go:171","msg":"trace[1171764806] transaction","detail":"{read_only:false; response_revision:767; number_of_response:1; }","duration":"108.689069ms","start":"2026-05-27T05:58:21.10508Z","end":"2026-05-27T05:58:21.21377Z","steps":["trace[1171764806] 'process raft request' (duration: 108.491233ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:24.702768Z","caller":"traceutil/trace.go:171","msg":"trace[787676781] linearizableReadLoop","detail":"{readStateIndex:812; appliedIndex:811; }","duration":"133.139397ms","start":"2026-05-27T05:58:24.569609Z","end":"2026-05-27T05:58:24.702749Z","steps":["trace[787676781] 'read index received' (duration: 36.223175ms)","trace[787676781] 'applied index is now lower than readState.Index' (duration: 96.915552ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T05:58:24.702859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.238789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T05:58:24.70288Z","caller":"traceutil/trace.go:171","msg":"trace[1579640784] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:784; }","duration":"133.296991ms","start":"2026-05-27T05:58:24.569576Z","end":"2026-05-27T05:58:24.702873Z","steps":["trace[1579640784] 'agreement among raft nodes before linearized reading' (duration: 133.24417ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:24.703036Z","caller":"traceutil/trace.go:171","msg":"trace[275908615] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"151.681646ms","start":"2026-05-27T05:58:24.551327Z","end":"2026-05-27T05:58:24.703009Z","steps":["trace[275908615] 'process raft request' (duration: 54.496216ms)","trace[275908615] 'compare' (duration: 96.84805ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T05:58:25.767082Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8079350426074568078,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T05:58:26.267272Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8079350426074568078,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T05:58:26.530559Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.274643938s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-27T05:58:26.533249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.554216696s","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-27T05:58:26.53334Z","caller":"traceutil/trace.go:171","msg":"trace[1712448185] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:784; }","duration":"1.55436196s","start":"2026-05-27T05:58:24.978955Z","end":"2026-05-27T05:58:26.533317Z","steps":["trace[1712448185] 'range keys from in-memory index tree' (duration: 1.55402985s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:26.533391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:58:24.978936Z","time spent":"1.554442173s","remote":"127.0.0.1:33250","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-27T05:58:26.533525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.300825471s","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-27T05:58:26.53361Z","caller":"traceutil/trace.go:171","msg":"trace[1304362000] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:784; }","duration":"1.300956285s","start":"2026-05-27T05:58:25.232631Z","end":"2026-05-27T05:58:26.533587Z","steps":["trace[1304362000] 'range keys from in-memory index tree' (duration: 1.300596874s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:26.533668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:58:25.232611Z","time spent":"1.301041677s","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-27T05:58:26.533871Z","caller":"traceutil/trace.go:171","msg":"trace[1920262105] transaction","detail":"{read_only:false; response_revision:785; number_of_response:1; }","duration":"1.278055289s","start":"2026-05-27T05:58:25.255799Z","end":"2026-05-27T05:58:26.533854Z","steps":["trace[1920262105] 'process raft request' (duration: 1.274955908s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:26.534003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:58:25.255772Z","time spent":"1.278161761s","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T05:58:26.549275Z","caller":"traceutil/trace.go:171","msg":"trace[486842877] transaction","detail":"{read_only:false; response_revision:786; number_of_response:1; }","duration":"839.999299ms","start":"2026-05-27T05:58:25.709238Z","end":"2026-05-27T05:58:26.549237Z","steps":["trace[486842877] 'process raft request' (duration: 839.719421ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:26.549466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:58:25.709218Z","time spent":"840.131543ms","remote":"127.0.0.1:33222","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T05:58:26.559703Z","caller":"traceutil/trace.go:171","msg":"trace[1243680374] linearizableReadLoop","detail":"{readStateIndex:815; appliedIndex:812; }","duration":"1.293197799s","start":"2026-05-27T05:58:25.266489Z","end":"2026-05-27T05:58:26.559687Z","steps":["trace[1243680374] 'read index received' (duration: 1.264282008s)","trace[1243680374] 'applied index is now lower than readState.Index' (duration: 28.914601ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T05:58:26.56046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.158155629s","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-27T05:58:26.560539Z","caller":"traceutil/trace.go:171","msg":"trace[1012403884] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:788; }","duration":"1.158280292s","start":"2026-05-27T05:58:25.402242Z","end":"2026-05-27T05:58:26.560522Z","steps":["trace[1012403884] 'agreement among raft nodes before linearized reading' (duration: 1.158092167s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:26.560585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:58:25.402221Z","time spent":"1.158355534s","remote":"127.0.0.1:33250","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-27T05:58:26.560921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.129036921s","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-27T05:58:26.561034Z","caller":"traceutil/trace.go:171","msg":"trace[1869669953] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:788; }","duration":"1.129212686s","start":"2026-05-27T05:58:25.431795Z","end":"2026-05-27T05:58:26.561008Z","steps":["trace[1869669953] 'agreement among raft nodes before linearized reading' (duration: 1.128944319s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:26.561103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:58:25.431778Z","time spent":"1.129312939s","remote":"127.0.0.1:33250","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-27T05:58:26.560831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"990.812208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T05:58:26.561452Z","caller":"traceutil/trace.go:171","msg":"trace[778695569] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:788; }","duration":"991.476478ms","start":"2026-05-27T05:58:25.569954Z","end":"2026-05-27T05:58:26.561431Z","steps":["trace[778695569] 'agreement among raft nodes before linearized reading' (duration: 990.800458ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:26.561517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:58:25.569935Z","time spent":"991.56625ms","remote":"127.0.0.1:39730","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-27T05:58:26.561882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.295395873s","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-27T05:58:26.561931Z","caller":"traceutil/trace.go:171","msg":"trace[1757034770] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:788; }","duration":"1.295470795s","start":"2026-05-27T05:58:25.266449Z","end":"2026-05-27T05:58:26.561919Z","steps":["trace[1757034770] 'agreement among raft nodes before linearized reading' (duration: 1.293341753s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:26.561964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:58:25.266433Z","time spent":"1.295523176s","remote":"127.0.0.1:33250","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-27T05:58:31.695941Z","caller":"traceutil/trace.go:171","msg":"trace[1937164299] transaction","detail":"{read_only:false; response_revision:846; number_of_response:1; }","duration":"107.586773ms","start":"2026-05-27T05:58:31.58833Z","end":"2026-05-27T05:58:31.695916Z","steps":["trace[1937164299] 'process raft request' (duration: 107.421908ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:31.836975Z","caller":"traceutil/trace.go:171","msg":"trace[332568922] transaction","detail":"{read_only:false; response_revision:848; number_of_response:1; }","duration":"132.698262ms","start":"2026-05-27T05:58:31.704245Z","end":"2026-05-27T05:58:31.836943Z","steps":["trace[332568922] 'process raft request' (duration: 132.478516ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:31.837227Z","caller":"traceutil/trace.go:171","msg":"trace[1171238974] transaction","detail":"{read_only:false; response_revision:849; number_of_response:1; }","duration":"132.94051ms","start":"2026-05-27T05:58:31.704265Z","end":"2026-05-27T05:58:31.837206Z","steps":["trace[1171238974] 'process raft request' (duration: 132.59796ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:58:40.985433Z","caller":"traceutil/trace.go:171","msg":"trace[298775983] transaction","detail":"{read_only:false; response_revision:956; number_of_response:1; }","duration":"285.134511ms","start":"2026-05-27T05:58:40.70017Z","end":"2026-05-27T05:58:40.985305Z","steps":["trace[298775983] 'process raft request' (duration: 271.176367ms)","trace[298775983] 'compare' (duration: 13.123659ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T05:58:40.985785Z","caller":"traceutil/trace.go:171","msg":"trace[1027014916] linearizableReadLoop","detail":"{readStateIndex:988; appliedIndex:987; }","duration":"274.143993ms","start":"2026-05-27T05:58:40.711425Z","end":"2026-05-27T05:58:40.985569Z","steps":["trace[1027014916] 'read index received' (duration: 259.933152ms)","trace[1027014916] 'applied index is now lower than readState.Index' (duration: 14.208071ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T05:58:40.986094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.652537ms","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-27T05:58:40.986164Z","caller":"traceutil/trace.go:171","msg":"trace[1002540709] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:956; }","duration":"274.772571ms","start":"2026-05-27T05:58:40.711372Z","end":"2026-05-27T05:58:40.986144Z","steps":["trace[1002540709] 'agreement among raft nodes before linearized reading' (duration: 274.542934ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:58:40.986805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.625328ms","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-27T05:58:40.986909Z","caller":"traceutil/trace.go:171","msg":"trace[1903172975] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:957; }","duration":"273.742272ms","start":"2026-05-27T05:58:40.713155Z","end":"2026-05-27T05:58:40.986898Z","steps":["trace[1903172975] 'agreement among raft nodes before linearized reading' (duration: 273.400382ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:59:53.651773Z","caller":"traceutil/trace.go:171","msg":"trace[1875913234] transaction","detail":"{read_only:false; response_revision:1207; number_of_response:1; }","duration":"150.572016ms","start":"2026-05-27T05:59:53.501162Z","end":"2026-05-27T05:59:53.651734Z","steps":["trace[1875913234] 'process raft request' (duration: 150.360269ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:59:55.196462Z","caller":"traceutil/trace.go:171","msg":"trace[1211177856] linearizableReadLoop","detail":"{readStateIndex:1254; appliedIndex:1253; }","duration":"100.695637ms","start":"2026-05-27T05:59:55.095745Z","end":"2026-05-27T05:59:55.19644Z","steps":["trace[1211177856] 'read index received' (duration: 100.48347ms)","trace[1211177856] 'applied index is now lower than readState.Index' (duration: 210.987µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T05:59:55.196537Z","caller":"traceutil/trace.go:171","msg":"trace[223247684] transaction","detail":"{read_only:false; response_revision:1208; number_of_response:1; }","duration":"165.986069ms","start":"2026-05-27T05:59:55.030508Z","end":"2026-05-27T05:59:55.196494Z","steps":["trace[223247684] 'process raft request' (duration: 165.776132ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:59:55.196708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.931725ms","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-27T05:59:55.196782Z","caller":"traceutil/trace.go:171","msg":"trace[1244052299] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1208; }","duration":"101.058699ms","start":"2026-05-27T05:59:55.095704Z","end":"2026-05-27T05:59:55.196762Z","steps":["trace[1244052299] 'agreement among raft nodes before linearized reading' (duration: 100.840972ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T05:59:55.407686Z","caller":"traceutil/trace.go:171","msg":"trace[426617641] transaction","detail":"{read_only:false; response_revision:1209; number_of_response:1; }","duration":"206.989434ms","start":"2026-05-27T05:59:55.200655Z","end":"2026-05-27T05:59:55.407645Z","steps":["trace[426617641] 'process raft request' (duration: 177.20214ms)","trace[426617641] 'compare' (duration: 29.634348ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T05:59:56.06762Z","caller":"traceutil/trace.go:171","msg":"trace[1336923196] transaction","detail":"{read_only:false; response_revision:1213; number_of_response:1; }","duration":"410.374414ms","start":"2026-05-27T05:59:55.657219Z","end":"2026-05-27T05:59:56.067593Z","steps":["trace[1336923196] 'process raft request' (duration: 410.216258ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T05:59:56.06778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T05:59:55.657208Z","time spent":"410.490717ms","remote":"127.0.0.1:33250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T06:00:04.204071Z","caller":"traceutil/trace.go:171","msg":"trace[635326477] transaction","detail":"{read_only:false; response_revision:1249; number_of_response:1; }","duration":"109.727807ms","start":"2026-05-27T06:00:04.094299Z","end":"2026-05-27T06:00:04.204027Z","steps":["trace[635326477] 'process raft request' (duration: 109.51987ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T06:00:07.729694Z","caller":"traceutil/trace.go:171","msg":"trace[1527935101] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"129.867292ms","start":"2026-05-27T06:00:07.599794Z","end":"2026-05-27T06:00:07.729662Z","steps":["trace[1527935101] 'process raft request' (duration: 129.475269ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T06:00:07.729623Z","caller":"traceutil/trace.go:171","msg":"trace[1139999425] linearizableReadLoop","detail":"{readStateIndex:1312; appliedIndex:1311; }","duration":"121.17191ms","start":"2026-05-27T06:00:07.608405Z","end":"2026-05-27T06:00:07.729576Z","steps":["trace[1139999425] 'read index received' (duration: 120.822968ms)","trace[1139999425] 'applied index is now lower than readState.Index' (duration: 347.372µs)"],"step_count":2} {"level":"warn","ts":"2026-05-27T06:00:07.729957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.527293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-27T06:00:07.730064Z","caller":"traceutil/trace.go:171","msg":"trace[2000494749] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1262; }","duration":"121.662147ms","start":"2026-05-27T06:00:07.608365Z","end":"2026-05-27T06:00:07.730027Z","steps":["trace[2000494749] 'agreement among raft nodes before linearized reading' (duration: 121.357107ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T06:00:12.496967Z","caller":"traceutil/trace.go:171","msg":"trace[161510699] transaction","detail":"{read_only:false; response_revision:1279; number_of_response:1; }","duration":"241.933665ms","start":"2026-05-27T06:00:12.254996Z","end":"2026-05-27T06:00:12.49693Z","steps":["trace[161510699] 'process raft request' (duration: 219.668041ms)","trace[161510699] 'compare' (duration: 22.023946ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T06:00:30.794929Z","caller":"traceutil/trace.go:171","msg":"trace[1369089953] transaction","detail":"{read_only:false; response_revision:1364; number_of_response:1; }","duration":"175.087252ms","start":"2026-05-27T06:00:30.61981Z","end":"2026-05-27T06:00:30.794897Z","steps":["trace[1369089953] 'process raft request' (duration: 153.897246ms)","trace[1369089953] 'compare' (duration: 21.052152ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T06:00:42.11064Z","caller":"traceutil/trace.go:171","msg":"trace[1433360248] linearizableReadLoop","detail":"{readStateIndex:1462; appliedIndex:1461; }","duration":"136.399675ms","start":"2026-05-27T06:00:41.974214Z","end":"2026-05-27T06:00:42.110614Z","steps":["trace[1433360248] 'read index received' (duration: 129.405678ms)","trace[1433360248] 'applied index is now lower than readState.Index' (duration: 6.992787ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T06:00:42.110674Z","caller":"traceutil/trace.go:171","msg":"trace[1255892802] transaction","detail":"{read_only:false; response_revision:1404; number_of_response:1; }","duration":"145.554224ms","start":"2026-05-27T06:00:41.965092Z","end":"2026-05-27T06:00:42.110647Z","steps":["trace[1255892802] 'process raft request' (duration: 138.545466ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:00:42.110875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.640404ms","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-27T06:00:42.110911Z","caller":"traceutil/trace.go:171","msg":"trace[1310270159] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1404; }","duration":"136.717036ms","start":"2026-05-27T06:00:41.974181Z","end":"2026-05-27T06:00:42.110898Z","steps":["trace[1310270159] 'agreement among raft nodes before linearized reading' (duration: 136.575081ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:00:42.110951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-27T06:00:42.111001Z","caller":"traceutil/trace.go:171","msg":"trace[1530155918] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1404; }","duration":"107.398883ms","start":"2026-05-27T06:00:42.003588Z","end":"2026-05-27T06:00:42.110987Z","steps":["trace[1530155918] 'agreement among raft nodes before linearized reading' (duration: 107.205336ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T06:00:46.320086Z","caller":"traceutil/trace.go:171","msg":"trace[648599775] linearizableReadLoop","detail":"{readStateIndex:1476; appliedIndex:1475; }","duration":"181.878956ms","start":"2026-05-27T06:00:46.138184Z","end":"2026-05-27T06:00:46.320063Z","steps":["trace[648599775] 'read index received' (duration: 181.671929ms)","trace[648599775] 'applied index is now lower than readState.Index' (duration: 206.007µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T06:00:46.320172Z","caller":"traceutil/trace.go:171","msg":"trace[711462798] transaction","detail":"{read_only:false; response_revision:1417; number_of_response:1; }","duration":"188.529981ms","start":"2026-05-27T06:00:46.131598Z","end":"2026-05-27T06:00:46.320128Z","steps":["trace[711462798] 'process raft request' (duration: 188.270292ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:00:46.320367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.874245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:kube-controller-manager\" ","response":"range_response_count:1 size:745"} {"level":"warn","ts":"2026-05-27T06:00:46.320374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.166315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-27T06:00:46.320413Z","caller":"traceutil/trace.go:171","msg":"trace[740134616] range","detail":"{range_begin:/registry/clusterrolebindings/system:kube-controller-manager; range_end:; response_count:1; response_revision:1417; }","duration":"152.956718ms","start":"2026-05-27T06:00:46.167442Z","end":"2026-05-27T06:00:46.320399Z","steps":["trace[740134616] 'agreement among raft nodes before linearized reading' (duration: 152.867235ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:00:46.320368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.322229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-27T06:00:46.320457Z","caller":"traceutil/trace.go:171","msg":"trace[276173593] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1417; }","duration":"165.511095ms","start":"2026-05-27T06:00:46.154933Z","end":"2026-05-27T06:00:46.320444Z","steps":["trace[276173593] 'agreement among raft nodes before linearized reading' (duration: 165.265997ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T06:00:46.320442Z","caller":"traceutil/trace.go:171","msg":"trace[1568067146] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1417; }","duration":"182.280308ms","start":"2026-05-27T06:00:46.138145Z","end":"2026-05-27T06:00:46.320425Z","steps":["trace[1568067146] 'agreement among raft nodes before linearized reading' (duration: 182.02662ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:00:46.32048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.331022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:kube-dns\" ","response":"range_response_count:1 size:674"} {"level":"info","ts":"2026-05-27T06:00:46.320707Z","caller":"traceutil/trace.go:171","msg":"trace[1376460863] range","detail":"{range_begin:/registry/clusterrolebindings/system:kube-dns; range_end:; response_count:1; response_revision:1417; }","duration":"133.58343ms","start":"2026-05-27T06:00:46.187052Z","end":"2026-05-27T06:00:46.320636Z","steps":["trace[1376460863] 'agreement among raft nodes before linearized reading' (duration: 133.244369ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T06:00:46.453206Z","caller":"traceutil/trace.go:171","msg":"trace[251763637] transaction","detail":"{read_only:false; response_revision:1419; number_of_response:1; }","duration":"128.195475ms","start":"2026-05-27T06:00:46.324985Z","end":"2026-05-27T06:00:46.45318Z","steps":["trace[251763637] 'process raft request' (duration: 66.810206ms)","trace[251763637] 'compare' (duration: 61.011267ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T06:00:47.04221Z","caller":"traceutil/trace.go:171","msg":"trace[215351503] linearizableReadLoop","detail":"{readStateIndex:1480; appliedIndex:1479; }","duration":"119.232663ms","start":"2026-05-27T06:00:46.92295Z","end":"2026-05-27T06:00:47.042183Z","steps":["trace[215351503] 'read index received' (duration: 119.080138ms)","trace[215351503] 'applied index is now lower than readState.Index' (duration: 151.145µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T06:00:47.042257Z","caller":"traceutil/trace.go:171","msg":"trace[2028162882] transaction","detail":"{read_only:false; response_revision:1421; number_of_response:1; }","duration":"120.895868ms","start":"2026-05-27T06:00:46.921334Z","end":"2026-05-27T06:00:47.04223Z","steps":["trace[2028162882] 'process raft request' (duration: 120.65303ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T06:00:47.042434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.462191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:public-info-viewer\" ","response":"range_response_count:1 size:783"} {"level":"warn","ts":"2026-05-27T06:00:47.042461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.039725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:node-proxier\" ","response":"range_response_count:1 size:699"} {"level":"info","ts":"2026-05-27T06:00:47.042515Z","caller":"traceutil/trace.go:171","msg":"trace[1389584927] range","detail":"{range_begin:/registry/clusterrolebindings/system:public-info-viewer; range_end:; response_count:1; response_revision:1421; }","duration":"119.586095ms","start":"2026-05-27T06:00:46.922913Z","end":"2026-05-27T06:00:47.042499Z","steps":["trace[1389584927] 'agreement among raft nodes before linearized reading' (duration: 119.42871ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T06:00:47.042524Z","caller":"traceutil/trace.go:171","msg":"trace[1781806798] range","detail":"{range_begin:/registry/clusterrolebindings/system:node-proxier; range_end:; response_count:1; response_revision:1421; }","duration":"118.19113ms","start":"2026-05-27T06:00:46.924316Z","end":"2026-05-27T06:00:47.042507Z","steps":["trace[1781806798] 'agreement among raft nodes before linearized reading' (duration: 118.026655ms)"],"step_count":1}