{"level":"warn","ts":"2026-04-23T09:44:58.332492Z","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-23T09:44:58.332586Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.91:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.91:2380","--initial-cluster=instance=https://199.19.213.91:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.91:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.91: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-23T09:44:58.332657Z","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-23T09:44:58.332672Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.91:2380"]} {"level":"info","ts":"2026-04-23T09:44:58.332689Z","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-23T09:44:58.333749Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.91:2379"]} {"level":"info","ts":"2026-04-23T09:44:58.333947Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.91:2380"],"listen-peer-urls":["https://199.19.213.91:2380"],"advertise-client-urls":["https://199.19.213.91:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.91:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.91: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-23T09:44:58.343639Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"9.494743ms"} {"level":"info","ts":"2026-04-23T09:44:58.359759Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"2c24222821500990","cluster-id":"f38faa6ba493daad"} {"level":"info","ts":"2026-04-23T09:44:58.359898Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2c24222821500990 switched to configuration voters=()"} {"level":"info","ts":"2026-04-23T09:44:58.359923Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2c24222821500990 became follower at term 0"} {"level":"info","ts":"2026-04-23T09:44:58.359934Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 2c24222821500990 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-23T09:44:58.359945Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2c24222821500990 became follower at term 1"} {"level":"info","ts":"2026-04-23T09:44:58.359985Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2c24222821500990 switched to configuration voters=(3180704792583342480)"} {"level":"warn","ts":"2026-04-23T09:44:58.422725Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-23T09:44:58.441696Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-23T09:44:58.456314Z","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-23T09:44:58.46373Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"2c24222821500990","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-23T09:44:58.466813Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"2c24222821500990","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-23T09:44:58.467731Z","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-23T09:44:58.467987Z","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-23T09:44:58.468235Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2c24222821500990 switched to configuration voters=(3180704792583342480)"} {"level":"info","ts":"2026-04-23T09:44:58.468277Z","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-23T09:44:58.46855Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"f38faa6ba493daad","local-member-id":"2c24222821500990","added-peer-id":"2c24222821500990","added-peer-peer-urls":["https://199.19.213.91:2380"]} {"level":"info","ts":"2026-04-23T09:44:58.472613Z","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-23T09:44:58.472713Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.91:2380"} {"level":"info","ts":"2026-04-23T09:44:58.472743Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.91:2380"} {"level":"info","ts":"2026-04-23T09:44:58.472933Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"2c24222821500990","initial-advertise-peer-urls":["https://199.19.213.91:2380"],"listen-peer-urls":["https://199.19.213.91:2380"],"advertise-client-urls":["https://199.19.213.91:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.91:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-23T09:44:58.47298Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-23T09:44:59.06117Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2c24222821500990 is starting a new election at term 1"} {"level":"info","ts":"2026-04-23T09:44:59.061231Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2c24222821500990 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-23T09:44:59.06128Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2c24222821500990 received MsgPreVoteResp from 2c24222821500990 at term 1"} {"level":"info","ts":"2026-04-23T09:44:59.061302Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2c24222821500990 became candidate at term 2"} {"level":"info","ts":"2026-04-23T09:44:59.061314Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2c24222821500990 received MsgVoteResp from 2c24222821500990 at term 2"} {"level":"info","ts":"2026-04-23T09:44:59.061341Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2c24222821500990 became leader at term 2"} {"level":"info","ts":"2026-04-23T09:44:59.061361Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 2c24222821500990 elected leader 2c24222821500990 at term 2"} {"level":"info","ts":"2026-04-23T09:44:59.062784Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T09:44:59.064952Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"2c24222821500990","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.91:2379]}","request-path":"/0/members/2c24222821500990/attributes","cluster-id":"f38faa6ba493daad","publish-timeout":"7s"} {"level":"info","ts":"2026-04-23T09:44:59.065107Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-23T09:44:59.065154Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-23T09:44:59.065308Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-23T09:44:59.065388Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-23T09:44:59.066356Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"f38faa6ba493daad","local-member-id":"2c24222821500990","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T09:44:59.066494Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T09:44:59.066562Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T09:44:59.06732Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.91:2379"} {"level":"info","ts":"2026-04-23T09:44:59.070428Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} 2026/04/23 09:45:04 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"info","ts":"2026-04-23T09:45:04.58442Z","caller":"traceutil/trace.go:171","msg":"trace[925189858] transaction","detail":"{read_only:false; response_revision:279; number_of_response:1; }","duration":"109.06664ms","start":"2026-04-23T09:45:04.475326Z","end":"2026-04-23T09:45:04.584393Z","steps":["trace[925189858] 'process raft request' (duration: 108.977709ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:45:27.029986Z","caller":"traceutil/trace.go:171","msg":"trace[1914607423] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"138.531062ms","start":"2026-04-23T09:45:26.891436Z","end":"2026-04-23T09:45:27.029967Z","steps":["trace[1914607423] 'process raft request' (duration: 138.427875ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:45:31.270652Z","caller":"traceutil/trace.go:171","msg":"trace[612269038] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"214.706826ms","start":"2026-04-23T09:45:31.055918Z","end":"2026-04-23T09:45:31.270625Z","steps":["trace[612269038] 'process raft request' (duration: 214.526904ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:45:31.577745Z","caller":"traceutil/trace.go:171","msg":"trace[970045261] linearizableReadLoop","detail":"{readStateIndex:617; appliedIndex:615; }","duration":"266.308788ms","start":"2026-04-23T09:45:31.311412Z","end":"2026-04-23T09:45:31.577721Z","steps":["trace[970045261] 'read index received' (duration: 204.055636ms)","trace[970045261] 'applied index is now lower than readState.Index' (duration: 62.252142ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T09:45:31.578218Z","caller":"traceutil/trace.go:171","msg":"trace[36939028] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"345.453913ms","start":"2026-04-23T09:45:31.232729Z","end":"2026-04-23T09:45:31.578183Z","steps":["trace[36939028] 'process raft request' (duration: 344.93467ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:45:31.578868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T09:45:31.232715Z","time spent":"345.582622ms","remote":"127.0.0.1:60792","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T09:45:31.579286Z","caller":"traceutil/trace.go:171","msg":"trace[615454062] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"351.512596ms","start":"2026-04-23T09:45:31.227749Z","end":"2026-04-23T09:45:31.579262Z","steps":["trace[615454062] 'process raft request' (duration: 287.684092ms)","trace[615454062] 'compare' (duration: 61.164591ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T09:45:31.579454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T09:45:31.227724Z","time spent":"351.676076ms","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036101,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T09:45:31.579663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.413903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-23T09:45:31.579623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.1985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T09:45:31.579732Z","caller":"traceutil/trace.go:171","msg":"trace[1298651862] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:595; }","duration":"253.51135ms","start":"2026-04-23T09:45:31.326204Z","end":"2026-04-23T09:45:31.579715Z","steps":["trace[1298651862] 'agreement among raft nodes before linearized reading' (duration: 253.303106ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:45:31.579747Z","caller":"traceutil/trace.go:171","msg":"trace[615456766] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:595; }","duration":"268.35321ms","start":"2026-04-23T09:45:31.311372Z","end":"2026-04-23T09:45:31.579725Z","steps":["trace[615456766] 'agreement among raft nodes before linearized reading' (duration: 268.20081ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:45:31.919612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.476143ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-23T09:45:31.919923Z","caller":"traceutil/trace.go:171","msg":"trace[715230793] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"283.953891ms","start":"2026-04-23T09:45:31.635942Z","end":"2026-04-23T09:45:31.919896Z","steps":["trace[715230793] 'process raft request' (duration: 283.845624ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:45:31.919909Z","caller":"traceutil/trace.go:171","msg":"trace[1417420998] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"331.65256ms","start":"2026-04-23T09:45:31.588214Z","end":"2026-04-23T09:45:31.919866Z","steps":["trace[1417420998] 'process raft request' (duration: 147.467341ms)","trace[1417420998] 'compare' (duration: 183.217006ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T09:45:31.92017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T09:45:31.588186Z","time spent":"331.881845ms","remote":"127.0.0.1:60792","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T09:45:31.920272Z","caller":"traceutil/trace.go:171","msg":"trace[1722856885] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:617; }","duration":"306.762698ms","start":"2026-04-23T09:45:31.613474Z","end":"2026-04-23T09:45:31.920236Z","steps":["trace[1722856885] 'read index received' (duration: 122.246677ms)","trace[1722856885] 'applied index is now lower than readState.Index' (duration: 184.51345ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T09:45:31.920751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.266591ms","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-23T09:45:31.920863Z","caller":"traceutil/trace.go:171","msg":"trace[69612539] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:597; }","duration":"307.422861ms","start":"2026-04-23T09:45:31.61342Z","end":"2026-04-23T09:45:31.920842Z","steps":["trace[69612539] 'agreement among raft nodes before linearized reading' (duration: 306.988363ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:45:31.920902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T09:45:31.613398Z","time spent":"307.493715ms","remote":"127.0.0.1:60792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-23T09:45:32.523317Z","caller":"traceutil/trace.go:171","msg":"trace[514230328] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"121.746666ms","start":"2026-04-23T09:45:32.401553Z","end":"2026-04-23T09:45:32.5233Z","steps":["trace[514230328] 'process raft request' (duration: 121.310917ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:45:38.204589Z","caller":"traceutil/trace.go:171","msg":"trace[131968622] transaction","detail":"{read_only:false; response_revision:664; number_of_response:1; }","duration":"166.316032ms","start":"2026-04-23T09:45:38.038251Z","end":"2026-04-23T09:45:38.204567Z","steps":["trace[131968622] 'process raft request' (duration: 165.844031ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:45:38.205703Z","caller":"traceutil/trace.go:171","msg":"trace[2105594614] linearizableReadLoop","detail":"{readStateIndex:688; appliedIndex:686; }","duration":"133.811106ms","start":"2026-04-23T09:45:38.07186Z","end":"2026-04-23T09:45:38.205671Z","steps":["trace[2105594614] 'read index received' (duration: 59.073176ms)","trace[2105594614] 'applied index is now lower than readState.Index' (duration: 74.73668ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T09:45:38.205999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.115386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T09:45:38.206025Z","caller":"traceutil/trace.go:171","msg":"trace[1044213371] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:665; }","duration":"134.163219ms","start":"2026-04-23T09:45:38.071854Z","end":"2026-04-23T09:45:38.206017Z","steps":["trace[1044213371] 'agreement among raft nodes before linearized reading' (duration: 134.069793ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:45:38.206168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.304539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T09:45:38.206189Z","caller":"traceutil/trace.go:171","msg":"trace[1283349974] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:665; }","duration":"134.367102ms","start":"2026-04-23T09:45:38.071816Z","end":"2026-04-23T09:45:38.206183Z","steps":["trace[1283349974] 'agreement among raft nodes before linearized reading' (duration: 134.319669ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:45:38.269991Z","caller":"traceutil/trace.go:171","msg":"trace[649926980] transaction","detail":"{read_only:false; response_revision:666; number_of_response:1; }","duration":"128.037692ms","start":"2026-04-23T09:45:38.141934Z","end":"2026-04-23T09:45:38.269972Z","steps":["trace[649926980] 'process raft request' (duration: 81.744584ms)","trace[649926980] 'compare' (duration: 45.669368ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T09:45:38.270073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.076431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T09:45:38.270294Z","caller":"traceutil/trace.go:171","msg":"trace[1111995320] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:668; }","duration":"121.304597ms","start":"2026-04-23T09:45:38.148969Z","end":"2026-04-23T09:45:38.270274Z","steps":["trace[1111995320] 'agreement among raft nodes before linearized reading' (duration: 121.060561ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:45:38.270591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.929294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T09:45:38.270629Z","caller":"traceutil/trace.go:171","msg":"trace[256444015] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:668; }","duration":"155.009639ms","start":"2026-04-23T09:45:38.115609Z","end":"2026-04-23T09:45:38.270619Z","steps":["trace[256444015] 'agreement among raft nodes before linearized reading' (duration: 154.943255ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:45:38.270738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.934465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-23T09:45:38.270696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.993548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T09:45:38.270826Z","caller":"traceutil/trace.go:171","msg":"trace[1820493462] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:668; }","duration":"155.151128ms","start":"2026-04-23T09:45:38.115664Z","end":"2026-04-23T09:45:38.270815Z","steps":["trace[1820493462] 'agreement among raft nodes before linearized reading' (duration: 154.990938ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:45:38.270835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.898955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T09:45:38.270861Z","caller":"traceutil/trace.go:171","msg":"trace[1360847663] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:668; }","duration":"121.927847ms","start":"2026-04-23T09:45:38.148926Z","end":"2026-04-23T09:45:38.270854Z","steps":["trace[1360847663] 'agreement among raft nodes before linearized reading' (duration: 121.888504ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:45:38.270889Z","caller":"traceutil/trace.go:171","msg":"trace[1678366711] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:668; }","duration":"154.992098ms","start":"2026-04-23T09:45:38.115787Z","end":"2026-04-23T09:45:38.270779Z","steps":["trace[1678366711] 'agreement among raft nodes before linearized reading' (duration: 154.834358ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:45:51.7583Z","caller":"traceutil/trace.go:171","msg":"trace[639727881] linearizableReadLoop","detail":"{readStateIndex:809; appliedIndex:808; }","duration":"256.883409ms","start":"2026-04-23T09:45:51.501391Z","end":"2026-04-23T09:45:51.758275Z","steps":["trace[639727881] 'read index received' (duration: 256.751355ms)","trace[639727881] 'applied index is now lower than readState.Index' (duration: 131.134µs)"],"step_count":2} {"level":"warn","ts":"2026-04-23T09:45:51.758485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.115305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-23T09:45:51.758522Z","caller":"traceutil/trace.go:171","msg":"trace[299288290] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:782; }","duration":"257.204138ms","start":"2026-04-23T09:45:51.501307Z","end":"2026-04-23T09:45:51.758511Z","steps":["trace[299288290] 'agreement among raft nodes before linearized reading' (duration: 257.061854ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:45:51.758803Z","caller":"traceutil/trace.go:171","msg":"trace[1801317610] transaction","detail":"{read_only:false; response_revision:782; number_of_response:1; }","duration":"392.701962ms","start":"2026-04-23T09:45:51.366092Z","end":"2026-04-23T09:45:51.758794Z","steps":["trace[1801317610] 'process raft request' (duration: 392.023182ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:45:51.758885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T09:45:51.366081Z","time spent":"392.753403ms","remote":"127.0.0.1:60792","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T09:45:51.934684Z","caller":"traceutil/trace.go:171","msg":"trace[2139772691] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"171.111068ms","start":"2026-04-23T09:45:51.763548Z","end":"2026-04-23T09:45:51.934659Z","steps":["trace[2139772691] 'process raft request' (duration: 170.711767ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:46:06.334249Z","caller":"traceutil/trace.go:171","msg":"trace[6108977] transaction","detail":"{read_only:false; response_revision:920; number_of_response:1; }","duration":"144.793575ms","start":"2026-04-23T09:46:06.189438Z","end":"2026-04-23T09:46:06.334232Z","steps":["trace[6108977] 'process raft request' (duration: 142.858561ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:46:06.334331Z","caller":"traceutil/trace.go:171","msg":"trace[856972893] transaction","detail":"{read_only:false; response_revision:922; number_of_response:1; }","duration":"140.893726ms","start":"2026-04-23T09:46:06.193414Z","end":"2026-04-23T09:46:06.334308Z","steps":["trace[856972893] 'process raft request' (duration: 140.785713ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:46:06.334531Z","caller":"traceutil/trace.go:171","msg":"trace[1133272556] transaction","detail":"{read_only:false; response_revision:921; number_of_response:1; }","duration":"143.451758ms","start":"2026-04-23T09:46:06.191069Z","end":"2026-04-23T09:46:06.334521Z","steps":["trace[1133272556] 'process raft request' (duration: 143.074887ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:46:07.093667Z","caller":"traceutil/trace.go:171","msg":"trace[370243716] transaction","detail":"{read_only:false; response_revision:929; number_of_response:1; }","duration":"124.702269ms","start":"2026-04-23T09:46:06.968937Z","end":"2026-04-23T09:46:07.093639Z","steps":["trace[370243716] 'process raft request' (duration: 124.356109ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:48:01.521572Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":689224164010558314,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-23T09:48:01.639622Z","caller":"traceutil/trace.go:171","msg":"trace[515505904] transaction","detail":"{read_only:false; response_revision:1307; number_of_response:1; }","duration":"624.131129ms","start":"2026-04-23T09:48:01.015464Z","end":"2026-04-23T09:48:01.639595Z","steps":["trace[515505904] 'process raft request' (duration: 623.976474ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:48:01.639764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T09:48:01.015443Z","time spent":"624.248063ms","remote":"127.0.0.1:60792","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T09:48:01.671593Z","caller":"traceutil/trace.go:171","msg":"trace[1732159120] linearizableReadLoop","detail":"{readStateIndex:1362; appliedIndex:1360; }","duration":"650.962801ms","start":"2026-04-23T09:48:01.020608Z","end":"2026-04-23T09:48:01.671571Z","steps":["trace[1732159120] 'read index received' (duration: 618.840171ms)","trace[1732159120] 'applied index is now lower than readState.Index' (duration: 32.12169ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T09:48:01.671984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.91437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T09:48:01.672017Z","caller":"traceutil/trace.go:171","msg":"trace[2108955062] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1308; }","duration":"359.007303ms","start":"2026-04-23T09:48:01.313001Z","end":"2026-04-23T09:48:01.672008Z","steps":["trace[2108955062] 'agreement among raft nodes before linearized reading' (duration: 358.942361ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:48:01.672045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T09:48:01.312975Z","time spent":"359.062595ms","remote":"127.0.0.1:60512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-23T09:48:01.67197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.40766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T09:48:01.672752Z","caller":"traceutil/trace.go:171","msg":"trace[1145806976] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:1308; }","duration":"502.246235ms","start":"2026-04-23T09:48:01.170479Z","end":"2026-04-23T09:48:01.672725Z","steps":["trace[1145806976] 'agreement among raft nodes before linearized reading' (duration: 501.41371ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:48:01.672912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T09:48:01.170455Z","time spent":"502.338157ms","remote":"127.0.0.1:34184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"info","ts":"2026-04-23T09:48:01.672063Z","caller":"traceutil/trace.go:171","msg":"trace[134872853] transaction","detail":"{read_only:false; response_revision:1308; number_of_response:1; }","duration":"249.341604ms","start":"2026-04-23T09:48:01.422672Z","end":"2026-04-23T09:48:01.672013Z","steps":["trace[134872853] 'process raft request' (duration: 248.788978ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:48:01.673284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"652.436315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-23T09:48:01.673361Z","caller":"traceutil/trace.go:171","msg":"trace[1013076218] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1308; }","duration":"652.836167ms","start":"2026-04-23T09:48:01.020509Z","end":"2026-04-23T09:48:01.673345Z","steps":["trace[1013076218] 'agreement among raft nodes before linearized reading' (duration: 651.425375ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:48:01.673398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T09:48:01.020491Z","time spent":"652.899169ms","remote":"127.0.0.1:60792","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-23T09:49:21.117568Z","caller":"traceutil/trace.go:171","msg":"trace[1068140404] transaction","detail":"{read_only:false; response_revision:1569; number_of_response:1; }","duration":"135.196309ms","start":"2026-04-23T09:49:20.982344Z","end":"2026-04-23T09:49:21.11754Z","steps":["trace[1068140404] 'process raft request' (duration: 135.023655ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:49:26.417204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.797496ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-23T09:49:26.417305Z","caller":"traceutil/trace.go:171","msg":"trace[717756799] linearizableReadLoop","detail":"{readStateIndex:1657; appliedIndex:1656; }","duration":"105.913897ms","start":"2026-04-23T09:49:26.311376Z","end":"2026-04-23T09:49:26.41729Z","steps":["trace[717756799] 'read index received' (duration: 41.101µs)","trace[717756799] 'applied index is now lower than readState.Index' (duration: 105.871646ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T09:49:26.417315Z","caller":"traceutil/trace.go:171","msg":"trace[1751295549] transaction","detail":"{read_only:false; response_revision:1586; number_of_response:1; }","duration":"185.609621ms","start":"2026-04-23T09:49:26.231688Z","end":"2026-04-23T09:49:26.417297Z","steps":["trace[1751295549] 'process raft request' (duration: 29.646341ms)","trace[1751295549] 'compare' (duration: 155.57654ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T09:49:26.417448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.071231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-23T09:49:26.417467Z","caller":"traceutil/trace.go:171","msg":"trace[1835349431] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1586; }","duration":"106.122493ms","start":"2026-04-23T09:49:26.311337Z","end":"2026-04-23T09:49:26.41746Z","steps":["trace[1835349431] 'agreement among raft nodes before linearized reading' (duration: 106.02758ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:49:26.417558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.02666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T09:49:26.417598Z","caller":"traceutil/trace.go:171","msg":"trace[442024883] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1586; }","duration":"106.108242ms","start":"2026-04-23T09:49:26.31148Z","end":"2026-04-23T09:49:26.417588Z","steps":["trace[442024883] 'agreement among raft nodes before linearized reading' (duration: 106.053631ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:49:27.09022Z","caller":"traceutil/trace.go:171","msg":"trace[369136572] transaction","detail":"{read_only:false; response_revision:1588; number_of_response:1; }","duration":"149.974824ms","start":"2026-04-23T09:49:26.94022Z","end":"2026-04-23T09:49:27.090195Z","steps":["trace[369136572] 'process raft request' (duration: 149.828101ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:50:21.8616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.750601ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-23T09:50:21.861752Z","caller":"traceutil/trace.go:171","msg":"trace[1617928824] linearizableReadLoop","detail":"{readStateIndex:1904; appliedIndex:1903; }","duration":"223.953676ms","start":"2026-04-23T09:50:21.637773Z","end":"2026-04-23T09:50:21.861727Z","steps":["trace[1617928824] 'read index received' (duration: 64.859335ms)","trace[1617928824] 'applied index is now lower than readState.Index' (duration: 159.092781ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T09:50:21.861775Z","caller":"traceutil/trace.go:171","msg":"trace[528208787] transaction","detail":"{read_only:false; response_revision:1820; number_of_response:1; }","duration":"296.404515ms","start":"2026-04-23T09:50:21.565329Z","end":"2026-04-23T09:50:21.861734Z","steps":["trace[528208787] 'process raft request' (duration: 137.407097ms)","trace[528208787] 'compare' (duration: 158.595297ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T09:50:21.861852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.0686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T09:50:21.861898Z","caller":"traceutil/trace.go:171","msg":"trace[1771986196] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1820; }","duration":"224.142891ms","start":"2026-04-23T09:50:21.637738Z","end":"2026-04-23T09:50:21.861881Z","steps":["trace[1771986196] 'agreement among raft nodes before linearized reading' (duration: 224.057539ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:50:24.870807Z","caller":"traceutil/trace.go:171","msg":"trace[841547664] linearizableReadLoop","detail":"{readStateIndex:1942; appliedIndex:1941; }","duration":"148.952558ms","start":"2026-04-23T09:50:24.721822Z","end":"2026-04-23T09:50:24.870775Z","steps":["trace[841547664] 'read index received' (duration: 148.66668ms)","trace[841547664] 'applied index is now lower than readState.Index' (duration: 284.268µs)"],"step_count":2} {"level":"warn","ts":"2026-04-23T09:50:24.871024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.178204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-23T09:50:24.871066Z","caller":"traceutil/trace.go:171","msg":"trace[683888470] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1857; }","duration":"149.286946ms","start":"2026-04-23T09:50:24.721767Z","end":"2026-04-23T09:50:24.871054Z","steps":["trace[683888470] 'agreement among raft nodes before linearized reading' (duration: 149.119682ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:50:24.870924Z","caller":"traceutil/trace.go:171","msg":"trace[1716038605] transaction","detail":"{read_only:false; response_revision:1857; number_of_response:1; }","duration":"150.807088ms","start":"2026-04-23T09:50:24.720071Z","end":"2026-04-23T09:50:24.870878Z","steps":["trace[1716038605] 'process raft request' (duration: 150.427867ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:50:24.986199Z","caller":"traceutil/trace.go:171","msg":"trace[1266561447] transaction","detail":"{read_only:false; response_revision:1858; number_of_response:1; }","duration":"109.900337ms","start":"2026-04-23T09:50:24.87627Z","end":"2026-04-23T09:50:24.986171Z","steps":["trace[1266561447] 'process raft request' (duration: 109.691951ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:50:26.571364Z","caller":"traceutil/trace.go:171","msg":"trace[1140217593] transaction","detail":"{read_only:false; response_revision:1866; number_of_response:1; }","duration":"221.304315ms","start":"2026-04-23T09:50:26.350017Z","end":"2026-04-23T09:50:26.571321Z","steps":["trace[1140217593] 'process raft request' (duration: 221.070059ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:50:26.784985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.160865ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-23T09:50:26.785306Z","caller":"traceutil/trace.go:171","msg":"trace[1341304791] transaction","detail":"{read_only:false; response_revision:1867; number_of_response:1; }","duration":"209.231219ms","start":"2026-04-23T09:50:26.576023Z","end":"2026-04-23T09:50:26.785254Z","steps":["trace[1341304791] 'process raft request' (duration: 76.705514ms)","trace[1341304791] 'compare' (duration: 131.982781ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T09:50:26.999366Z","caller":"traceutil/trace.go:171","msg":"trace[1063053578] linearizableReadLoop","detail":"{readStateIndex:1953; appliedIndex:1952; }","duration":"123.568425ms","start":"2026-04-23T09:50:26.875768Z","end":"2026-04-23T09:50:26.999337Z","steps":["trace[1063053578] 'read index received' (duration: 123.337459ms)","trace[1063053578] 'applied index is now lower than readState.Index' (duration: 229.836µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T09:50:26.999443Z","caller":"traceutil/trace.go:171","msg":"trace[420107760] transaction","detail":"{read_only:false; response_revision:1868; number_of_response:1; }","duration":"206.494697ms","start":"2026-04-23T09:50:26.792897Z","end":"2026-04-23T09:50:26.999392Z","steps":["trace[420107760] 'process raft request' (duration: 206.293171ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:50:26.999712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.901025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-23T09:50:26.999798Z","caller":"traceutil/trace.go:171","msg":"trace[1004188825] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1868; }","duration":"124.086499ms","start":"2026-04-23T09:50:26.875702Z","end":"2026-04-23T09:50:26.999788Z","steps":["trace[1004188825] 'agreement among raft nodes before linearized reading' (duration: 123.777471ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:50:27.122753Z","caller":"traceutil/trace.go:171","msg":"trace[1475513023] transaction","detail":"{read_only:false; response_revision:1870; number_of_response:1; }","duration":"115.55203ms","start":"2026-04-23T09:50:27.007176Z","end":"2026-04-23T09:50:27.122728Z","steps":["trace[1475513023] 'process raft request' (duration: 109.183458ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:50:27.123278Z","caller":"traceutil/trace.go:171","msg":"trace[1620570343] transaction","detail":"{read_only:false; response_revision:1871; number_of_response:1; }","duration":"113.464233ms","start":"2026-04-23T09:50:27.009784Z","end":"2026-04-23T09:50:27.123248Z","steps":["trace[1620570343] 'process raft request' (duration: 112.839066ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:50:27.123563Z","caller":"traceutil/trace.go:171","msg":"trace[380894222] linearizableReadLoop","detail":"{readStateIndex:1955; appliedIndex:1954; }","duration":"113.861864ms","start":"2026-04-23T09:50:27.009691Z","end":"2026-04-23T09:50:27.123553Z","steps":["trace[380894222] 'read index received' (duration: 41.589339ms)","trace[380894222] 'applied index is now lower than readState.Index' (duration: 72.271685ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T09:50:27.123659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.948186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:1948"} {"level":"info","ts":"2026-04-23T09:50:27.123687Z","caller":"traceutil/trace.go:171","msg":"trace[1978367186] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:1873; }","duration":"114.039828ms","start":"2026-04-23T09:50:27.00964Z","end":"2026-04-23T09:50:27.123679Z","steps":["trace[1978367186] 'agreement among raft nodes before linearized reading' (duration: 113.954096ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:50:27.123821Z","caller":"traceutil/trace.go:171","msg":"trace[429953068] transaction","detail":"{read_only:false; response_revision:1872; number_of_response:1; }","duration":"113.869894ms","start":"2026-04-23T09:50:27.009936Z","end":"2026-04-23T09:50:27.123806Z","steps":["trace[429953068] 'process raft request' (duration: 113.181475ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:50:27.123989Z","caller":"traceutil/trace.go:171","msg":"trace[1574683229] transaction","detail":"{read_only:false; response_revision:1873; number_of_response:1; }","duration":"112.586239ms","start":"2026-04-23T09:50:27.011392Z","end":"2026-04-23T09:50:27.123978Z","steps":["trace[1574683229] 'process raft request' (duration: 112.084546ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:50:43.533212Z","caller":"traceutil/trace.go:171","msg":"trace[1492447975] linearizableReadLoop","detail":"{readStateIndex:2086; appliedIndex:2085; }","duration":"283.242932ms","start":"2026-04-23T09:50:43.249941Z","end":"2026-04-23T09:50:43.533183Z","steps":["trace[1492447975] 'read index received' (duration: 282.819881ms)","trace[1492447975] 'applied index is now lower than readState.Index' (duration: 421.891µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T09:50:43.53328Z","caller":"traceutil/trace.go:171","msg":"trace[782945065] transaction","detail":"{read_only:false; response_revision:1997; number_of_response:1; }","duration":"286.182631ms","start":"2026-04-23T09:50:43.247055Z","end":"2026-04-23T09:50:43.533237Z","steps":["trace[782945065] 'process raft request' (duration: 285.846972ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:50:43.53349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.737823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-23T09:50:43.5335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.531239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-23T09:50:43.533552Z","caller":"traceutil/trace.go:171","msg":"trace[1919833668] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1997; }","duration":"219.905197ms","start":"2026-04-23T09:50:43.313628Z","end":"2026-04-23T09:50:43.533533Z","steps":["trace[1919833668] 'agreement among raft nodes before linearized reading' (duration: 219.723053ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:50:43.533584Z","caller":"traceutil/trace.go:171","msg":"trace[2120767859] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1997; }","duration":"283.674403ms","start":"2026-04-23T09:50:43.249885Z","end":"2026-04-23T09:50:43.533559Z","steps":["trace[2120767859] 'agreement among raft nodes before linearized reading' (duration: 283.430837ms)"],"step_count":1}