{"level":"warn","ts":"2026-06-05T18:03:21.244971Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-05T18:03:21.245069Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.148:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.148:2380","--initial-cluster=instance=https://199.204.45.148:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.148:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.148: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-06-05T18:03:21.245148Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-05T18:03:21.245162Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.148:2380"]} {"level":"info","ts":"2026-06-05T18:03:21.245192Z","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-06-05T18:03:21.245815Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.148:2379"]} {"level":"info","ts":"2026-06-05T18:03:21.245885Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.148:2380"],"listen-peer-urls":["https://199.204.45.148:2380"],"advertise-client-urls":["https://199.204.45.148:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.148:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.148: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-06-05T18:03:21.249654Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.592184ms"} {"level":"info","ts":"2026-06-05T18:03:21.257567Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"8d200b79e0a2e7ca","cluster-id":"908374b13ab3ba47"} {"level":"info","ts":"2026-06-05T18:03:21.257667Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8d200b79e0a2e7ca switched to configuration voters=()"} {"level":"info","ts":"2026-06-05T18:03:21.257693Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8d200b79e0a2e7ca became follower at term 0"} {"level":"info","ts":"2026-06-05T18:03:21.257705Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8d200b79e0a2e7ca [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-05T18:03:21.257716Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8d200b79e0a2e7ca became follower at term 1"} {"level":"info","ts":"2026-06-05T18:03:21.257778Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8d200b79e0a2e7ca switched to configuration voters=(10169140576690300874)"} {"level":"warn","ts":"2026-06-05T18:03:21.263743Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-05T18:03:21.265708Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-05T18:03:21.266679Z","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-06-05T18:03:21.268843Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"8d200b79e0a2e7ca","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-05T18:03:21.269146Z","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-06-05T18:03:21.269244Z","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-06-05T18:03:21.269257Z","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-06-05T18:03:21.269265Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"8d200b79e0a2e7ca","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-05T18:03:21.270016Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8d200b79e0a2e7ca switched to configuration voters=(10169140576690300874)"} {"level":"info","ts":"2026-06-05T18:03:21.270141Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"908374b13ab3ba47","local-member-id":"8d200b79e0a2e7ca","added-peer-id":"8d200b79e0a2e7ca","added-peer-peer-urls":["https://199.204.45.148:2380"]} {"level":"info","ts":"2026-06-05T18:03:21.274707Z","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-06-05T18:03:21.274906Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.148:2380"} {"level":"info","ts":"2026-06-05T18:03:21.274966Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.148:2380"} {"level":"info","ts":"2026-06-05T18:03:21.275082Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"8d200b79e0a2e7ca","initial-advertise-peer-urls":["https://199.204.45.148:2380"],"listen-peer-urls":["https://199.204.45.148:2380"],"advertise-client-urls":["https://199.204.45.148:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.148:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-05T18:03:21.275136Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-05T18:03:21.458102Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8d200b79e0a2e7ca is starting a new election at term 1"} {"level":"info","ts":"2026-06-05T18:03:21.458213Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8d200b79e0a2e7ca became pre-candidate at term 1"} {"level":"info","ts":"2026-06-05T18:03:21.458238Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8d200b79e0a2e7ca received MsgPreVoteResp from 8d200b79e0a2e7ca at term 1"} {"level":"info","ts":"2026-06-05T18:03:21.458281Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8d200b79e0a2e7ca became candidate at term 2"} {"level":"info","ts":"2026-06-05T18:03:21.458299Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8d200b79e0a2e7ca received MsgVoteResp from 8d200b79e0a2e7ca at term 2"} {"level":"info","ts":"2026-06-05T18:03:21.458321Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8d200b79e0a2e7ca became leader at term 2"} {"level":"info","ts":"2026-06-05T18:03:21.458335Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8d200b79e0a2e7ca elected leader 8d200b79e0a2e7ca at term 2"} {"level":"info","ts":"2026-06-05T18:03:21.459536Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-05T18:03:21.459863Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"8d200b79e0a2e7ca","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.148:2379]}","request-path":"/0/members/8d200b79e0a2e7ca/attributes","cluster-id":"908374b13ab3ba47","publish-timeout":"7s"} {"level":"info","ts":"2026-06-05T18:03:21.459894Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-05T18:03:21.459878Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-05T18:03:21.460165Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-05T18:03:21.460256Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"908374b13ab3ba47","local-member-id":"8d200b79e0a2e7ca","cluster-version":"3.5"} {"level":"info","ts":"2026-06-05T18:03:21.460279Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-05T18:03:21.460431Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-05T18:03:21.460469Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-05T18:03:21.46281Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.148:2379"} {"level":"info","ts":"2026-06-05T18:03:21.463406Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-05T18:03:23.235507Z","caller":"traceutil/trace.go:171","msg":"trace[237979773] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:4; }","duration":"127.246173ms","start":"2026-06-05T18:03:23.108225Z","end":"2026-06-05T18:03:23.235471Z","steps":["trace[237979773] 'read index received' (duration: 12.684003ms)","trace[237979773] 'applied index is now lower than readState.Index' (duration: 114.56076ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T18:03:23.23578Z","caller":"traceutil/trace.go:171","msg":"trace[213084368] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"141.54179ms","start":"2026-06-05T18:03:23.094193Z","end":"2026-06-05T18:03:23.235735Z","steps":["trace[213084368] 'process raft request' (duration: 85.24942ms)","trace[213084368] 'compare' (duration: 55.901339ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T18:03:23.235876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.626024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-05T18:03:23.235971Z","caller":"traceutil/trace.go:171","msg":"trace[942353527] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:3; }","duration":"127.781689ms","start":"2026-06-05T18:03:23.108176Z","end":"2026-06-05T18:03:23.235958Z","steps":["trace[942353527] 'agreement among raft nodes before linearized reading' (duration: 127.479932ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:03:23.394101Z","caller":"traceutil/trace.go:171","msg":"trace[1565101766] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"214.57185ms","start":"2026-06-05T18:03:23.179491Z","end":"2026-06-05T18:03:23.394063Z","steps":["trace[1565101766] 'process raft request' (duration: 214.460017ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:03:23.394299Z","caller":"traceutil/trace.go:171","msg":"trace[1195697011] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"126.117405ms","start":"2026-06-05T18:03:23.268166Z","end":"2026-06-05T18:03:23.394283Z","steps":["trace[1195697011] 'process raft request' (duration: 125.994702ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:03:23.394358Z","caller":"traceutil/trace.go:171","msg":"trace[30374170] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"214.911759ms","start":"2026-06-05T18:03:23.179432Z","end":"2026-06-05T18:03:23.394344Z","steps":["trace[30374170] 'process raft request' (duration: 158.808005ms)","trace[30374170] 'compare' (duration: 55.55652ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T18:03:23.394559Z","caller":"traceutil/trace.go:171","msg":"trace[443954445] linearizableReadLoop","detail":"{readStateIndex:14; appliedIndex:6; }","duration":"158.919547ms","start":"2026-06-05T18:03:23.235627Z","end":"2026-06-05T18:03:23.394547Z","steps":["trace[443954445] 'read index received' (duration: 26.588749ms)","trace[443954445] 'applied index is now lower than readState.Index' (duration: 132.323468ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T18:03:23.394731Z","caller":"traceutil/trace.go:171","msg":"trace[1092520036] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"127.093901ms","start":"2026-06-05T18:03:23.267621Z","end":"2026-06-05T18:03:23.394715Z","steps":["trace[1092520036] 'process raft request' (duration: 126.385452ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:03:23.394966Z","caller":"traceutil/trace.go:171","msg":"trace[441967990] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"127.048658ms","start":"2026-06-05T18:03:23.267899Z","end":"2026-06-05T18:03:23.394948Z","steps":["trace[441967990] 'process raft request' (duration: 126.170855ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:03:23.395075Z","caller":"traceutil/trace.go:171","msg":"trace[475789988] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"127.044128ms","start":"2026-06-05T18:03:23.268015Z","end":"2026-06-05T18:03:23.395059Z","steps":["trace[475789988] 'process raft request' (duration: 126.092013ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:03:23.395154Z","caller":"traceutil/trace.go:171","msg":"trace[2043401487] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"127.090909ms","start":"2026-06-05T18:03:23.268056Z","end":"2026-06-05T18:03:23.395147Z","steps":["trace[2043401487] 'process raft request' (duration: 126.079783ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:03:23.395276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.692136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-05T18:03:23.395217Z","caller":"traceutil/trace.go:171","msg":"trace[1257437432] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"127.481371ms","start":"2026-06-05T18:03:23.267688Z","end":"2026-06-05T18:03:23.395169Z","steps":["trace[1257437432] 'process raft request' (duration: 126.354172ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:03:23.39532Z","caller":"traceutil/trace.go:171","msg":"trace[1230469718] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:17; }","duration":"224.791318ms","start":"2026-06-05T18:03:23.170517Z","end":"2026-06-05T18:03:23.395308Z","steps":["trace[1230469718] 'agreement among raft nodes before linearized reading' (duration: 224.703796ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:03:23.395359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.910302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-05T18:03:23.395405Z","caller":"traceutil/trace.go:171","msg":"trace[1585562518] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:17; }","duration":"174.016774ms","start":"2026-06-05T18:03:23.221376Z","end":"2026-06-05T18:03:23.395393Z","steps":["trace[1585562518] 'agreement among raft nodes before linearized reading' (duration: 173.943763ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:03:23.395608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.571146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3171"} {"level":"warn","ts":"2026-06-05T18:03:23.39562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.884878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-05T18:03:23.395633Z","caller":"traceutil/trace.go:171","msg":"trace[538568992] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:17; }","duration":"156.658968ms","start":"2026-06-05T18:03:23.238968Z","end":"2026-06-05T18:03:23.395627Z","steps":["trace[538568992] 'agreement among raft nodes before linearized reading' (duration: 156.604687ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:03:23.395653Z","caller":"traceutil/trace.go:171","msg":"trace[1494027682] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:17; }","duration":"155.920069ms","start":"2026-06-05T18:03:23.239724Z","end":"2026-06-05T18:03:23.395644Z","steps":["trace[1494027682] 'agreement among raft nodes before linearized reading' (duration: 155.863897ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:03:23.395805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.731642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.148\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-05T18:03:23.395805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.776644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-05T18:03:23.39583Z","caller":"traceutil/trace.go:171","msg":"trace[2019916120] range","detail":"{range_begin:/registry/masterleases/199.204.45.148; range_end:; response_count:0; response_revision:17; }","duration":"228.780732ms","start":"2026-06-05T18:03:23.167044Z","end":"2026-06-05T18:03:23.395824Z","steps":["trace[2019916120] 'agreement among raft nodes before linearized reading' (duration: 228.742261ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:03:23.395869Z","caller":"traceutil/trace.go:171","msg":"trace[1165728414] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:17; }","duration":"225.854266ms","start":"2026-06-05T18:03:23.169997Z","end":"2026-06-05T18:03:23.395851Z","steps":["trace[1165728414] 'agreement among raft nodes before linearized reading' (duration: 225.752723ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:03:23.395627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.792141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-05T18:03:23.396214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.275037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-05T18:03:23.39626Z","caller":"traceutil/trace.go:171","msg":"trace[1354206029] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:17; }","duration":"251.453229ms","start":"2026-06-05T18:03:23.144795Z","end":"2026-06-05T18:03:23.396248Z","steps":["trace[1354206029] 'agreement among raft nodes before linearized reading' (duration: 250.167025ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:03:23.39597Z","caller":"traceutil/trace.go:171","msg":"trace[1685249641] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:17; }","duration":"251.218253ms","start":"2026-06-05T18:03:23.14474Z","end":"2026-06-05T18:03:23.395959Z","steps":["trace[1685249641] 'agreement among raft nodes before linearized reading' (duration: 250.823363ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:03:24.685805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.033459ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-06-05T18:03:24.685925Z","caller":"traceutil/trace.go:171","msg":"trace[1169523699] linearizableReadLoop","detail":"{readStateIndex:77; appliedIndex:76; }","duration":"532.899286ms","start":"2026-06-05T18:03:24.153008Z","end":"2026-06-05T18:03:24.685907Z","steps":["trace[1169523699] 'read index received' (duration: 295.430125ms)","trace[1169523699] 'applied index is now lower than readState.Index' (duration: 237.467991ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T18:03:24.685994Z","caller":"traceutil/trace.go:171","msg":"trace[1173418216] transaction","detail":"{read_only:false; response_revision:73; number_of_response:1; }","duration":"533.451971ms","start":"2026-06-05T18:03:24.152502Z","end":"2026-06-05T18:03:24.685954Z","steps":["trace[1173418216] 'process raft request' (duration: 295.749844ms)","trace[1173418216] 'compare' (duration: 236.880736ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T18:03:24.686062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.051681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-view\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-05T18:03:24.686096Z","caller":"traceutil/trace.go:171","msg":"trace[442242964] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-view; range_end:; response_count:0; response_revision:73; }","duration":"533.102562ms","start":"2026-06-05T18:03:24.152983Z","end":"2026-06-05T18:03:24.686086Z","steps":["trace[442242964] 'agreement among raft nodes before linearized reading' (duration: 532.995739ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:03:24.686142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:03:24.152976Z","time spent":"533.158223ms","remote":"127.0.0.1:54456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":0,"response size":28,"request content":"key:\"/registry/clusterroles/system:aggregate-to-view\" "} {"level":"warn","ts":"2026-06-05T18:03:24.686163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:03:24.152491Z","time spent":"533.583304ms","remote":"127.0.0.1:54474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-05T18:03:25.099319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.678395ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-06-05T18:03:25.09943Z","caller":"traceutil/trace.go:171","msg":"trace[269002956] linearizableReadLoop","detail":"{readStateIndex:78; appliedIndex:77; }","duration":"413.463028ms","start":"2026-06-05T18:03:24.685951Z","end":"2026-06-05T18:03:25.099414Z","steps":["trace[269002956] 'read index received' (duration: 274.525006ms)","trace[269002956] 'applied index is now lower than readState.Index' (duration: 138.936982ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T18:03:25.09949Z","caller":"traceutil/trace.go:171","msg":"trace[774814344] transaction","detail":"{read_only:false; response_revision:74; number_of_response:1; }","duration":"763.95672ms","start":"2026-06-05T18:03:24.335487Z","end":"2026-06-05T18:03:25.099444Z","steps":["trace[774814344] 'process raft request' (duration: 625.083559ms)","trace[774814344] 'compare' (duration: 138.524911ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T18:03:25.099573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"689.79482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-05T18:03:25.09961Z","caller":"traceutil/trace.go:171","msg":"trace[874914304] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:74; }","duration":"689.833832ms","start":"2026-06-05T18:03:24.409765Z","end":"2026-06-05T18:03:25.099599Z","steps":["trace[874914304] 'agreement among raft nodes before linearized reading' (duration: 689.737019ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:03:25.099649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:03:24.409672Z","time spent":"689.970315ms","remote":"127.0.0.1:54116","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-06-05T18:03:25.099684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:03:24.335459Z","time spent":"764.127013ms","remote":"127.0.0.1:54296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5498,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-05T18:03:25.100043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.206979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/view\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-05T18:03:25.100157Z","caller":"traceutil/trace.go:171","msg":"trace[1960739828] range","detail":"{range_begin:/registry/clusterroles/view; range_end:; response_count:0; response_revision:74; }","duration":"411.367253ms","start":"2026-06-05T18:03:24.688764Z","end":"2026-06-05T18:03:25.100131Z","steps":["trace[1960739828] 'agreement among raft nodes before linearized reading' (duration: 411.164957ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:03:25.100206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:03:24.688749Z","time spent":"411.447965ms","remote":"127.0.0.1:54456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":28,"request content":"key:\"/registry/clusterroles/view\" "} {"level":"info","ts":"2026-06-05T18:03:28.995398Z","caller":"traceutil/trace.go:171","msg":"trace[652359313] transaction","detail":"{read_only:false; response_revision:310; number_of_response:1; }","duration":"147.183214ms","start":"2026-06-05T18:03:28.84819Z","end":"2026-06-05T18:03:28.995373Z","steps":["trace[652359313] 'process raft request' (duration: 147.03631ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:03:28.99551Z","caller":"traceutil/trace.go:171","msg":"trace[1612645502] linearizableReadLoop","detail":"{readStateIndex:319; appliedIndex:319; }","duration":"126.863152ms","start":"2026-06-05T18:03:28.868519Z","end":"2026-06-05T18:03:28.995382Z","steps":["trace[1612645502] 'read index received' (duration: 126.851792ms)","trace[1612645502] 'applied index is now lower than readState.Index' (duration: 8.62µs)"],"step_count":2} {"level":"warn","ts":"2026-06-05T18:03:28.995717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.16642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-06-05T18:03:28.995832Z","caller":"traceutil/trace.go:171","msg":"trace[832641760] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/generic-garbage-collector; range_end:; response_count:1; response_revision:310; }","duration":"127.334734ms","start":"2026-06-05T18:03:28.868475Z","end":"2026-06-05T18:03:28.995809Z","steps":["trace[832641760] 'agreement among raft nodes before linearized reading' (duration: 127.120449ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:03:29.116816Z","caller":"traceutil/trace.go:171","msg":"trace[848889717] transaction","detail":"{read_only:false; response_revision:311; number_of_response:1; }","duration":"109.586258ms","start":"2026-06-05T18:03:29.007198Z","end":"2026-06-05T18:03:29.116784Z","steps":["trace[848889717] 'process raft request' (duration: 90.813527ms)","trace[848889717] 'compare' (duration: 18.567956ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T18:03:43.579881Z","caller":"traceutil/trace.go:171","msg":"trace[777807692] transaction","detail":"{read_only:false; response_revision:426; number_of_response:1; }","duration":"119.078927ms","start":"2026-06-05T18:03:43.460776Z","end":"2026-06-05T18:03:43.579855Z","steps":["trace[777807692] 'process raft request' (duration: 118.620405ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:03:58.519891Z","caller":"traceutil/trace.go:171","msg":"trace[327692056] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"193.012673ms","start":"2026-06-05T18:03:58.32686Z","end":"2026-06-05T18:03:58.519873Z","steps":["trace[327692056] 'process raft request' (duration: 192.916171ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:04:01.811516Z","caller":"traceutil/trace.go:171","msg":"trace[400643346] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"104.858175ms","start":"2026-06-05T18:04:01.706629Z","end":"2026-06-05T18:04:01.811487Z","steps":["trace[400643346] 'process raft request' (duration: 104.628479ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:04:01.811727Z","caller":"traceutil/trace.go:171","msg":"trace[144325336] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"103.451968ms","start":"2026-06-05T18:04:01.708266Z","end":"2026-06-05T18:04:01.811718Z","steps":["trace[144325336] 'process raft request' (duration: 103.118959ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:02.346465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.132824ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-05T18:04:02.346663Z","caller":"traceutil/trace.go:171","msg":"trace[209670043] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"284.385535ms","start":"2026-06-05T18:04:02.062256Z","end":"2026-06-05T18:04:02.346641Z","steps":["trace[209670043] 'process raft request' (duration: 118.788369ms)","trace[209670043] 'compare' (duration: 164.944499ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T18:04:02.347033Z","caller":"traceutil/trace.go:171","msg":"trace[1765741455] linearizableReadLoop","detail":"{readStateIndex:597; appliedIndex:594; }","duration":"119.417146ms","start":"2026-06-05T18:04:02.227605Z","end":"2026-06-05T18:04:02.347022Z","steps":["trace[1765741455] 'read index received' (duration: 118.315008ms)","trace[1765741455] 'applied index is now lower than readState.Index' (duration: 1.101128ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T18:04:02.34711Z","caller":"traceutil/trace.go:171","msg":"trace[858912107] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"256.006702ms","start":"2026-06-05T18:04:02.091095Z","end":"2026-06-05T18:04:02.347102Z","steps":["trace[858912107] 'process raft request' (duration: 255.869788ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:02.347217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.593762ms","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-06-05T18:04:02.347279Z","caller":"traceutil/trace.go:171","msg":"trace[985002600] 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:577; }","duration":"119.662303ms","start":"2026-06-05T18:04:02.227599Z","end":"2026-06-05T18:04:02.347262Z","steps":["trace[985002600] 'agreement among raft nodes before linearized reading' (duration: 119.52703ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:02.347332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.221424ms","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-06-05T18:04:02.347437Z","caller":"traceutil/trace.go:171","msg":"trace[1211638089] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:577; }","duration":"100.368608ms","start":"2026-06-05T18:04:02.24704Z","end":"2026-06-05T18:04:02.347408Z","steps":["trace[1211638089] 'agreement among raft nodes before linearized reading' (duration: 100.161693ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:04:02.347373Z","caller":"traceutil/trace.go:171","msg":"trace[1508762519] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"278.533142ms","start":"2026-06-05T18:04:02.068758Z","end":"2026-06-05T18:04:02.347292Z","steps":["trace[1508762519] 'process raft request' (duration: 278.07467ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:02.347657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.184409ms","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-06-05T18:04:02.347704Z","caller":"traceutil/trace.go:171","msg":"trace[922321118] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:577; }","duration":"101.264671ms","start":"2026-06-05T18:04:02.246429Z","end":"2026-06-05T18:04:02.347694Z","steps":["trace[922321118] 'agreement among raft nodes before linearized reading' (duration: 101.20735ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:02.347634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.18321ms","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-06-05T18:04:02.347818Z","caller":"traceutil/trace.go:171","msg":"trace[2089877834] 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:577; }","duration":"119.393557ms","start":"2026-06-05T18:04:02.228414Z","end":"2026-06-05T18:04:02.347807Z","steps":["trace[2089877834] 'agreement among raft nodes before linearized reading' (duration: 119.195421ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:02.347451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.560771ms","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-06-05T18:04:02.34908Z","caller":"traceutil/trace.go:171","msg":"trace[952918223] 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:577; }","duration":"121.400518ms","start":"2026-06-05T18:04:02.227666Z","end":"2026-06-05T18:04:02.349066Z","steps":["trace[952918223] 'agreement among raft nodes before linearized reading' (duration: 119.52099ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:02.347581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.123197ms","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":"info","ts":"2026-06-05T18:04:02.349668Z","caller":"traceutil/trace.go:171","msg":"trace[847409223] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:577; }","duration":"103.243043ms","start":"2026-06-05T18:04:02.246409Z","end":"2026-06-05T18:04:02.349652Z","steps":["trace[847409223] 'agreement among raft nodes before linearized reading' (duration: 101.141208ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:04:04.007697Z","caller":"traceutil/trace.go:171","msg":"trace[1844409327] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"197.801689ms","start":"2026-06-05T18:04:03.809865Z","end":"2026-06-05T18:04:04.007667Z","steps":["trace[1844409327] 'process raft request' (duration: 197.487011ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:04:04.007862Z","caller":"traceutil/trace.go:171","msg":"trace[509187374] linearizableReadLoop","detail":"{readStateIndex:631; appliedIndex:630; }","duration":"175.120235ms","start":"2026-06-05T18:04:03.832727Z","end":"2026-06-05T18:04:04.007848Z","steps":["trace[509187374] 'read index received' (duration: 174.54662ms)","trace[509187374] 'applied index is now lower than readState.Index' (duration: 572.185µs)"],"step_count":2} {"level":"warn","ts":"2026-06-05T18:04:04.008006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.262119ms","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-06-05T18:04:04.008043Z","caller":"traceutil/trace.go:171","msg":"trace[519142046] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:611; }","duration":"175.339341ms","start":"2026-06-05T18:04:03.832693Z","end":"2026-06-05T18:04:04.008032Z","steps":["trace[519142046] 'agreement among raft nodes before linearized reading' (duration: 175.221468ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:04:09.036068Z","caller":"traceutil/trace.go:171","msg":"trace[1780480415] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"422.857611ms","start":"2026-06-05T18:04:08.61318Z","end":"2026-06-05T18:04:09.036038Z","steps":["trace[1780480415] 'process raft request' (duration: 422.228065ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:09.036517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:04:08.613143Z","time spent":"423.141678ms","remote":"127.0.0.1:54192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T18:04:10.17115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.087767457s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-05T18:04:10.171281Z","caller":"traceutil/trace.go:171","msg":"trace[1418294570] linearizableReadLoop","detail":"{readStateIndex:665; appliedIndex:663; }","duration":"1.281758157s","start":"2026-06-05T18:04:08.889502Z","end":"2026-06-05T18:04:10.17126Z","steps":["trace[1418294570] 'read index received' (duration: 145.700096ms)","trace[1418294570] 'applied index is now lower than readState.Index' (duration: 1.136056431s)"],"step_count":2} {"level":"info","ts":"2026-06-05T18:04:10.171377Z","caller":"traceutil/trace.go:171","msg":"trace[2082648950] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"1.382153346s","start":"2026-06-05T18:04:08.789207Z","end":"2026-06-05T18:04:10.17136Z","steps":["trace[2082648950] 'process raft request' (duration: 294.0699ms)","trace[2082648950] 'compare' (duration: 1.087611794s)"],"step_count":2} {"level":"warn","ts":"2026-06-05T18:04:10.171456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:04:08.789181Z","time spent":"1.382230768s","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T18:04:10.171517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.281993874s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-dx2z5\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-06-05T18:04:10.171637Z","caller":"traceutil/trace.go:171","msg":"trace[800453898] range","detail":"{range_begin:/registry/pods/kube-system/cilium-dx2z5; range_end:; response_count:1; response_revision:644; }","duration":"1.282154618s","start":"2026-06-05T18:04:08.88946Z","end":"2026-06-05T18:04:10.171615Z","steps":["trace[800453898] 'agreement among raft nodes before linearized reading' (duration: 1.281893991s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:10.171683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:04:08.889443Z","time spent":"1.28223041s","remote":"127.0.0.1:54296","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16989,"request content":"key:\"/registry/pods/kube-system/cilium-dx2z5\" "} {"level":"warn","ts":"2026-06-05T18:04:10.191364Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.09587801s","expected-duration":"1s"} {"level":"info","ts":"2026-06-05T18:04:10.192221Z","caller":"traceutil/trace.go:171","msg":"trace[277927573] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"1.096861985s","start":"2026-06-05T18:04:09.095329Z","end":"2026-06-05T18:04:10.192191Z","steps":["trace[277927573] 'process raft request' (duration: 1.096760993s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:10.192336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:04:09.095298Z","time spent":"1.096981708s","remote":"127.0.0.1:54366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-05T18:04:10.192359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.28035115s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T18:04:10.192461Z","caller":"traceutil/trace.go:171","msg":"trace[755097678] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:645; }","duration":"1.280490785s","start":"2026-06-05T18:04:08.911953Z","end":"2026-06-05T18:04:10.192444Z","steps":["trace[755097678] 'agreement among raft nodes before linearized reading' (duration: 1.280299419s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:10.192521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:04:08.91157Z","time spent":"1.280940956s","remote":"127.0.0.1:54116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-05T18:04:10.192691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"611.770488ms","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-06-05T18:04:10.192726Z","caller":"traceutil/trace.go:171","msg":"trace[1418704030] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:645; }","duration":"611.83397ms","start":"2026-06-05T18:04:09.580884Z","end":"2026-06-05T18:04:10.192718Z","steps":["trace[1418704030] 'agreement among raft nodes before linearized reading' (duration: 611.742068ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:10.192755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:04:09.580868Z","time spent":"611.881081ms","remote":"127.0.0.1:54400","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-06-05T18:04:10.19319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.813267ms","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-06-05T18:04:10.193413Z","caller":"traceutil/trace.go:171","msg":"trace[1915679146] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:645; }","duration":"162.022772ms","start":"2026-06-05T18:04:10.031327Z","end":"2026-06-05T18:04:10.193349Z","steps":["trace[1915679146] 'agreement among raft nodes before linearized reading' (duration: 161.211451ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:11.942765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.926081ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T18:04:11.942842Z","caller":"traceutil/trace.go:171","msg":"trace[1014689413] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:646; }","duration":"531.012403ms","start":"2026-06-05T18:04:11.411817Z","end":"2026-06-05T18:04:11.94283Z","steps":["trace[1014689413] 'range keys from in-memory index tree' (duration: 530.913291ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:11.943329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"729.586311ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-05T18:04:11.943579Z","caller":"traceutil/trace.go:171","msg":"trace[1687125756] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"1.746536557s","start":"2026-06-05T18:04:10.197024Z","end":"2026-06-05T18:04:11.94356Z","steps":["trace[1687125756] 'process raft request' (duration: 1.016638907s)","trace[1687125756] 'compare' (duration: 729.018917ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T18:04:11.943696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:04:10.197003Z","time spent":"1.74665744s","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T18:04:11.943795Z","caller":"traceutil/trace.go:171","msg":"trace[1001833345] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"1.746598588s","start":"2026-06-05T18:04:10.197146Z","end":"2026-06-05T18:04:11.943745Z","steps":["trace[1001833345] 'process raft request' (duration: 1.746315781s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:11.943868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:04:10.197139Z","time spent":"1.74668306s","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T18:04:11.943962Z","caller":"traceutil/trace.go:171","msg":"trace[1725747956] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"1.746627928s","start":"2026-06-05T18:04:10.197322Z","end":"2026-06-05T18:04:11.94395Z","steps":["trace[1725747956] 'process raft request' (duration: 1.746554017s)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:04:11.943965Z","caller":"traceutil/trace.go:171","msg":"trace[1835360534] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"1.746652959s","start":"2026-06-05T18:04:10.197283Z","end":"2026-06-05T18:04:11.943936Z","steps":["trace[1835360534] 'process raft request' (duration: 1.746389503s)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:04:11.944004Z","caller":"traceutil/trace.go:171","msg":"trace[1557441852] linearizableReadLoop","detail":"{readStateIndex:671; appliedIndex:666; }","duration":"1.745594173s","start":"2026-06-05T18:04:10.198379Z","end":"2026-06-05T18:04:11.943973Z","steps":["trace[1557441852] 'read index received' (duration: 49.125436ms)","trace[1557441852] 'applied index is now lower than readState.Index' (duration: 1.696466546s)"],"step_count":2} {"level":"warn","ts":"2026-06-05T18:04:11.944117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:04:10.197318Z","time spent":"1.746716882s","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T18:04:11.944126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:04:10.197278Z","time spent":"1.746777743s","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T18:04:12.192574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.601509ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"warn","ts":"2026-06-05T18:04:12.192639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.994226362s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-06-05T18:04:12.192726Z","caller":"traceutil/trace.go:171","msg":"trace[46503076] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:650; }","duration":"1.994358695s","start":"2026-06-05T18:04:10.198341Z","end":"2026-06-05T18:04:12.1927Z","steps":["trace[46503076] 'agreement among raft nodes before linearized reading' (duration: 1.745773028s)","trace[46503076] 'range keys from in-memory index tree' (duration: 248.429784ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T18:04:12.192735Z","caller":"traceutil/trace.go:171","msg":"trace[1289938980] linearizableReadLoop","detail":"{readStateIndex:672; appliedIndex:671; }","duration":"248.64127ms","start":"2026-06-05T18:04:11.944068Z","end":"2026-06-05T18:04:12.19271Z","steps":["trace[1289938980] 'read index received' (duration: 62.142µs)","trace[1289938980] 'applied index is now lower than readState.Index' (duration: 248.577558ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T18:04:12.192786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:04:10.198323Z","time spent":"1.994446757s","remote":"127.0.0.1:54320","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":217,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"warn","ts":"2026-06-05T18:04:12.192959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.992192087s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T18:04:12.193046Z","caller":"traceutil/trace.go:171","msg":"trace[1402871105] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:650; }","duration":"1.992247319s","start":"2026-06-05T18:04:10.200734Z","end":"2026-06-05T18:04:12.192981Z","steps":["trace[1402871105] 'agreement among raft nodes before linearized reading' (duration: 1.992091346s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:12.193122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:04:10.200726Z","time spent":"1.992356733s","remote":"127.0.0.1:54096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-05T18:04:15.476071Z","caller":"traceutil/trace.go:171","msg":"trace[44774257] transaction","detail":"{read_only:false; response_revision:694; number_of_response:1; }","duration":"179.49783ms","start":"2026-06-05T18:04:15.296546Z","end":"2026-06-05T18:04:15.476044Z","steps":["trace[44774257] 'process raft request' (duration: 179.369146ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:04:15.608118Z","caller":"traceutil/trace.go:171","msg":"trace[624789976] transaction","detail":"{read_only:false; response_revision:695; number_of_response:1; }","duration":"173.677796ms","start":"2026-06-05T18:04:15.434417Z","end":"2026-06-05T18:04:15.608095Z","steps":["trace[624789976] 'process raft request' (duration: 168.920911ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:04:15.616763Z","caller":"traceutil/trace.go:171","msg":"trace[375806846] transaction","detail":"{read_only:false; response_revision:696; number_of_response:1; }","duration":"134.321436ms","start":"2026-06-05T18:04:15.482414Z","end":"2026-06-05T18:04:15.616736Z","steps":["trace[375806846] 'process raft request' (duration: 134.201532ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:04:15.806862Z","caller":"traceutil/trace.go:171","msg":"trace[1033528794] transaction","detail":"{read_only:false; response_revision:698; number_of_response:1; }","duration":"172.170738ms","start":"2026-06-05T18:04:15.634665Z","end":"2026-06-05T18:04:15.806836Z","steps":["trace[1033528794] 'process raft request' (duration: 132.537981ms)","trace[1033528794] 'compare' (duration: 39.300688ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T18:04:15.806884Z","caller":"traceutil/trace.go:171","msg":"trace[1045343716] transaction","detail":"{read_only:false; response_revision:699; number_of_response:1; }","duration":"168.653775ms","start":"2026-06-05T18:04:15.638206Z","end":"2026-06-05T18:04:15.80686Z","steps":["trace[1045343716] 'process raft request' (duration: 168.542963ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:04:15.9141Z","caller":"traceutil/trace.go:171","msg":"trace[1327059613] transaction","detail":"{read_only:false; response_revision:700; number_of_response:1; }","duration":"100.165253ms","start":"2026-06-05T18:04:15.813914Z","end":"2026-06-05T18:04:15.914079Z","steps":["trace[1327059613] 'process raft request' (duration: 94.436582ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:04:16.33913Z","caller":"traceutil/trace.go:171","msg":"trace[546316653] transaction","detail":"{read_only:false; response_revision:702; number_of_response:1; }","duration":"416.368381ms","start":"2026-06-05T18:04:15.922724Z","end":"2026-06-05T18:04:16.339092Z","steps":["trace[546316653] 'process raft request' (duration: 341.05926ms)","trace[546316653] 'compare' (duration: 75.026194ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T18:04:16.339476Z","caller":"traceutil/trace.go:171","msg":"trace[1175925722] transaction","detail":"{read_only:false; response_revision:703; number_of_response:1; }","duration":"415.955631ms","start":"2026-06-05T18:04:15.923509Z","end":"2026-06-05T18:04:16.339464Z","steps":["trace[1175925722] 'process raft request' (duration: 415.518139ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:16.339558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:04:15.923487Z","time spent":"416.024363ms","remote":"127.0.0.1:54174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":771,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-05T18:04:16.339453Z","caller":"traceutil/trace.go:171","msg":"trace[892482517] linearizableReadLoop","detail":"{readStateIndex:727; appliedIndex:724; }","duration":"387.495786ms","start":"2026-06-05T18:04:15.951929Z","end":"2026-06-05T18:04:16.339425Z","steps":["trace[892482517] 'read index received' (duration: 311.848935ms)","trace[892482517] 'applied index is now lower than readState.Index' (duration: 75.645991ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T18:04:16.339642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.073011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-dx2z5\" ","response":"range_response_count:1 size:17790"} {"level":"info","ts":"2026-06-05T18:04:16.339754Z","caller":"traceutil/trace.go:171","msg":"trace[481191638] transaction","detail":"{read_only:false; response_revision:704; number_of_response:1; }","duration":"416.144335ms","start":"2026-06-05T18:04:15.923549Z","end":"2026-06-05T18:04:16.339694Z","steps":["trace[481191638] 'process raft request' (duration: 415.714855ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:16.340066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:04:15.923537Z","time spent":"416.379552ms","remote":"127.0.0.1:54146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4059,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T18:04:16.340212Z","caller":"traceutil/trace.go:171","msg":"trace[1011084713] range","detail":"{range_begin:/registry/pods/kube-system/cilium-dx2z5; range_end:; response_count:1; response_revision:704; }","duration":"417.170093ms","start":"2026-06-05T18:04:15.922511Z","end":"2026-06-05T18:04:16.339681Z","steps":["trace[1011084713] 'agreement among raft nodes before linearized reading' (duration: 416.987488ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:16.340278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:04:15.922489Z","time spent":"417.773798ms","remote":"127.0.0.1:54296","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":17814,"request content":"key:\"/registry/pods/kube-system/cilium-dx2z5\" "} {"level":"warn","ts":"2026-06-05T18:04:16.340491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:04:15.922707Z","time spent":"416.625358ms","remote":"127.0.0.1:54146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9305,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T18:04:16.342895Z","caller":"traceutil/trace.go:171","msg":"trace[489530656] transaction","detail":"{read_only:false; response_revision:705; number_of_response:1; }","duration":"389.700314ms","start":"2026-06-05T18:04:15.953179Z","end":"2026-06-05T18:04:16.34288Z","steps":["trace[489530656] 'process raft request' (duration: 389.312854ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:16.342921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.829319ms","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-06-05T18:04:16.342992Z","caller":"traceutil/trace.go:171","msg":"trace[2043293372] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:707; }","duration":"383.944462ms","start":"2026-06-05T18:04:15.959028Z","end":"2026-06-05T18:04:16.342973Z","steps":["trace[2043293372] 'agreement among raft nodes before linearized reading' (duration: 383.744028ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:16.343027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:04:15.953159Z","time spent":"389.789806ms","remote":"127.0.0.1:54124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T18:04:16.343037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:04:15.95901Z","time spent":"384.016875ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-05T18:04:16.343198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.381808ms","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-06-05T18:04:16.343252Z","caller":"traceutil/trace.go:171","msg":"trace[829174789] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:707; }","duration":"383.436609ms","start":"2026-06-05T18:04:15.959802Z","end":"2026-06-05T18:04:16.343238Z","steps":["trace[829174789] 'agreement among raft nodes before linearized reading' (duration: 383.278075ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:16.34329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:04:15.959755Z","time spent":"383.528661ms","remote":"127.0.0.1:54400","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-06-05T18:04:16.343291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.50165ms","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-06-05T18:04:16.343308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.833629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-05T18:04:16.343334Z","caller":"traceutil/trace.go:171","msg":"trace[1783796295] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:707; }","duration":"383.555312ms","start":"2026-06-05T18:04:15.959765Z","end":"2026-06-05T18:04:16.343321Z","steps":["trace[1783796295] 'agreement among raft nodes before linearized reading' (duration: 383.431259ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:04:16.343355Z","caller":"traceutil/trace.go:171","msg":"trace[422782535] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:707; }","duration":"383.898021ms","start":"2026-06-05T18:04:15.95945Z","end":"2026-06-05T18:04:16.343348Z","steps":["trace[422782535] 'agreement among raft nodes before linearized reading' (duration: 383.802018ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:16.343364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:04:15.95976Z","time spent":"383.596973ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-05T18:04:16.343372Z","caller":"traceutil/trace.go:171","msg":"trace[2094689797] transaction","detail":"{read_only:false; response_revision:706; number_of_response:1; }","duration":"306.740341ms","start":"2026-06-05T18:04:16.036622Z","end":"2026-06-05T18:04:16.343363Z","steps":["trace[2094689797] 'process raft request' (duration: 306.054214ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:16.343381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:04:15.959445Z","time spent":"383.929893ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-05T18:04:16.343418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:04:16.036582Z","time spent":"306.810344ms","remote":"127.0.0.1:54146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23277,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-05T18:04:16.343443Z","caller":"traceutil/trace.go:171","msg":"trace[149218363] transaction","detail":"{read_only:false; response_revision:707; number_of_response:1; }","duration":"108.292426ms","start":"2026-06-05T18:04:16.235141Z","end":"2026-06-05T18:04:16.343433Z","steps":["trace[149218363] 'process raft request' (duration: 107.594318ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:04:22.928397Z","caller":"traceutil/trace.go:171","msg":"trace[457885916] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"115.705859ms","start":"2026-06-05T18:04:22.81265Z","end":"2026-06-05T18:04:22.928356Z","steps":["trace[457885916] 'process raft request' (duration: 115.608946ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:04:26.217227Z","caller":"traceutil/trace.go:171","msg":"trace[362915118] transaction","detail":"{read_only:false; response_revision:793; number_of_response:1; }","duration":"112.207997ms","start":"2026-06-05T18:04:26.105001Z","end":"2026-06-05T18:04:26.217209Z","steps":["trace[362915118] 'process raft request' (duration: 112.169486ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:04:26.217301Z","caller":"traceutil/trace.go:171","msg":"trace[1144276931] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"113.502771ms","start":"2026-06-05T18:04:26.103754Z","end":"2026-06-05T18:04:26.217257Z","steps":["trace[1144276931] 'process raft request' (duration: 113.307047ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:04:26.930621Z","caller":"traceutil/trace.go:171","msg":"trace[343962221] linearizableReadLoop","detail":"{readStateIndex:820; appliedIndex:819; }","duration":"494.820635ms","start":"2026-06-05T18:04:26.435779Z","end":"2026-06-05T18:04:26.9306Z","steps":["trace[343962221] 'read index received' (duration: 494.594049ms)","trace[343962221] 'applied index is now lower than readState.Index' (duration: 225.476µs)"],"step_count":2} {"level":"info","ts":"2026-06-05T18:04:26.93067Z","caller":"traceutil/trace.go:171","msg":"trace[1651809740] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"704.560846ms","start":"2026-06-05T18:04:26.226086Z","end":"2026-06-05T18:04:26.930646Z","steps":["trace[1651809740] 'process raft request' (duration: 704.356951ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:26.930834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:04:26.226069Z","time spent":"704.702869ms","remote":"127.0.0.1:54564","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4213,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T18:04:26.93085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"490.321486ms","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-06-05T18:04:26.930885Z","caller":"traceutil/trace.go:171","msg":"trace[707769789] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:794; }","duration":"490.403569ms","start":"2026-06-05T18:04:26.440472Z","end":"2026-06-05T18:04:26.930875Z","steps":["trace[707769789] 'agreement among raft nodes before linearized reading' (duration: 490.262475ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:26.930865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.05371ms","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-06-05T18:04:26.930921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:04:26.440453Z","time spent":"490.460651ms","remote":"127.0.0.1:54400","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-06-05T18:04:26.930947Z","caller":"traceutil/trace.go:171","msg":"trace[773035812] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:794; }","duration":"495.182875ms","start":"2026-06-05T18:04:26.435743Z","end":"2026-06-05T18:04:26.930926Z","steps":["trace[773035812] 'agreement among raft nodes before linearized reading' (duration: 494.945858ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:26.930968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.04272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-05T18:04:26.930992Z","caller":"traceutil/trace.go:171","msg":"trace[60360277] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:794; }","duration":"168.092031ms","start":"2026-06-05T18:04:26.762893Z","end":"2026-06-05T18:04:26.930985Z","steps":["trace[60360277] 'agreement among raft nodes before linearized reading' (duration: 168.03479ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:26.930995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:04:26.435727Z","time spent":"495.258397ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-05T18:04:26.931238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.548922ms","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-06-05T18:04:26.93127Z","caller":"traceutil/trace.go:171","msg":"trace[735860357] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:794; }","duration":"226.602753ms","start":"2026-06-05T18:04:26.704658Z","end":"2026-06-05T18:04:26.931261Z","steps":["trace[735860357] 'agreement among raft nodes before linearized reading' (duration: 226.501871ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:26.931283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.17001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-05T18:04:26.931306Z","caller":"traceutil/trace.go:171","msg":"trace[42451458] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:794; }","duration":"483.220741ms","start":"2026-06-05T18:04:26.448077Z","end":"2026-06-05T18:04:26.931298Z","steps":["trace[42451458] 'agreement among raft nodes before linearized reading' (duration: 483.128869ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:26.931323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:04:26.448057Z","time spent":"483.262812ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-05T18:04:26.931312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.495589ms","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-06-05T18:04:26.931383Z","caller":"traceutil/trace.go:171","msg":"trace[911532420] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:794; }","duration":"483.582091ms","start":"2026-06-05T18:04:26.447781Z","end":"2026-06-05T18:04:26.931363Z","steps":["trace[911532420] 'agreement among raft nodes before linearized reading' (duration: 483.385806ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:26.931424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:04:26.447773Z","time spent":"483.642192ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-05T18:04:27.05389Z","caller":"traceutil/trace.go:171","msg":"trace[381211963] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"118.999146ms","start":"2026-06-05T18:04:26.934869Z","end":"2026-06-05T18:04:27.053868Z","steps":["trace[381211963] 'process raft request' (duration: 118.691258ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:04:27.054267Z","caller":"traceutil/trace.go:171","msg":"trace[1755575587] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"119.340565ms","start":"2026-06-05T18:04:26.934908Z","end":"2026-06-05T18:04:27.054248Z","steps":["trace[1755575587] 'process raft request' (duration: 118.915314ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:04:27.054494Z","caller":"traceutil/trace.go:171","msg":"trace[860276876] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"118.908663ms","start":"2026-06-05T18:04:26.935576Z","end":"2026-06-05T18:04:27.054484Z","steps":["trace[860276876] 'process raft request' (duration: 118.851222ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:04:27.054552Z","caller":"traceutil/trace.go:171","msg":"trace[2097632224] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"119.132789ms","start":"2026-06-05T18:04:26.935399Z","end":"2026-06-05T18:04:27.054531Z","steps":["trace[2097632224] 'process raft request' (duration: 118.76574ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:31.467915Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16702336547826118558,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-05T18:04:31.492795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.694292ms","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-06-05T18:04:31.492873Z","caller":"traceutil/trace.go:171","msg":"trace[165152440] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:814; }","duration":"530.804104ms","start":"2026-06-05T18:04:30.962046Z","end":"2026-06-05T18:04:31.49285Z","steps":["trace[165152440] 'range keys from in-memory index tree' (duration: 530.541558ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:31.492919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:04:30.962031Z","time spent":"530.877958ms","remote":"127.0.0.1:54400","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-06-05T18:04:31.49297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"971.351054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-05T18:04:31.493065Z","caller":"traceutil/trace.go:171","msg":"trace[1139436983] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:814; }","duration":"971.493207ms","start":"2026-06-05T18:04:30.521557Z","end":"2026-06-05T18:04:31.493051Z","steps":["trace[1139436983] 'count revisions from in-memory index tree' (duration: 971.24326ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:31.49312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:04:30.521542Z","time spent":"971.569499ms","remote":"127.0.0.1:54308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":2,"response size":31,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "} {"level":"info","ts":"2026-06-05T18:04:31.494279Z","caller":"traceutil/trace.go:171","msg":"trace[1340699743] transaction","detail":"{read_only:false; response_revision:815; number_of_response:1; }","duration":"531.798571ms","start":"2026-06-05T18:04:30.962463Z","end":"2026-06-05T18:04:31.494262Z","steps":["trace[1340699743] 'process raft request' (duration: 531.687359ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:31.4944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:04:30.962454Z","time spent":"531.857053ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T18:04:31.501468Z","caller":"traceutil/trace.go:171","msg":"trace[170390781] transaction","detail":"{read_only:false; response_revision:816; number_of_response:1; }","duration":"488.012246ms","start":"2026-06-05T18:04:31.013427Z","end":"2026-06-05T18:04:31.501439Z","steps":["trace[170390781] 'process raft request' (duration: 487.888823ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:31.501628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:04:31.0134Z","time spent":"488.142829ms","remote":"127.0.0.1:54366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T18:04:31.507277Z","caller":"traceutil/trace.go:171","msg":"trace[1856594596] linearizableReadLoop","detail":"{readStateIndex:844; appliedIndex:841; }","duration":"539.638117ms","start":"2026-06-05T18:04:30.967603Z","end":"2026-06-05T18:04:31.507241Z","steps":["trace[1856594596] 'read index received' (duration: 526.642577ms)","trace[1856594596] 'applied index is now lower than readState.Index' (duration: 12.99035ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T18:04:31.507373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"539.76318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T18:04:31.507431Z","caller":"traceutil/trace.go:171","msg":"trace[2110843655] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:817; }","duration":"539.844703ms","start":"2026-06-05T18:04:30.967573Z","end":"2026-06-05T18:04:31.507417Z","steps":["trace[2110843655] 'agreement among raft nodes before linearized reading' (duration: 539.76624ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:31.507462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:04:30.967559Z","time spent":"539.896324ms","remote":"127.0.0.1:54096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-05T18:04:31.507556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.618736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T18:04:31.507604Z","caller":"traceutil/trace.go:171","msg":"trace[1159497278] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:817; }","duration":"300.717959ms","start":"2026-06-05T18:04:31.206874Z","end":"2026-06-05T18:04:31.507592Z","steps":["trace[1159497278] 'agreement among raft nodes before linearized reading' (duration: 300.631606ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:31.507601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.069713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-06-05T18:04:31.507642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:04:31.206849Z","time spent":"300.784391ms","remote":"127.0.0.1:54262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":29,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "} {"level":"info","ts":"2026-06-05T18:04:31.507651Z","caller":"traceutil/trace.go:171","msg":"trace[1286247968] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:817; }","duration":"439.131455ms","start":"2026-06-05T18:04:31.068507Z","end":"2026-06-05T18:04:31.507639Z","steps":["trace[1286247968] 'agreement among raft nodes before linearized reading' (duration: 438.92814ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:31.507679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:04:31.068478Z","time spent":"439.194077ms","remote":"127.0.0.1:54400","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":"warn","ts":"2026-06-05T18:04:31.508133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.132587ms","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-06-05T18:04:31.5082Z","caller":"traceutil/trace.go:171","msg":"trace[1999348199] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:817; }","duration":"441.248631ms","start":"2026-06-05T18:04:31.066932Z","end":"2026-06-05T18:04:31.508181Z","steps":["trace[1999348199] 'agreement among raft nodes before linearized reading' (duration: 440.488781ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:31.50827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:04:31.066911Z","time spent":"441.339533ms","remote":"127.0.0.1:54400","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-06-05T18:04:31.508575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.558612ms","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-06-05T18:04:31.50862Z","caller":"traceutil/trace.go:171","msg":"trace[1680024896] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:817; }","duration":"440.608793ms","start":"2026-06-05T18:04:31.067986Z","end":"2026-06-05T18:04:31.508595Z","steps":["trace[1680024896] 'agreement among raft nodes before linearized reading' (duration: 439.503365ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:31.508642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:04:31.067973Z","time spent":"440.664515ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-05T18:04:31.508708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.616213ms","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-06-05T18:04:31.508762Z","caller":"traceutil/trace.go:171","msg":"trace[1988281302] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:817; }","duration":"440.695525ms","start":"2026-06-05T18:04:31.068051Z","end":"2026-06-05T18:04:31.508746Z","steps":["trace[1988281302] 'agreement among raft nodes before linearized reading' (duration: 439.414942ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:31.508803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:04:31.068039Z","time spent":"440.752776ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-05T18:04:35.187709Z","caller":"traceutil/trace.go:171","msg":"trace[1699207541] transaction","detail":"{read_only:false; response_revision:832; number_of_response:1; }","duration":"103.943343ms","start":"2026-06-05T18:04:35.083712Z","end":"2026-06-05T18:04:35.187655Z","steps":["trace[1699207541] 'process raft request' (duration: 64.519701ms)","trace[1699207541] 'compare' (duration: 39.103074ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T18:04:35.314194Z","caller":"traceutil/trace.go:171","msg":"trace[314167021] transaction","detail":"{read_only:false; response_revision:834; number_of_response:1; }","duration":"119.404229ms","start":"2026-06-05T18:04:35.194761Z","end":"2026-06-05T18:04:35.314165Z","steps":["trace[314167021] 'process raft request' (duration: 99.763934ms)","trace[314167021] 'compare' (duration: 19.529782ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T18:04:35.667478Z","caller":"traceutil/trace.go:171","msg":"trace[415513559] transaction","detail":"{read_only:false; response_revision:840; number_of_response:1; }","duration":"149.657082ms","start":"2026-06-05T18:04:35.517775Z","end":"2026-06-05T18:04:35.667432Z","steps":["trace[415513559] 'process raft request' (duration: 149.486447ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:04:35.67064Z","caller":"traceutil/trace.go:171","msg":"trace[1044122966] linearizableReadLoop","detail":"{readStateIndex:869; appliedIndex:867; }","duration":"146.880909ms","start":"2026-06-05T18:04:35.523741Z","end":"2026-06-05T18:04:35.670622Z","steps":["trace[1044122966] 'read index received' (duration: 143.438159ms)","trace[1044122966] 'applied index is now lower than readState.Index' (duration: 3.44135ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T18:04:35.670897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.556124ms","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-06-05T18:04:35.670922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.744892ms","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-06-05T18:04:35.670961Z","caller":"traceutil/trace.go:171","msg":"trace[958257880] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:841; }","duration":"142.689699ms","start":"2026-06-05T18:04:35.528261Z","end":"2026-06-05T18:04:35.670951Z","steps":["trace[958257880] 'agreement among raft nodes before linearized reading' (duration: 142.477633ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:04:35.670973Z","caller":"traceutil/trace.go:171","msg":"trace[2077446343] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:841; }","duration":"139.839815ms","start":"2026-06-05T18:04:35.53112Z","end":"2026-06-05T18:04:35.67096Z","steps":["trace[2077446343] 'agreement among raft nodes before linearized reading' (duration: 139.67507ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:35.671063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.185604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-05T18:04:35.67119Z","caller":"traceutil/trace.go:171","msg":"trace[2012127897] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:841; }","duration":"140.373849ms","start":"2026-06-05T18:04:35.530785Z","end":"2026-06-05T18:04:35.671158Z","steps":["trace[2012127897] 'agreement among raft nodes before linearized reading' (duration: 140.05751ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:35.671216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.948583ms","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-06-05T18:04:35.671402Z","caller":"traceutil/trace.go:171","msg":"trace[1092353046] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:841; }","duration":"141.260431ms","start":"2026-06-05T18:04:35.530124Z","end":"2026-06-05T18:04:35.671384Z","steps":["trace[1092353046] 'agreement among raft nodes before linearized reading' (duration: 140.732417ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:35.671702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.965578ms","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-06-05T18:04:35.671763Z","caller":"traceutil/trace.go:171","msg":"trace[1795920194] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:841; }","duration":"148.0686ms","start":"2026-06-05T18:04:35.523685Z","end":"2026-06-05T18:04:35.671753Z","steps":["trace[1795920194] 'agreement among raft nodes before linearized reading' (duration: 146.992472ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:04:35.671881Z","caller":"traceutil/trace.go:171","msg":"trace[1754794385] transaction","detail":"{read_only:false; response_revision:841; number_of_response:1; }","duration":"153.539843ms","start":"2026-06-05T18:04:35.518324Z","end":"2026-06-05T18:04:35.671864Z","steps":["trace[1754794385] 'process raft request' (duration: 152.228439ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:04:36.053222Z","caller":"traceutil/trace.go:171","msg":"trace[1387273831] linearizableReadLoop","detail":"{readStateIndex:892; appliedIndex:890; }","duration":"110.663089ms","start":"2026-06-05T18:04:35.942539Z","end":"2026-06-05T18:04:36.053202Z","steps":["trace[1387273831] 'read index received' (duration: 29.337758ms)","trace[1387273831] 'applied index is now lower than readState.Index' (duration: 81.324441ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T18:04:36.053653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.118021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-06-05T18:04:36.053698Z","caller":"traceutil/trace.go:171","msg":"trace[1305911504] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:864; }","duration":"111.220154ms","start":"2026-06-05T18:04:35.942465Z","end":"2026-06-05T18:04:36.053686Z","steps":["trace[1305911504] 'agreement among raft nodes before linearized reading' (duration: 111.130882ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:36.053674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.09559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-vzgg8\" ","response":"range_response_count:1 size:4495"} {"level":"info","ts":"2026-06-05T18:04:36.053853Z","caller":"traceutil/trace.go:171","msg":"trace[967668598] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-vzgg8; range_end:; response_count:1; response_revision:864; }","duration":"111.314957ms","start":"2026-06-05T18:04:35.942517Z","end":"2026-06-05T18:04:36.053832Z","steps":["trace[967668598] 'agreement among raft nodes before linearized reading' (duration: 110.866775ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:04:36.05411Z","caller":"traceutil/trace.go:171","msg":"trace[788089119] transaction","detail":"{read_only:false; response_revision:863; number_of_response:1; }","duration":"111.642776ms","start":"2026-06-05T18:04:35.942457Z","end":"2026-06-05T18:04:36.0541Z","steps":["trace[788089119] 'process raft request' (duration: 110.660209ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:04:36.054229Z","caller":"traceutil/trace.go:171","msg":"trace[649748588] transaction","detail":"{read_only:false; response_revision:864; number_of_response:1; }","duration":"111.521821ms","start":"2026-06-05T18:04:35.942693Z","end":"2026-06-05T18:04:36.054214Z","steps":["trace[649748588] 'process raft request' (duration: 110.478035ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:04:36.053236Z","caller":"traceutil/trace.go:171","msg":"trace[2073421841] transaction","detail":"{read_only:false; response_revision:862; number_of_response:1; }","duration":"110.773803ms","start":"2026-06-05T18:04:35.942425Z","end":"2026-06-05T18:04:36.053199Z","steps":["trace[2073421841] 'process raft request' (duration: 29.512264ms)","trace[2073421841] 'compare' (duration: 81.054543ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T18:04:36.288192Z","caller":"traceutil/trace.go:171","msg":"trace[1768753229] transaction","detail":"{read_only:false; response_revision:865; number_of_response:1; }","duration":"224.05744ms","start":"2026-06-05T18:04:36.064102Z","end":"2026-06-05T18:04:36.28816Z","steps":["trace[1768753229] 'process raft request' (duration: 145.506373ms)","trace[1768753229] 'compare' (duration: 78.401674ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T18:04:36.318144Z","caller":"traceutil/trace.go:171","msg":"trace[168992330] linearizableReadLoop","detail":"{readStateIndex:895; appliedIndex:893; }","duration":"219.089661ms","start":"2026-06-05T18:04:36.099028Z","end":"2026-06-05T18:04:36.318117Z","steps":["trace[168992330] 'read index received' (duration: 110.607298ms)","trace[168992330] 'applied index is now lower than readState.Index' (duration: 108.481263ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T18:04:36.318213Z","caller":"traceutil/trace.go:171","msg":"trace[1296717430] transaction","detail":"{read_only:false; response_revision:866; number_of_response:1; }","duration":"254.072447ms","start":"2026-06-05T18:04:36.064109Z","end":"2026-06-05T18:04:36.318182Z","steps":["trace[1296717430] 'process raft request' (duration: 253.827521ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:36.318455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.393928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-06-05T18:04:36.318562Z","caller":"traceutil/trace.go:171","msg":"trace[1135561719] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway; range_end:; response_count:1; response_revision:866; }","duration":"219.545763ms","start":"2026-06-05T18:04:36.098981Z","end":"2026-06-05T18:04:36.318527Z","steps":["trace[1135561719] 'agreement among raft nodes before linearized reading' (duration: 219.304406ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:04:36.429642Z","caller":"traceutil/trace.go:171","msg":"trace[851606400] linearizableReadLoop","detail":"{readStateIndex:896; appliedIndex:895; }","duration":"109.827707ms","start":"2026-06-05T18:04:36.319788Z","end":"2026-06-05T18:04:36.429616Z","steps":["trace[851606400] 'read index received' (duration: 107.475256ms)","trace[851606400] 'applied index is now lower than readState.Index' (duration: 2.351451ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T18:04:36.429738Z","caller":"traceutil/trace.go:171","msg":"trace[1413971145] transaction","detail":"{read_only:false; response_revision:867; number_of_response:1; }","duration":"160.294969ms","start":"2026-06-05T18:04:36.269405Z","end":"2026-06-05T18:04:36.4297Z","steps":["trace[1413971145] 'process raft request' (duration: 158.578345ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:36.429854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.040243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-vzgg8\" ","response":"range_response_count:1 size:5393"} {"level":"info","ts":"2026-06-05T18:04:36.429904Z","caller":"traceutil/trace.go:171","msg":"trace[1289638952] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-vzgg8; range_end:; response_count:1; response_revision:867; }","duration":"110.148006ms","start":"2026-06-05T18:04:36.319743Z","end":"2026-06-05T18:04:36.429891Z","steps":["trace[1289638952] 'agreement among raft nodes before linearized reading' (duration: 109.971671ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:36.680552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.051757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:5 size:1050264"} {"level":"info","ts":"2026-06-05T18:04:36.680665Z","caller":"traceutil/trace.go:171","msg":"trace[1548645076] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:5; response_revision:867; }","duration":"104.267792ms","start":"2026-06-05T18:04:36.576375Z","end":"2026-06-05T18:04:36.680643Z","steps":["trace[1548645076] 'range keys from in-memory index tree' (duration: 103.024219ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:04:38.19625Z","caller":"traceutil/trace.go:171","msg":"trace[1305838437] transaction","detail":"{read_only:false; response_revision:883; number_of_response:1; }","duration":"128.198718ms","start":"2026-06-05T18:04:38.06802Z","end":"2026-06-05T18:04:38.196219Z","steps":["trace[1305838437] 'process raft request' (duration: 127.917ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:04:38.383355Z","caller":"traceutil/trace.go:171","msg":"trace[1807598357] transaction","detail":"{read_only:false; response_revision:885; number_of_response:1; }","duration":"178.299431ms","start":"2026-06-05T18:04:38.205033Z","end":"2026-06-05T18:04:38.383332Z","steps":["trace[1807598357] 'process raft request' (duration: 167.825107ms)","trace[1807598357] 'compare' (duration: 10.159515ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T18:04:43.822288Z","caller":"traceutil/trace.go:171","msg":"trace[656591336] linearizableReadLoop","detail":"{readStateIndex:969; appliedIndex:968; }","duration":"103.574213ms","start":"2026-06-05T18:04:43.71869Z","end":"2026-06-05T18:04:43.822264Z","steps":["trace[656591336] 'read index received' (duration: 103.43688ms)","trace[656591336] 'applied index is now lower than readState.Index' (duration: 136.393µs)"],"step_count":2} {"level":"info","ts":"2026-06-05T18:04:43.822671Z","caller":"traceutil/trace.go:171","msg":"trace[1350086193] transaction","detail":"{read_only:false; response_revision:939; number_of_response:1; }","duration":"107.213649ms","start":"2026-06-05T18:04:43.715362Z","end":"2026-06-05T18:04:43.822576Z","steps":["trace[1350086193] 'process raft request' (duration: 106.763258ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:43.822916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.848412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-05T18:04:43.823015Z","caller":"traceutil/trace.go:171","msg":"trace[2062932718] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:939; }","duration":"103.976264ms","start":"2026-06-05T18:04:43.719015Z","end":"2026-06-05T18:04:43.822992Z","steps":["trace[2062932718] 'agreement among raft nodes before linearized reading' (duration: 103.702126ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:43.823871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.170725ms","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-06-05T18:04:43.824074Z","caller":"traceutil/trace.go:171","msg":"trace[901739969] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:939; }","duration":"105.422572ms","start":"2026-06-05T18:04:43.718637Z","end":"2026-06-05T18:04:43.82406Z","steps":["trace[901739969] 'agreement among raft nodes before linearized reading' (duration: 104.301483ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:04:52.094095Z","caller":"traceutil/trace.go:171","msg":"trace[2049588772] transaction","detail":"{read_only:false; response_revision:976; number_of_response:1; }","duration":"142.733709ms","start":"2026-06-05T18:04:51.951327Z","end":"2026-06-05T18:04:52.094061Z","steps":["trace[2049588772] 'process raft request' (duration: 82.891542ms)","trace[2049588772] 'compare' (duration: 59.719174ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T18:04:52.094908Z","caller":"traceutil/trace.go:171","msg":"trace[414104152] linearizableReadLoop","detail":"{readStateIndex:1010; appliedIndex:1008; }","duration":"120.358704ms","start":"2026-06-05T18:04:51.974523Z","end":"2026-06-05T18:04:52.094881Z","steps":["trace[414104152] 'read index received' (duration: 59.771947ms)","trace[414104152] 'applied index is now lower than readState.Index' (duration: 60.585707ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T18:04:52.095049Z","caller":"traceutil/trace.go:171","msg":"trace[421986010] transaction","detail":"{read_only:false; response_revision:977; number_of_response:1; }","duration":"142.37397ms","start":"2026-06-05T18:04:51.952649Z","end":"2026-06-05T18:04:52.095023Z","steps":["trace[421986010] 'process raft request' (duration: 142.060962ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:52.095436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.899318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-05T18:04:52.095534Z","caller":"traceutil/trace.go:171","msg":"trace[1070564686] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:977; }","duration":"121.052181ms","start":"2026-06-05T18:04:51.974468Z","end":"2026-06-05T18:04:52.09552Z","steps":["trace[1070564686] 'agreement among raft nodes before linearized reading' (duration: 120.779125ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:04:52.095462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.359395ms","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-06-05T18:04:52.095855Z","caller":"traceutil/trace.go:171","msg":"trace[220289257] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:977; }","duration":"114.799197ms","start":"2026-06-05T18:04:51.981044Z","end":"2026-06-05T18:04:52.095843Z","steps":["trace[220289257] 'agreement among raft nodes before linearized reading' (duration: 114.283354ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:05:07.957663Z","caller":"traceutil/trace.go:171","msg":"trace[1787365680] transaction","detail":"{read_only:false; response_revision:1033; number_of_response:1; }","duration":"426.517494ms","start":"2026-06-05T18:05:07.531122Z","end":"2026-06-05T18:05:07.95764Z","steps":["trace[1787365680] 'process raft request' (duration: 426.3422ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:05:07.957792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:05:07.531104Z","time spent":"426.610877ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T18:05:07.957803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.617713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T18:05:07.957902Z","caller":"traceutil/trace.go:171","msg":"trace[1925658549] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:1033; }","duration":"419.777578ms","start":"2026-06-05T18:05:07.538112Z","end":"2026-06-05T18:05:07.95789Z","steps":["trace[1925658549] 'agreement among raft nodes before linearized reading' (duration: 419.627724ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:05:07.95801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:05:07.538091Z","time spent":"419.890932ms","remote":"127.0.0.1:54444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":29,"request content":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true "} {"level":"info","ts":"2026-06-05T18:05:07.957684Z","caller":"traceutil/trace.go:171","msg":"trace[691445761] linearizableReadLoop","detail":"{readStateIndex:1070; appliedIndex:1069; }","duration":"419.445749ms","start":"2026-06-05T18:05:07.538166Z","end":"2026-06-05T18:05:07.957611Z","steps":["trace[691445761] 'read index received' (duration: 419.237314ms)","trace[691445761] 'applied index is now lower than readState.Index' (duration: 204.595µs)"],"step_count":2} {"level":"warn","ts":"2026-06-05T18:05:07.958646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.271581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T18:05:07.958695Z","caller":"traceutil/trace.go:171","msg":"trace[280031253] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1033; }","duration":"278.384954ms","start":"2026-06-05T18:05:07.680292Z","end":"2026-06-05T18:05:07.958677Z","steps":["trace[280031253] 'agreement among raft nodes before linearized reading' (duration: 278.267491ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:05:07.958838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.328612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-05T18:05:07.958876Z","caller":"traceutil/trace.go:171","msg":"trace[1870918223] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1033; }","duration":"228.412784ms","start":"2026-06-05T18:05:07.730449Z","end":"2026-06-05T18:05:07.958862Z","steps":["trace[1870918223] 'agreement among raft nodes before linearized reading' (duration: 228.332692ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:05:08.224322Z","caller":"traceutil/trace.go:171","msg":"trace[486111976] transaction","detail":"{read_only:false; response_revision:1034; number_of_response:1; }","duration":"244.913297ms","start":"2026-06-05T18:05:07.97938Z","end":"2026-06-05T18:05:08.224293Z","steps":["trace[486111976] 'process raft request' (duration: 242.953715ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:05:10.150212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.996633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-05T18:05:10.150287Z","caller":"traceutil/trace.go:171","msg":"trace[1203027590] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:1039; }","duration":"107.128306ms","start":"2026-06-05T18:05:10.043143Z","end":"2026-06-05T18:05:10.150271Z","steps":["trace[1203027590] 'count revisions from in-memory index tree' (duration: 106.879221ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:05:12.412654Z","caller":"traceutil/trace.go:171","msg":"trace[984592548] transaction","detail":"{read_only:false; response_revision:1049; number_of_response:1; }","duration":"142.844922ms","start":"2026-06-05T18:05:12.269783Z","end":"2026-06-05T18:05:12.412628Z","steps":["trace[984592548] 'process raft request' (duration: 142.707938ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:05:12.414656Z","caller":"traceutil/trace.go:171","msg":"trace[1951360777] transaction","detail":"{read_only:false; response_revision:1050; number_of_response:1; }","duration":"144.815884ms","start":"2026-06-05T18:05:12.26982Z","end":"2026-06-05T18:05:12.414636Z","steps":["trace[1951360777] 'process raft request' (duration: 144.71921ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:05:24.736299Z","caller":"traceutil/trace.go:171","msg":"trace[1491403868] transaction","detail":"{read_only:false; response_revision:1090; number_of_response:1; }","duration":"108.514733ms","start":"2026-06-05T18:05:24.627698Z","end":"2026-06-05T18:05:24.736213Z","steps":["trace[1491403868] 'process raft request' (duration: 103.085002ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:05:30.532139Z","caller":"traceutil/trace.go:171","msg":"trace[1685051294] transaction","detail":"{read_only:false; response_revision:1107; number_of_response:1; }","duration":"139.370591ms","start":"2026-06-05T18:05:30.392739Z","end":"2026-06-05T18:05:30.532109Z","steps":["trace[1685051294] 'process raft request' (duration: 139.202647ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:05:30.549445Z","caller":"traceutil/trace.go:171","msg":"trace[1168004058] transaction","detail":"{read_only:false; response_revision:1108; number_of_response:1; }","duration":"153.626595ms","start":"2026-06-05T18:05:30.3958Z","end":"2026-06-05T18:05:30.549426Z","steps":["trace[1168004058] 'process raft request' (duration: 153.533453ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:05:34.659624Z","caller":"traceutil/trace.go:171","msg":"trace[1080733898] linearizableReadLoop","detail":"{readStateIndex:1160; appliedIndex:1159; }","duration":"277.989734ms","start":"2026-06-05T18:05:34.381616Z","end":"2026-06-05T18:05:34.659606Z","steps":["trace[1080733898] 'read index received' (duration: 277.861981ms)","trace[1080733898] 'applied index is now lower than readState.Index' (duration: 126.693µs)"],"step_count":2} {"level":"info","ts":"2026-06-05T18:05:34.659651Z","caller":"traceutil/trace.go:171","msg":"trace[1431943045] transaction","detail":"{read_only:false; response_revision:1118; number_of_response:1; }","duration":"559.924721ms","start":"2026-06-05T18:05:34.099715Z","end":"2026-06-05T18:05:34.659639Z","steps":["trace[1431943045] 'process raft request' (duration: 559.776867ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:05:34.659734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:05:34.099694Z","time spent":"559.987102ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T18:05:34.659764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.227789ms","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":"info","ts":"2026-06-05T18:05:34.659798Z","caller":"traceutil/trace.go:171","msg":"trace[1902536652] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:1118; }","duration":"252.303741ms","start":"2026-06-05T18:05:34.407484Z","end":"2026-06-05T18:05:34.659788Z","steps":["trace[1902536652] 'agreement among raft nodes before linearized reading' (duration: 252.243619ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:05:34.659807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.183759ms","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-06-05T18:05:34.659838Z","caller":"traceutil/trace.go:171","msg":"trace[1799780925] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1118; }","duration":"278.249941ms","start":"2026-06-05T18:05:34.381577Z","end":"2026-06-05T18:05:34.659827Z","steps":["trace[1799780925] 'agreement among raft nodes before linearized reading' (duration: 278.115627ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:05:34.659853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.109582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-05T18:05:34.659867Z","caller":"traceutil/trace.go:171","msg":"trace[1535092048] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1118; }","duration":"116.161673ms","start":"2026-06-05T18:05:34.543701Z","end":"2026-06-05T18:05:34.659862Z","steps":["trace[1535092048] 'agreement among raft nodes before linearized reading' (duration: 116.118132ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:05:34.659951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.073968ms","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-06-05T18:05:34.660023Z","caller":"traceutil/trace.go:171","msg":"trace[877004841] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1118; }","duration":"101.221391ms","start":"2026-06-05T18:05:34.558784Z","end":"2026-06-05T18:05:34.660005Z","steps":["trace[877004841] 'agreement among raft nodes before linearized reading' (duration: 101.002206ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:05:35.812905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"997.332413ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-05T18:05:35.813138Z","caller":"traceutil/trace.go:171","msg":"trace[2025966724] transaction","detail":"{read_only:false; response_revision:1119; number_of_response:1; }","duration":"1.149255963s","start":"2026-06-05T18:05:34.663846Z","end":"2026-06-05T18:05:35.813102Z","steps":["trace[2025966724] 'process raft request' (duration: 151.625362ms)","trace[2025966724] 'compare' (duration: 996.82121ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T18:05:35.813225Z","caller":"traceutil/trace.go:171","msg":"trace[1969034612] transaction","detail":"{read_only:false; response_revision:1120; number_of_response:1; }","duration":"1.149193493s","start":"2026-06-05T18:05:34.66401Z","end":"2026-06-05T18:05:35.813204Z","steps":["trace[1969034612] 'process raft request' (duration: 1.149044048s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:05:35.813311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:05:34.663986Z","time spent":"1.149282765s","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T18:05:35.813323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:05:34.663831Z","time spent":"1.149391518s","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T18:05:35.813414Z","caller":"traceutil/trace.go:171","msg":"trace[277185929] linearizableReadLoop","detail":"{readStateIndex:1163; appliedIndex:1160; }","duration":"1.059349068s","start":"2026-06-05T18:05:34.754048Z","end":"2026-06-05T18:05:35.813397Z","steps":["trace[277185929] 'read index received' (duration: 61.437659ms)","trace[277185929] 'applied index is now lower than readState.Index' (duration: 997.910479ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T18:05:35.813529Z","caller":"traceutil/trace.go:171","msg":"trace[304561137] transaction","detail":"{read_only:false; response_revision:1121; number_of_response:1; }","duration":"1.14911695s","start":"2026-06-05T18:05:34.664395Z","end":"2026-06-05T18:05:35.813512Z","steps":["trace[304561137] 'process raft request' (duration: 1.148765501s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:05:35.813637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:05:34.664366Z","time spent":"1.149204042s","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T18:05:35.81375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.018167119s","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-06-05T18:05:35.813797Z","caller":"traceutil/trace.go:171","msg":"trace[2098086140] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1121; }","duration":"1.018238761s","start":"2026-06-05T18:05:34.795546Z","end":"2026-06-05T18:05:35.813785Z","steps":["trace[2098086140] 'agreement among raft nodes before linearized reading' (duration: 1.018105298s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:05:35.813837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:05:34.795533Z","time spent":"1.018291652s","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-05T18:05:35.813926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.059870382s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-05T18:05:35.81397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"902.607032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T18:05:35.813983Z","caller":"traceutil/trace.go:171","msg":"trace[585658923] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1121; }","duration":"1.059969455s","start":"2026-06-05T18:05:34.753995Z","end":"2026-06-05T18:05:35.813965Z","steps":["trace[585658923] 'agreement among raft nodes before linearized reading' (duration: 1.059796879s)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:05:35.814004Z","caller":"traceutil/trace.go:171","msg":"trace[2110048833] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1121; }","duration":"902.659623ms","start":"2026-06-05T18:05:34.911333Z","end":"2026-06-05T18:05:35.813992Z","steps":["trace[2110048833] 'agreement among raft nodes before linearized reading' (duration: 902.608662ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:05:35.81403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:05:34.753975Z","time spent":"1.060042616s","remote":"127.0.0.1:54400","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-06-05T18:05:35.814043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:05:34.911316Z","time spent":"902.714925ms","remote":"127.0.0.1:54096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-05T18:05:36.326815Z","caller":"traceutil/trace.go:171","msg":"trace[1449440950] transaction","detail":"{read_only:false; response_revision:1124; number_of_response:1; }","duration":"320.588215ms","start":"2026-06-05T18:05:36.006201Z","end":"2026-06-05T18:05:36.326789Z","steps":["trace[1449440950] 'process raft request' (duration: 305.475537ms)","trace[1449440950] 'compare' (duration: 14.785219ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T18:05:36.326935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:05:36.006187Z","time spent":"320.687167ms","remote":"127.0.0.1:54124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T18:05:36.698216Z","caller":"traceutil/trace.go:171","msg":"trace[112032473] transaction","detail":"{read_only:false; response_revision:1125; number_of_response:1; }","duration":"226.809151ms","start":"2026-06-05T18:05:36.471368Z","end":"2026-06-05T18:05:36.698177Z","steps":["trace[112032473] 'process raft request' (duration: 178.685272ms)","trace[112032473] 'compare' (duration: 47.961734ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T18:05:38.085387Z","caller":"traceutil/trace.go:171","msg":"trace[1012189618] transaction","detail":"{read_only:false; response_revision:1127; number_of_response:1; }","duration":"262.80114ms","start":"2026-06-05T18:05:37.822567Z","end":"2026-06-05T18:05:38.085368Z","steps":["trace[1012189618] 'process raft request' (duration: 262.679427ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:05:38.470658Z","caller":"traceutil/trace.go:171","msg":"trace[1367870577] transaction","detail":"{read_only:false; response_revision:1128; number_of_response:1; }","duration":"647.786993ms","start":"2026-06-05T18:05:37.822822Z","end":"2026-06-05T18:05:38.470609Z","steps":["trace[1367870577] 'process raft request' (duration: 626.288576ms)","trace[1367870577] 'compare' (duration: 21.200029ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T18:05:38.470851Z","caller":"traceutil/trace.go:171","msg":"trace[1625253481] linearizableReadLoop","detail":"{readStateIndex:1172; appliedIndex:1169; }","duration":"611.441115ms","start":"2026-06-05T18:05:37.859377Z","end":"2026-06-05T18:05:38.470818Z","steps":["trace[1625253481] 'read index received' (duration: 225.804415ms)","trace[1625253481] 'applied index is now lower than readState.Index' (duration: 385.63535ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T18:05:38.47087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:05:37.822784Z","time spent":"647.950117ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T18:05:38.470974Z","caller":"traceutil/trace.go:171","msg":"trace[1101766569] transaction","detail":"{read_only:false; response_revision:1129; number_of_response:1; }","duration":"645.885693ms","start":"2026-06-05T18:05:37.825061Z","end":"2026-06-05T18:05:38.470946Z","steps":["trace[1101766569] 'process raft request' (duration: 645.505453ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:05:38.471135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:05:37.825032Z","time spent":"646.021857ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T18:05:38.471149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"611.748443ms","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-06-05T18:05:38.471186Z","caller":"traceutil/trace.go:171","msg":"trace[1538569375] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1129; }","duration":"611.829185ms","start":"2026-06-05T18:05:37.859343Z","end":"2026-06-05T18:05:38.471172Z","steps":["trace[1538569375] 'agreement among raft nodes before linearized reading' (duration: 611.62048ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:05:38.471205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"596.361097ms","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-06-05T18:05:38.471221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:05:37.859318Z","time spent":"611.895427ms","remote":"127.0.0.1:54400","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-06-05T18:05:38.471252Z","caller":"traceutil/trace.go:171","msg":"trace[1784504750] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1129; }","duration":"596.435769ms","start":"2026-06-05T18:05:37.874803Z","end":"2026-06-05T18:05:38.471239Z","steps":["trace[1784504750] 'agreement among raft nodes before linearized reading' (duration: 596.273545ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:05:38.471295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:05:37.874791Z","time spent":"596.492601ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-05T18:05:40.397608Z","caller":"traceutil/trace.go:171","msg":"trace[872486044] transaction","detail":"{read_only:false; response_revision:1133; number_of_response:1; }","duration":"305.080665ms","start":"2026-06-05T18:05:40.092498Z","end":"2026-06-05T18:05:40.397578Z","steps":["trace[872486044] 'process raft request' (duration: 304.954612ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:05:40.39772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:05:40.092482Z","time spent":"305.182129ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T18:05:40.608785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.773131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-05T18:05:40.608868Z","caller":"traceutil/trace.go:171","msg":"trace[684400895] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1133; }","duration":"132.908595ms","start":"2026-06-05T18:05:40.47594Z","end":"2026-06-05T18:05:40.608849Z","steps":["trace[684400895] 'range keys from in-memory index tree' (duration: 132.581396ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:05:40.608903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.139575ms","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-06-05T18:05:40.608991Z","caller":"traceutil/trace.go:171","msg":"trace[1020799705] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1133; }","duration":"132.282468ms","start":"2026-06-05T18:05:40.476689Z","end":"2026-06-05T18:05:40.608971Z","steps":["trace[1020799705] 'range keys from in-memory index tree' (duration: 131.96937ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:05:46.87354Z","caller":"traceutil/trace.go:171","msg":"trace[1294400830] transaction","detail":"{read_only:false; response_revision:1155; number_of_response:1; }","duration":"121.658598ms","start":"2026-06-05T18:05:46.751859Z","end":"2026-06-05T18:05:46.873518Z","steps":["trace[1294400830] 'process raft request' (duration: 81.550921ms)","trace[1294400830] 'compare' (duration: 40.014655ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T18:05:46.874341Z","caller":"traceutil/trace.go:171","msg":"trace[1313496650] transaction","detail":"{read_only:false; response_revision:1156; number_of_response:1; }","duration":"122.209663ms","start":"2026-06-05T18:05:46.752108Z","end":"2026-06-05T18:05:46.874318Z","steps":["trace[1313496650] 'process raft request' (duration: 121.895106ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:05:46.87438Z","caller":"traceutil/trace.go:171","msg":"trace[1556493250] transaction","detail":"{read_only:false; response_revision:1157; number_of_response:1; }","duration":"122.188222ms","start":"2026-06-05T18:05:46.752179Z","end":"2026-06-05T18:05:46.874367Z","steps":["trace[1556493250] 'process raft request' (duration: 121.907605ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:05:56.344765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:05:55.918338Z","time spent":"426.422236ms","remote":"127.0.0.1:54124","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-06-05T18:05:56.987883Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16702336547826119557,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-05T18:05:57.289818Z","caller":"traceutil/trace.go:171","msg":"trace[1105328515] transaction","detail":"{read_only:false; response_revision:1236; number_of_response:1; }","duration":"943.593723ms","start":"2026-06-05T18:05:56.346207Z","end":"2026-06-05T18:05:57.2898Z","steps":["trace[1105328515] 'process raft request' (duration: 939.802173ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:05:57.290203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:05:56.346178Z","time spent":"943.969554ms","remote":"127.0.0.1:54124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T18:05:57.293952Z","caller":"traceutil/trace.go:171","msg":"trace[1207712027] linearizableReadLoop","detail":"{readStateIndex:1286; appliedIndex:1284; }","duration":"806.632951ms","start":"2026-06-05T18:05:56.487309Z","end":"2026-06-05T18:05:57.293942Z","steps":["trace[1207712027] 'read index received' (duration: 798.859506ms)","trace[1207712027] 'applied index is now lower than readState.Index' (duration: 7.772725ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T18:05:57.294103Z","caller":"traceutil/trace.go:171","msg":"trace[67616283] transaction","detail":"{read_only:false; response_revision:1237; number_of_response:1; }","duration":"382.162218ms","start":"2026-06-05T18:05:56.911933Z","end":"2026-06-05T18:05:57.294096Z","steps":["trace[67616283] 'process raft request' (duration: 381.921162ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:05:57.294145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:05:56.911915Z","time spent":"382.20533ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T18:05:57.29425Z","caller":"traceutil/trace.go:171","msg":"trace[1810394573] transaction","detail":"{read_only:false; response_revision:1238; number_of_response:1; }","duration":"219.5218ms","start":"2026-06-05T18:05:57.07472Z","end":"2026-06-05T18:05:57.294242Z","steps":["trace[1810394573] 'process raft request' (duration: 219.195311ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:05:57.294317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"807.006751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-05T18:05:57.294336Z","caller":"traceutil/trace.go:171","msg":"trace[2107516385] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1238; }","duration":"807.026552ms","start":"2026-06-05T18:05:56.487304Z","end":"2026-06-05T18:05:57.294331Z","steps":["trace[2107516385] 'agreement among raft nodes before linearized reading' (duration: 806.988291ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:05:57.294362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:05:56.487245Z","time spent":"807.101934ms","remote":"127.0.0.1:54296","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":13,"response size":31,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "} {"level":"warn","ts":"2026-06-05T18:05:57.294478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"758.45339ms","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-06-05T18:05:57.294507Z","caller":"traceutil/trace.go:171","msg":"trace[11617849] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1238; }","duration":"758.517933ms","start":"2026-06-05T18:05:56.53598Z","end":"2026-06-05T18:05:57.294498Z","steps":["trace[11617849] 'agreement among raft nodes before linearized reading' (duration: 758.426691ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:05:57.294528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:05:56.53596Z","time spent":"758.562265ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-05T18:05:57.294712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.946716ms","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-06-05T18:05:57.29472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.002768ms","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-06-05T18:05:57.294733Z","caller":"traceutil/trace.go:171","msg":"trace[2058714407] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1238; }","duration":"377.981898ms","start":"2026-06-05T18:05:56.916745Z","end":"2026-06-05T18:05:57.294727Z","steps":["trace[2058714407] 'agreement among raft nodes before linearized reading' (duration: 377.906536ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:05:57.294742Z","caller":"traceutil/trace.go:171","msg":"trace[1240337959] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1238; }","duration":"381.042368ms","start":"2026-06-05T18:05:56.913692Z","end":"2026-06-05T18:05:57.294734Z","steps":["trace[1240337959] 'agreement among raft nodes before linearized reading' (duration: 380.984817ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:05:57.29475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:05:56.916738Z","time spent":"378.007758ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-05T18:05:57.294762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:05:56.913682Z","time spent":"381.075749ms","remote":"127.0.0.1:54400","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-06-05T18:05:57.294828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.029208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-05T18:05:57.294842Z","caller":"traceutil/trace.go:171","msg":"trace[1707373949] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1238; }","duration":"582.07973ms","start":"2026-06-05T18:05:56.712757Z","end":"2026-06-05T18:05:57.294837Z","steps":["trace[1707373949] 'agreement among raft nodes before linearized reading' (duration: 582.038589ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:05:57.294856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:05:56.712729Z","time spent":"582.123591ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-05T18:05:57.294878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.058827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-05T18:05:57.294908Z","caller":"traceutil/trace.go:171","msg":"trace[32820411] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1238; }","duration":"260.1071ms","start":"2026-06-05T18:05:57.034791Z","end":"2026-06-05T18:05:57.294898Z","steps":["trace[32820411] 'agreement among raft nodes before linearized reading' (duration: 260.056368ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:05:57.295037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.633683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T18:05:57.295061Z","caller":"traceutil/trace.go:171","msg":"trace[474063203] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1238; }","duration":"274.698435ms","start":"2026-06-05T18:05:57.020355Z","end":"2026-06-05T18:05:57.295054Z","steps":["trace[474063203] 'agreement among raft nodes before linearized reading' (duration: 274.660154ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:05:57.295151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.266274ms","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-06-05T18:05:57.295171Z","caller":"traceutil/trace.go:171","msg":"trace[78936293] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1238; }","duration":"378.323927ms","start":"2026-06-05T18:05:56.916841Z","end":"2026-06-05T18:05:57.295165Z","steps":["trace[78936293] 'agreement among raft nodes before linearized reading' (duration: 378.269275ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:05:57.295187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:05:56.916823Z","time spent":"378.360768ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-05T18:06:06.152173Z","caller":"traceutil/trace.go:171","msg":"trace[560651560] transaction","detail":"{read_only:false; response_revision:1269; number_of_response:1; }","duration":"209.582046ms","start":"2026-06-05T18:06:05.942565Z","end":"2026-06-05T18:06:06.152147Z","steps":["trace[560651560] 'process raft request' (duration: 136.288204ms)","trace[560651560] 'compare' (duration: 73.17579ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T18:06:07.475357Z","caller":"traceutil/trace.go:171","msg":"trace[316241884] transaction","detail":"{read_only:false; response_revision:1272; number_of_response:1; }","duration":"120.028334ms","start":"2026-06-05T18:06:07.35531Z","end":"2026-06-05T18:06:07.475338Z","steps":["trace[316241884] 'process raft request' (duration: 118.405262ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:06:07.475367Z","caller":"traceutil/trace.go:171","msg":"trace[382150022] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"119.191133ms","start":"2026-06-05T18:06:07.356157Z","end":"2026-06-05T18:06:07.475348Z","steps":["trace[382150022] 'process raft request' (duration: 119.121131ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:06:07.47565Z","caller":"traceutil/trace.go:171","msg":"trace[345431790] transaction","detail":"{read_only:false; response_revision:1274; number_of_response:1; }","duration":"119.433939ms","start":"2026-06-05T18:06:07.356199Z","end":"2026-06-05T18:06:07.475633Z","steps":["trace[345431790] 'process raft request' (duration: 119.119701ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:06:07.475712Z","caller":"traceutil/trace.go:171","msg":"trace[523737352] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"118.866395ms","start":"2026-06-05T18:06:07.356825Z","end":"2026-06-05T18:06:07.475692Z","steps":["trace[523737352] 'process raft request' (duration: 118.68741ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:06:14.710203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"793.621748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T18:06:14.710289Z","caller":"traceutil/trace.go:171","msg":"trace[1041984752] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1315; }","duration":"793.749712ms","start":"2026-06-05T18:06:13.91652Z","end":"2026-06-05T18:06:14.710269Z","steps":["trace[1041984752] 'range keys from in-memory index tree' (duration: 793.561036ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:06:14.710333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:06:13.916507Z","time spent":"793.817014ms","remote":"127.0.0.1:54096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-05T18:06:14.710338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.561131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T18:06:14.710379Z","caller":"traceutil/trace.go:171","msg":"trace[446828313] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1315; }","duration":"527.633824ms","start":"2026-06-05T18:06:14.182731Z","end":"2026-06-05T18:06:14.710365Z","steps":["trace[446828313] 'count revisions from in-memory index tree' (duration: 527.514311ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:06:14.710425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:06:14.182714Z","time spent":"527.702015ms","remote":"127.0.0.1:45740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"info","ts":"2026-06-05T18:06:15.679235Z","caller":"traceutil/trace.go:171","msg":"trace[1951026785] linearizableReadLoop","detail":"{readStateIndex:1368; appliedIndex:1367; }","duration":"227.52762ms","start":"2026-06-05T18:06:15.451692Z","end":"2026-06-05T18:06:15.67922Z","steps":["trace[1951026785] 'read index received' (duration: 227.402947ms)","trace[1951026785] 'applied index is now lower than readState.Index' (duration: 124.153µs)"],"step_count":2} {"level":"info","ts":"2026-06-05T18:06:15.679404Z","caller":"traceutil/trace.go:171","msg":"trace[2061733920] transaction","detail":"{read_only:false; response_revision:1316; number_of_response:1; }","duration":"303.156965ms","start":"2026-06-05T18:06:15.376241Z","end":"2026-06-05T18:06:15.679398Z","steps":["trace[2061733920] 'process raft request' (duration: 302.892928ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:06:15.679466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:06:15.376203Z","time spent":"303.216407ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T18:06:15.67961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.935462ms","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-06-05T18:06:15.679625Z","caller":"traceutil/trace.go:171","msg":"trace[1597340320] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1316; }","duration":"227.986852ms","start":"2026-06-05T18:06:15.451634Z","end":"2026-06-05T18:06:15.679621Z","steps":["trace[1597340320] 'agreement among raft nodes before linearized reading' (duration: 227.92249ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:06:15.679712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.145421ms","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-06-05T18:06:15.679724Z","caller":"traceutil/trace.go:171","msg":"trace[1583204063] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1316; }","duration":"177.207412ms","start":"2026-06-05T18:06:15.502513Z","end":"2026-06-05T18:06:15.679721Z","steps":["trace[1583204063] 'agreement among raft nodes before linearized reading' (duration: 177.170331ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:06:15.679923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.199881ms","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-06-05T18:06:15.679937Z","caller":"traceutil/trace.go:171","msg":"trace[1503508321] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1316; }","duration":"172.222122ms","start":"2026-06-05T18:06:15.507711Z","end":"2026-06-05T18:06:15.679933Z","steps":["trace[1503508321] 'agreement among raft nodes before linearized reading' (duration: 172.182081ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:06:15.680018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.341035ms","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-06-05T18:06:15.680033Z","caller":"traceutil/trace.go:171","msg":"trace[820192306] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1316; }","duration":"172.376745ms","start":"2026-06-05T18:06:15.507652Z","end":"2026-06-05T18:06:15.680029Z","steps":["trace[820192306] 'agreement among raft nodes before linearized reading' (duration: 172.339264ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:06:15.680111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.516459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-05T18:06:15.680123Z","caller":"traceutil/trace.go:171","msg":"trace[199713841] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1316; }","duration":"175.528189ms","start":"2026-06-05T18:06:15.504591Z","end":"2026-06-05T18:06:15.680119Z","steps":["trace[199713841] 'agreement among raft nodes before linearized reading' (duration: 175.490777ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:06:15.891553Z","caller":"traceutil/trace.go:171","msg":"trace[1922011468] transaction","detail":"{read_only:false; response_revision:1318; number_of_response:1; }","duration":"204.681648ms","start":"2026-06-05T18:06:15.686834Z","end":"2026-06-05T18:06:15.891516Z","steps":["trace[1922011468] 'process raft request' (duration: 204.474132ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:06:15.891647Z","caller":"traceutil/trace.go:171","msg":"trace[1701983020] transaction","detail":"{read_only:false; response_revision:1321; number_of_response:1; }","duration":"203.139088ms","start":"2026-06-05T18:06:15.688441Z","end":"2026-06-05T18:06:15.89158Z","steps":["trace[1701983020] 'process raft request' (duration: 203.083056ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:06:15.891864Z","caller":"traceutil/trace.go:171","msg":"trace[2909597] transaction","detail":"{read_only:false; response_revision:1319; number_of_response:1; }","duration":"204.275947ms","start":"2026-06-05T18:06:15.687579Z","end":"2026-06-05T18:06:15.891855Z","steps":["trace[2909597] 'process raft request' (duration: 203.848295ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:06:15.891945Z","caller":"traceutil/trace.go:171","msg":"trace[722657447] transaction","detail":"{read_only:false; response_revision:1320; number_of_response:1; }","duration":"204.261007ms","start":"2026-06-05T18:06:15.687679Z","end":"2026-06-05T18:06:15.89194Z","steps":["trace[722657447] 'process raft request' (duration: 203.774694ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:06:16.738893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.991791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-05T18:06:16.738991Z","caller":"traceutil/trace.go:171","msg":"trace[1742599282] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1323; }","duration":"424.150455ms","start":"2026-06-05T18:06:16.314818Z","end":"2026-06-05T18:06:16.738968Z","steps":["trace[1742599282] 'count revisions from in-memory index tree' (duration: 423.902039ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:06:16.739046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:06:16.314798Z","time spent":"424.231397ms","remote":"127.0.0.1:54454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":17,"response size":31,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "} {"level":"warn","ts":"2026-06-05T18:06:18.130727Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16702336547826119760,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-05T18:06:18.631012Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16702336547826119760,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-05T18:06:18.676123Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.049526186s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-05T18:06:18.8017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.214842ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-05T18:06:18.801822Z","caller":"traceutil/trace.go:171","msg":"trace[2129453885] transaction","detail":"{read_only:false; response_revision:1328; number_of_response:1; }","duration":"1.186607261s","start":"2026-06-05T18:06:17.615179Z","end":"2026-06-05T18:06:18.801786Z","steps":["trace[2129453885] 'process raft request' (duration: 1.061237135s)","trace[2129453885] 'compare' (duration: 125.035068ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T18:06:18.801876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:06:17.61516Z","time spent":"1.186692465s","remote":"127.0.0.1:54174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":836,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-05T18:06:18.812972Z","caller":"traceutil/trace.go:171","msg":"trace[451012538] linearizableReadLoop","detail":"{readStateIndex:1383; appliedIndex:1380; }","duration":"1.182675058s","start":"2026-06-05T18:06:17.630284Z","end":"2026-06-05T18:06:18.812959Z","steps":["trace[451012538] 'read index received' (duration: 1.046143677s)","trace[451012538] 'applied index is now lower than readState.Index' (duration: 136.530771ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T18:06:18.81304Z","caller":"traceutil/trace.go:171","msg":"trace[651029504] transaction","detail":"{read_only:false; response_revision:1330; number_of_response:1; }","duration":"1.126564749s","start":"2026-06-05T18:06:17.686468Z","end":"2026-06-05T18:06:18.813032Z","steps":["trace[651029504] 'process raft request' (duration: 1.126446025s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:06:18.813127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:06:17.686447Z","time spent":"1.1266152s","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T18:06:18.813275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.101409955s","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-06-05T18:06:18.813338Z","caller":"traceutil/trace.go:171","msg":"trace[277766905] transaction","detail":"{read_only:false; response_revision:1329; number_of_response:1; }","duration":"1.180885021s","start":"2026-06-05T18:06:17.632432Z","end":"2026-06-05T18:06:18.813317Z","steps":["trace[277766905] 'process raft request' (duration: 1.180416909s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:06:18.813366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"916.370476ms","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-06-05T18:06:18.813384Z","caller":"traceutil/trace.go:171","msg":"trace[487142707] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1330; }","duration":"1.101564659s","start":"2026-06-05T18:06:17.711798Z","end":"2026-06-05T18:06:18.813362Z","steps":["trace[487142707] 'agreement among raft nodes before linearized reading' (duration: 1.101316112s)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:06:18.813405Z","caller":"traceutil/trace.go:171","msg":"trace[686814764] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1330; }","duration":"916.444027ms","start":"2026-06-05T18:06:17.896951Z","end":"2026-06-05T18:06:18.813395Z","steps":["trace[686814764] 'agreement among raft nodes before linearized reading' (duration: 916.296744ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:06:18.813426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:06:17.632421Z","time spent":"1.180958593s","remote":"127.0.0.1:54174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":773,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-05T18:06:18.813435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:06:17.711779Z","time spent":"1.101642471s","remote":"127.0.0.1:54400","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-06-05T18:06:18.813508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.183224782s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-06-05T18:06:18.813534Z","caller":"traceutil/trace.go:171","msg":"trace[943193880] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1330; }","duration":"1.183248403s","start":"2026-06-05T18:06:17.630279Z","end":"2026-06-05T18:06:18.813527Z","steps":["trace[943193880] 'agreement among raft nodes before linearized reading' (duration: 1.183179751s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:06:18.813557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:06:17.63024Z","time spent":"1.183311834s","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":498,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-06-05T18:06:18.81344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:06:17.896945Z","time spent":"916.488028ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-05T18:06:18.813641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.614588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T18:06:18.813667Z","caller":"traceutil/trace.go:171","msg":"trace[257865321] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1330; }","duration":"443.68646ms","start":"2026-06-05T18:06:18.369971Z","end":"2026-06-05T18:06:18.813657Z","steps":["trace[257865321] 'agreement among raft nodes before linearized reading' (duration: 443.650009ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:06:18.813692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:06:18.369947Z","time spent":"443.738251ms","remote":"127.0.0.1:54350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":29,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"warn","ts":"2026-06-05T18:06:18.813804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"917.584877ms","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-06-05T18:06:18.813839Z","caller":"traceutil/trace.go:171","msg":"trace[1126328045] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1330; }","duration":"917.636809ms","start":"2026-06-05T18:06:17.896192Z","end":"2026-06-05T18:06:18.813829Z","steps":["trace[1126328045] 'agreement among raft nodes before linearized reading' (duration: 917.543537ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:06:18.813866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:06:17.896186Z","time spent":"917.67395ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-05T18:06:18.813973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"918.102182ms","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-06-05T18:06:18.813996Z","caller":"traceutil/trace.go:171","msg":"trace[2076704267] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1330; }","duration":"918.136332ms","start":"2026-06-05T18:06:17.895852Z","end":"2026-06-05T18:06:18.813988Z","steps":["trace[2076704267] 'agreement among raft nodes before linearized reading' (duration: 918.069791ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:06:18.81402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:06:17.895845Z","time spent":"918.168653ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-05T18:06:18.814068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"918.729127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-05T18:06:18.814116Z","caller":"traceutil/trace.go:171","msg":"trace[1201178706] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1330; }","duration":"918.805179ms","start":"2026-06-05T18:06:17.895297Z","end":"2026-06-05T18:06:18.814102Z","steps":["trace[1201178706] 'agreement among raft nodes before linearized reading' (duration: 918.670636ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:06:18.814155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:06:17.895281Z","time spent":"918.864471ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-05T18:06:19.286714Z","caller":"traceutil/trace.go:171","msg":"trace[1667082927] transaction","detail":"{read_only:false; response_revision:1331; number_of_response:1; }","duration":"467.004905ms","start":"2026-06-05T18:06:18.819693Z","end":"2026-06-05T18:06:19.286698Z","steps":["trace[1667082927] 'process raft request' (duration: 466.917903ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:06:19.286816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:06:18.819673Z","time spent":"467.086397ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T18:06:19.340803Z","caller":"traceutil/trace.go:171","msg":"trace[1351330589] linearizableReadLoop","detail":"{readStateIndex:1389; appliedIndex:1384; }","duration":"503.864307ms","start":"2026-06-05T18:06:18.836919Z","end":"2026-06-05T18:06:19.340783Z","steps":["trace[1351330589] 'read index received' (duration: 449.778931ms)","trace[1351330589] 'applied index is now lower than readState.Index' (duration: 54.084476ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T18:06:19.34109Z","caller":"traceutil/trace.go:171","msg":"trace[1647793937] transaction","detail":"{read_only:false; response_revision:1332; number_of_response:1; }","duration":"520.902206ms","start":"2026-06-05T18:06:18.820176Z","end":"2026-06-05T18:06:19.341078Z","steps":["trace[1647793937] 'process raft request' (duration: 520.377042ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:06:19.341199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:06:18.82015Z","time spent":"520.989499ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T18:06:19.34137Z","caller":"traceutil/trace.go:171","msg":"trace[1267927953] transaction","detail":"{read_only:false; response_revision:1333; number_of_response:1; }","duration":"521.185363ms","start":"2026-06-05T18:06:18.820175Z","end":"2026-06-05T18:06:19.341361Z","steps":["trace[1267927953] 'process raft request' (duration: 520.482955ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:06:19.341433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:06:18.820159Z","time spent":"521.245635ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T18:06:19.341558Z","caller":"traceutil/trace.go:171","msg":"trace[1225038210] transaction","detail":"{read_only:false; response_revision:1334; number_of_response:1; }","duration":"521.353008ms","start":"2026-06-05T18:06:18.820197Z","end":"2026-06-05T18:06:19.34155Z","steps":["trace[1225038210] 'process raft request' (duration: 520.491646ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:06:19.341612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:06:18.820182Z","time spent":"521.40446ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T18:06:19.341764Z","caller":"traceutil/trace.go:171","msg":"trace[1112723588] transaction","detail":"{read_only:false; response_revision:1335; number_of_response:1; }","duration":"521.523233ms","start":"2026-06-05T18:06:18.820232Z","end":"2026-06-05T18:06:19.341755Z","steps":["trace[1112723588] 'process raft request' (duration: 520.487595ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:06:19.341816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:06:18.820223Z","time spent":"521.568274ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T18:06:19.341897Z","caller":"traceutil/trace.go:171","msg":"trace[1786925138] transaction","detail":"{read_only:false; response_revision:1336; number_of_response:1; }","duration":"521.419ms","start":"2026-06-05T18:06:18.820455Z","end":"2026-06-05T18:06:19.341874Z","steps":["trace[1786925138] 'process raft request' (duration: 520.29196ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:06:19.342042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:06:18.820449Z","time spent":"521.541613ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T18:06:19.342249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.874605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T18:06:19.342292Z","caller":"traceutil/trace.go:171","msg":"trace[552381314] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1336; }","duration":"432.946008ms","start":"2026-06-05T18:06:18.909336Z","end":"2026-06-05T18:06:19.342282Z","steps":["trace[552381314] 'agreement among raft nodes before linearized reading' (duration: 432.887166ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:06:19.342319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:06:18.909318Z","time spent":"432.995169ms","remote":"127.0.0.1:54096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-05T18:06:19.342454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.531741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-05T18:06:19.342488Z","caller":"traceutil/trace.go:171","msg":"trace[1630502799] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:1336; }","duration":"505.591602ms","start":"2026-06-05T18:06:18.836888Z","end":"2026-06-05T18:06:19.34248Z","steps":["trace[1630502799] 'agreement among raft nodes before linearized reading' (duration: 505.537501ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:06:19.342515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:06:18.836876Z","time spent":"505.631884ms","remote":"127.0.0.1:54402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":5,"response size":31,"request content":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true "} {"level":"warn","ts":"2026-06-05T18:06:19.342657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.996004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T18:06:19.34269Z","caller":"traceutil/trace.go:171","msg":"trace[2072536365] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:1336; }","duration":"230.030075ms","start":"2026-06-05T18:06:19.112651Z","end":"2026-06-05T18:06:19.342682Z","steps":["trace[2072536365] 'agreement among raft nodes before linearized reading' (duration: 229.978364ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:06:20.971608Z","caller":"traceutil/trace.go:171","msg":"trace[353181466] transaction","detail":"{read_only:false; response_revision:1337; number_of_response:1; }","duration":"152.863192ms","start":"2026-06-05T18:06:20.818708Z","end":"2026-06-05T18:06:20.971571Z","steps":["trace[353181466] 'process raft request' (duration: 152.466841ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:06:27.940803Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16702336547826119887,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-05T18:06:28.441328Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16702336547826119887,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-05T18:06:28.942219Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16702336547826119887,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-05T18:06:28.993587Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.641547059s","expected-duration":"1s"} {"level":"info","ts":"2026-06-05T18:06:28.994015Z","caller":"traceutil/trace.go:171","msg":"trace[1606665532] transaction","detail":"{read_only:false; response_revision:1392; number_of_response:1; }","duration":"1.642143725s","start":"2026-06-05T18:06:27.351846Z","end":"2026-06-05T18:06:28.99399Z","steps":["trace[1606665532] 'process raft request' (duration: 1.64194278s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:06:28.996796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:06:27.351822Z","time spent":"1.642274009s","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":494,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T18:06:29.473881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.864426ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-05T18:06:29.474084Z","caller":"traceutil/trace.go:171","msg":"trace[860493859] transaction","detail":"{read_only:false; response_revision:1394; number_of_response:1; }","duration":"471.047892ms","start":"2026-06-05T18:06:29.003013Z","end":"2026-06-05T18:06:29.474061Z","steps":["trace[860493859] 'process raft request' (duration: 470.98021ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:06:29.4741Z","caller":"traceutil/trace.go:171","msg":"trace[1089600426] transaction","detail":"{read_only:false; response_revision:1393; number_of_response:1; }","duration":"1.898723942s","start":"2026-06-05T18:06:27.575328Z","end":"2026-06-05T18:06:29.474052Z","steps":["trace[1089600426] 'process raft request' (duration: 1.603578308s)","trace[1089600426] 'compare' (duration: 294.715492ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T18:06:29.474286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:06:27.575304Z","time spent":"1.898863075s","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T18:06:29.474324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:06:29.002984Z","time spent":"471.147545ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T18:06:29.474505Z","caller":"traceutil/trace.go:171","msg":"trace[668367409] linearizableReadLoop","detail":"{readStateIndex:1448; appliedIndex:1446; }","duration":"2.033967088s","start":"2026-06-05T18:06:27.440475Z","end":"2026-06-05T18:06:29.474442Z","steps":["trace[668367409] 'read index received' (duration: 1.553361924s)","trace[668367409] 'applied index is now lower than readState.Index' (duration: 480.601374ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T18:06:29.474666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.034184523s","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-06-05T18:06:29.474752Z","caller":"traceutil/trace.go:171","msg":"trace[1771161257] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1394; }","duration":"2.034309696s","start":"2026-06-05T18:06:27.440429Z","end":"2026-06-05T18:06:29.474739Z","steps":["trace[1771161257] 'agreement among raft nodes before linearized reading' (duration: 2.034119031s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:06:29.474799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.288292794s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:530"} {"level":"warn","ts":"2026-06-05T18:06:29.474826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:06:27.440411Z","time spent":"2.034403959s","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-05T18:06:29.474898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.865537966s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-05T18:06:29.474907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.842067397s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-05T18:06:29.474926Z","caller":"traceutil/trace.go:171","msg":"trace[1732583464] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1394; }","duration":"1.865585368s","start":"2026-06-05T18:06:27.609333Z","end":"2026-06-05T18:06:29.474918Z","steps":["trace[1732583464] 'agreement among raft nodes before linearized reading' (duration: 1.865486775s)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:06:29.474933Z","caller":"traceutil/trace.go:171","msg":"trace[412019920] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1394; }","duration":"1.84214026s","start":"2026-06-05T18:06:27.632786Z","end":"2026-06-05T18:06:29.474926Z","steps":["trace[412019920] 'agreement among raft nodes before linearized reading' (duration: 1.842070098s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:06:29.474883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.023276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-05T18:06:29.474948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.864483618s","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-06-05T18:06:29.474968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:06:27.609323Z","time spent":"1.865638659s","remote":"127.0.0.1:54400","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-06-05T18:06:29.474969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:06:27.632772Z","time spent":"1.842191331s","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-05T18:06:29.474798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.871731119s","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-06-05T18:06:29.474985Z","caller":"traceutil/trace.go:171","msg":"trace[198881723] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1394; }","duration":"467.200851ms","start":"2026-06-05T18:06:29.007767Z","end":"2026-06-05T18:06:29.474968Z","steps":["trace[198881723] 'agreement among raft nodes before linearized reading' (duration: 466.943253ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:06:29.475014Z","caller":"traceutil/trace.go:171","msg":"trace[1515169254] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1394; }","duration":"1.864572731s","start":"2026-06-05T18:06:27.610422Z","end":"2026-06-05T18:06:29.474994Z","steps":["trace[1515169254] 'agreement among raft nodes before linearized reading' (duration: 1.864394626s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:06:29.475064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:06:29.00775Z","time spent":"467.302114ms","remote":"127.0.0.1:54096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-05T18:06:29.475049Z","caller":"traceutil/trace.go:171","msg":"trace[786102344] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1394; }","duration":"1.872016277s","start":"2026-06-05T18:06:27.603026Z","end":"2026-06-05T18:06:29.475043Z","steps":["trace[786102344] 'agreement among raft nodes before linearized reading' (duration: 1.871639856s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:06:29.475026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.763029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"warn","ts":"2026-06-05T18:06:29.474711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.564851386s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T18:06:29.475143Z","caller":"traceutil/trace.go:171","msg":"trace[692862884] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1394; }","duration":"1.565389571s","start":"2026-06-05T18:06:27.90974Z","end":"2026-06-05T18:06:29.475129Z","steps":["trace[692862884] 'agreement among raft nodes before linearized reading' (duration: 1.564930788s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:06:29.475089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:06:27.610412Z","time spent":"1.864647892s","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-05T18:06:29.475155Z","caller":"traceutil/trace.go:171","msg":"trace[955968104] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1394; }","duration":"116.955644ms","start":"2026-06-05T18:06:29.358165Z","end":"2026-06-05T18:06:29.475121Z","steps":["trace[955968104] 'agreement among raft nodes before linearized reading' (duration: 116.573113ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:06:29.475185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:06:27.909722Z","time spent":"1.565454782s","remote":"127.0.0.1:54096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-05T18:06:29.475106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:06:27.603014Z","time spent":"1.872084218s","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-05T18:06:29.474833Z","caller":"traceutil/trace.go:171","msg":"trace[421405917] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1394; }","duration":"1.288359106s","start":"2026-06-05T18:06:28.186462Z","end":"2026-06-05T18:06:29.474821Z","steps":["trace[421405917] 'agreement among raft nodes before linearized reading' (duration: 1.288269113s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:06:29.475292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:06:28.186444Z","time spent":"1.288839778s","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":554,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"info","ts":"2026-06-05T18:06:29.641295Z","caller":"traceutil/trace.go:171","msg":"trace[1606292075] transaction","detail":"{read_only:false; response_revision:1397; number_of_response:1; }","duration":"160.490862ms","start":"2026-06-05T18:06:29.480795Z","end":"2026-06-05T18:06:29.641286Z","steps":["trace[1606292075] 'process raft request' (duration: 160.442951ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:06:29.64129Z","caller":"traceutil/trace.go:171","msg":"trace[1745561496] transaction","detail":"{read_only:false; response_revision:1396; number_of_response:1; }","duration":"160.583635ms","start":"2026-06-05T18:06:29.480682Z","end":"2026-06-05T18:06:29.641265Z","steps":["trace[1745561496] 'process raft request' (duration: 160.440111ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:06:29.641504Z","caller":"traceutil/trace.go:171","msg":"trace[1861987165] transaction","detail":"{read_only:false; response_revision:1398; number_of_response:1; }","duration":"160.655968ms","start":"2026-06-05T18:06:29.480841Z","end":"2026-06-05T18:06:29.641497Z","steps":["trace[1861987165] 'process raft request' (duration: 160.419681ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:06:29.641807Z","caller":"traceutil/trace.go:171","msg":"trace[563306423] transaction","detail":"{read_only:false; response_revision:1399; number_of_response:1; }","duration":"160.736238ms","start":"2026-06-05T18:06:29.481062Z","end":"2026-06-05T18:06:29.641798Z","steps":["trace[563306423] 'process raft request' (duration: 160.388839ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:06:29.642099Z","caller":"traceutil/trace.go:171","msg":"trace[382159442] transaction","detail":"{read_only:false; response_revision:1400; number_of_response:1; }","duration":"159.6344ms","start":"2026-06-05T18:06:29.482453Z","end":"2026-06-05T18:06:29.642088Z","steps":["trace[382159442] 'process raft request' (duration: 159.296941ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:06:29.642373Z","caller":"traceutil/trace.go:171","msg":"trace[1319207090] transaction","detail":"{read_only:false; response_revision:1401; number_of_response:1; }","duration":"159.410375ms","start":"2026-06-05T18:06:29.482938Z","end":"2026-06-05T18:06:29.642348Z","steps":["trace[1319207090] 'process raft request' (duration: 158.950562ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:07:05.983791Z","caller":"traceutil/trace.go:171","msg":"trace[1977702416] transaction","detail":"{read_only:false; response_revision:1563; number_of_response:1; }","duration":"116.290474ms","start":"2026-06-05T18:07:05.86747Z","end":"2026-06-05T18:07:05.98376Z","steps":["trace[1977702416] 'process raft request' (duration: 116.033808ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:07:06.228617Z","caller":"traceutil/trace.go:171","msg":"trace[871154474] transaction","detail":"{read_only:false; response_revision:1564; number_of_response:1; }","duration":"360.891801ms","start":"2026-06-05T18:07:05.867688Z","end":"2026-06-05T18:07:06.228579Z","steps":["trace[871154474] 'process raft request' (duration: 360.615613ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:07:06.228729Z","caller":"traceutil/trace.go:171","msg":"trace[1482001440] linearizableReadLoop","detail":"{readStateIndex:1629; appliedIndex:1624; }","duration":"316.583029ms","start":"2026-06-05T18:07:05.912131Z","end":"2026-06-05T18:07:06.228714Z","steps":["trace[1482001440] 'read index received' (duration: 71.570862ms)","trace[1482001440] 'applied index is now lower than readState.Index' (duration: 245.010377ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T18:07:06.228786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:07:05.86768Z","time spent":"361.013164ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T18:07:06.228815Z","caller":"traceutil/trace.go:171","msg":"trace[1224947772] transaction","detail":"{read_only:false; response_revision:1567; number_of_response:1; }","duration":"360.608873ms","start":"2026-06-05T18:07:05.868198Z","end":"2026-06-05T18:07:06.228807Z","steps":["trace[1224947772] 'process raft request' (duration: 360.344786ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:07:06.228617Z","caller":"traceutil/trace.go:171","msg":"trace[1879895045] transaction","detail":"{read_only:false; response_revision:1565; number_of_response:1; }","duration":"360.84203ms","start":"2026-06-05T18:07:05.867751Z","end":"2026-06-05T18:07:06.228593Z","steps":["trace[1879895045] 'process raft request' (duration: 360.725917ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:07:06.228912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:07:05.868191Z","time spent":"360.647784ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":516,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T18:07:06.228934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:07:05.867743Z","time spent":"361.164137ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T18:07:06.229036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.908048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T18:07:06.229072Z","caller":"traceutil/trace.go:171","msg":"trace[2128728480] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1567; }","duration":"316.994539ms","start":"2026-06-05T18:07:05.912069Z","end":"2026-06-05T18:07:06.229064Z","steps":["trace[2128728480] 'agreement among raft nodes before linearized reading' (duration: 316.937197ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:07:06.229098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:07:05.912038Z","time spent":"317.055311ms","remote":"127.0.0.1:54096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-05T18:07:06.228638Z","caller":"traceutil/trace.go:171","msg":"trace[1401456001] transaction","detail":"{read_only:false; response_revision:1566; number_of_response:1; }","duration":"360.783047ms","start":"2026-06-05T18:07:05.867792Z","end":"2026-06-05T18:07:06.228575Z","steps":["trace[1401456001] 'process raft request' (duration: 360.720856ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:07:06.229227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.921615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.148\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-05T18:07:06.229362Z","caller":"traceutil/trace.go:171","msg":"trace[840871816] range","detail":"{range_begin:/registry/masterleases/199.204.45.148; range_end:; response_count:1; response_revision:1567; }","duration":"307.095048ms","start":"2026-06-05T18:07:05.92221Z","end":"2026-06-05T18:07:06.229305Z","steps":["trace[840871816] 'agreement among raft nodes before linearized reading' (duration: 306.648116ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:07:06.22941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:07:05.867786Z","time spent":"361.492246ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T18:07:06.229483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:07:05.922199Z","time spent":"307.266932ms","remote":"127.0.0.1:54124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/199.204.45.148\" "} {"level":"info","ts":"2026-06-05T18:07:14.14154Z","caller":"traceutil/trace.go:171","msg":"trace[1885958321] transaction","detail":"{read_only:false; response_revision:1598; number_of_response:1; }","duration":"123.127465ms","start":"2026-06-05T18:07:14.018389Z","end":"2026-06-05T18:07:14.141516Z","steps":["trace[1885958321] 'process raft request' (duration: 122.765075ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:07:16.1852Z","caller":"traceutil/trace.go:171","msg":"trace[1360979992] linearizableReadLoop","detail":"{readStateIndex:1673; appliedIndex:1672; }","duration":"252.076123ms","start":"2026-06-05T18:07:15.933109Z","end":"2026-06-05T18:07:16.185185Z","steps":["trace[1360979992] 'read index received' (duration: 188.223725ms)","trace[1360979992] 'applied index is now lower than readState.Index' (duration: 63.851398ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T18:07:16.185496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.36793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T18:07:16.185607Z","caller":"traceutil/trace.go:171","msg":"trace[643729850] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1608; }","duration":"252.517144ms","start":"2026-06-05T18:07:15.93307Z","end":"2026-06-05T18:07:16.185588Z","steps":["trace[643729850] 'agreement among raft nodes before linearized reading' (duration: 252.299749ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:07:54.723483Z","caller":"traceutil/trace.go:171","msg":"trace[1380049430] transaction","detail":"{read_only:false; response_revision:1785; number_of_response:1; }","duration":"123.153636ms","start":"2026-06-05T18:07:54.6003Z","end":"2026-06-05T18:07:54.723454Z","steps":["trace[1380049430] 'process raft request' (duration: 122.974001ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:07:54.72694Z","caller":"traceutil/trace.go:171","msg":"trace[798352805] transaction","detail":"{read_only:false; response_revision:1786; number_of_response:1; }","duration":"126.563696ms","start":"2026-06-05T18:07:54.60036Z","end":"2026-06-05T18:07:54.726924Z","steps":["trace[798352805] 'process raft request' (duration: 126.441252ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:07:54.727095Z","caller":"traceutil/trace.go:171","msg":"trace[658039253] transaction","detail":"{read_only:false; response_revision:1787; number_of_response:1; }","duration":"126.088253ms","start":"2026-06-05T18:07:54.600987Z","end":"2026-06-05T18:07:54.727075Z","steps":["trace[658039253] 'process raft request' (duration: 125.902359ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:07:59.991813Z","caller":"traceutil/trace.go:171","msg":"trace[1660873325] transaction","detail":"{read_only:false; response_revision:1808; number_of_response:1; }","duration":"115.745342ms","start":"2026-06-05T18:07:59.876049Z","end":"2026-06-05T18:07:59.991795Z","steps":["trace[1660873325] 'process raft request' (duration: 114.814857ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:10:19.819481Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16702336547826122535,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-05T18:10:20.320361Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16702336547826122535,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-05T18:10:20.459908Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.284839511s","expected-duration":"1s"} {"level":"info","ts":"2026-06-05T18:10:20.460261Z","caller":"traceutil/trace.go:171","msg":"trace[1108026274] linearizableReadLoop","detail":"{readStateIndex:2571; appliedIndex:2570; }","duration":"1.141854162s","start":"2026-06-05T18:10:19.318385Z","end":"2026-06-05T18:10:20.460239Z","steps":["trace[1108026274] 'read index received' (duration: 1.141643436s)","trace[1108026274] 'applied index is now lower than readState.Index' (duration: 209.966µs)"],"step_count":2} {"level":"warn","ts":"2026-06-05T18:10:20.460628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.494238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T18:10:20.460661Z","caller":"traceutil/trace.go:171","msg":"trace[1423842557] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2469; }","duration":"549.57043ms","start":"2026-06-05T18:10:19.911083Z","end":"2026-06-05T18:10:20.460653Z","steps":["trace[1423842557] 'agreement among raft nodes before linearized reading' (duration: 549.441197ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:10:20.460685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:10:19.911062Z","time spent":"549.618171ms","remote":"127.0.0.1:54096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-05T18:10:20.460766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.000243369s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-05T18:10:20.460818Z","caller":"traceutil/trace.go:171","msg":"trace[1012932906] transaction","detail":"{read_only:false; response_revision:2469; number_of_response:1; }","duration":"1.286039512s","start":"2026-06-05T18:10:19.174772Z","end":"2026-06-05T18:10:20.460811Z","steps":["trace[1012932906] 'process raft request' (duration: 1.285312223s)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:10:20.460828Z","caller":"traceutil/trace.go:171","msg":"trace[830752349] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2469; }","duration":"1.000365732s","start":"2026-06-05T18:10:19.460446Z","end":"2026-06-05T18:10:20.460812Z","steps":["trace[830752349] 'agreement among raft nodes before linearized reading' (duration: 1.000079675s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:10:20.460861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:10:19.460419Z","time spent":"1.000436123s","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-05T18:10:20.460896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:10:19.174756Z","time spent":"1.286082693s","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T18:10:20.461073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.142686083s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-05T18:10:20.461098Z","caller":"traceutil/trace.go:171","msg":"trace[1850566415] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2469; }","duration":"1.142710544s","start":"2026-06-05T18:10:19.31838Z","end":"2026-06-05T18:10:20.461091Z","steps":["trace[1850566415] 'agreement among raft nodes before linearized reading' (duration: 1.142601171s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:10:20.461116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:10:19.318337Z","time spent":"1.142774265s","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-05T18:10:20.461285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.061875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-06-05T18:10:20.461365Z","caller":"traceutil/trace.go:171","msg":"trace[1384390823] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2469; }","duration":"177.175128ms","start":"2026-06-05T18:10:20.284163Z","end":"2026-06-05T18:10:20.461338Z","steps":["trace[1384390823] 'agreement among raft nodes before linearized reading' (duration: 176.958201ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:10:20.461372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.000845354s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-05T18:10:20.461397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"732.575521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-05T18:10:20.461425Z","caller":"traceutil/trace.go:171","msg":"trace[526705455] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:2469; }","duration":"732.632893ms","start":"2026-06-05T18:10:19.728785Z","end":"2026-06-05T18:10:20.461418Z","steps":["trace[526705455] 'agreement among raft nodes before linearized reading' (duration: 732.586162ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:10:20.461426Z","caller":"traceutil/trace.go:171","msg":"trace[834035448] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2469; }","duration":"1.000933907s","start":"2026-06-05T18:10:19.460478Z","end":"2026-06-05T18:10:20.461412Z","steps":["trace[834035448] 'agreement among raft nodes before linearized reading' (duration: 1.000775403s)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:10:20.461444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:10:19.728767Z","time spent":"732.671343ms","remote":"127.0.0.1:54600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":5,"response size":31,"request content":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true "} {"level":"warn","ts":"2026-06-05T18:10:20.461468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:10:19.460457Z","time spent":"1.001003439s","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-05T18:10:20.461526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"807.003348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"warn","ts":"2026-06-05T18:10:20.461304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"962.162988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-06-05T18:10:20.461552Z","caller":"traceutil/trace.go:171","msg":"trace[1673513559] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2469; }","duration":"807.0715ms","start":"2026-06-05T18:10:19.654471Z","end":"2026-06-05T18:10:20.461542Z","steps":["trace[1673513559] 'agreement among raft nodes before linearized reading' (duration: 806.994288ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:10:20.461568Z","caller":"traceutil/trace.go:171","msg":"trace[512873079] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2469; }","duration":"962.448534ms","start":"2026-06-05T18:10:19.49911Z","end":"2026-06-05T18:10:20.461558Z","steps":["trace[512873079] 'agreement among raft nodes before linearized reading' (duration: 962.115136ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:10:20.461574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:10:19.654452Z","time spent":"807.116121ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":533,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-06-05T18:10:20.461594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:10:19.499091Z","time spent":"962.493886ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"info","ts":"2026-06-05T18:10:20.917775Z","caller":"traceutil/trace.go:171","msg":"trace[473584756] transaction","detail":"{read_only:false; response_revision:2478; number_of_response:1; }","duration":"134.750703ms","start":"2026-06-05T18:10:20.783007Z","end":"2026-06-05T18:10:20.917757Z","steps":["trace[473584756] 'process raft request' (duration: 134.424394ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:10:22.975573Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16702336547826122558,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-05T18:10:23.035314Z","caller":"traceutil/trace.go:171","msg":"trace[1302867988] transaction","detail":"{read_only:false; response_revision:2480; number_of_response:1; }","duration":"566.504324ms","start":"2026-06-05T18:10:22.468776Z","end":"2026-06-05T18:10:23.035281Z","steps":["trace[1302867988] 'process raft request' (duration: 566.144085ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:10:23.035555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:10:22.468763Z","time spent":"566.653077ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T18:10:23.037264Z","caller":"traceutil/trace.go:171","msg":"trace[762836533] linearizableReadLoop","detail":"{readStateIndex:2584; appliedIndex:2582; }","duration":"562.581181ms","start":"2026-06-05T18:10:22.474646Z","end":"2026-06-05T18:10:23.037227Z","steps":["trace[762836533] 'read index received' (duration: 560.302712ms)","trace[762836533] 'applied index is now lower than readState.Index' (duration: 2.276969ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T18:10:23.037326Z","caller":"traceutil/trace.go:171","msg":"trace[1287451308] transaction","detail":"{read_only:false; response_revision:2481; number_of_response:1; }","duration":"559.975923ms","start":"2026-06-05T18:10:22.477335Z","end":"2026-06-05T18:10:23.037311Z","steps":["trace[1287451308] 'process raft request' (duration: 559.629254ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:10:23.037402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:10:22.477325Z","time spent":"560.036435ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T18:10:23.037488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.26128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T18:10:23.037534Z","caller":"traceutil/trace.go:171","msg":"trace[1323842092] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2481; }","duration":"126.347302ms","start":"2026-06-05T18:10:22.911171Z","end":"2026-06-05T18:10:23.037519Z","steps":["trace[1323842092] 'agreement among raft nodes before linearized reading' (duration: 126.27254ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:10:23.037536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"562.570851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-06-05T18:10:23.037579Z","caller":"traceutil/trace.go:171","msg":"trace[852788000] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2481; }","duration":"562.622883ms","start":"2026-06-05T18:10:22.474943Z","end":"2026-06-05T18:10:23.037566Z","steps":["trace[852788000] 'agreement among raft nodes before linearized reading' (duration: 562.473878ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:10:23.037611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:10:22.474939Z","time spent":"562.664994ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-06-05T18:10:23.037599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.931358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-05T18:10:23.03766Z","caller":"traceutil/trace.go:171","msg":"trace[1816807265] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2481; }","duration":"116.033261ms","start":"2026-06-05T18:10:22.921612Z","end":"2026-06-05T18:10:23.037646Z","steps":["trace[1816807265] 'agreement among raft nodes before linearized reading' (duration: 115.835115ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:10:23.037673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"562.407817ms","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-06-05T18:10:23.037718Z","caller":"traceutil/trace.go:171","msg":"trace[1016600479] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2481; }","duration":"562.494639ms","start":"2026-06-05T18:10:22.475212Z","end":"2026-06-05T18:10:23.037706Z","steps":["trace[1016600479] 'agreement among raft nodes before linearized reading' (duration: 562.308084ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:10:23.037759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:10:22.475208Z","time spent":"562.542781ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-05T18:10:23.037762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"562.446149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-05T18:10:23.037874Z","caller":"traceutil/trace.go:171","msg":"trace[600188315] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2481; }","duration":"562.575902ms","start":"2026-06-05T18:10:22.475258Z","end":"2026-06-05T18:10:23.037834Z","steps":["trace[600188315] 'agreement among raft nodes before linearized reading' (duration: 562.254243ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:10:23.037932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:10:22.47525Z","time spent":"562.668974ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-05T18:10:23.038546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"563.893696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-05T18:10:23.038596Z","caller":"traceutil/trace.go:171","msg":"trace[1075971161] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2481; }","duration":"563.970318ms","start":"2026-06-05T18:10:22.474614Z","end":"2026-06-05T18:10:23.038585Z","steps":["trace[1075971161] 'agreement among raft nodes before linearized reading' (duration: 562.771626ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T18:10:23.038643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T18:10:22.474599Z","time spent":"564.022519ms","remote":"127.0.0.1:54400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-05T18:10:30.6246Z","caller":"traceutil/trace.go:171","msg":"trace[855950585] transaction","detail":"{read_only:false; response_revision:2521; number_of_response:1; }","duration":"136.028997ms","start":"2026-06-05T18:10:30.488539Z","end":"2026-06-05T18:10:30.624568Z","steps":["trace[855950585] 'process raft request' (duration: 135.780099ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T18:10:30.643061Z","caller":"traceutil/trace.go:171","msg":"trace[1648283455] transaction","detail":"{read_only:false; response_revision:2522; number_of_response:1; }","duration":"152.545201ms","start":"2026-06-05T18:10:30.490485Z","end":"2026-06-05T18:10:30.64303Z","steps":["trace[1648283455] 'process raft request' (duration: 152.241933ms)"],"step_count":1}