{"level":"warn","ts":"2026-04-10T09:44:39.303488Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-10T09:44:39.303593Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.155: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.155:2380","--initial-cluster=instance=https://199.204.45.155:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.155:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.155: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-04-10T09:44:39.303696Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-10T09:44:39.30371Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.155:2380"]} {"level":"info","ts":"2026-04-10T09:44:39.303876Z","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-04-10T09:44:39.30462Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.155:2379"]} {"level":"info","ts":"2026-04-10T09:44:39.304814Z","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.155:2380"],"listen-peer-urls":["https://199.204.45.155:2380"],"advertise-client-urls":["https://199.204.45.155:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.155:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.155: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-04-10T09:44:39.370241Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"65.080862ms"} {"level":"info","ts":"2026-04-10T09:44:39.408576Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"344940fc142d902f","cluster-id":"c7d65bf2a36fbd4"} {"level":"info","ts":"2026-04-10T09:44:39.408773Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f switched to configuration voters=()"} {"level":"info","ts":"2026-04-10T09:44:39.408849Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f became follower at term 0"} {"level":"info","ts":"2026-04-10T09:44:39.408879Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 344940fc142d902f [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-10T09:44:39.40893Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f became follower at term 1"} {"level":"info","ts":"2026-04-10T09:44:39.409037Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f switched to configuration voters=(3767614014686597167)"} {"level":"warn","ts":"2026-04-10T09:44:39.51921Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-10T09:44:39.5699Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-10T09:44:39.602587Z","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-04-10T09:44:39.626719Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"344940fc142d902f","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-10T09:44:39.627245Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"344940fc142d902f","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-10T09:44:39.627582Z","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-04-10T09:44:39.628074Z","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-04-10T09:44:39.628123Z","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-04-10T09:44:39.630844Z","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-04-10T09:44:39.631045Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.155:2380"} {"level":"info","ts":"2026-04-10T09:44:39.631111Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.155:2380"} {"level":"info","ts":"2026-04-10T09:44:39.631335Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f switched to configuration voters=(3767614014686597167)"} {"level":"info","ts":"2026-04-10T09:44:39.631477Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c7d65bf2a36fbd4","local-member-id":"344940fc142d902f","added-peer-id":"344940fc142d902f","added-peer-peer-urls":["https://199.204.45.155:2380"]} {"level":"info","ts":"2026-04-10T09:44:39.63164Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"344940fc142d902f","initial-advertise-peer-urls":["https://199.204.45.155:2380"],"listen-peer-urls":["https://199.204.45.155:2380"],"advertise-client-urls":["https://199.204.45.155:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.155:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-10T09:44:39.631692Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-10T09:44:39.810211Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f is starting a new election at term 1"} {"level":"info","ts":"2026-04-10T09:44:39.810374Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f became pre-candidate at term 1"} {"level":"info","ts":"2026-04-10T09:44:39.810441Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f received MsgPreVoteResp from 344940fc142d902f at term 1"} {"level":"info","ts":"2026-04-10T09:44:39.810485Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f became candidate at term 2"} {"level":"info","ts":"2026-04-10T09:44:39.810519Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f received MsgVoteResp from 344940fc142d902f at term 2"} {"level":"info","ts":"2026-04-10T09:44:39.810557Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"344940fc142d902f became leader at term 2"} {"level":"info","ts":"2026-04-10T09:44:39.810592Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 344940fc142d902f elected leader 344940fc142d902f at term 2"} {"level":"info","ts":"2026-04-10T09:44:39.830322Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"344940fc142d902f","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.155:2379]}","request-path":"/0/members/344940fc142d902f/attributes","cluster-id":"c7d65bf2a36fbd4","publish-timeout":"7s"} {"level":"info","ts":"2026-04-10T09:44:39.830381Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-10T09:44:39.830686Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-10T09:44:39.830361Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-10T09:44:39.830921Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-10T09:44:39.830952Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-10T09:44:39.835451Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.155:2379"} {"level":"info","ts":"2026-04-10T09:44:39.835814Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-10T09:44:39.843798Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c7d65bf2a36fbd4","local-member-id":"344940fc142d902f","cluster-version":"3.5"} {"level":"info","ts":"2026-04-10T09:44:39.843961Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-10T09:44:39.844004Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-04-10T09:44:42.61234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.146191ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-10T09:44:42.612506Z","caller":"traceutil/trace.go:171","msg":"trace[808221589] linearizableReadLoop","detail":"{readStateIndex:117; appliedIndex:116; }","duration":"447.487626ms","start":"2026-04-10T09:44:42.164999Z","end":"2026-04-10T09:44:42.612486Z","steps":["trace[808221589] 'read index received' (duration: 52.478062ms)","trace[808221589] 'applied index is now lower than readState.Index' (duration: 395.008084ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T09:44:42.612715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.724902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-10T09:44:42.612755Z","caller":"traceutil/trace.go:171","msg":"trace[574238672] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:112; }","duration":"404.815994ms","start":"2026-04-10T09:44:42.207929Z","end":"2026-04-10T09:44:42.612745Z","steps":["trace[574238672] 'agreement among raft nodes before linearized reading' (duration: 404.704601ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:44:42.612727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.688912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:discovery\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-10T09:44:42.612799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:42.207909Z","time spent":"404.881925ms","remote":"127.0.0.1:55946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-10T09:44:42.612844Z","caller":"traceutil/trace.go:171","msg":"trace[259795585] range","detail":"{range_begin:/registry/clusterroles/system:discovery; range_end:; response_count:0; response_revision:112; }","duration":"447.837287ms","start":"2026-04-10T09:44:42.164973Z","end":"2026-04-10T09:44:42.61281Z","steps":["trace[259795585] 'agreement among raft nodes before linearized reading' (duration: 447.607091ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:44:42.612909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:42.164964Z","time spent":"447.935119ms","remote":"127.0.0.1:56338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":0,"response size":26,"request content":"key:\"/registry/clusterroles/system:discovery\" "} {"level":"info","ts":"2026-04-10T09:44:42.613198Z","caller":"traceutil/trace.go:171","msg":"trace[1081532999] transaction","detail":"{read_only:false; response_revision:112; number_of_response:1; }","duration":"449.011968ms","start":"2026-04-10T09:44:42.163517Z","end":"2026-04-10T09:44:42.612529Z","steps":["trace[1081532999] 'process raft request' (duration: 54.052565ms)","trace[1081532999] 'compare' (duration: 393.962736ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T09:44:42.613329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:42.163503Z","time spent":"449.765308ms","remote":"127.0.0.1:56046","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":772,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-10T09:44:43.387765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.417408ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-10T09:44:43.387993Z","caller":"traceutil/trace.go:171","msg":"trace[1878442356] transaction","detail":"{read_only:false; response_revision:200; number_of_response:1; }","duration":"141.680759ms","start":"2026-04-10T09:44:43.246236Z","end":"2026-04-10T09:44:43.387917Z","steps":["trace[1878442356] 'process raft request' (duration: 12.003524ms)","trace[1878442356] 'compare' (duration: 129.212123ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T09:44:43.546773Z","caller":"traceutil/trace.go:171","msg":"trace[135130596] transaction","detail":"{read_only:false; response_revision:205; number_of_response:1; }","duration":"115.626568ms","start":"2026-04-10T09:44:43.431115Z","end":"2026-04-10T09:44:43.546742Z","steps":["trace[135130596] 'process raft request' (duration: 73.424007ms)","trace[135130596] 'compare' (duration: 42.039207ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T09:44:44.552845Z","caller":"traceutil/trace.go:171","msg":"trace[735580984] linearizableReadLoop","detail":"{readStateIndex:254; appliedIndex:253; }","duration":"138.132004ms","start":"2026-04-10T09:44:44.414689Z","end":"2026-04-10T09:44:44.552821Z","steps":["trace[735580984] 'read index received' (duration: 138.036012ms)","trace[735580984] 'applied index is now lower than readState.Index' (duration: 94.702µs)"],"step_count":2} {"level":"warn","ts":"2026-04-10T09:44:44.552987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.286197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T09:44:44.55302Z","caller":"traceutil/trace.go:171","msg":"trace[1834976735] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:248; }","duration":"138.38605ms","start":"2026-04-10T09:44:44.414625Z","end":"2026-04-10T09:44:44.553011Z","steps":["trace[1834976735] 'agreement among raft nodes before linearized reading' (duration: 138.288917ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T09:44:44.553018Z","caller":"traceutil/trace.go:171","msg":"trace[555290948] transaction","detail":"{read_only:false; response_revision:248; number_of_response:1; }","duration":"177.630626ms","start":"2026-04-10T09:44:44.37532Z","end":"2026-04-10T09:44:44.552951Z","steps":["trace[555290948] 'process raft request' (duration: 177.318598ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T09:44:44.957057Z","caller":"traceutil/trace.go:171","msg":"trace[973220418] transaction","detail":"{read_only:false; response_revision:253; number_of_response:1; }","duration":"155.255197ms","start":"2026-04-10T09:44:44.801768Z","end":"2026-04-10T09:44:44.957024Z","steps":["trace[973220418] 'process raft request' (duration: 102.610215ms)","trace[973220418] 'compare' (duration: 52.486848ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T09:44:45.183183Z","caller":"traceutil/trace.go:171","msg":"trace[1622981592] transaction","detail":"{read_only:false; response_revision:255; number_of_response:1; }","duration":"146.98336ms","start":"2026-04-10T09:44:45.036098Z","end":"2026-04-10T09:44:45.183082Z","steps":["trace[1622981592] 'process raft request' (duration: 47.5542ms)","trace[1622981592] 'compare' (duration: 99.146362ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T09:44:46.434406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.773202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-04-10T09:44:46.434477Z","caller":"traceutil/trace.go:171","msg":"trace[658028855] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:297; }","duration":"100.908115ms","start":"2026-04-10T09:44:46.333554Z","end":"2026-04-10T09:44:46.434462Z","steps":["trace[658028855] 'range keys from in-memory index tree' (duration: 100.622208ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:44:46.434465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.7444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T09:44:46.434577Z","caller":"traceutil/trace.go:171","msg":"trace[1095424518] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:0; response_revision:297; }","duration":"118.918823ms","start":"2026-04-10T09:44:46.315632Z","end":"2026-04-10T09:44:46.43455Z","steps":["trace[1095424518] 'range keys from in-memory index tree' (duration: 118.642167ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:44:46.434684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.141782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T09:44:46.434712Z","caller":"traceutil/trace.go:171","msg":"trace[815084356] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:297; }","duration":"101.205443ms","start":"2026-04-10T09:44:46.333497Z","end":"2026-04-10T09:44:46.434703Z","steps":["trace[815084356] 'range keys from in-memory index tree' (duration: 100.983417ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:44:46.43496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.871552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:115"} {"level":"info","ts":"2026-04-10T09:44:46.434994Z","caller":"traceutil/trace.go:171","msg":"trace[988455206] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:297; }","duration":"131.945374ms","start":"2026-04-10T09:44:46.303039Z","end":"2026-04-10T09:44:46.434984Z","steps":["trace[988455206] 'range keys from in-memory index tree' (duration: 131.76151ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T09:44:46.435082Z","caller":"traceutil/trace.go:171","msg":"trace[1634342991] transaction","detail":"{read_only:false; response_revision:298; number_of_response:1; }","duration":"101.265654ms","start":"2026-04-10T09:44:46.333807Z","end":"2026-04-10T09:44:46.435072Z","steps":["trace[1634342991] 'process raft request' (duration: 101.159362ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T09:44:46.648119Z","caller":"traceutil/trace.go:171","msg":"trace[72988703] transaction","detail":"{read_only:false; response_revision:309; number_of_response:1; }","duration":"106.547179ms","start":"2026-04-10T09:44:46.54155Z","end":"2026-04-10T09:44:46.648097Z","steps":["trace[72988703] 'process raft request' (duration: 106.278142ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T09:44:49.027885Z","caller":"traceutil/trace.go:171","msg":"trace[1038888089] linearizableReadLoop","detail":"{readStateIndex:349; appliedIndex:348; }","duration":"212.970837ms","start":"2026-04-10T09:44:48.814889Z","end":"2026-04-10T09:44:49.02786Z","steps":["trace[1038888089] 'read index received' (duration: 212.793402ms)","trace[1038888089] 'applied index is now lower than readState.Index' (duration: 176.055µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T09:44:49.027994Z","caller":"traceutil/trace.go:171","msg":"trace[504211426] transaction","detail":"{read_only:false; response_revision:338; number_of_response:1; }","duration":"253.727265ms","start":"2026-04-10T09:44:48.774242Z","end":"2026-04-10T09:44:49.027969Z","steps":["trace[504211426] 'process raft request' (duration: 253.475469ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:44:49.028127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.210612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-04-10T09:44:49.028664Z","caller":"traceutil/trace.go:171","msg":"trace[442636723] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:338; }","duration":"213.800507ms","start":"2026-04-10T09:44:48.814845Z","end":"2026-04-10T09:44:49.028646Z","steps":["trace[442636723] 'agreement among raft nodes before linearized reading' (duration: 213.141481ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:44:49.02842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.226204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"warn","ts":"2026-04-10T09:44:49.028608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.926036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-04-10T09:44:49.028759Z","caller":"traceutil/trace.go:171","msg":"trace[1509117883] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:338; }","duration":"113.601884ms","start":"2026-04-10T09:44:48.915119Z","end":"2026-04-10T09:44:49.028721Z","steps":["trace[1509117883] 'agreement among raft nodes before linearized reading' (duration: 113.202814ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T09:44:49.02882Z","caller":"traceutil/trace.go:171","msg":"trace[961648218] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:338; }","duration":"163.177942ms","start":"2026-04-10T09:44:48.865634Z","end":"2026-04-10T09:44:49.028812Z","steps":["trace[961648218] 'agreement among raft nodes before linearized reading' (duration: 162.591288ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:44:51.414521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.799181305s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"warn","ts":"2026-04-10T09:44:51.414645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.249624674s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-04-10T09:44:51.414721Z","caller":"traceutil/trace.go:171","msg":"trace[1788726696] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:338; }","duration":"2.249724566s","start":"2026-04-10T09:44:49.164968Z","end":"2026-04-10T09:44:51.414692Z","steps":["trace[1788726696] 'range keys from in-memory index tree' (duration: 2.249520722s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:44:51.414775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:49.164943Z","time spent":"2.2498211s","remote":"127.0.0.1:56198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":231,"request content":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" "} {"level":"warn","ts":"2026-04-10T09:44:51.414863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.920106661s","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-04-10T09:44:51.414927Z","caller":"traceutil/trace.go:171","msg":"trace[1132776535] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:338; }","duration":"1.920246114s","start":"2026-04-10T09:44:49.494661Z","end":"2026-04-10T09:44:51.414907Z","steps":["trace[1132776535] 'range keys from in-memory index tree' (duration: 1.919961397s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:44:51.414976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:49.49464Z","time spent":"1.920323266s","remote":"127.0.0.1:56266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-10T09:44:51.414756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.048789019s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"warn","ts":"2026-04-10T09:44:51.415026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.904977936s","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-04-10T09:44:51.415094Z","caller":"traceutil/trace.go:171","msg":"trace[837603017] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:338; }","duration":"2.049136777s","start":"2026-04-10T09:44:49.365914Z","end":"2026-04-10T09:44:51.415051Z","steps":["trace[837603017] 'range keys from in-memory index tree' (duration: 2.048657056s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:44:51.415027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.430803ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T09:44:51.414639Z","caller":"traceutil/trace.go:171","msg":"trace[1059061937] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:338; }","duration":"1.799343739s","start":"2026-04-10T09:44:49.615269Z","end":"2026-04-10T09:44:51.414613Z","steps":["trace[1059061937] 'range keys from in-memory index tree' (duration: 1.799061351s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:44:51.415154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:49.3659Z","time spent":"2.04923646s","remote":"127.0.0.1:56198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":256,"request content":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" "} {"level":"info","ts":"2026-04-10T09:44:51.415162Z","caller":"traceutil/trace.go:171","msg":"trace[2004218655] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:338; }","duration":"145.580416ms","start":"2026-04-10T09:44:51.269563Z","end":"2026-04-10T09:44:51.415144Z","steps":["trace[2004218655] 'range keys from in-memory index tree' (duration: 145.272659ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:44:51.415181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:49.615251Z","time spent":"1.799915223s","remote":"127.0.0.1:56198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":1,"response size":240,"request content":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" "} {"level":"warn","ts":"2026-04-10T09:44:51.414529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.848840834s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"warn","ts":"2026-04-10T09:44:51.415316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.950306248s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-04-10T09:44:51.415317Z","caller":"traceutil/trace.go:171","msg":"trace[1931521782] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:338; }","duration":"1.849763247s","start":"2026-04-10T09:44:49.565544Z","end":"2026-04-10T09:44:51.415307Z","steps":["trace[1931521782] 'range keys from in-memory index tree' (duration: 1.848654619s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:44:51.415352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:49.565522Z","time spent":"1.849820829s","remote":"127.0.0.1:56198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":215,"request content":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" "} {"level":"info","ts":"2026-04-10T09:44:51.415345Z","caller":"traceutil/trace.go:171","msg":"trace[340224759] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:338; }","duration":"1.95038297s","start":"2026-04-10T09:44:49.464953Z","end":"2026-04-10T09:44:51.415336Z","steps":["trace[340224759] 'range keys from in-memory index tree' (duration: 1.949840467s)"],"step_count":1} {"level":"info","ts":"2026-04-10T09:44:51.415114Z","caller":"traceutil/trace.go:171","msg":"trace[624878975] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:338; }","duration":"1.905120859s","start":"2026-04-10T09:44:49.509973Z","end":"2026-04-10T09:44:51.415094Z","steps":["trace[624878975] 'range keys from in-memory index tree' (duration: 1.904584136s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:44:51.415382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:49.46493Z","time spent":"1.950444302s","remote":"127.0.0.1:56198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":225,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" "} {"level":"warn","ts":"2026-04-10T09:44:51.415409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:49.509944Z","time spent":"1.905453807s","remote":"127.0.0.1:56266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-10T09:44:51.415444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.901004657s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-04-10T09:44:51.415468Z","caller":"traceutil/trace.go:171","msg":"trace[1975031841] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:338; }","duration":"1.901038988s","start":"2026-04-10T09:44:49.514421Z","end":"2026-04-10T09:44:51.41546Z","steps":["trace[1975031841] 'range keys from in-memory index tree' (duration: 1.900831303s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:44:51.415476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.050958502s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-04-10T09:44:51.415493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:49.514412Z","time spent":"1.901075238s","remote":"127.0.0.1:56198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":217,"request content":"key:\"/registry/serviceaccounts/kube-system/node-controller\" "} {"level":"info","ts":"2026-04-10T09:44:51.415502Z","caller":"traceutil/trace.go:171","msg":"trace[891827579] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:338; }","duration":"2.051015433s","start":"2026-04-10T09:44:49.364479Z","end":"2026-04-10T09:44:51.415494Z","steps":["trace[891827579] 'range keys from in-memory index tree' (duration: 2.050821529s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:44:51.415531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:49.364456Z","time spent":"2.051066674s","remote":"127.0.0.1:56266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-10T09:44:51.415666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.150873497s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-04-10T09:44:51.415695Z","caller":"traceutil/trace.go:171","msg":"trace[1414704746] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:338; }","duration":"2.150904408s","start":"2026-04-10T09:44:49.264782Z","end":"2026-04-10T09:44:51.415687Z","steps":["trace[1414704746] 'range keys from in-memory index tree' (duration: 2.150533669s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:44:51.415697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.725435837s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-10T09:44:51.415726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:49.264717Z","time spent":"2.15100245s","remote":"127.0.0.1:56198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":229,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" "} {"level":"info","ts":"2026-04-10T09:44:51.415736Z","caller":"traceutil/trace.go:171","msg":"trace[115515198] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:338; }","duration":"1.725510269s","start":"2026-04-10T09:44:49.690214Z","end":"2026-04-10T09:44:51.415724Z","steps":["trace[115515198] 'range keys from in-memory index tree' (duration: 1.72431845s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:44:51.415741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.099521605s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"warn","ts":"2026-04-10T09:44:51.415764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:49.690195Z","time spent":"1.72556189s","remote":"127.0.0.1:56266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-10T09:44:51.415797Z","caller":"traceutil/trace.go:171","msg":"trace[1692853110] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:338; }","duration":"2.099604127s","start":"2026-04-10T09:44:49.316175Z","end":"2026-04-10T09:44:51.41578Z","steps":["trace[1692853110] 'range keys from in-memory index tree' (duration: 2.099140845s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:44:51.415681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999377234s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"warn","ts":"2026-04-10T09:44:51.415865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:49.316153Z","time spent":"2.099682029s","remote":"127.0.0.1:56198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":231,"request content":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" "} {"level":"info","ts":"2026-04-10T09:44:51.415877Z","caller":"traceutil/trace.go:171","msg":"trace[1972558369] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:338; }","duration":"1.999621719s","start":"2026-04-10T09:44:49.416245Z","end":"2026-04-10T09:44:51.415867Z","steps":["trace[1972558369] 'range keys from in-memory index tree' (duration: 1.998396801s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:44:51.415916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.20062724s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-04-10T09:44:51.415955Z","caller":"traceutil/trace.go:171","msg":"trace[2077082598] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:338; }","duration":"2.200666631s","start":"2026-04-10T09:44:49.21528Z","end":"2026-04-10T09:44:51.415946Z","steps":["trace[2077082598] 'range keys from in-memory index tree' (duration: 2.199955395s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:44:51.415963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:49.41622Z","time spent":"1.999724822s","remote":"127.0.0.1:56198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":219,"request content":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" "} {"level":"warn","ts":"2026-04-10T09:44:51.415996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:49.215223Z","time spent":"2.200764753s","remote":"127.0.0.1:56198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":229,"request content":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" "} {"level":"warn","ts":"2026-04-10T09:44:52.510562Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.076630653s","expected-duration":"1s"} {"level":"info","ts":"2026-04-10T09:44:52.511292Z","caller":"traceutil/trace.go:171","msg":"trace[516356203] linearizableReadLoop","detail":"{readStateIndex:350; appliedIndex:349; }","duration":"1.079032061s","start":"2026-04-10T09:44:51.432233Z","end":"2026-04-10T09:44:52.511265Z","steps":["trace[516356203] 'read index received' (duration: 1.619039ms)","trace[516356203] 'applied index is now lower than readState.Index' (duration: 1.077411722s)"],"step_count":2} {"level":"info","ts":"2026-04-10T09:44:52.511731Z","caller":"traceutil/trace.go:171","msg":"trace[1642932974] transaction","detail":"{read_only:false; response_revision:341; number_of_response:1; }","duration":"1.080557388s","start":"2026-04-10T09:44:51.431147Z","end":"2026-04-10T09:44:52.511704Z","steps":["trace[1642932974] 'process raft request' (duration: 1.080019256s)"],"step_count":1} {"level":"info","ts":"2026-04-10T09:44:52.512051Z","caller":"traceutil/trace.go:171","msg":"trace[984982769] transaction","detail":"{read_only:false; response_revision:339; number_of_response:1; }","duration":"1.08270191s","start":"2026-04-10T09:44:51.429308Z","end":"2026-04-10T09:44:52.51201Z","steps":["trace[984982769] 'process raft request' (duration: 1.081559483s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:44:52.512163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.079904552s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-04-10T09:44:52.51202Z","caller":"traceutil/trace.go:171","msg":"trace[236122438] transaction","detail":"{read_only:false; response_revision:340; number_of_response:1; }","duration":"1.080808274s","start":"2026-04-10T09:44:51.43112Z","end":"2026-04-10T09:44:52.511928Z","steps":["trace[236122438] 'process raft request' (duration: 1.079978464s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:44:52.512213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:51.429279Z","time spent":"1.082847514s","remote":"127.0.0.1:56076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1723,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T09:44:52.512235Z","caller":"traceutil/trace.go:171","msg":"trace[1183405149] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:341; }","duration":"1.080013404s","start":"2026-04-10T09:44:51.432203Z","end":"2026-04-10T09:44:52.512216Z","steps":["trace[1183405149] 'agreement among raft nodes before linearized reading' (duration: 1.079838899s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:44:52.512287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:51.43219Z","time spent":"1.080082736s","remote":"127.0.0.1:56198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":229,"request content":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" "} {"level":"warn","ts":"2026-04-10T09:44:52.512489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:51.431114Z","time spent":"1.080678752s","remote":"127.0.0.1:56178","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5149,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T09:44:52.512656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:51.431099Z","time spent":"1.081128612s","remote":"127.0.0.1:56338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":899,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T09:44:52.897215Z","caller":"traceutil/trace.go:171","msg":"trace[169995649] transaction","detail":"{read_only:false; response_revision:343; number_of_response:1; }","duration":"1.465321473s","start":"2026-04-10T09:44:51.431863Z","end":"2026-04-10T09:44:52.897185Z","steps":["trace[169995649] 'process raft request' (duration: 1.4652163s)"],"step_count":1} {"level":"info","ts":"2026-04-10T09:44:52.897232Z","caller":"traceutil/trace.go:171","msg":"trace[859132546] transaction","detail":"{read_only:false; response_revision:342; number_of_response:1; }","duration":"1.465862005s","start":"2026-04-10T09:44:51.431333Z","end":"2026-04-10T09:44:52.897195Z","steps":["trace[859132546] 'process raft request' (duration: 1.457478423s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:44:52.897422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:51.431853Z","time spent":"1.465462636s","remote":"127.0.0.1:56338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2191,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T09:44:52.897525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:51.43129Z","time spent":"1.466036219s","remote":"127.0.0.1:56076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2163,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T09:44:52.897765Z","caller":"traceutil/trace.go:171","msg":"trace[1241005859] transaction","detail":"{read_only:false; response_revision:344; number_of_response:1; }","duration":"1.465408815s","start":"2026-04-10T09:44:51.432232Z","end":"2026-04-10T09:44:52.897641Z","steps":["trace[1241005859] 'process raft request' (duration: 1.464906123s)"],"step_count":1} {"level":"info","ts":"2026-04-10T09:44:52.897884Z","caller":"traceutil/trace.go:171","msg":"trace[2115142720] transaction","detail":"{read_only:false; response_revision:346; number_of_response:1; }","duration":"1.464769508s","start":"2026-04-10T09:44:51.433073Z","end":"2026-04-10T09:44:52.897843Z","steps":["trace[2115142720] 'process raft request' (duration: 1.464579984s)"],"step_count":1} {"level":"info","ts":"2026-04-10T09:44:52.898017Z","caller":"traceutil/trace.go:171","msg":"trace[881995935] transaction","detail":"{read_only:false; response_revision:347; number_of_response:1; }","duration":"1.46481384s","start":"2026-04-10T09:44:51.433135Z","end":"2026-04-10T09:44:52.897949Z","steps":["trace[881995935] 'process raft request' (duration: 1.464612235s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:44:52.898009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:51.432222Z","time spent":"1.46564182s","remote":"127.0.0.1:56046","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":649,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-10T09:44:52.898051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:51.433059Z","time spent":"1.464912462s","remote":"127.0.0.1:56150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":596,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T09:44:52.898167Z","caller":"traceutil/trace.go:171","msg":"trace[919910981] transaction","detail":"{read_only:false; response_revision:348; number_of_response:1; }","duration":"1.464728327s","start":"2026-04-10T09:44:51.43341Z","end":"2026-04-10T09:44:52.898138Z","steps":["trace[919910981] 'process raft request' (duration: 1.46441438s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:44:52.898311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:51.433396Z","time spent":"1.464836571s","remote":"127.0.0.1:56338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2094,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T09:44:52.898302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:51.433122Z","time spent":"1.465011884s","remote":"127.0.0.1:56178","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4781,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T09:44:52.898387Z","caller":"traceutil/trace.go:171","msg":"trace[380372723] transaction","detail":"{read_only:false; response_revision:349; number_of_response:1; }","duration":"1.46440254s","start":"2026-04-10T09:44:51.433959Z","end":"2026-04-10T09:44:52.898361Z","steps":["trace[380372723] 'process raft request' (duration: 1.464068282s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:44:52.898566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:51.433947Z","time spent":"1.464573493s","remote":"127.0.0.1:56162","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4355,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T09:44:52.898712Z","caller":"traceutil/trace.go:171","msg":"trace[184746059] transaction","detail":"{read_only:false; response_revision:350; number_of_response:1; }","duration":"1.463494707s","start":"2026-04-10T09:44:51.435154Z","end":"2026-04-10T09:44:52.898648Z","steps":["trace[184746059] 'process raft request' (duration: 1.463135118s)"],"step_count":1} {"level":"info","ts":"2026-04-10T09:44:52.898957Z","caller":"traceutil/trace.go:171","msg":"trace[10246208] transaction","detail":"{read_only:false; response_revision:351; number_of_response:1; }","duration":"1.463694551s","start":"2026-04-10T09:44:51.435245Z","end":"2026-04-10T09:44:52.898939Z","steps":["trace[10246208] 'process raft request' (duration: 1.463305312s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:44:52.899081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:51.435216Z","time spent":"1.463801944s","remote":"127.0.0.1:56266","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T09:44:52.899138Z","caller":"traceutil/trace.go:171","msg":"trace[1860817667] transaction","detail":"{read_only:false; response_revision:352; number_of_response:1; }","duration":"1.463802184s","start":"2026-04-10T09:44:51.435324Z","end":"2026-04-10T09:44:52.899126Z","steps":["trace[1860817667] 'process raft request' (duration: 1.463532007s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:44:52.899199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:51.435316Z","time spent":"1.463847436s","remote":"127.0.0.1:56266","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T09:44:52.899478Z","caller":"traceutil/trace.go:171","msg":"trace[956874580] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"1.464097192s","start":"2026-04-10T09:44:51.435366Z","end":"2026-04-10T09:44:52.899463Z","steps":["trace[956874580] 'process raft request' (duration: 1.463691191s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:44:52.899553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:51.435361Z","time spent":"1.464156084s","remote":"127.0.0.1:56266","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T09:44:52.899571Z","caller":"traceutil/trace.go:171","msg":"trace[1905396142] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"1.463633991s","start":"2026-04-10T09:44:51.435927Z","end":"2026-04-10T09:44:52.899561Z","steps":["trace[1905396142] 'process raft request' (duration: 1.463467247s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:44:52.89962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:51.435918Z","time spent":"1.463676812s","remote":"127.0.0.1:56264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1247,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T09:44:52.899819Z","caller":"traceutil/trace.go:171","msg":"trace[543367651] transaction","detail":"{read_only:false; response_revision:345; number_of_response:1; }","duration":"1.467143636s","start":"2026-04-10T09:44:51.432656Z","end":"2026-04-10T09:44:52.8998Z","steps":["trace[543367651] 'process raft request' (duration: 1.464791629s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:44:52.899892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:51.432622Z","time spent":"1.467240628s","remote":"127.0.0.1:56198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":156,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-10T09:44:52.901821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:51.435142Z","time spent":"1.46361524s","remote":"127.0.0.1:56266","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T09:44:52.90291Z","caller":"traceutil/trace.go:171","msg":"trace[1758084897] linearizableReadLoop","detail":"{readStateIndex:366; appliedIndex:352; }","duration":"391.506787ms","start":"2026-04-10T09:44:52.511377Z","end":"2026-04-10T09:44:52.902884Z","steps":["trace[1758084897] 'read index received' (duration: 377.504459ms)","trace[1758084897] 'applied index is now lower than readState.Index' (duration: 14.001068ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T09:44:52.903388Z","caller":"traceutil/trace.go:171","msg":"trace[1707092373] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"1.094069598s","start":"2026-04-10T09:44:51.8093Z","end":"2026-04-10T09:44:52.903369Z","steps":["trace[1707092373] 'process raft request' (duration: 1.090232605s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:44:52.903462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:51.809273Z","time spent":"1.0941538s","remote":"127.0.0.1:56266","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T09:44:52.904015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.471481841s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-04-10T09:44:52.904087Z","caller":"traceutil/trace.go:171","msg":"trace[1701845373] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:355; }","duration":"1.471569082s","start":"2026-04-10T09:44:51.432496Z","end":"2026-04-10T09:44:52.904065Z","steps":["trace[1701845373] 'agreement among raft nodes before linearized reading' (duration: 1.47145858s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:44:52.904121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:51.43246Z","time spent":"1.471654894s","remote":"127.0.0.1:56198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":229,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" "} {"level":"warn","ts":"2026-04-10T09:44:52.910641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.911685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6965"} {"level":"info","ts":"2026-04-10T09:44:52.910707Z","caller":"traceutil/trace.go:171","msg":"trace[698053818] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"392.477391ms","start":"2026-04-10T09:44:52.518183Z","end":"2026-04-10T09:44:52.91066Z","steps":["trace[698053818] 'process raft request' (duration: 392.253376ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T09:44:52.910711Z","caller":"traceutil/trace.go:171","msg":"trace[932962277] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:357; }","duration":"394.034568ms","start":"2026-04-10T09:44:52.516662Z","end":"2026-04-10T09:44:52.910697Z","steps":["trace[932962277] 'agreement among raft nodes before linearized reading' (duration: 393.902195ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:44:52.910872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:52.516641Z","time spent":"394.221663ms","remote":"127.0.0.1:56178","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":6987,"request content":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" "} {"level":"warn","ts":"2026-04-10T09:44:52.910908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:52.518147Z","time spent":"392.661946ms","remote":"127.0.0.1:56076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1739,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T09:44:52.910905Z","caller":"traceutil/trace.go:171","msg":"trace[1279595670] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"388.184398ms","start":"2026-04-10T09:44:52.522691Z","end":"2026-04-10T09:44:52.910875Z","steps":["trace[1279595670] 'process raft request' (duration: 387.836839ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:44:52.911122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:52.522662Z","time spent":"388.340372ms","remote":"127.0.0.1:56480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3642,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T09:44:53.112717Z","caller":"traceutil/trace.go:171","msg":"trace[2024524135] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"111.180603ms","start":"2026-04-10T09:44:53.001513Z","end":"2026-04-10T09:44:53.112693Z","steps":["trace[2024524135] 'process raft request' (duration: 111.011169ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T09:44:53.112911Z","caller":"traceutil/trace.go:171","msg":"trace[1556572978] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"110.123169ms","start":"2026-04-10T09:44:53.002757Z","end":"2026-04-10T09:44:53.11288Z","steps":["trace[1556572978] 'process raft request' (duration: 109.860972ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T09:44:53.113503Z","caller":"traceutil/trace.go:171","msg":"trace[1419340058] linearizableReadLoop","detail":"{readStateIndex:381; appliedIndex:379; }","duration":"111.144843ms","start":"2026-04-10T09:44:53.002333Z","end":"2026-04-10T09:44:53.113477Z","steps":["trace[1419340058] 'read index received' (duration: 66.427842ms)","trace[1419340058] 'applied index is now lower than readState.Index' (duration: 44.715211ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T09:44:53.113643Z","caller":"traceutil/trace.go:171","msg":"trace[1712941782] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"108.374946ms","start":"2026-04-10T09:44:53.005254Z","end":"2026-04-10T09:44:53.113629Z","steps":["trace[1712941782] 'process raft request' (duration: 108.070249ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:44:53.1143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.344057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:3706"} {"level":"info","ts":"2026-04-10T09:44:53.114397Z","caller":"traceutil/trace.go:171","msg":"trace[1453122075] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:372; }","duration":"112.025793ms","start":"2026-04-10T09:44:53.00232Z","end":"2026-04-10T09:44:53.114346Z","steps":["trace[1453122075] 'agreement among raft nodes before linearized reading' (duration: 111.255425ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T09:44:53.255623Z","caller":"traceutil/trace.go:171","msg":"trace[680823338] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"147.818652ms","start":"2026-04-10T09:44:53.107776Z","end":"2026-04-10T09:44:53.255594Z","steps":["trace[680823338] 'process raft request' (duration: 147.7696ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T09:44:53.255931Z","caller":"traceutil/trace.go:171","msg":"trace[1338569450] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"150.401854ms","start":"2026-04-10T09:44:53.105465Z","end":"2026-04-10T09:44:53.255867Z","steps":["trace[1338569450] 'process raft request' (duration: 149.913332ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T09:44:53.256202Z","caller":"traceutil/trace.go:171","msg":"trace[620411629] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"150.899375ms","start":"2026-04-10T09:44:53.105222Z","end":"2026-04-10T09:44:53.256121Z","steps":["trace[620411629] 'process raft request' (duration: 116.358248ms)","trace[620411629] 'compare' (duration: 33.630395ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T09:44:53.256139Z","caller":"traceutil/trace.go:171","msg":"trace[1228491397] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"148.880546ms","start":"2026-04-10T09:44:53.107174Z","end":"2026-04-10T09:44:53.256055Z","steps":["trace[1228491397] 'process raft request' (duration: 148.287302ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T09:44:53.259241Z","caller":"traceutil/trace.go:171","msg":"trace[228003232] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"138.746984ms","start":"2026-04-10T09:44:53.120476Z","end":"2026-04-10T09:44:53.259223Z","steps":["trace[228003232] 'process raft request' (duration: 138.607031ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T09:44:53.656513Z","caller":"traceutil/trace.go:171","msg":"trace[361770791] transaction","detail":"{read_only:false; response_revision:386; number_of_response:1; }","duration":"344.020201ms","start":"2026-04-10T09:44:53.312458Z","end":"2026-04-10T09:44:53.656478Z","steps":["trace[361770791] 'process raft request' (duration: 268.111962ms)","trace[361770791] 'compare' (duration: 75.762706ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T09:44:53.656986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:53.312441Z","time spent":"344.161175ms","remote":"127.0.0.1:56178","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4001,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T09:44:53.684926Z","caller":"traceutil/trace.go:171","msg":"trace[356508745] linearizableReadLoop","detail":"{readStateIndex:399; appliedIndex:396; }","duration":"300.496899ms","start":"2026-04-10T09:44:53.384407Z","end":"2026-04-10T09:44:53.684904Z","steps":["trace[356508745] 'read index received' (duration: 196.335133ms)","trace[356508745] 'applied index is now lower than readState.Index' (duration: 104.160426ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T09:44:53.685087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.674133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:185"} {"level":"info","ts":"2026-04-10T09:44:53.685128Z","caller":"traceutil/trace.go:171","msg":"trace[1267607904] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:388; }","duration":"300.778285ms","start":"2026-04-10T09:44:53.384338Z","end":"2026-04-10T09:44:53.685116Z","steps":["trace[1267607904] 'agreement among raft nodes before linearized reading' (duration: 300.644092ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T09:44:53.685246Z","caller":"traceutil/trace.go:171","msg":"trace[851994978] transaction","detail":"{read_only:false; response_revision:388; number_of_response:1; }","duration":"328.032539ms","start":"2026-04-10T09:44:53.357199Z","end":"2026-04-10T09:44:53.685231Z","steps":["trace[851994978] 'process raft request' (duration: 327.564918ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T09:44:53.684943Z","caller":"traceutil/trace.go:171","msg":"trace[825859692] transaction","detail":"{read_only:false; response_revision:387; number_of_response:1; }","duration":"329.837892ms","start":"2026-04-10T09:44:53.355035Z","end":"2026-04-10T09:44:53.684873Z","steps":["trace[825859692] 'process raft request' (duration: 329.605767ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:44:53.685417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:53.357189Z","time spent":"328.129081ms","remote":"127.0.0.1:56480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3804,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T09:44:53.685757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:53.355013Z","time spent":"330.525898ms","remote":"127.0.0.1:56046","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":830,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-10T09:44:53.685467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:53.384308Z","time spent":"300.849687ms","remote":"127.0.0.1:56198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":1,"response size":207,"request content":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" "} {"level":"warn","ts":"2026-04-10T09:44:53.951669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.923677ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-10T09:44:53.95183Z","caller":"traceutil/trace.go:171","msg":"trace[1608826484] linearizableReadLoop","detail":"{readStateIndex:400; appliedIndex:399; }","duration":"143.324153ms","start":"2026-04-10T09:44:53.80847Z","end":"2026-04-10T09:44:53.951794Z","steps":["trace[1608826484] 'read index received' (duration: 33.461µs)","trace[1608826484] 'applied index is now lower than readState.Index' (duration: 143.287472ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T09:44:53.951922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.447966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.155\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-10T09:44:53.95197Z","caller":"traceutil/trace.go:171","msg":"trace[1567632761] range","detail":"{range_begin:/registry/masterleases/199.204.45.155; range_end:; response_count:1; response_revision:389; }","duration":"143.532528ms","start":"2026-04-10T09:44:53.808427Z","end":"2026-04-10T09:44:53.951959Z","steps":["trace[1567632761] 'agreement among raft nodes before linearized reading' (duration: 143.444286ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T09:44:53.952314Z","caller":"traceutil/trace.go:171","msg":"trace[584174440] transaction","detail":"{read_only:false; response_revision:389; number_of_response:1; }","duration":"257.950299ms","start":"2026-04-10T09:44:53.694317Z","end":"2026-04-10T09:44:53.952267Z","steps":["trace[584174440] 'process raft request' (duration: 103.311425ms)","trace[584174440] 'compare' (duration: 153.738643ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T09:44:54.338825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.158495ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:39"} {"level":"warn","ts":"2026-04-10T09:44:54.338963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:53.95366Z","time spent":"385.298174ms","remote":"127.0.0.1:55998","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-04-10T09:44:55.034999Z","caller":"traceutil/trace.go:171","msg":"trace[2141641784] linearizableReadLoop","detail":"{readStateIndex:403; appliedIndex:402; }","duration":"365.374755ms","start":"2026-04-10T09:44:54.669588Z","end":"2026-04-10T09:44:55.034963Z","steps":["trace[2141641784] 'read index received' (duration: 365.100058ms)","trace[2141641784] 'applied index is now lower than readState.Index' (duration: 272.957µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T09:44:55.03514Z","caller":"traceutil/trace.go:171","msg":"trace[827925517] transaction","detail":"{read_only:false; response_revision:391; number_of_response:1; }","duration":"487.68052ms","start":"2026-04-10T09:44:54.547413Z","end":"2026-04-10T09:44:55.035093Z","steps":["trace[827925517] 'process raft request' (duration: 487.27282ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:44:55.03528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.238644ms","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-04-10T09:44:55.03528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.682552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/coredns-7c96b6546b-x8hb9.18a4f5b0ebad4241\" ","response":"range_response_count:1 size:845"} {"level":"info","ts":"2026-04-10T09:44:55.035342Z","caller":"traceutil/trace.go:171","msg":"trace[1675676464] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:391; }","duration":"129.322126ms","start":"2026-04-10T09:44:54.905996Z","end":"2026-04-10T09:44:55.035318Z","steps":["trace[1675676464] 'agreement among raft nodes before linearized reading' (duration: 129.183173ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T09:44:55.035349Z","caller":"traceutil/trace.go:171","msg":"trace[37924345] range","detail":"{range_begin:/registry/events/kube-system/coredns-7c96b6546b-x8hb9.18a4f5b0ebad4241; range_end:; response_count:1; response_revision:391; }","duration":"365.804504ms","start":"2026-04-10T09:44:54.669525Z","end":"2026-04-10T09:44:55.035329Z","steps":["trace[37924345] 'agreement among raft nodes before linearized reading' (duration: 365.651531ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:44:55.035406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:54.669497Z","time spent":"365.886987ms","remote":"127.0.0.1:56046","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":867,"request content":"key:\"/registry/events/kube-system/coredns-7c96b6546b-x8hb9.18a4f5b0ebad4241\" "} {"level":"warn","ts":"2026-04-10T09:44:55.035406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:54.547383Z","time spent":"487.879185ms","remote":"127.0.0.1:56178","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4311,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T09:44:55.0355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.531672ms","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-04-10T09:44:55.035636Z","caller":"traceutil/trace.go:171","msg":"trace[2061593615] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:391; }","duration":"124.709346ms","start":"2026-04-10T09:44:54.910886Z","end":"2026-04-10T09:44:55.035596Z","steps":["trace[2061593615] 'agreement among raft nodes before linearized reading' (duration: 124.359347ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:44:55.035864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.63474ms","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-04-10T09:44:55.035654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.301272ms","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-04-10T09:44:55.035987Z","caller":"traceutil/trace.go:171","msg":"trace[1379439409] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:391; }","duration":"128.788004ms","start":"2026-04-10T09:44:54.907156Z","end":"2026-04-10T09:44:55.035944Z","steps":["trace[1379439409] 'agreement among raft nodes before linearized reading' (duration: 128.510487ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T09:44:55.036048Z","caller":"traceutil/trace.go:171","msg":"trace[439062341] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:391; }","duration":"128.702281ms","start":"2026-04-10T09:44:54.907303Z","end":"2026-04-10T09:44:55.036005Z","steps":["trace[439062341] 'agreement among raft nodes before linearized reading' (duration: 128.246911ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T09:44:55.806242Z","caller":"traceutil/trace.go:171","msg":"trace[1386080914] transaction","detail":"{read_only:false; response_revision:392; number_of_response:1; }","duration":"767.442635ms","start":"2026-04-10T09:44:55.038771Z","end":"2026-04-10T09:44:55.806214Z","steps":["trace[1386080914] 'process raft request' (duration: 767.21347ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:44:55.806427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:55.038724Z","time spent":"767.604059ms","remote":"127.0.0.1:56046","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":830,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T09:44:55.904679Z","caller":"traceutil/trace.go:171","msg":"trace[1806415822] linearizableReadLoop","detail":"{readStateIndex:408; appliedIndex:403; }","duration":"520.095785ms","start":"2026-04-10T09:44:55.384563Z","end":"2026-04-10T09:44:55.904659Z","steps":["trace[1806415822] 'read index received' (duration: 421.41493ms)","trace[1806415822] 'applied index is now lower than readState.Index' (duration: 98.680145ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T09:44:55.904822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"520.244879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4326"} {"level":"info","ts":"2026-04-10T09:44:55.904792Z","caller":"traceutil/trace.go:171","msg":"trace[988179162] transaction","detail":"{read_only:false; response_revision:394; number_of_response:1; }","duration":"862.915765ms","start":"2026-04-10T09:44:55.041829Z","end":"2026-04-10T09:44:55.904745Z","steps":["trace[988179162] 'process raft request' (duration: 862.68253ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T09:44:55.90485Z","caller":"traceutil/trace.go:171","msg":"trace[1654847702] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:397; }","duration":"520.345431ms","start":"2026-04-10T09:44:55.384497Z","end":"2026-04-10T09:44:55.904842Z","steps":["trace[1654847702] 'agreement among raft nodes before linearized reading' (duration: 520.247839ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:44:55.904876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:55.384462Z","time spent":"520.408843ms","remote":"127.0.0.1:56178","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":4348,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "} {"level":"info","ts":"2026-04-10T09:44:55.904988Z","caller":"traceutil/trace.go:171","msg":"trace[1003438592] transaction","detail":"{read_only:false; response_revision:396; number_of_response:1; }","duration":"862.283999ms","start":"2026-04-10T09:44:55.042681Z","end":"2026-04-10T09:44:55.904965Z","steps":["trace[1003438592] 'process raft request' (duration: 861.914781ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T09:44:55.905079Z","caller":"traceutil/trace.go:171","msg":"trace[1816876103] transaction","detail":"{read_only:false; response_revision:393; number_of_response:1; }","duration":"863.228012ms","start":"2026-04-10T09:44:55.041833Z","end":"2026-04-10T09:44:55.905061Z","steps":["trace[1816876103] 'process raft request' (duration: 842.816491ms)","trace[1816876103] 'compare' (duration: 19.725964ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T09:44:55.905173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:55.041818Z","time spent":"863.312375ms","remote":"127.0.0.1:56266","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T09:44:55.905217Z","caller":"traceutil/trace.go:171","msg":"trace[1005317914] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"863.325325ms","start":"2026-04-10T09:44:55.041882Z","end":"2026-04-10T09:44:55.905207Z","steps":["trace[1005317914] 'process raft request' (duration: 862.683669ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:44:55.905297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:55.042653Z","time spent":"862.435653ms","remote":"127.0.0.1:56266","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T09:44:55.905017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:55.041805Z","time spent":"863.077068ms","remote":"127.0.0.1:56266","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T09:44:55.905035Z","caller":"traceutil/trace.go:171","msg":"trace[791398924] transaction","detail":"{read_only:false; response_revision:397; number_of_response:1; }","duration":"342.159313ms","start":"2026-04-10T09:44:55.562869Z","end":"2026-04-10T09:44:55.905028Z","steps":["trace[791398924] 'process raft request' (duration: 341.752273ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:44:55.905309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:55.041856Z","time spent":"863.392187ms","remote":"127.0.0.1:56266","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-04-10T09:44:55.905519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:55.562833Z","time spent":"342.649895ms","remote":"127.0.0.1:56046","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":777,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T09:44:56.48706Z","caller":"traceutil/trace.go:171","msg":"trace[170168010] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"132.550847ms","start":"2026-04-10T09:44:56.354478Z","end":"2026-04-10T09:44:56.487028Z","steps":["trace[170168010] 'process raft request' (duration: 132.360093ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T09:44:56.657034Z","caller":"traceutil/trace.go:171","msg":"trace[636500702] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"122.460133ms","start":"2026-04-10T09:44:56.534547Z","end":"2026-04-10T09:44:56.657007Z","steps":["trace[636500702] 'process raft request' (duration: 103.323646ms)","trace[636500702] 'compare' (duration: 19.012984ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T09:44:58.055902Z","caller":"traceutil/trace.go:171","msg":"trace[1534462852] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"140.734502ms","start":"2026-04-10T09:44:57.915137Z","end":"2026-04-10T09:44:58.055871Z","steps":["trace[1534462852] 'process raft request' (duration: 140.547308ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T09:44:58.187772Z","caller":"traceutil/trace.go:171","msg":"trace[1997110034] linearizableReadLoop","detail":"{readStateIndex:422; appliedIndex:418; }","duration":"190.0345ms","start":"2026-04-10T09:44:57.997706Z","end":"2026-04-10T09:44:58.18774Z","steps":["trace[1997110034] 'read index received' (duration: 58.111576ms)","trace[1997110034] 'applied index is now lower than readState.Index' (duration: 131.921084ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T09:44:58.187946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.216285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T09:44:58.187981Z","caller":"traceutil/trace.go:171","msg":"trace[1295526135] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:409; }","duration":"190.312229ms","start":"2026-04-10T09:44:57.997657Z","end":"2026-04-10T09:44:58.187969Z","steps":["trace[1295526135] 'agreement among raft nodes before linearized reading' (duration: 190.193926ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T09:44:58.18805Z","caller":"traceutil/trace.go:171","msg":"trace[1565041068] transaction","detail":"{read_only:false; response_revision:408; number_of_response:1; }","duration":"272.028263ms","start":"2026-04-10T09:44:57.915998Z","end":"2026-04-10T09:44:58.188027Z","steps":["trace[1565041068] 'process raft request' (duration: 271.660035ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T09:44:58.188161Z","caller":"traceutil/trace.go:171","msg":"trace[2089452004] transaction","detail":"{read_only:false; response_revision:409; number_of_response:1; }","duration":"271.210532ms","start":"2026-04-10T09:44:57.916928Z","end":"2026-04-10T09:44:58.188138Z","steps":["trace[2089452004] 'process raft request' (duration: 270.773612ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T09:44:58.188179Z","caller":"traceutil/trace.go:171","msg":"trace[428991636] transaction","detail":"{read_only:false; response_revision:407; number_of_response:1; }","duration":"272.833911ms","start":"2026-04-10T09:44:57.915298Z","end":"2026-04-10T09:44:58.188131Z","steps":["trace[428991636] 'process raft request' (duration: 190.388185ms)","trace[428991636] 'compare' (duration: 81.830632ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T09:44:58.501319Z","caller":"traceutil/trace.go:171","msg":"trace[1758884639] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"302.027307ms","start":"2026-04-10T09:44:58.199257Z","end":"2026-04-10T09:44:58.501284Z","steps":["trace[1758884639] 'process raft request' (duration: 280.637456ms)","trace[1758884639] 'compare' (duration: 21.250458ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T09:44:58.501514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:44:58.199236Z","time spent":"302.17697ms","remote":"127.0.0.1:56178","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7288,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T09:45:13.733268Z","caller":"traceutil/trace.go:171","msg":"trace[1764312121] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"191.17056ms","start":"2026-04-10T09:45:13.542066Z","end":"2026-04-10T09:45:13.733237Z","steps":["trace[1764312121] 'process raft request' (duration: 190.964956ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:45:20.432811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.248055564s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"warn","ts":"2026-04-10T09:45:20.432812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:45:19.37135Z","time spent":"1.061451046s","remote":"127.0.0.1:39180","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-04-10T09:45:20.432945Z","caller":"traceutil/trace.go:171","msg":"trace[1582568667] linearizableReadLoop","detail":"{readStateIndex:540; appliedIndex:539; }","duration":"1.197465937s","start":"2026-04-10T09:45:19.235456Z","end":"2026-04-10T09:45:20.432922Z","steps":["trace[1582568667] 'read index received' (duration: 52.551µs)","trace[1582568667] 'applied index is now lower than readState.Index' (duration: 1.197412006s)"],"step_count":2} {"level":"warn","ts":"2026-04-10T09:45:20.433029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"695.161592ms","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-04-10T09:45:20.433193Z","caller":"traceutil/trace.go:171","msg":"trace[1878173906] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:522; }","duration":"695.341886ms","start":"2026-04-10T09:45:19.737825Z","end":"2026-04-10T09:45:20.433167Z","steps":["trace[1878173906] 'range keys from in-memory index tree' (duration: 695.135952ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:45:20.433454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.19766623s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T09:45:20.433522Z","caller":"traceutil/trace.go:171","msg":"trace[1614852257] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:522; }","duration":"1.198102389s","start":"2026-04-10T09:45:19.235396Z","end":"2026-04-10T09:45:20.433499Z","steps":["trace[1614852257] 'agreement among raft nodes before linearized reading' (duration: 1.197678491s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:45:20.433563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.081869ms","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-04-10T09:45:20.433576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:45:19.23537Z","time spent":"1.198190451s","remote":"127.0.0.1:56062","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":27,"request content":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" "} {"level":"info","ts":"2026-04-10T09:45:20.433629Z","caller":"traceutil/trace.go:171","msg":"trace[959705098] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:522; }","duration":"102.242933ms","start":"2026-04-10T09:45:20.331358Z","end":"2026-04-10T09:45:20.433601Z","steps":["trace[959705098] 'agreement among raft nodes before linearized reading' (duration: 102.08136ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:45:20.433663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.465887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-10T09:45:20.433667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.468986ms","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-04-10T09:45:20.433732Z","caller":"traceutil/trace.go:171","msg":"trace[1013143758] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:522; }","duration":"249.582189ms","start":"2026-04-10T09:45:20.184134Z","end":"2026-04-10T09:45:20.433717Z","steps":["trace[1013143758] 'agreement among raft nodes before linearized reading' (duration: 249.422326ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T09:45:20.433785Z","caller":"traceutil/trace.go:171","msg":"trace[701232043] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:522; }","duration":"131.68815ms","start":"2026-04-10T09:45:20.302062Z","end":"2026-04-10T09:45:20.43375Z","steps":["trace[701232043] 'agreement among raft nodes before linearized reading' (duration: 131.437565ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:45:20.433887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.43303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T09:45:20.433973Z","caller":"traceutil/trace.go:171","msg":"trace[578412255] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:522; }","duration":"510.554373ms","start":"2026-04-10T09:45:19.923395Z","end":"2026-04-10T09:45:20.43395Z","steps":["trace[578412255] 'agreement among raft nodes before linearized reading' (duration: 509.92014ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:45:20.435301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:45:19.923365Z","time spent":"511.916458ms","remote":"127.0.0.1:55946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-10T09:45:27.319384Z","caller":"traceutil/trace.go:171","msg":"trace[483804574] linearizableReadLoop","detail":"{readStateIndex:653; appliedIndex:652; }","duration":"394.565368ms","start":"2026-04-10T09:45:26.924781Z","end":"2026-04-10T09:45:27.319346Z","steps":["trace[483804574] 'read index received' (duration: 393.679861ms)","trace[483804574] 'applied index is now lower than readState.Index' (duration: 884.277µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T09:45:27.319489Z","caller":"traceutil/trace.go:171","msg":"trace[1483299042] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"755.385438ms","start":"2026-04-10T09:45:26.564051Z","end":"2026-04-10T09:45:27.319436Z","steps":["trace[1483299042] 'process raft request' (duration: 754.684545ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:45:27.319575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.767351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T09:45:27.319628Z","caller":"traceutil/trace.go:171","msg":"trace[1511772582] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:632; }","duration":"394.882225ms","start":"2026-04-10T09:45:26.924731Z","end":"2026-04-10T09:45:27.319613Z","steps":["trace[1511772582] 'agreement among raft nodes before linearized reading' (duration: 394.773062ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:45:27.319669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:45:26.924705Z","time spent":"394.955727ms","remote":"127.0.0.1:55946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-10T09:45:27.319925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:45:26.563983Z","time spent":"755.618103ms","remote":"127.0.0.1:56062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036257,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T09:45:27.490232Z","caller":"traceutil/trace.go:171","msg":"trace[631325014] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"106.837911ms","start":"2026-04-10T09:45:27.383365Z","end":"2026-04-10T09:45:27.490203Z","steps":["trace[631325014] 'process raft request' (duration: 77.720146ms)","trace[631325014] 'compare' (duration: 28.904601ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T09:45:28.043991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.093566ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-10T09:45:28.04413Z","caller":"traceutil/trace.go:171","msg":"trace[1196915812] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"374.247924ms","start":"2026-04-10T09:45:27.669856Z","end":"2026-04-10T09:45:28.044104Z","steps":["trace[1196915812] 'process raft request' (duration: 254.917654ms)","trace[1196915812] 'compare' (duration: 118.823841ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T09:45:28.0442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:45:27.669829Z","time spent":"374.339327ms","remote":"127.0.0.1:56266","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T09:45:28.06613Z","caller":"traceutil/trace.go:171","msg":"trace[1537925697] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"169.977867ms","start":"2026-04-10T09:45:27.896064Z","end":"2026-04-10T09:45:28.066041Z","steps":["trace[1537925697] 'process raft request' (duration: 169.098221ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:45:29.017379Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10389695998845842983,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-10T09:45:29.519384Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10389695998845842983,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-10T09:45:29.840278Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.698926593s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-10T09:45:29.849268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.574476ms","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-04-10T09:45:29.84944Z","caller":"traceutil/trace.go:171","msg":"trace[886564691] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:635; }","duration":"110.76768ms","start":"2026-04-10T09:45:29.738644Z","end":"2026-04-10T09:45:29.849412Z","steps":["trace[886564691] 'range keys from in-memory index tree' (duration: 110.548054ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T09:45:29.849755Z","caller":"traceutil/trace.go:171","msg":"trace[323154357] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"1.708527321s","start":"2026-04-10T09:45:28.141168Z","end":"2026-04-10T09:45:29.849695Z","steps":["trace[323154357] 'process raft request' (duration: 1.699631586s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:45:29.849944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:45:28.141123Z","time spent":"1.708728455s","remote":"127.0.0.1:56506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T09:45:29.870626Z","caller":"traceutil/trace.go:171","msg":"trace[1283602439] linearizableReadLoop","detail":"{readStateIndex:658; appliedIndex:656; }","duration":"1.353753263s","start":"2026-04-10T09:45:28.516836Z","end":"2026-04-10T09:45:29.870589Z","steps":["trace[1283602439] 'read index received' (duration: 1.323791029s)","trace[1283602439] 'applied index is now lower than readState.Index' (duration: 29.960494ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T09:45:29.870885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.354031348s","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-04-10T09:45:29.870997Z","caller":"traceutil/trace.go:171","msg":"trace[2101652234] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:636; }","duration":"1.354197771s","start":"2026-04-10T09:45:28.516771Z","end":"2026-04-10T09:45:29.870968Z","steps":["trace[2101652234] 'agreement among raft nodes before linearized reading' (duration: 1.353913286s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:45:29.870998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"950.213661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T09:45:29.871143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.348043957s","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-04-10T09:45:29.871167Z","caller":"traceutil/trace.go:171","msg":"trace[190869866] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:636; }","duration":"1.348087958s","start":"2026-04-10T09:45:28.523073Z","end":"2026-04-10T09:45:29.871161Z","steps":["trace[190869866] 'agreement among raft nodes before linearized reading' (duration: 1.348007296s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:45:29.871188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:45:28.523063Z","time spent":"1.348120189s","remote":"127.0.0.1:56266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-10T09:45:29.871156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.345909127s","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-04-10T09:45:29.871193Z","caller":"traceutil/trace.go:171","msg":"trace[221946144] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:636; }","duration":"950.470476ms","start":"2026-04-10T09:45:28.920697Z","end":"2026-04-10T09:45:29.871168Z","steps":["trace[221946144] 'agreement among raft nodes before linearized reading' (duration: 950.189211ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:45:29.871238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:45:28.920679Z","time spent":"950.550027ms","remote":"127.0.0.1:55946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-10T09:45:29.871236Z","caller":"traceutil/trace.go:171","msg":"trace[539013465] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:636; }","duration":"1.34604784s","start":"2026-04-10T09:45:28.525164Z","end":"2026-04-10T09:45:29.871212Z","steps":["trace[539013465] 'agreement among raft nodes before linearized reading' (duration: 1.345798695s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:45:29.871282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:45:28.525155Z","time spent":"1.346119041s","remote":"127.0.0.1:56266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-10T09:45:29.871053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:45:28.516742Z","time spent":"1.354303934s","remote":"127.0.0.1:56266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-10T09:45:29.871083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.352711674s","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-04-10T09:45:29.871588Z","caller":"traceutil/trace.go:171","msg":"trace[345397451] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:636; }","duration":"1.353271084s","start":"2026-04-10T09:45:28.518307Z","end":"2026-04-10T09:45:29.871578Z","steps":["trace[345397451] 'agreement among raft nodes before linearized reading' (duration: 1.352514871s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:45:29.871621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:45:28.518272Z","time spent":"1.353338946s","remote":"127.0.0.1:56266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-10T09:45:44.213651Z","caller":"traceutil/trace.go:171","msg":"trace[1454853970] transaction","detail":"{read_only:false; response_revision:786; number_of_response:1; }","duration":"255.873992ms","start":"2026-04-10T09:45:43.957742Z","end":"2026-04-10T09:45:44.213616Z","steps":["trace[1454853970] 'process raft request' (duration: 221.312875ms)","trace[1454853970] 'compare' (duration: 34.419505ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T09:45:44.220001Z","caller":"traceutil/trace.go:171","msg":"trace[1024542202] linearizableReadLoop","detail":"{readStateIndex:815; appliedIndex:813; }","duration":"256.190577ms","start":"2026-04-10T09:45:43.963791Z","end":"2026-04-10T09:45:44.219982Z","steps":["trace[1024542202] 'read index received' (duration: 215.347874ms)","trace[1024542202] 'applied index is now lower than readState.Index' (duration: 40.841133ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T09:45:44.220056Z","caller":"traceutil/trace.go:171","msg":"trace[2124753829] transaction","detail":"{read_only:false; response_revision:787; number_of_response:1; }","duration":"261.083551ms","start":"2026-04-10T09:45:43.95895Z","end":"2026-04-10T09:45:44.220033Z","steps":["trace[2124753829] 'process raft request' (duration: 260.929679ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:45:44.220222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.919422ms","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-04-10T09:45:44.220232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.435262ms","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-04-10T09:45:44.220299Z","caller":"traceutil/trace.go:171","msg":"trace[704845811] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:787; }","duration":"256.018375ms","start":"2026-04-10T09:45:43.964237Z","end":"2026-04-10T09:45:44.220255Z","steps":["trace[704845811] 'agreement among raft nodes before linearized reading' (duration: 255.852461ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T09:45:44.220306Z","caller":"traceutil/trace.go:171","msg":"trace[1392168578] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:787; }","duration":"256.548354ms","start":"2026-04-10T09:45:43.96373Z","end":"2026-04-10T09:45:44.220278Z","steps":["trace[1392168578] 'agreement among raft nodes before linearized reading' (duration: 256.35552ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:45:46.555407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"631.4162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T09:45:46.555496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.226742ms","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-04-10T09:45:46.555522Z","caller":"traceutil/trace.go:171","msg":"trace[1787638793] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:800; }","duration":"631.583182ms","start":"2026-04-10T09:45:45.923908Z","end":"2026-04-10T09:45:46.555492Z","steps":["trace[1787638793] 'range keys from in-memory index tree' (duration: 631.318477ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:45:46.555581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:45:45.923881Z","time spent":"631.689664ms","remote":"127.0.0.1:55946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-10T09:45:46.555635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.236705ms","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-04-10T09:45:46.555496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.921713ms","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-04-10T09:45:46.555886Z","caller":"traceutil/trace.go:171","msg":"trace[1265732503] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:800; }","duration":"260.375481ms","start":"2026-04-10T09:45:46.295477Z","end":"2026-04-10T09:45:46.555853Z","steps":["trace[1265732503] 'range keys from in-memory index tree' (duration: 259.595657ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T09:45:46.555746Z","caller":"traceutil/trace.go:171","msg":"trace[424880136] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:800; }","duration":"270.405678ms","start":"2026-04-10T09:45:46.285316Z","end":"2026-04-10T09:45:46.555721Z","steps":["trace[424880136] 'range keys from in-memory index tree' (duration: 270.001102ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T09:45:46.555573Z","caller":"traceutil/trace.go:171","msg":"trace[904733595] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:800; }","duration":"331.362765ms","start":"2026-04-10T09:45:46.224194Z","end":"2026-04-10T09:45:46.555557Z","steps":["trace[904733595] 'range keys from in-memory index tree' (duration: 331.024089ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:45:46.556433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:45:46.224164Z","time spent":"332.254159ms","remote":"127.0.0.1:56266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-10T09:45:46.557231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.443004ms","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-04-10T09:45:46.557651Z","caller":"traceutil/trace.go:171","msg":"trace[1073246011] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:800; }","duration":"338.577966ms","start":"2026-04-10T09:45:46.218722Z","end":"2026-04-10T09:45:46.5573Z","steps":["trace[1073246011] 'range keys from in-memory index tree' (duration: 336.520261ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:45:46.557722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:45:46.2187Z","time spent":"339.007413ms","remote":"127.0.0.1:56266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-10T09:46:36.990204Z","caller":"traceutil/trace.go:171","msg":"trace[1072351637] transaction","detail":"{read_only:false; response_revision:1098; number_of_response:1; }","duration":"100.874616ms","start":"2026-04-10T09:46:36.889296Z","end":"2026-04-10T09:46:36.990171Z","steps":["trace[1072351637] 'process raft request' (duration: 100.675253ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T09:46:37.030225Z","caller":"traceutil/trace.go:171","msg":"trace[1956587370] linearizableReadLoop","detail":"{readStateIndex:1137; appliedIndex:1135; }","duration":"119.661595ms","start":"2026-04-10T09:46:36.910533Z","end":"2026-04-10T09:46:37.030195Z","steps":["trace[1956587370] 'read index received' (duration: 79.523691ms)","trace[1956587370] 'applied index is now lower than readState.Index' (duration: 40.137034ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T09:46:37.030295Z","caller":"traceutil/trace.go:171","msg":"trace[1239762142] transaction","detail":"{read_only:false; response_revision:1099; number_of_response:1; }","duration":"139.364618ms","start":"2026-04-10T09:46:36.890888Z","end":"2026-04-10T09:46:37.030253Z","steps":["trace[1239762142] 'process raft request' (duration: 139.118334ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:46:37.030492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.561145ms","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-04-10T09:46:37.030533Z","caller":"traceutil/trace.go:171","msg":"trace[1541282320] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1099; }","duration":"114.666895ms","start":"2026-04-10T09:46:36.915854Z","end":"2026-04-10T09:46:37.030521Z","steps":["trace[1541282320] 'agreement among raft nodes before linearized reading' (duration: 114.496593ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:46:37.030529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.6223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T09:46:37.030593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.03518ms","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-04-10T09:46:37.030712Z","caller":"traceutil/trace.go:171","msg":"trace[113519277] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1099; }","duration":"120.214973ms","start":"2026-04-10T09:46:36.910464Z","end":"2026-04-10T09:46:37.030679Z","steps":["trace[113519277] 'agreement among raft nodes before linearized reading' (duration: 119.879578ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T09:46:37.030867Z","caller":"traceutil/trace.go:171","msg":"trace[1804764057] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1099; }","duration":"105.740351ms","start":"2026-04-10T09:46:36.924853Z","end":"2026-04-10T09:46:37.030593Z","steps":["trace[1804764057] 'agreement among raft nodes before linearized reading' (duration: 105.573019ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T09:46:53.195407Z","caller":"traceutil/trace.go:171","msg":"trace[87965291] transaction","detail":"{read_only:false; response_revision:1150; number_of_response:1; }","duration":"121.605203ms","start":"2026-04-10T09:46:53.073722Z","end":"2026-04-10T09:46:53.195328Z","steps":["trace[87965291] 'process raft request' (duration: 121.4031ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T09:47:13.763668Z","caller":"traceutil/trace.go:171","msg":"trace[376161610] transaction","detail":"{read_only:false; response_revision:1220; number_of_response:1; }","duration":"196.347911ms","start":"2026-04-10T09:47:13.567295Z","end":"2026-04-10T09:47:13.763643Z","steps":["trace[376161610] 'process raft request' (duration: 196.204069ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T09:47:15.500202Z","caller":"traceutil/trace.go:171","msg":"trace[1836186889] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"101.262716ms","start":"2026-04-10T09:47:15.398909Z","end":"2026-04-10T09:47:15.500171Z","steps":["trace[1836186889] 'process raft request' (duration: 100.927271ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T09:47:47.40796Z","caller":"traceutil/trace.go:171","msg":"trace[184295333] transaction","detail":"{read_only:false; response_revision:1365; number_of_response:1; }","duration":"821.124393ms","start":"2026-04-10T09:47:46.586807Z","end":"2026-04-10T09:47:47.407932Z","steps":["trace[184295333] 'process raft request' (duration: 820.9319ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:47:47.408136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:47:46.586772Z","time spent":"821.271174ms","remote":"127.0.0.1:56266","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T09:47:47.416538Z","caller":"traceutil/trace.go:171","msg":"trace[1394338406] transaction","detail":"{read_only:false; response_revision:1366; number_of_response:1; }","duration":"685.686863ms","start":"2026-04-10T09:47:46.730832Z","end":"2026-04-10T09:47:47.416519Z","steps":["trace[1394338406] 'process raft request' (duration: 685.571692ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:47:47.4167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:47:46.7308Z","time spent":"685.839495ms","remote":"127.0.0.1:56266","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T09:48:20.184866Z","caller":"traceutil/trace.go:171","msg":"trace[2134355296] linearizableReadLoop","detail":"{readStateIndex:1540; appliedIndex:1539; }","duration":"261.084768ms","start":"2026-04-10T09:48:19.923734Z","end":"2026-04-10T09:48:20.184819Z","steps":["trace[2134355296] 'read index received' (duration: 226.988686ms)","trace[2134355296] 'applied index is now lower than readState.Index' (duration: 34.094192ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T09:48:20.184947Z","caller":"traceutil/trace.go:171","msg":"trace[343689575] transaction","detail":"{read_only:false; response_revision:1478; number_of_response:1; }","duration":"264.603603ms","start":"2026-04-10T09:48:19.920294Z","end":"2026-04-10T09:48:20.184897Z","steps":["trace[343689575] 'process raft request' (duration: 230.493101ms)","trace[343689575] 'compare' (duration: 33.843595ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T09:48:20.185078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.313104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T09:48:20.185191Z","caller":"traceutil/trace.go:171","msg":"trace[831550762] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1478; }","duration":"261.456868ms","start":"2026-04-10T09:48:19.92371Z","end":"2026-04-10T09:48:20.185167Z","steps":["trace[831550762] 'agreement among raft nodes before linearized reading' (duration: 261.292084ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:48:20.243362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.134771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T09:48:20.24344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.137321ms","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-04-10T09:48:20.243474Z","caller":"traceutil/trace.go:171","msg":"trace[1826606943] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1479; }","duration":"300.295826ms","start":"2026-04-10T09:48:19.943151Z","end":"2026-04-10T09:48:20.243447Z","steps":["trace[1826606943] 'agreement among raft nodes before linearized reading' (duration: 300.07761ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T09:48:20.243492Z","caller":"traceutil/trace.go:171","msg":"trace[348736209] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1479; }","duration":"251.215803ms","start":"2026-04-10T09:48:19.992262Z","end":"2026-04-10T09:48:20.243478Z","steps":["trace[348736209] 'agreement among raft nodes before linearized reading' (duration: 250.962266ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:48:20.243527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:48:19.943135Z","time spent":"300.381118ms","remote":"127.0.0.1:59182","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"info","ts":"2026-04-10T09:48:20.243496Z","caller":"traceutil/trace.go:171","msg":"trace[1953573069] transaction","detail":"{read_only:false; response_revision:1479; number_of_response:1; }","duration":"139.657826ms","start":"2026-04-10T09:48:20.103775Z","end":"2026-04-10T09:48:20.243432Z","steps":["trace[1953573069] 'process raft request' (duration: 139.193793ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:48:20.243617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.582428ms","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-04-10T09:48:20.243703Z","caller":"traceutil/trace.go:171","msg":"trace[1372954168] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1479; }","duration":"309.723922ms","start":"2026-04-10T09:48:19.933957Z","end":"2026-04-10T09:48:20.243681Z","steps":["trace[1372954168] 'agreement among raft nodes before linearized reading' (duration: 309.439354ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T09:48:20.243754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T09:48:19.933946Z","time spent":"309.799743ms","remote":"127.0.0.1:56266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}