{"level":"warn","ts":"2026-04-28T07:22:58.281674Z","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-28T07:22:58.281771Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.112: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.112:2380","--initial-cluster=instance=https://199.19.213.112:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.112:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.112: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-28T07:22:58.281839Z","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-28T07:22:58.281856Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.112:2380"]} {"level":"info","ts":"2026-04-28T07:22:58.281877Z","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-28T07:22:58.282668Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.112:2379"]} {"level":"info","ts":"2026-04-28T07:22:58.282761Z","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.112:2380"],"listen-peer-urls":["https://199.19.213.112:2380"],"advertise-client-urls":["https://199.19.213.112:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.112:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.112: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-28T07:22:58.297595Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"14.528566ms"} {"level":"info","ts":"2026-04-28T07:22:58.31834Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"197930edc5411b2e","cluster-id":"8165613f50a6d530"} {"level":"info","ts":"2026-04-28T07:22:58.318446Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e switched to configuration voters=()"} {"level":"info","ts":"2026-04-28T07:22:58.31849Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e became follower at term 0"} {"level":"info","ts":"2026-04-28T07:22:58.318509Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 197930edc5411b2e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-28T07:22:58.318529Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e became follower at term 1"} {"level":"info","ts":"2026-04-28T07:22:58.318581Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e switched to configuration voters=(1835552120904948526)"} {"level":"warn","ts":"2026-04-28T07:22:58.342551Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-28T07:22:58.344634Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-28T07:22:58.346568Z","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-28T07:22:58.350128Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"197930edc5411b2e","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-28T07:22:58.350324Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"197930edc5411b2e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-28T07:22:58.350437Z","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-28T07:22:58.350485Z","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-28T07:22:58.350495Z","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-28T07:22:58.351435Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e switched to configuration voters=(1835552120904948526)"} {"level":"info","ts":"2026-04-28T07:22:58.351549Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8165613f50a6d530","local-member-id":"197930edc5411b2e","added-peer-id":"197930edc5411b2e","added-peer-peer-urls":["https://199.19.213.112:2380"]} {"level":"info","ts":"2026-04-28T07:22:58.357555Z","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-28T07:22:58.35784Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"197930edc5411b2e","initial-advertise-peer-urls":["https://199.19.213.112:2380"],"listen-peer-urls":["https://199.19.213.112:2380"],"advertise-client-urls":["https://199.19.213.112:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.112:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-28T07:22:58.357896Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-28T07:22:58.35846Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.112:2380"} {"level":"info","ts":"2026-04-28T07:22:58.358513Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.112:2380"} {"level":"info","ts":"2026-04-28T07:22:58.819027Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e is starting a new election at term 1"} {"level":"info","ts":"2026-04-28T07:22:58.8191Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e became pre-candidate at term 1"} {"level":"info","ts":"2026-04-28T07:22:58.819137Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e received MsgPreVoteResp from 197930edc5411b2e at term 1"} {"level":"info","ts":"2026-04-28T07:22:58.819181Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e became candidate at term 2"} {"level":"info","ts":"2026-04-28T07:22:58.819194Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e received MsgVoteResp from 197930edc5411b2e at term 2"} {"level":"info","ts":"2026-04-28T07:22:58.819211Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"197930edc5411b2e became leader at term 2"} {"level":"info","ts":"2026-04-28T07:22:58.81923Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 197930edc5411b2e elected leader 197930edc5411b2e at term 2"} {"level":"info","ts":"2026-04-28T07:22:58.820789Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"197930edc5411b2e","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.112:2379]}","request-path":"/0/members/197930edc5411b2e/attributes","cluster-id":"8165613f50a6d530","publish-timeout":"7s"} {"level":"info","ts":"2026-04-28T07:22:58.820964Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-28T07:22:58.821027Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-28T07:22:58.821426Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-28T07:22:58.822421Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8165613f50a6d530","local-member-id":"197930edc5411b2e","cluster-version":"3.5"} {"level":"info","ts":"2026-04-28T07:22:58.822653Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-28T07:22:58.822678Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-28T07:22:58.824867Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.112:2379"} {"level":"info","ts":"2026-04-28T07:22:58.825031Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-28T07:22:58.825059Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-28T07:22:58.829316Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-04-28T07:23:00.378058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.162985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-28T07:23:00.378152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.179807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-28T07:23:00.37807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.355782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-28T07:23:00.378122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.606426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-28T07:23:00.378471Z","caller":"traceutil/trace.go:171","msg":"trace[490394201] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:3; }","duration":"258.967377ms","start":"2026-04-28T07:23:00.119487Z","end":"2026-04-28T07:23:00.378454Z","steps":["trace[490394201] 'range keys from in-memory index tree' (duration: 258.560885ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:23:00.378482Z","caller":"traceutil/trace.go:171","msg":"trace[1041465709] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:3; }","duration":"234.31215ms","start":"2026-04-28T07:23:00.143907Z","end":"2026-04-28T07:23:00.378219Z","steps":["trace[1041465709] 'range keys from in-memory index tree' (duration: 234.035432ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:23:00.378424Z","caller":"traceutil/trace.go:171","msg":"trace[711278849] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:3; }","duration":"234.782604ms","start":"2026-04-28T07:23:00.143619Z","end":"2026-04-28T07:23:00.378402Z","steps":["trace[711278849] 'range keys from in-memory index tree' (duration: 234.122025ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:23:00.37923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.382424ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"warn","ts":"2026-04-28T07:23:00.378153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.09349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.112\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-28T07:23:00.379345Z","caller":"traceutil/trace.go:171","msg":"trace[1287127811] range","detail":"{range_begin:/registry/masterleases/199.19.213.112; range_end:; response_count:0; response_revision:3; }","duration":"238.288584ms","start":"2026-04-28T07:23:00.141018Z","end":"2026-04-28T07:23:00.379307Z","steps":["trace[1287127811] 'range keys from in-memory index tree' (duration: 234.322951ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:23:00.378224Z","caller":"traceutil/trace.go:171","msg":"trace[1829920891] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:3; }","duration":"234.350261ms","start":"2026-04-28T07:23:00.143847Z","end":"2026-04-28T07:23:00.378197Z","steps":["trace[1829920891] 'range keys from in-memory index tree' (duration: 234.077813ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:23:00.379274Z","caller":"traceutil/trace.go:171","msg":"trace[1140826895] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"234.596068ms","start":"2026-04-28T07:23:00.144672Z","end":"2026-04-28T07:23:00.379268Z","steps":["trace[1140826895] 'process raft request' (duration: 103.699029ms)","trace[1140826895] 'compare' (duration: 129.620362ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T07:23:00.660012Z","caller":"traceutil/trace.go:171","msg":"trace[915324764] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"515.175943ms","start":"2026-04-28T07:23:00.144784Z","end":"2026-04-28T07:23:00.659959Z","steps":["trace[915324764] 'process raft request' (duration: 448.525084ms)","trace[915324764] 'compare' (duration: 66.411412ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T07:23:00.66008Z","caller":"traceutil/trace.go:171","msg":"trace[584841454] linearizableReadLoop","detail":"{readStateIndex:8; appliedIndex:6; }","duration":"515.229885ms","start":"2026-04-28T07:23:00.144834Z","end":"2026-04-28T07:23:00.660064Z","steps":["trace[584841454] 'read index received' (duration: 103.620487ms)","trace[584841454] 'applied index is now lower than readState.Index' (duration: 411.608588ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T07:23:00.660154Z","caller":"traceutil/trace.go:171","msg":"trace[2174829] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"515.309237ms","start":"2026-04-28T07:23:00.144836Z","end":"2026-04-28T07:23:00.660145Z","steps":["trace[2174829] 'process raft request' (duration: 515.024609ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:23:00.660179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:23:00.144763Z","time spent":"515.341758ms","remote":"127.0.0.1:47758","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T07:23:00.660254Z","caller":"traceutil/trace.go:171","msg":"trace[82564359] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"501.039908ms","start":"2026-04-28T07:23:00.159206Z","end":"2026-04-28T07:23:00.660246Z","steps":["trace[82564359] 'process raft request' (duration: 500.787241ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:23:00.660265Z","caller":"traceutil/trace.go:171","msg":"trace[18313843] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"515.342287ms","start":"2026-04-28T07:23:00.144892Z","end":"2026-04-28T07:23:00.660234Z","steps":["trace[18313843] 'process raft request' (duration: 515.045899ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:23:00.660296Z","caller":"traceutil/trace.go:171","msg":"trace[1963639335] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"515.265035ms","start":"2026-04-28T07:23:00.144998Z","end":"2026-04-28T07:23:00.660263Z","steps":["trace[1963639335] 'process raft request' (duration: 514.964627ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:23:00.660221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:23:00.144825Z","time spent":"515.350518ms","remote":"127.0.0.1:47758","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T07:23:00.660387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:23:00.14499Z","time spent":"515.361438ms","remote":"127.0.0.1:47758","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T07:23:00.660297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:23:00.159192Z","time spent":"501.08726ms","remote":"127.0.0.1:47416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3159,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T07:23:00.660417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:23:00.144873Z","time spent":"515.469212ms","remote":"127.0.0.1:47758","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T07:23:00.660467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.622056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-28T07:23:00.66049Z","caller":"traceutil/trace.go:171","msg":"trace[1920277413] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"515.622225ms","start":"2026-04-28T07:23:00.144842Z","end":"2026-04-28T07:23:00.660465Z","steps":["trace[1920277413] 'process raft request' (duration: 515.073219ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:23:00.660516Z","caller":"traceutil/trace.go:171","msg":"trace[916587963] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"500.987496ms","start":"2026-04-28T07:23:00.159483Z","end":"2026-04-28T07:23:00.66047Z","steps":["trace[916587963] 'process raft request' (duration: 500.548614ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:23:00.660507Z","caller":"traceutil/trace.go:171","msg":"trace[987223503] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"515.688998ms","start":"2026-04-28T07:23:00.144804Z","end":"2026-04-28T07:23:00.660493Z","steps":["trace[987223503] 'agreement among raft nodes before linearized reading' (duration: 515.584495ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:23:00.660603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:23:00.144793Z","time spent":"515.802511ms","remote":"127.0.0.1:47330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"warn","ts":"2026-04-28T07:23:00.660604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:23:00.144823Z","time spent":"515.726479ms","remote":"127.0.0.1:47758","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T07:23:00.660659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:23:00.159471Z","time spent":"501.123541ms","remote":"127.0.0.1:47502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T07:23:00.833904Z","caller":"traceutil/trace.go:171","msg":"trace[1908164669] linearizableReadLoop","detail":"{readStateIndex:15; appliedIndex:14; }","duration":"173.760637ms","start":"2026-04-28T07:23:00.660118Z","end":"2026-04-28T07:23:00.833878Z","steps":["trace[1908164669] 'read index received' (duration: 166.973533ms)","trace[1908164669] 'applied index is now lower than readState.Index' (duration: 6.786134ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T07:23:00.834047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.389526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-28T07:23:00.834099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"668.610748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-28T07:23:00.834162Z","caller":"traceutil/trace.go:171","msg":"trace[1119658510] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:12; }","duration":"668.711781ms","start":"2026-04-28T07:23:00.165436Z","end":"2026-04-28T07:23:00.834148Z","steps":["trace[1119658510] 'agreement among raft nodes before linearized reading' (duration: 668.611658ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:23:00.834105Z","caller":"traceutil/trace.go:171","msg":"trace[110622201] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:12; }","duration":"452.487669ms","start":"2026-04-28T07:23:00.381603Z","end":"2026-04-28T07:23:00.83409Z","steps":["trace[110622201] 'agreement among raft nodes before linearized reading' (duration: 452.402596ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:23:00.834212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:23:00.381583Z","time spent":"452.614873ms","remote":"127.0.0.1:47246","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-28T07:23:00.834204Z","caller":"traceutil/trace.go:171","msg":"trace[652608705] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"450.724338ms","start":"2026-04-28T07:23:00.383453Z","end":"2026-04-28T07:23:00.834178Z","steps":["trace[652608705] 'process raft request' (duration: 443.621965ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:23:00.834047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.982438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-28T07:23:00.834232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"679.442109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-28T07:23:00.834299Z","caller":"traceutil/trace.go:171","msg":"trace[958804715] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:12; }","duration":"251.273697ms","start":"2026-04-28T07:23:00.583Z","end":"2026-04-28T07:23:00.834274Z","steps":["trace[958804715] 'agreement among raft nodes before linearized reading' (duration: 250.923137ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:23:00.834318Z","caller":"traceutil/trace.go:171","msg":"trace[126644591] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:12; }","duration":"679.543731ms","start":"2026-04-28T07:23:00.154745Z","end":"2026-04-28T07:23:00.834288Z","steps":["trace[126644591] 'agreement among raft nodes before linearized reading' (duration: 679.375436ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:23:00.834267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"640.291517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-28T07:23:00.834329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:23:00.383429Z","time spent":"450.839552ms","remote":"127.0.0.1:47672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T07:23:00.834367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:23:00.154738Z","time spent":"679.620863ms","remote":"127.0.0.1:47616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"info","ts":"2026-04-28T07:23:00.834369Z","caller":"traceutil/trace.go:171","msg":"trace[312147613] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:12; }","duration":"640.40632ms","start":"2026-04-28T07:23:00.193949Z","end":"2026-04-28T07:23:00.834355Z","steps":["trace[312147613] 'agreement among raft nodes before linearized reading' (duration: 640.292267ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:23:00.834427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:23:00.193939Z","time spent":"640.461382ms","remote":"127.0.0.1:47356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-04-28T07:23:00.834212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:23:00.165401Z","time spent":"668.797494ms","remote":"127.0.0.1:47356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":30,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/default\" "} {"level":"info","ts":"2026-04-28T07:23:00.835436Z","caller":"traceutil/trace.go:171","msg":"trace[369000708] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"172.09652ms","start":"2026-04-28T07:23:00.663317Z","end":"2026-04-28T07:23:00.835413Z","steps":["trace[369000708] 'process raft request' (duration: 171.634726ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:23:00.835768Z","caller":"traceutil/trace.go:171","msg":"trace[835008251] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"170.272207ms","start":"2026-04-28T07:23:00.665483Z","end":"2026-04-28T07:23:00.835755Z","steps":["trace[835008251] 'process raft request' (duration: 170.02538ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:23:00.835572Z","caller":"traceutil/trace.go:171","msg":"trace[1252561887] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"170.554555ms","start":"2026-04-28T07:23:00.664995Z","end":"2026-04-28T07:23:00.835549Z","steps":["trace[1252561887] 'process raft request' (duration: 170.36904ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:23:00.835873Z","caller":"traceutil/trace.go:171","msg":"trace[12071787] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"170.778282ms","start":"2026-04-28T07:23:00.665086Z","end":"2026-04-28T07:23:00.835864Z","steps":["trace[12071787] 'process raft request' (duration: 170.36595ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:23:00.836006Z","caller":"traceutil/trace.go:171","msg":"trace[106594521] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"170.601677ms","start":"2026-04-28T07:23:00.665385Z","end":"2026-04-28T07:23:00.835987Z","steps":["trace[106594521] 'process raft request' (duration: 170.097863ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:23:00.835969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.382129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-lb8s9\" ","response":"range_response_count:1 size:861"} {"level":"info","ts":"2026-04-28T07:23:00.836125Z","caller":"traceutil/trace.go:171","msg":"trace[2017587444] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-lb8s9; range_end:; response_count:1; response_revision:19; }","duration":"171.572585ms","start":"2026-04-28T07:23:00.664541Z","end":"2026-04-28T07:23:00.836113Z","steps":["trace[2017587444] 'agreement among raft nodes before linearized reading' (duration: 171.169993ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:23:00.83609Z","caller":"traceutil/trace.go:171","msg":"trace[643949445] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"169.376742ms","start":"2026-04-28T07:23:00.666675Z","end":"2026-04-28T07:23:00.836051Z","steps":["trace[643949445] 'process raft request' (duration: 168.858247ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:23:00.836342Z","caller":"traceutil/trace.go:171","msg":"trace[1335156895] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"165.10332ms","start":"2026-04-28T07:23:00.671228Z","end":"2026-04-28T07:23:00.836331Z","steps":["trace[1335156895] 'process raft request' (duration: 164.391039ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:23:00.835523Z","caller":"traceutil/trace.go:171","msg":"trace[1071415723] transaction","detail":"{read_only:false; number_of_response:0; response_revision:13; }","duration":"172.08827ms","start":"2026-04-28T07:23:00.663393Z","end":"2026-04-28T07:23:00.835481Z","steps":["trace[1071415723] 'process raft request' (duration: 171.929545ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:23:54.134053Z","caller":"traceutil/trace.go:171","msg":"trace[459412288] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"159.061482ms","start":"2026-04-28T07:23:53.974958Z","end":"2026-04-28T07:23:54.134019Z","steps":["trace[459412288] 'process raft request' (duration: 158.429164ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:23:54.394818Z","caller":"traceutil/trace.go:171","msg":"trace[953902266] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"195.003281ms","start":"2026-04-28T07:23:54.199782Z","end":"2026-04-28T07:23:54.394785Z","steps":["trace[953902266] 'process raft request' (duration: 194.833286ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:23:54.413103Z","caller":"traceutil/trace.go:171","msg":"trace[648059878] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"170.974817ms","start":"2026-04-28T07:23:54.242103Z","end":"2026-04-28T07:23:54.413078Z","steps":["trace[648059878] 'process raft request' (duration: 170.765032ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:23:54.956433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.493886ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-28T07:23:54.956626Z","caller":"traceutil/trace.go:171","msg":"trace[1724380890] linearizableReadLoop","detail":"{readStateIndex:689; appliedIndex:688; }","duration":"383.948173ms","start":"2026-04-28T07:23:54.572653Z","end":"2026-04-28T07:23:54.956601Z","steps":["trace[1724380890] 'read index received' (duration: 245.027655ms)","trace[1724380890] 'applied index is now lower than readState.Index' (duration: 138.918828ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T07:23:54.956707Z","caller":"traceutil/trace.go:171","msg":"trace[1732983405] transaction","detail":"{read_only:false; response_revision:661; number_of_response:1; }","duration":"396.462944ms","start":"2026-04-28T07:23:54.560177Z","end":"2026-04-28T07:23:54.95664Z","steps":["trace[1732983405] 'process raft request' (duration: 257.409712ms)","trace[1732983405] 'compare' (duration: 138.28213ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T07:23:54.956849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.188219ms","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-28T07:23:54.956887Z","caller":"traceutil/trace.go:171","msg":"trace[625207245] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:661; }","duration":"384.245861ms","start":"2026-04-28T07:23:54.572628Z","end":"2026-04-28T07:23:54.956873Z","steps":["trace[625207245] 'agreement among raft nodes before linearized reading' (duration: 384.070747ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:23:54.956934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:23:54.572617Z","time spent":"384.305193ms","remote":"127.0.0.1:47510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-28T07:23:54.956929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:23:54.560162Z","time spent":"396.65198ms","remote":"127.0.0.1:47510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T07:23:54.980731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.293763ms","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-28T07:23:54.980862Z","caller":"traceutil/trace.go:171","msg":"trace[2008749780] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:662; }","duration":"286.473248ms","start":"2026-04-28T07:23:54.694359Z","end":"2026-04-28T07:23:54.980833Z","steps":["trace[2008749780] 'agreement among raft nodes before linearized reading' (duration: 286.129788ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:23:54.981485Z","caller":"traceutil/trace.go:171","msg":"trace[1870838530] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"168.391735ms","start":"2026-04-28T07:23:54.813022Z","end":"2026-04-28T07:23:54.981413Z","steps":["trace[1870838530] 'process raft request' (duration: 166.630086ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:24:11.753302Z","caller":"traceutil/trace.go:171","msg":"trace[141786940] transaction","detail":"{read_only:false; response_revision:827; number_of_response:1; }","duration":"237.109603ms","start":"2026-04-28T07:24:11.51616Z","end":"2026-04-28T07:24:11.753269Z","steps":["trace[141786940] 'process raft request' (duration: 236.785354ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:25:22.078231Z","caller":"traceutil/trace.go:171","msg":"trace[1872872151] transaction","detail":"{read_only:false; response_revision:1208; number_of_response:1; }","duration":"118.035392ms","start":"2026-04-28T07:25:21.960177Z","end":"2026-04-28T07:25:22.078213Z","steps":["trace[1872872151] 'process raft request' (duration: 116.823898ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:25:37.668296Z","caller":"traceutil/trace.go:171","msg":"trace[182181666] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"154.237753ms","start":"2026-04-28T07:25:37.51404Z","end":"2026-04-28T07:25:37.668278Z","steps":["trace[182181666] 'process raft request' (duration: 114.362777ms)","trace[182181666] 'compare' (duration: 39.627229ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T07:25:41.008184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.629337ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-28T07:25:41.008413Z","caller":"traceutil/trace.go:171","msg":"trace[428750028] linearizableReadLoop","detail":"{readStateIndex:1363; appliedIndex:1361; }","duration":"112.312769ms","start":"2026-04-28T07:25:40.896082Z","end":"2026-04-28T07:25:41.008395Z","steps":["trace[428750028] 'read index received' (duration: 101.868512ms)","trace[428750028] 'applied index is now lower than readState.Index' (duration: 10.443367ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T07:25:41.008549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.465593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-28T07:25:41.008586Z","caller":"traceutil/trace.go:171","msg":"trace[930651415] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1308; }","duration":"112.534655ms","start":"2026-04-28T07:25:40.89604Z","end":"2026-04-28T07:25:41.008575Z","steps":["trace[930651415] 'agreement among raft nodes before linearized reading' (duration: 112.411702ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:25:41.008593Z","caller":"traceutil/trace.go:171","msg":"trace[353151095] transaction","detail":"{read_only:false; response_revision:1307; number_of_response:1; }","duration":"253.968064ms","start":"2026-04-28T07:25:40.754592Z","end":"2026-04-28T07:25:41.00856Z","steps":["trace[353151095] 'process raft request' (duration: 114.380738ms)","trace[353151095] 'compare' (duration: 138.933427ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T07:25:41.0088Z","caller":"traceutil/trace.go:171","msg":"trace[305665549] transaction","detail":"{read_only:false; response_revision:1308; number_of_response:1; }","duration":"250.317919ms","start":"2026-04-28T07:25:40.758469Z","end":"2026-04-28T07:25:41.008787Z","steps":["trace[305665549] 'process raft request' (duration: 249.811915ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:25:41.150364Z","caller":"traceutil/trace.go:171","msg":"trace[926165106] transaction","detail":"{read_only:false; response_revision:1309; number_of_response:1; }","duration":"137.101045ms","start":"2026-04-28T07:25:41.01322Z","end":"2026-04-28T07:25:41.150321Z","steps":["trace[926165106] 'process raft request' (duration: 136.870678ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:28:37.166123Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1958676417386488108,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-28T07:28:37.666594Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1958676417386488108,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-28T07:28:38.166742Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1958676417386488108,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-28T07:28:38.224235Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.661843246s","expected-duration":"1s"} {"level":"info","ts":"2026-04-28T07:28:38.225542Z","caller":"traceutil/trace.go:171","msg":"trace[1295425188] transaction","detail":"{read_only:false; response_revision:2132; number_of_response:1; }","duration":"1.663241195s","start":"2026-04-28T07:28:36.562276Z","end":"2026-04-28T07:28:38.225517Z","steps":["trace[1295425188] 'process raft request' (duration: 1.662990958s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:28:38.225663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:28:36.562248Z","time spent":"1.663350819s","remote":"127.0.0.1:47510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T07:28:39.235065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000142576s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-28T07:28:39.235173Z","caller":"traceutil/trace.go:171","msg":"trace[2039245094] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00029627s","start":"2026-04-28T07:28:37.234857Z","end":"2026-04-28T07:28:39.235153Z","steps":["trace[2039245094] 'agreement among raft nodes before linearized reading' (duration: 2.000163517s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:28:39.235211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:28:37.234843Z","time spent":"2.000359182s","remote":"127.0.0.1:47236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-28T07:28:39.314086Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.089680414s","expected-duration":"1s"} {"level":"info","ts":"2026-04-28T07:28:39.354922Z","caller":"traceutil/trace.go:171","msg":"trace[734364282] linearizableReadLoop","detail":"{readStateIndex:2225; appliedIndex:2221; }","duration":"2.689447487s","start":"2026-04-28T07:28:36.665454Z","end":"2026-04-28T07:28:39.354902Z","steps":["trace[734364282] 'read index received' (duration: 1.559717819s)","trace[734364282] 'applied index is now lower than readState.Index' (duration: 1.129728958s)"],"step_count":2} {"level":"warn","ts":"2026-04-28T07:28:39.355222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.684676824s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-04-28T07:28:39.355224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.689778637s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-28T07:28:39.355252Z","caller":"traceutil/trace.go:171","msg":"trace[1842783040] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2134; }","duration":"2.684752396s","start":"2026-04-28T07:28:36.670491Z","end":"2026-04-28T07:28:39.355244Z","steps":["trace[1842783040] 'agreement among raft nodes before linearized reading' (duration: 2.684653933s)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:28:39.355268Z","caller":"traceutil/trace.go:171","msg":"trace[599502643] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2134; }","duration":"2.689868319s","start":"2026-04-28T07:28:36.665388Z","end":"2026-04-28T07:28:39.355256Z","steps":["trace[599502643] 'agreement among raft nodes before linearized reading' (duration: 2.689694674s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:28:39.355274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:28:36.670473Z","time spent":"2.684795857s","remote":"127.0.0.1:47510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-28T07:28:39.355296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:28:36.665364Z","time spent":"2.689924971s","remote":"127.0.0.1:47510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-28T07:28:39.355401Z","caller":"traceutil/trace.go:171","msg":"trace[1949156954] transaction","detail":"{read_only:false; response_revision:2133; number_of_response:1; }","duration":"1.990211948s","start":"2026-04-28T07:28:37.365163Z","end":"2026-04-28T07:28:39.355375Z","steps":["trace[1949156954] 'process raft request' (duration: 1.98960338s)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:28:39.355451Z","caller":"traceutil/trace.go:171","msg":"trace[1332225615] transaction","detail":"{read_only:false; response_revision:2134; number_of_response:1; }","duration":"1.20814874s","start":"2026-04-28T07:28:38.147291Z","end":"2026-04-28T07:28:39.35544Z","steps":["trace[1332225615] 'process raft request' (duration: 1.207573994s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:28:39.355512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:28:38.147266Z","time spent":"1.208208882s","remote":"127.0.0.1:47510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T07:28:39.355513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:28:37.365106Z","time spent":"1.990348141s","remote":"127.0.0.1:47510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T07:28:39.355552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.760532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T07:28:39.355513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.126756255s","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-28T07:28:39.355594Z","caller":"traceutil/trace.go:171","msg":"trace[834283334] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2134; }","duration":"1.126880928s","start":"2026-04-28T07:28:38.228703Z","end":"2026-04-28T07:28:39.355584Z","steps":["trace[834283334] 'agreement among raft nodes before linearized reading' (duration: 1.126734384s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:28:39.355621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:28:38.228684Z","time spent":"1.12692992s","remote":"127.0.0.1:47510","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-28T07:28:39.355581Z","caller":"traceutil/trace.go:171","msg":"trace[210858578] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2134; }","duration":"119.818784ms","start":"2026-04-28T07:28:39.235751Z","end":"2026-04-28T07:28:39.35557Z","steps":["trace[210858578] 'agreement among raft nodes before linearized reading' (duration: 119.783413ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:28:39.35563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.093504972s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:473"} {"level":"info","ts":"2026-04-28T07:28:39.355658Z","caller":"traceutil/trace.go:171","msg":"trace[2061809265] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2134; }","duration":"1.093560983s","start":"2026-04-28T07:28:38.262088Z","end":"2026-04-28T07:28:39.355649Z","steps":["trace[2061809265] 'agreement among raft nodes before linearized reading' (duration: 1.093484601s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:28:39.355677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:28:38.262074Z","time spent":"1.093598294s","remote":"127.0.0.1:47510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":496,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-28T07:28:39.355718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.695275157s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T07:28:39.355748Z","caller":"traceutil/trace.go:171","msg":"trace[358663611] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:2134; }","duration":"1.695307528s","start":"2026-04-28T07:28:37.66043Z","end":"2026-04-28T07:28:39.355738Z","steps":["trace[358663611] 'agreement among raft nodes before linearized reading' (duration: 1.695256236s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:28:39.355775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:28:37.660417Z","time spent":"1.695348609s","remote":"127.0.0.1:60934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-28T07:28:39.355813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.758486751s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-04-28T07:28:39.355834Z","caller":"traceutil/trace.go:171","msg":"trace[213742171] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2134; }","duration":"1.758537622s","start":"2026-04-28T07:28:37.597288Z","end":"2026-04-28T07:28:39.355826Z","steps":["trace[213742171] 'agreement among raft nodes before linearized reading' (duration: 1.758488211s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:28:39.35585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:28:37.597268Z","time spent":"1.758578704s","remote":"127.0.0.1:47510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-04-28T07:28:39.355852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.197638926s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-28T07:28:39.355877Z","caller":"traceutil/trace.go:171","msg":"trace[1581552759] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2134; }","duration":"1.197688488s","start":"2026-04-28T07:28:38.158182Z","end":"2026-04-28T07:28:39.355871Z","steps":["trace[1581552759] 'agreement among raft nodes before linearized reading' (duration: 1.197611165s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:28:39.355895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:28:38.158171Z","time spent":"1.197719598s","remote":"127.0.0.1:47510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-28T07:28:39.355932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.348924738s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T07:28:39.355963Z","caller":"traceutil/trace.go:171","msg":"trace[835195248] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:2134; }","duration":"2.34899785s","start":"2026-04-28T07:28:37.006957Z","end":"2026-04-28T07:28:39.355955Z","steps":["trace[835195248] 'agreement among raft nodes before linearized reading' (duration: 2.348949479s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:28:39.355961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.332661357s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:525"} {"level":"warn","ts":"2026-04-28T07:28:39.355988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:28:37.006939Z","time spent":"2.349041872s","remote":"127.0.0.1:47536","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":28,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "} {"level":"info","ts":"2026-04-28T07:28:39.356001Z","caller":"traceutil/trace.go:171","msg":"trace[1306655168] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2134; }","duration":"1.332738509s","start":"2026-04-28T07:28:38.023253Z","end":"2026-04-28T07:28:39.355991Z","steps":["trace[1306655168] 'agreement among raft nodes before linearized reading' (duration: 1.332646726s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:28:39.356026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:28:38.023237Z","time spent":"1.33278134s","remote":"127.0.0.1:47510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":548,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "}