{"level":"warn","ts":"2026-04-26T10:01:41.624704Z","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-26T10:01:41.624859Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.129:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.129:2380","--initial-cluster=instance=https://199.204.45.129:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.129:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.129: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-26T10:01:41.624938Z","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-26T10:01:41.62495Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.129:2380"]} {"level":"info","ts":"2026-04-26T10:01:41.624967Z","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-26T10:01:41.625606Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"]} {"level":"info","ts":"2026-04-26T10:01:41.625679Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.129:2380"],"listen-peer-urls":["https://199.204.45.129:2380"],"advertise-client-urls":["https://199.204.45.129:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.129: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-26T10:01:41.628882Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.003781ms"} {"level":"info","ts":"2026-04-26T10:01:41.636995Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3cec112083e8d3ff","cluster-id":"3f68255a3b440659"} {"level":"info","ts":"2026-04-26T10:01:41.637069Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=()"} {"level":"info","ts":"2026-04-26T10:01:41.637088Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became follower at term 0"} {"level":"info","ts":"2026-04-26T10:01:41.637098Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3cec112083e8d3ff [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-26T10:01:41.637106Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became follower at term 1"} {"level":"info","ts":"2026-04-26T10:01:41.637135Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=(4389902568129090559)"} {"level":"warn","ts":"2026-04-26T10:01:41.64398Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-26T10:01:41.64502Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-26T10:01:41.646207Z","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-26T10:01:41.647869Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3cec112083e8d3ff","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-26T10:01:41.651088Z","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-26T10:01:41.653759Z","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-26T10:01:41.653885Z","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-26T10:01:41.653897Z","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-26T10:01:41.653972Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3cec112083e8d3ff","initial-advertise-peer-urls":["https://199.204.45.129:2380"],"listen-peer-urls":["https://199.204.45.129:2380"],"advertise-client-urls":["https://199.204.45.129:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-26T10:01:41.65404Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-26T10:01:41.654017Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3cec112083e8d3ff","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-26T10:01:41.654271Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.129:2380"} {"level":"info","ts":"2026-04-26T10:01:41.654284Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.129:2380"} {"level":"info","ts":"2026-04-26T10:01:41.65696Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=(4389902568129090559)"} {"level":"info","ts":"2026-04-26T10:01:41.657095Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"3f68255a3b440659","local-member-id":"3cec112083e8d3ff","added-peer-id":"3cec112083e8d3ff","added-peer-peer-urls":["https://199.204.45.129:2380"]} {"level":"info","ts":"2026-04-26T10:01:42.137329Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff is starting a new election at term 1"} {"level":"info","ts":"2026-04-26T10:01:42.137404Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became pre-candidate at term 1"} {"level":"info","ts":"2026-04-26T10:01:42.137428Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff received MsgPreVoteResp from 3cec112083e8d3ff at term 1"} {"level":"info","ts":"2026-04-26T10:01:42.137445Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became candidate at term 2"} {"level":"info","ts":"2026-04-26T10:01:42.13745Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff received MsgVoteResp from 3cec112083e8d3ff at term 2"} {"level":"info","ts":"2026-04-26T10:01:42.137466Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became leader at term 2"} {"level":"info","ts":"2026-04-26T10:01:42.137473Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3cec112083e8d3ff elected leader 3cec112083e8d3ff at term 2"} {"level":"info","ts":"2026-04-26T10:01:42.139696Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-26T10:01:42.141811Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3cec112083e8d3ff","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.129:2379]}","request-path":"/0/members/3cec112083e8d3ff/attributes","cluster-id":"3f68255a3b440659","publish-timeout":"7s"} {"level":"info","ts":"2026-04-26T10:01:42.142204Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-26T10:01:42.142875Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-26T10:01:42.143106Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"3f68255a3b440659","local-member-id":"3cec112083e8d3ff","cluster-version":"3.5"} {"level":"info","ts":"2026-04-26T10:01:42.143168Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-26T10:01:42.143188Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-26T10:01:42.143196Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-26T10:01:42.143218Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-26T10:01:42.144475Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-26T10:01:42.156101Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.129:2379"} {"level":"warn","ts":"2026-04-26T10:01:43.636167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.066706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.129\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-26T10:01:43.636268Z","caller":"traceutil/trace.go:171","msg":"trace[1349458090] linearizableReadLoop","detail":"{readStateIndex:7; appliedIndex:6; }","duration":"168.541073ms","start":"2026-04-26T10:01:43.467707Z","end":"2026-04-26T10:01:43.636248Z","steps":["trace[1349458090] 'read index received' (duration: 115.124468ms)","trace[1349458090] 'applied index is now lower than readState.Index' (duration: 53.415795ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T10:01:43.63629Z","caller":"traceutil/trace.go:171","msg":"trace[849079252] range","detail":"{range_begin:/registry/masterleases/199.204.45.129; range_end:; response_count:0; response_revision:3; }","duration":"172.230348ms","start":"2026-04-26T10:01:43.464046Z","end":"2026-04-26T10:01:43.636276Z","steps":["trace[849079252] 'range keys from in-memory index tree' (duration: 171.971786ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T10:01:43.636283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.826552ms","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-26T10:01:43.636605Z","caller":"traceutil/trace.go:171","msg":"trace[560422114] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"169.939553ms","start":"2026-04-26T10:01:43.466652Z","end":"2026-04-26T10:01:43.636592Z","steps":["trace[560422114] 'process raft request' (duration: 116.153706ms)","trace[560422114] 'compare' (duration: 53.341214ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T10:01:43.636645Z","caller":"traceutil/trace.go:171","msg":"trace[637492427] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:3; }","duration":"170.124224ms","start":"2026-04-26T10:01:43.466396Z","end":"2026-04-26T10:01:43.63652Z","steps":["trace[637492427] 'range keys from in-memory index tree' (duration: 169.775661ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T10:01:43.636773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.060296ms","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-26T10:01:43.636807Z","caller":"traceutil/trace.go:171","msg":"trace[948909648] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:4; }","duration":"169.123696ms","start":"2026-04-26T10:01:43.467672Z","end":"2026-04-26T10:01:43.636796Z","steps":["trace[948909648] 'agreement among raft nodes before linearized reading' (duration: 169.054616ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:01:43.655867Z","caller":"traceutil/trace.go:171","msg":"trace[1136725889] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"187.709818ms","start":"2026-04-26T10:01:43.468136Z","end":"2026-04-26T10:01:43.655846Z","steps":["trace[1136725889] 'process raft request' (duration: 187.529746ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:01:43.655998Z","caller":"traceutil/trace.go:171","msg":"trace[1385944928] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"187.673657ms","start":"2026-04-26T10:01:43.468256Z","end":"2026-04-26T10:01:43.65593Z","steps":["trace[1385944928] 'process raft request' (duration: 187.548306ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:01:43.656131Z","caller":"traceutil/trace.go:171","msg":"trace[824662144] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"188.0143ms","start":"2026-04-26T10:01:43.468074Z","end":"2026-04-26T10:01:43.656089Z","steps":["trace[824662144] 'process raft request' (duration: 187.756019ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:01:43.656518Z","caller":"traceutil/trace.go:171","msg":"trace[1254639753] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"180.514136ms","start":"2026-04-26T10:01:43.47593Z","end":"2026-04-26T10:01:43.656444Z","steps":["trace[1254639753] 'process raft request' (duration: 179.948323ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:01:43.656564Z","caller":"traceutil/trace.go:171","msg":"trace[295196325] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"176.134707ms","start":"2026-04-26T10:01:43.480394Z","end":"2026-04-26T10:01:43.656529Z","steps":["trace[295196325] 'process raft request' (duration: 175.521572ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T10:01:43.65662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.869077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-26T10:01:43.656769Z","caller":"traceutil/trace.go:171","msg":"trace[1478881235] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:11; }","duration":"184.997588ms","start":"2026-04-26T10:01:43.471708Z","end":"2026-04-26T10:01:43.656706Z","steps":["trace[1478881235] 'agreement among raft nodes before linearized reading' (duration: 184.762705ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T10:01:43.657027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.610415ms","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-26T10:01:43.657065Z","caller":"traceutil/trace.go:171","msg":"trace[673274358] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"137.669496ms","start":"2026-04-26T10:01:43.519383Z","end":"2026-04-26T10:01:43.657053Z","steps":["trace[673274358] 'agreement among raft nodes before linearized reading' (duration: 137.615205ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:01:43.657078Z","caller":"traceutil/trace.go:171","msg":"trace[2082613957] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"188.676354ms","start":"2026-04-26T10:01:43.468363Z","end":"2026-04-26T10:01:43.65704Z","steps":["trace[2082613957] 'process raft request' (duration: 187.491906ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T10:01:43.657373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.932182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-26T10:01:43.657448Z","caller":"traceutil/trace.go:171","msg":"trace[1188703704] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:11; }","duration":"127.135213ms","start":"2026-04-26T10:01:43.530294Z","end":"2026-04-26T10:01:43.657429Z","steps":["trace[1188703704] 'agreement among raft nodes before linearized reading' (duration: 126.77163ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:01:43.656038Z","caller":"traceutil/trace.go:171","msg":"trace[231036173] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"187.804978ms","start":"2026-04-26T10:01:43.468208Z","end":"2026-04-26T10:01:43.656013Z","steps":["trace[231036173] 'process raft request' (duration: 187.559285ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:01:43.978368Z","caller":"traceutil/trace.go:171","msg":"trace[1887340324] linearizableReadLoop","detail":"{readStateIndex:26; appliedIndex:25; }","duration":"264.996619ms","start":"2026-04-26T10:01:43.71333Z","end":"2026-04-26T10:01:43.978327Z","steps":["trace[1887340324] 'read index received' (duration: 180.319855ms)","trace[1887340324] 'applied index is now lower than readState.Index' (duration: 84.675704ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T10:01:43.978551Z","caller":"traceutil/trace.go:171","msg":"trace[1288761895] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"265.25684ms","start":"2026-04-26T10:01:43.713266Z","end":"2026-04-26T10:01:43.978523Z","steps":["trace[1288761895] 'process raft request' (duration: 180.372915ms)","trace[1288761895] 'compare' (duration: 84.558544ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T10:01:43.978603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.248632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-26T10:01:43.978722Z","caller":"traceutil/trace.go:171","msg":"trace[2020303053] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:22; }","duration":"265.410323ms","start":"2026-04-26T10:01:43.713295Z","end":"2026-04-26T10:01:43.978706Z","steps":["trace[2020303053] 'agreement among raft nodes before linearized reading' (duration: 265.22882ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:01:43.990768Z","caller":"traceutil/trace.go:171","msg":"trace[1800183166] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"277.007215ms","start":"2026-04-26T10:01:43.713744Z","end":"2026-04-26T10:01:43.990752Z","steps":["trace[1800183166] 'process raft request' (duration: 276.655252ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T10:01:43.990843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.301342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-26T10:01:43.990936Z","caller":"traceutil/trace.go:171","msg":"trace[151252244] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"277.113595ms","start":"2026-04-26T10:01:43.713812Z","end":"2026-04-26T10:01:43.990925Z","steps":["trace[151252244] 'process raft request' (duration: 276.689053ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:01:43.990956Z","caller":"traceutil/trace.go:171","msg":"trace[25262222] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:0; response_revision:30; }","duration":"275.449023ms","start":"2026-04-26T10:01:43.715482Z","end":"2026-04-26T10:01:43.990931Z","steps":["trace[25262222] 'agreement among raft nodes before linearized reading' (duration: 275.269912ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:01:43.991049Z","caller":"traceutil/trace.go:171","msg":"trace[963602035] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"277.089205ms","start":"2026-04-26T10:01:43.713951Z","end":"2026-04-26T10:01:43.99104Z","steps":["trace[963602035] 'process raft request' (duration: 276.602232ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:01:43.991325Z","caller":"traceutil/trace.go:171","msg":"trace[625240520] transaction","detail":"{read_only:false; response_revision:26; number_of_response:1; }","duration":"275.933967ms","start":"2026-04-26T10:01:43.715377Z","end":"2026-04-26T10:01:43.991311Z","steps":["trace[625240520] 'process raft request' (duration: 275.204062ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:01:43.991486Z","caller":"traceutil/trace.go:171","msg":"trace[20264129] transaction","detail":"{read_only:false; response_revision:29; number_of_response:1; }","duration":"275.912067ms","start":"2026-04-26T10:01:43.71556Z","end":"2026-04-26T10:01:43.991472Z","steps":["trace[20264129] 'process raft request' (duration: 275.132712ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:01:43.991584Z","caller":"traceutil/trace.go:171","msg":"trace[582774371] transaction","detail":"{read_only:false; response_revision:28; number_of_response:1; }","duration":"276.010817ms","start":"2026-04-26T10:01:43.715565Z","end":"2026-04-26T10:01:43.991576Z","steps":["trace[582774371] 'process raft request' (duration: 275.09182ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:01:43.991637Z","caller":"traceutil/trace.go:171","msg":"trace[1018911742] transaction","detail":"{read_only:false; response_revision:27; number_of_response:1; }","duration":"276.078248ms","start":"2026-04-26T10:01:43.715545Z","end":"2026-04-26T10:01:43.991624Z","steps":["trace[1018911742] 'process raft request' (duration: 275.080241ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:01:43.991658Z","caller":"traceutil/trace.go:171","msg":"trace[996484856] transaction","detail":"{read_only:false; response_revision:30; number_of_response:1; }","duration":"274.9609ms","start":"2026-04-26T10:01:43.71666Z","end":"2026-04-26T10:01:43.991621Z","steps":["trace[996484856] 'process raft request' (duration: 274.057204ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T10:01:43.991867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.146348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-26T10:01:43.991957Z","caller":"traceutil/trace.go:171","msg":"trace[2136107593] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:30; }","duration":"118.24578ms","start":"2026-04-26T10:01:43.873696Z","end":"2026-04-26T10:01:43.991941Z","steps":["trace[2136107593] 'agreement among raft nodes before linearized reading' (duration: 118.117288ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:01:44.152877Z","caller":"traceutil/trace.go:171","msg":"trace[796025785] linearizableReadLoop","detail":"{readStateIndex:35; appliedIndex:34; }","duration":"157.902867ms","start":"2026-04-26T10:01:43.99495Z","end":"2026-04-26T10:01:44.152852Z","steps":["trace[796025785] 'read index received' (duration: 86.808118ms)","trace[796025785] 'applied index is now lower than readState.Index' (duration: 71.093669ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T10:01:44.152953Z","caller":"traceutil/trace.go:171","msg":"trace[1642127926] transaction","detail":"{read_only:false; response_revision:31; number_of_response:1; }","duration":"171.180432ms","start":"2026-04-26T10:01:43.981735Z","end":"2026-04-26T10:01:44.152915Z","steps":["trace[1642127926] 'process raft request' (duration: 99.927212ms)","trace[1642127926] 'compare' (duration: 71.076388ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T10:01:44.153142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.167579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-node-lease/\" range_end:\"/registry/resourcequotas/kube-node-lease0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-26T10:01:44.153207Z","caller":"traceutil/trace.go:171","msg":"trace[1138977724] range","detail":"{range_begin:/registry/resourcequotas/kube-node-lease/; range_end:/registry/resourcequotas/kube-node-lease0; response_count:0; response_revision:31; }","duration":"158.247651ms","start":"2026-04-26T10:01:43.994944Z","end":"2026-04-26T10:01:44.153192Z","steps":["trace[1138977724] 'agreement among raft nodes before linearized reading' (duration: 158.016429ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:01:44.153308Z","caller":"traceutil/trace.go:171","msg":"trace[602429118] transaction","detail":"{read_only:false; response_revision:32; number_of_response:1; }","duration":"151.10038ms","start":"2026-04-26T10:01:44.002192Z","end":"2026-04-26T10:01:44.153292Z","steps":["trace[602429118] 'process raft request' (duration: 150.949209ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:01:44.153438Z","caller":"traceutil/trace.go:171","msg":"trace[845089441] transaction","detail":"{read_only:false; response_revision:36; number_of_response:1; }","duration":"151.110351ms","start":"2026-04-26T10:01:44.002306Z","end":"2026-04-26T10:01:44.153417Z","steps":["trace[845089441] 'process raft request' (duration: 151.01515ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:01:44.153508Z","caller":"traceutil/trace.go:171","msg":"trace[1628912522] transaction","detail":"{read_only:false; response_revision:34; number_of_response:1; }","duration":"151.227021ms","start":"2026-04-26T10:01:44.002268Z","end":"2026-04-26T10:01:44.153495Z","steps":["trace[1628912522] 'process raft request' (duration: 151.01056ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T10:01:44.153525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.927368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-26T10:01:44.153505Z","caller":"traceutil/trace.go:171","msg":"trace[1878969818] transaction","detail":"{read_only:false; response_revision:33; number_of_response:1; }","duration":"151.275331ms","start":"2026-04-26T10:01:44.002219Z","end":"2026-04-26T10:01:44.153494Z","steps":["trace[1878969818] 'process raft request' (duration: 151.02789ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:01:44.153596Z","caller":"traceutil/trace.go:171","msg":"trace[527246283] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:38; }","duration":"114.03366ms","start":"2026-04-26T10:01:44.039546Z","end":"2026-04-26T10:01:44.15358Z","steps":["trace[527246283] 'agreement among raft nodes before linearized reading' (duration: 113.874169ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:01:44.153621Z","caller":"traceutil/trace.go:171","msg":"trace[583055507] transaction","detail":"{read_only:false; response_revision:37; number_of_response:1; }","duration":"151.199481ms","start":"2026-04-26T10:01:44.002408Z","end":"2026-04-26T10:01:44.153608Z","steps":["trace[583055507] 'process raft request' (duration: 150.930649ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:01:44.153439Z","caller":"traceutil/trace.go:171","msg":"trace[1412766959] transaction","detail":"{read_only:false; response_revision:35; number_of_response:1; }","duration":"151.132421ms","start":"2026-04-26T10:01:44.002283Z","end":"2026-04-26T10:01:44.153415Z","steps":["trace[1412766959] 'process raft request' (duration: 151.01589ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:01:44.15371Z","caller":"traceutil/trace.go:171","msg":"trace[2100119028] transaction","detail":"{read_only:false; response_revision:38; number_of_response:1; }","duration":"151.141811ms","start":"2026-04-26T10:01:44.002558Z","end":"2026-04-26T10:01:44.153699Z","steps":["trace[2100119028] 'process raft request' (duration: 150.826448ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:01:44.472833Z","caller":"traceutil/trace.go:171","msg":"trace[1927634535] transaction","detail":"{read_only:false; response_revision:47; number_of_response:1; }","duration":"171.867945ms","start":"2026-04-26T10:01:44.300936Z","end":"2026-04-26T10:01:44.472804Z","steps":["trace[1927634535] 'process raft request' (duration: 134.04535ms)","trace[1927634535] 'compare' (duration: 37.689874ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T10:01:44.473417Z","caller":"traceutil/trace.go:171","msg":"trace[126832251] linearizableReadLoop","detail":"{readStateIndex:54; appliedIndex:51; }","duration":"109.244397ms","start":"2026-04-26T10:01:44.364159Z","end":"2026-04-26T10:01:44.473404Z","steps":["trace[126832251] 'read index received' (duration: 70.823657ms)","trace[126832251] 'applied index is now lower than readState.Index' (duration: 38.41974ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T10:01:44.473422Z","caller":"traceutil/trace.go:171","msg":"trace[867639394] transaction","detail":"{read_only:false; response_revision:48; number_of_response:1; }","duration":"172.4673ms","start":"2026-04-26T10:01:44.300933Z","end":"2026-04-26T10:01:44.4734Z","steps":["trace[867639394] 'process raft request' (duration: 172.336519ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T10:01:44.473708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.126426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-26T10:01:44.473733Z","caller":"traceutil/trace.go:171","msg":"trace[34461849] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:49; }","duration":"109.181966ms","start":"2026-04-26T10:01:44.364544Z","end":"2026-04-26T10:01:44.473726Z","steps":["trace[34461849] 'agreement among raft nodes before linearized reading' (duration: 109.122246ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T10:01:44.473746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.567889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-26T10:01:44.473784Z","caller":"traceutil/trace.go:171","msg":"trace[1746791163] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:49; }","duration":"109.65978ms","start":"2026-04-26T10:01:44.364113Z","end":"2026-04-26T10:01:44.473773Z","steps":["trace[1746791163] 'agreement among raft nodes before linearized reading' (duration: 109.587209ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:01:44.473927Z","caller":"traceutil/trace.go:171","msg":"trace[710187069] transaction","detail":"{read_only:false; response_revision:49; number_of_response:1; }","duration":"172.927483ms","start":"2026-04-26T10:01:44.300989Z","end":"2026-04-26T10:01:44.473917Z","steps":["trace[710187069] 'process raft request' (duration: 172.336559ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:01:44.627584Z","caller":"traceutil/trace.go:171","msg":"trace[2085061139] transaction","detail":"{read_only:false; response_revision:51; number_of_response:1; }","duration":"149.419469ms","start":"2026-04-26T10:01:44.478132Z","end":"2026-04-26T10:01:44.627551Z","steps":["trace[2085061139] 'process raft request' (duration: 137.076882ms)","trace[2085061139] 'compare' (duration: 12.050125ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T10:01:44.627802Z","caller":"traceutil/trace.go:171","msg":"trace[1574931991] linearizableReadLoop","detail":"{readStateIndex:58; appliedIndex:55; }","duration":"148.135141ms","start":"2026-04-26T10:01:44.479643Z","end":"2026-04-26T10:01:44.627778Z","steps":["trace[1574931991] 'read index received' (duration: 1.042498ms)","trace[1574931991] 'applied index is now lower than readState.Index' (duration: 147.091543ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T10:01:44.628058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.395032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-admin\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-26T10:01:44.628095Z","caller":"traceutil/trace.go:171","msg":"trace[2116206872] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-admin; range_end:; response_count:0; response_revision:53; }","duration":"148.469732ms","start":"2026-04-26T10:01:44.479615Z","end":"2026-04-26T10:01:44.628084Z","steps":["trace[2116206872] 'agreement among raft nodes before linearized reading' (duration: 148.392252ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T10:01:44.628099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.996537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.18a9dfe491c3cafa\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-26T10:01:44.628141Z","caller":"traceutil/trace.go:171","msg":"trace[1113769155] range","detail":"{range_begin:/registry/events/default/instance.18a9dfe491c3cafa; range_end:; response_count:0; response_revision:53; }","duration":"145.081598ms","start":"2026-04-26T10:01:44.483047Z","end":"2026-04-26T10:01:44.628129Z","steps":["trace[1113769155] 'agreement among raft nodes before linearized reading' (duration: 145.004077ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:01:44.628321Z","caller":"traceutil/trace.go:171","msg":"trace[814925275] transaction","detail":"{read_only:false; response_revision:52; number_of_response:1; }","duration":"150.059414ms","start":"2026-04-26T10:01:44.478251Z","end":"2026-04-26T10:01:44.62831Z","steps":["trace[814925275] 'process raft request' (duration: 149.373239ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:01:44.628433Z","caller":"traceutil/trace.go:171","msg":"trace[1281075476] transaction","detail":"{read_only:false; response_revision:53; number_of_response:1; }","duration":"149.63207ms","start":"2026-04-26T10:01:44.47879Z","end":"2026-04-26T10:01:44.628422Z","steps":["trace[1281075476] 'process raft request' (duration: 148.900105ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T10:01:51.53223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.859808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-04-26T10:01:51.532311Z","caller":"traceutil/trace.go:171","msg":"trace[25103812] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:336; }","duration":"101.023958ms","start":"2026-04-26T10:01:51.43127Z","end":"2026-04-26T10:01:51.532294Z","steps":["trace[25103812] 'range keys from in-memory index tree' (duration: 100.735877ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T10:01:51.937568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.166125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-04-26T10:01:51.937671Z","caller":"traceutil/trace.go:171","msg":"trace[783043787] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:340; }","duration":"106.308276ms","start":"2026-04-26T10:01:51.831331Z","end":"2026-04-26T10:01:51.93764Z","steps":["trace[783043787] 'range keys from in-memory index tree' (duration: 106.039214ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:01:52.292102Z","caller":"traceutil/trace.go:171","msg":"trace[1760064755] linearizableReadLoop","detail":"{readStateIndex:356; appliedIndex:355; }","duration":"160.829459ms","start":"2026-04-26T10:01:52.131235Z","end":"2026-04-26T10:01:52.292064Z","steps":["trace[1760064755] 'read index received' (duration: 154.238162ms)","trace[1760064755] 'applied index is now lower than readState.Index' (duration: 6.590417ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T10:01:52.292149Z","caller":"traceutil/trace.go:171","msg":"trace[1169120635] transaction","detail":"{read_only:false; response_revision:347; number_of_response:1; }","duration":"182.240389ms","start":"2026-04-26T10:01:52.109888Z","end":"2026-04-26T10:01:52.292128Z","steps":["trace[1169120635] 'process raft request' (duration: 175.629872ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T10:01:52.292225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.97113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-04-26T10:01:52.292247Z","caller":"traceutil/trace.go:171","msg":"trace[175230987] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:347; }","duration":"161.04297ms","start":"2026-04-26T10:01:52.131198Z","end":"2026-04-26T10:01:52.292241Z","steps":["trace[175230987] 'agreement among raft nodes before linearized reading' (duration: 160.97826ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T10:01:52.292386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.280785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-04-26T10:01:52.292468Z","caller":"traceutil/trace.go:171","msg":"trace[639780192] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:347; }","duration":"110.431325ms","start":"2026-04-26T10:01:52.182016Z","end":"2026-04-26T10:01:52.292448Z","steps":["trace[639780192] 'agreement among raft nodes before linearized reading' (duration: 110.253284ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:02:00.948495Z","caller":"traceutil/trace.go:171","msg":"trace[1081084814] transaction","detail":"{read_only:false; response_revision:444; number_of_response:1; }","duration":"113.779481ms","start":"2026-04-26T10:02:00.834697Z","end":"2026-04-26T10:02:00.948477Z","steps":["trace[1081084814] 'process raft request' (duration: 113.602635ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:02:03.582052Z","caller":"traceutil/trace.go:171","msg":"trace[559605139] transaction","detail":"{read_only:false; response_revision:450; number_of_response:1; }","duration":"122.166385ms","start":"2026-04-26T10:02:03.459864Z","end":"2026-04-26T10:02:03.582031Z","steps":["trace[559605139] 'process raft request' (duration: 121.941067ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T10:02:07.613634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.685175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-26T10:02:07.613759Z","caller":"traceutil/trace.go:171","msg":"trace[1332494606] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:494; }","duration":"120.816557ms","start":"2026-04-26T10:02:07.492887Z","end":"2026-04-26T10:02:07.613703Z","steps":["trace[1332494606] 'range keys from in-memory index tree' (duration: 120.616022ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T10:02:07.613518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.145696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-26T10:02:07.613943Z","caller":"traceutil/trace.go:171","msg":"trace[292347076] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:494; }","duration":"131.584537ms","start":"2026-04-26T10:02:07.48229Z","end":"2026-04-26T10:02:07.613875Z","steps":["trace[292347076] 'range keys from in-memory index tree' (duration: 131.055454ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:02:07.875285Z","caller":"traceutil/trace.go:171","msg":"trace[261093952] linearizableReadLoop","detail":"{readStateIndex:511; appliedIndex:510; }","duration":"155.837038ms","start":"2026-04-26T10:02:07.719406Z","end":"2026-04-26T10:02:07.875243Z","steps":["trace[261093952] 'read index received' (duration: 141.569037ms)","trace[261093952] 'applied index is now lower than readState.Index' (duration: 14.266821ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T10:02:07.8754Z","caller":"traceutil/trace.go:171","msg":"trace[429017769] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"190.120358ms","start":"2026-04-26T10:02:07.685259Z","end":"2026-04-26T10:02:07.87538Z","steps":["trace[429017769] 'process raft request' (duration: 175.660393ms)","trace[429017769] 'compare' (duration: 14.209879ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T10:02:07.875431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.004042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-26T10:02:07.875507Z","caller":"traceutil/trace.go:171","msg":"trace[1510304998] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:497; }","duration":"156.125685ms","start":"2026-04-26T10:02:07.719364Z","end":"2026-04-26T10:02:07.87549Z","steps":["trace[1510304998] 'agreement among raft nodes before linearized reading' (duration: 156.000612ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:02:08.714781Z","caller":"traceutil/trace.go:171","msg":"trace[871751452] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"229.167592ms","start":"2026-04-26T10:02:08.485568Z","end":"2026-04-26T10:02:08.714736Z","steps":["trace[871751452] 'process raft request' (duration: 179.891502ms)","trace[871751452] 'compare' (duration: 49.110466ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T10:02:08.722321Z","caller":"traceutil/trace.go:171","msg":"trace[896838696] linearizableReadLoop","detail":"{readStateIndex:568; appliedIndex:565; }","duration":"148.804986ms","start":"2026-04-26T10:02:08.5735Z","end":"2026-04-26T10:02:08.722305Z","steps":["trace[896838696] 'read index received' (duration: 91.837955ms)","trace[896838696] 'applied index is now lower than readState.Index' (duration: 56.966381ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T10:02:08.722501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.98859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-26T10:02:08.722535Z","caller":"traceutil/trace.go:171","msg":"trace[568875426] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:547; }","duration":"149.070662ms","start":"2026-04-26T10:02:08.573454Z","end":"2026-04-26T10:02:08.722525Z","steps":["trace[568875426] 'agreement among raft nodes before linearized reading' (duration: 148.916648ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:02:08.722629Z","caller":"traceutil/trace.go:171","msg":"trace[2077751668] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"210.464975ms","start":"2026-04-26T10:02:08.512145Z","end":"2026-04-26T10:02:08.72261Z","steps":["trace[2077751668] 'process raft request' (duration: 208.426202ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:02:08.722716Z","caller":"traceutil/trace.go:171","msg":"trace[825989078] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"193.083835ms","start":"2026-04-26T10:02:08.52962Z","end":"2026-04-26T10:02:08.722704Z","steps":["trace[825989078] 'process raft request' (duration: 191.240127ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T10:02:10.221458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.396174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutefilters.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:15688"} {"level":"info","ts":"2026-04-26T10:02:10.22155Z","caller":"traceutil/trace.go:171","msg":"trace[1710961036] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/httproutefilters.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:576; }","duration":"133.543688ms","start":"2026-04-26T10:02:10.087986Z","end":"2026-04-26T10:02:10.221529Z","steps":["trace[1710961036] 'range keys from in-memory index tree' (duration: 133.172478ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:02:15.435284Z","caller":"traceutil/trace.go:171","msg":"trace[431111724] linearizableReadLoop","detail":"{readStateIndex:630; appliedIndex:629; }","duration":"134.948094ms","start":"2026-04-26T10:02:15.300309Z","end":"2026-04-26T10:02:15.435257Z","steps":["trace[431111724] 'read index received' (duration: 134.706518ms)","trace[431111724] 'applied index is now lower than readState.Index' (duration: 240.446µs)"],"step_count":2} {"level":"warn","ts":"2026-04-26T10:02:15.435477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.106418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.129\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-26T10:02:15.435477Z","caller":"traceutil/trace.go:171","msg":"trace[326612646] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"245.479005ms","start":"2026-04-26T10:02:15.189968Z","end":"2026-04-26T10:02:15.435447Z","steps":["trace[326612646] 'process raft request' (duration: 245.109335ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:02:15.43552Z","caller":"traceutil/trace.go:171","msg":"trace[221433645] range","detail":"{range_begin:/registry/masterleases/199.204.45.129; range_end:; response_count:1; response_revision:608; }","duration":"135.242662ms","start":"2026-04-26T10:02:15.300266Z","end":"2026-04-26T10:02:15.435509Z","steps":["trace[221433645] 'agreement among raft nodes before linearized reading' (duration: 135.091698ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:02:18.168285Z","caller":"traceutil/trace.go:171","msg":"trace[1653052850] linearizableReadLoop","detail":"{readStateIndex:678; appliedIndex:677; }","duration":"203.67364ms","start":"2026-04-26T10:02:17.964591Z","end":"2026-04-26T10:02:18.168265Z","steps":["trace[1653052850] 'read index received' (duration: 203.520816ms)","trace[1653052850] 'applied index is now lower than readState.Index' (duration: 151.724µs)"],"step_count":2} {"level":"info","ts":"2026-04-26T10:02:18.168362Z","caller":"traceutil/trace.go:171","msg":"trace[1223154229] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"232.639102ms","start":"2026-04-26T10:02:17.935672Z","end":"2026-04-26T10:02:18.168311Z","steps":["trace[1223154229] 'process raft request' (duration: 232.453097ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T10:02:18.168589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.977229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-gnm2j\" ","response":"range_response_count:1 size:17524"} {"level":"info","ts":"2026-04-26T10:02:18.168632Z","caller":"traceutil/trace.go:171","msg":"trace[2047493827] range","detail":"{range_begin:/registry/pods/kube-system/cilium-gnm2j; range_end:; response_count:1; response_revision:655; }","duration":"204.05931ms","start":"2026-04-26T10:02:17.964563Z","end":"2026-04-26T10:02:18.168622Z","steps":["trace[2047493827] 'agreement among raft nodes before linearized reading' (duration: 203.801373ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:02:18.236252Z","caller":"traceutil/trace.go:171","msg":"trace[848465534] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"199.486961ms","start":"2026-04-26T10:02:18.036747Z","end":"2026-04-26T10:02:18.236234Z","steps":["trace[848465534] 'process raft request' (duration: 199.426279ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:02:18.236479Z","caller":"traceutil/trace.go:171","msg":"trace[1773245991] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"270.893396ms","start":"2026-04-26T10:02:17.965551Z","end":"2026-04-26T10:02:18.236444Z","steps":["trace[1773245991] 'process raft request' (duration: 270.476695ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T10:02:18.236558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.681277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-26T10:02:18.236621Z","caller":"traceutil/trace.go:171","msg":"trace[1100874012] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:657; }","duration":"261.789419ms","start":"2026-04-26T10:02:17.974818Z","end":"2026-04-26T10:02:18.236608Z","steps":["trace[1100874012] 'agreement among raft nodes before linearized reading' (duration: 261.527692ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:02:18.461422Z","caller":"traceutil/trace.go:171","msg":"trace[1695253700] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"191.515725ms","start":"2026-04-26T10:02:18.269876Z","end":"2026-04-26T10:02:18.461391Z","steps":["trace[1695253700] 'process raft request' (duration: 189.552054ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:02:18.465547Z","caller":"traceutil/trace.go:171","msg":"trace[433151420] linearizableReadLoop","detail":"{readStateIndex:687; appliedIndex:684; }","duration":"141.804153ms","start":"2026-04-26T10:02:18.323725Z","end":"2026-04-26T10:02:18.46553Z","steps":["trace[433151420] 'read index received' (duration: 135.882549ms)","trace[433151420] 'applied index is now lower than readState.Index' (duration: 5.920794ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T10:02:18.465655Z","caller":"traceutil/trace.go:171","msg":"trace[1141014412] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"196.104483ms","start":"2026-04-26T10:02:18.269537Z","end":"2026-04-26T10:02:18.465641Z","steps":["trace[1141014412] 'process raft request' (duration: 195.791194ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T10:02:18.46581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.070409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-26T10:02:18.465876Z","caller":"traceutil/trace.go:171","msg":"trace[1278836468] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:664; }","duration":"142.179852ms","start":"2026-04-26T10:02:18.323681Z","end":"2026-04-26T10:02:18.46586Z","steps":["trace[1278836468] 'agreement among raft nodes before linearized reading' (duration: 142.003628ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:02:18.466083Z","caller":"traceutil/trace.go:171","msg":"trace[685653476] transaction","detail":"{read_only:false; response_revision:664; number_of_response:1; }","duration":"195.336563ms","start":"2026-04-26T10:02:18.270734Z","end":"2026-04-26T10:02:18.466071Z","steps":["trace[685653476] 'process raft request' (duration: 194.740147ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:02:18.577865Z","caller":"traceutil/trace.go:171","msg":"trace[73729509] transaction","detail":"{read_only:false; response_revision:666; number_of_response:1; }","duration":"101.138166ms","start":"2026-04-26T10:02:18.476713Z","end":"2026-04-26T10:02:18.577852Z","steps":["trace[73729509] 'process raft request' (duration: 100.764407ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:02:18.723341Z","caller":"traceutil/trace.go:171","msg":"trace[2124519825] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"135.565801ms","start":"2026-04-26T10:02:18.587745Z","end":"2026-04-26T10:02:18.72331Z","steps":["trace[2124519825] 'process raft request' (duration: 134.830812ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:02:19.239243Z","caller":"traceutil/trace.go:171","msg":"trace[240592092] linearizableReadLoop","detail":"{readStateIndex:696; appliedIndex:695; }","duration":"205.779474ms","start":"2026-04-26T10:02:19.033429Z","end":"2026-04-26T10:02:19.239208Z","steps":["trace[240592092] 'read index received' (duration: 30.708907ms)","trace[240592092] 'applied index is now lower than readState.Index' (duration: 175.069307ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T10:02:19.239408Z","caller":"traceutil/trace.go:171","msg":"trace[431929386] transaction","detail":"{read_only:false; response_revision:673; number_of_response:1; }","duration":"249.87065ms","start":"2026-04-26T10:02:18.989526Z","end":"2026-04-26T10:02:19.239396Z","steps":["trace[431929386] 'process raft request' (duration: 249.347586ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T10:02:19.239549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.729925ms","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-26T10:02:19.239609Z","caller":"traceutil/trace.go:171","msg":"trace[994075735] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:673; }","duration":"197.803467ms","start":"2026-04-26T10:02:19.041791Z","end":"2026-04-26T10:02:19.239594Z","steps":["trace[994075735] 'agreement among raft nodes before linearized reading' (duration: 197.682624ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T10:02:19.23977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.340399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:1 size:5586"} {"level":"info","ts":"2026-04-26T10:02:19.239785Z","caller":"traceutil/trace.go:171","msg":"trace[968158222] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:673; }","duration":"206.37522ms","start":"2026-04-26T10:02:19.033405Z","end":"2026-04-26T10:02:19.23978Z","steps":["trace[968158222] 'agreement among raft nodes before linearized reading' (duration: 206.324659ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:02:24.546915Z","caller":"traceutil/trace.go:171","msg":"trace[1909485756] transaction","detail":"{read_only:false; response_revision:722; number_of_response:1; }","duration":"113.786835ms","start":"2026-04-26T10:02:24.433026Z","end":"2026-04-26T10:02:24.546813Z","steps":["trace[1909485756] 'process raft request' (duration: 74.650548ms)","trace[1909485756] 'compare' (duration: 38.976433ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T10:02:29.485184Z","caller":"traceutil/trace.go:171","msg":"trace[1980684245] transaction","detail":"{read_only:false; response_revision:759; number_of_response:1; }","duration":"156.157486ms","start":"2026-04-26T10:02:29.329001Z","end":"2026-04-26T10:02:29.485159Z","steps":["trace[1980684245] 'process raft request' (duration: 155.980612ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:02:30.81961Z","caller":"traceutil/trace.go:171","msg":"trace[1315358187] transaction","detail":"{read_only:false; response_revision:763; number_of_response:1; }","duration":"161.193306ms","start":"2026-04-26T10:02:30.658391Z","end":"2026-04-26T10:02:30.819585Z","steps":["trace[1315358187] 'process raft request' (duration: 160.994291ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:02:32.22745Z","caller":"traceutil/trace.go:171","msg":"trace[152126630] linearizableReadLoop","detail":"{readStateIndex:792; appliedIndex:791; }","duration":"294.120649ms","start":"2026-04-26T10:02:31.933295Z","end":"2026-04-26T10:02:32.227416Z","steps":["trace[152126630] 'read index received' (duration: 293.812671ms)","trace[152126630] 'applied index is now lower than readState.Index' (duration: 306.287µs)"],"step_count":2} {"level":"info","ts":"2026-04-26T10:02:32.227761Z","caller":"traceutil/trace.go:171","msg":"trace[121332790] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"298.472461ms","start":"2026-04-26T10:02:31.929267Z","end":"2026-04-26T10:02:32.227739Z","steps":["trace[121332790] 'process raft request' (duration: 297.964099ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T10:02:32.227776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.451337ms","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-26T10:02:32.227864Z","caller":"traceutil/trace.go:171","msg":"trace[936045005] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:765; }","duration":"294.584291ms","start":"2026-04-26T10:02:31.933266Z","end":"2026-04-26T10:02:32.22785Z","steps":["trace[936045005] 'agreement among raft nodes before linearized reading' (duration: 294.271943ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:02:32.408286Z","caller":"traceutil/trace.go:171","msg":"trace[1333747202] transaction","detail":"{read_only:false; response_revision:766; number_of_response:1; }","duration":"176.280409ms","start":"2026-04-26T10:02:32.231974Z","end":"2026-04-26T10:02:32.408255Z","steps":["trace[1333747202] 'process raft request' (duration: 108.652193ms)","trace[1333747202] 'compare' (duration: 67.493643ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T10:02:36.35502Z","caller":"traceutil/trace.go:171","msg":"trace[836214666] transaction","detail":"{read_only:false; response_revision:789; number_of_response:1; }","duration":"156.365011ms","start":"2026-04-26T10:02:36.198622Z","end":"2026-04-26T10:02:36.354987Z","steps":["trace[836214666] 'process raft request' (duration: 143.305752ms)","trace[836214666] 'compare' (duration: 12.918345ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T10:02:37.428974Z","caller":"traceutil/trace.go:171","msg":"trace[1034587296] transaction","detail":"{read_only:false; response_revision:823; number_of_response:1; }","duration":"152.740257ms","start":"2026-04-26T10:02:37.276212Z","end":"2026-04-26T10:02:37.428953Z","steps":["trace[1034587296] 'process raft request' (duration: 148.462296ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:04:06.970873Z","caller":"traceutil/trace.go:171","msg":"trace[1174146732] transaction","detail":"{read_only:false; response_revision:1182; number_of_response:1; }","duration":"106.437119ms","start":"2026-04-26T10:04:06.864416Z","end":"2026-04-26T10:04:06.970853Z","steps":["trace[1174146732] 'process raft request' (duration: 106.329606ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:04:07.207498Z","caller":"traceutil/trace.go:171","msg":"trace[1764560323] transaction","detail":"{read_only:false; response_revision:1184; number_of_response:1; }","duration":"108.088272ms","start":"2026-04-26T10:04:07.099332Z","end":"2026-04-26T10:04:07.20742Z","steps":["trace[1764560323] 'process raft request' (duration: 97.907567ms)","trace[1764560323] 'compare' (duration: 10.025331ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T10:05:45.844734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.555773ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-26T10:05:45.844888Z","caller":"traceutil/trace.go:171","msg":"trace[13132401] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1504; }","duration":"443.743078ms","start":"2026-04-26T10:05:45.40112Z","end":"2026-04-26T10:05:45.844863Z","steps":["trace[13132401] 'range keys from in-memory index tree' (duration: 443.519863ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T10:05:45.845671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.19484ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-26T10:05:45.845735Z","caller":"traceutil/trace.go:171","msg":"trace[2110712172] linearizableReadLoop","detail":"{readStateIndex:1572; appliedIndex:1571; }","duration":"360.161867ms","start":"2026-04-26T10:05:45.485565Z","end":"2026-04-26T10:05:45.845726Z","steps":["trace[2110712172] 'read index received' (duration: 61.652µs)","trace[2110712172] 'applied index is now lower than readState.Index' (duration: 360.099195ms)"],"step_count":2} {"level":"info","ts":"2026-04-26T10:05:45.845799Z","caller":"traceutil/trace.go:171","msg":"trace[1274571393] transaction","detail":"{read_only:false; response_revision:1505; number_of_response:1; }","duration":"495.529879ms","start":"2026-04-26T10:05:45.35026Z","end":"2026-04-26T10:05:45.84579Z","steps":["trace[1274571393] 'process raft request' (duration: 83.286483ms)","trace[1274571393] 'compare' (duration: 411.023336ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T10:05:45.845864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:05:45.350239Z","time spent":"495.58825ms","remote":"127.0.0.1:43226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-26T10:05:45.846122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.527306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-26T10:05:45.846213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.007371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-26T10:05:45.846225Z","caller":"traceutil/trace.go:171","msg":"trace[1585058162] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1505; }","duration":"360.67862ms","start":"2026-04-26T10:05:45.485521Z","end":"2026-04-26T10:05:45.846199Z","steps":["trace[1585058162] 'agreement among raft nodes before linearized reading' (duration: 360.472845ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T10:05:45.846252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.283522ms","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-26T10:05:45.846257Z","caller":"traceutil/trace.go:171","msg":"trace[654972454] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1505; }","duration":"274.069561ms","start":"2026-04-26T10:05:45.572168Z","end":"2026-04-26T10:05:45.846238Z","steps":["trace[654972454] 'agreement among raft nodes before linearized reading' (duration: 274.0253ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:05:45.846278Z","caller":"traceutil/trace.go:171","msg":"trace[755007431] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1505; }","duration":"212.348833ms","start":"2026-04-26T10:05:45.633922Z","end":"2026-04-26T10:05:45.846271Z","steps":["trace[755007431] 'agreement among raft nodes before linearized reading' (duration: 212.244391ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T10:05:45.846288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:05:45.485501Z","time spent":"360.770402ms","remote":"127.0.0.1:58646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":3,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "} {"level":"warn","ts":"2026-04-26T10:05:45.846145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.347954ms","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-26T10:05:45.846345Z","caller":"traceutil/trace.go:171","msg":"trace[93634065] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1505; }","duration":"287.59617ms","start":"2026-04-26T10:05:45.558743Z","end":"2026-04-26T10:05:45.846339Z","steps":["trace[93634065] 'agreement among raft nodes before linearized reading' (duration: 287.20829ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:06:09.119436Z","caller":"traceutil/trace.go:171","msg":"trace[205788966] linearizableReadLoop","detail":"{readStateIndex:1653; appliedIndex:1652; }","duration":"460.268003ms","start":"2026-04-26T10:06:08.659142Z","end":"2026-04-26T10:06:09.11941Z","steps":["trace[205788966] 'read index received' (duration: 459.996376ms)","trace[205788966] 'applied index is now lower than readState.Index' (duration: 270.357µs)"],"step_count":2} {"level":"info","ts":"2026-04-26T10:06:09.119583Z","caller":"traceutil/trace.go:171","msg":"trace[1342322470] transaction","detail":"{read_only:false; response_revision:1582; number_of_response:1; }","duration":"483.030209ms","start":"2026-04-26T10:06:08.636523Z","end":"2026-04-26T10:06:09.119553Z","steps":["trace[1342322470] 'process raft request' (duration: 482.67271ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T10:06:09.119776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.614642ms","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":"warn","ts":"2026-04-26T10:06:09.119819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:06:08.636494Z","time spent":"483.207123ms","remote":"127.0.0.1:43426","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-26T10:06:09.119872Z","caller":"traceutil/trace.go:171","msg":"trace[1892677956] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1582; }","duration":"460.772236ms","start":"2026-04-26T10:06:08.659085Z","end":"2026-04-26T10:06:09.119857Z","steps":["trace[1892677956] 'agreement among raft nodes before linearized reading' (duration: 460.497489ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T10:06:09.119972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:06:08.659019Z","time spent":"460.938611ms","remote":"127.0.0.1:43426","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-26T10:06:09.425941Z","caller":"traceutil/trace.go:171","msg":"trace[47942530] linearizableReadLoop","detail":"{readStateIndex:1654; appliedIndex:1653; }","duration":"199.181865ms","start":"2026-04-26T10:06:09.226735Z","end":"2026-04-26T10:06:09.425917Z","steps":["trace[47942530] 'read index received' (duration: 199.048592ms)","trace[47942530] 'applied index is now lower than readState.Index' (duration: 132.223µs)"],"step_count":2} {"level":"warn","ts":"2026-04-26T10:06:09.426072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.321049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-26T10:06:09.426106Z","caller":"traceutil/trace.go:171","msg":"trace[1641863095] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:1583; }","duration":"199.415811ms","start":"2026-04-26T10:06:09.226681Z","end":"2026-04-26T10:06:09.426097Z","steps":["trace[1641863095] 'agreement among raft nodes before linearized reading' (duration: 199.317268ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:06:09.426078Z","caller":"traceutil/trace.go:171","msg":"trace[1549565974] transaction","detail":"{read_only:false; response_revision:1583; number_of_response:1; }","duration":"301.313472ms","start":"2026-04-26T10:06:09.124697Z","end":"2026-04-26T10:06:09.42601Z","steps":["trace[1549565974] 'process raft request' (duration: 301.077737ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T10:06:09.426356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:06:09.124672Z","time spent":"301.535679ms","remote":"127.0.0.1:43426","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-26T10:06:10.24003Z","caller":"traceutil/trace.go:171","msg":"trace[844851772] transaction","detail":"{read_only:false; response_revision:1588; number_of_response:1; }","duration":"105.824964ms","start":"2026-04-26T10:06:10.134167Z","end":"2026-04-26T10:06:10.239992Z","steps":["trace[844851772] 'process raft request' (duration: 105.638739ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T10:06:24.550636Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15276101948698924073,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-26T10:06:24.883301Z","caller":"traceutil/trace.go:171","msg":"trace[1798301752] linearizableReadLoop","detail":"{readStateIndex:1758; appliedIndex:1757; }","duration":"833.704514ms","start":"2026-04-26T10:06:24.04957Z","end":"2026-04-26T10:06:24.883275Z","steps":["trace[1798301752] 'read index received' (duration: 833.398196ms)","trace[1798301752] 'applied index is now lower than readState.Index' (duration: 305.238µs)"],"step_count":2} {"level":"info","ts":"2026-04-26T10:06:24.883341Z","caller":"traceutil/trace.go:171","msg":"trace[754121984] transaction","detail":"{read_only:false; response_revision:1682; number_of_response:1; }","duration":"841.938606ms","start":"2026-04-26T10:06:24.041372Z","end":"2026-04-26T10:06:24.88331Z","steps":["trace[754121984] 'process raft request' (duration: 841.688419ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T10:06:24.883458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:06:24.04136Z","time spent":"842.03983ms","remote":"127.0.0.1:43426","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-26T10:06:24.883532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"833.93983ms","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-26T10:06:24.88357Z","caller":"traceutil/trace.go:171","msg":"trace[189046471] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1682; }","duration":"834.028962ms","start":"2026-04-26T10:06:24.049528Z","end":"2026-04-26T10:06:24.883557Z","steps":["trace[189046471] 'agreement among raft nodes before linearized reading' (duration: 833.866668ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T10:06:24.8836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:06:24.049509Z","time spent":"834.083953ms","remote":"127.0.0.1:43426","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-26T10:06:24.883592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"813.608856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-26T10:06:24.883654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.396814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-26T10:06:24.883662Z","caller":"traceutil/trace.go:171","msg":"trace[657913010] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1682; }","duration":"813.73256ms","start":"2026-04-26T10:06:24.069914Z","end":"2026-04-26T10:06:24.883646Z","steps":["trace[657913010] 'agreement among raft nodes before linearized reading' (duration: 813.518814ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:06:24.883673Z","caller":"traceutil/trace.go:171","msg":"trace[1633890744] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1682; }","duration":"308.450524ms","start":"2026-04-26T10:06:24.575216Z","end":"2026-04-26T10:06:24.883666Z","steps":["trace[1633890744] 'agreement among raft nodes before linearized reading' (duration: 308.427463ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T10:06:24.883695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:06:24.575195Z","time spent":"308.496286ms","remote":"127.0.0.1:43184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-26T10:06:24.883698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:06:24.069894Z","time spent":"813.798032ms","remote":"127.0.0.1:43426","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-26T10:06:24.883628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.514784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-26T10:06:24.883762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"735.613457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-26T10:06:24.883799Z","caller":"traceutil/trace.go:171","msg":"trace[235362919] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1682; }","duration":"582.719049ms","start":"2026-04-26T10:06:24.301071Z","end":"2026-04-26T10:06:24.88379Z","steps":["trace[235362919] 'agreement among raft nodes before linearized reading' (duration: 582.479613ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T10:06:24.88382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:06:24.301047Z","time spent":"582.766452ms","remote":"127.0.0.1:43426","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-26T10:06:24.883814Z","caller":"traceutil/trace.go:171","msg":"trace[304721086] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:1682; }","duration":"735.703149ms","start":"2026-04-26T10:06:24.148095Z","end":"2026-04-26T10:06:24.883798Z","steps":["trace[304721086] 'agreement among raft nodes before linearized reading' (duration: 735.622727ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T10:06:24.883849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:06:24.148076Z","time spent":"735.763931ms","remote":"127.0.0.1:43624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":5,"response size":29,"request content":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true "} {"level":"info","ts":"2026-04-26T10:06:25.393825Z","caller":"traceutil/trace.go:171","msg":"trace[1299108124] transaction","detail":"{read_only:false; response_revision:1685; number_of_response:1; }","duration":"503.341145ms","start":"2026-04-26T10:06:24.890473Z","end":"2026-04-26T10:06:25.393814Z","steps":["trace[1299108124] 'process raft request' (duration: 503.294334ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:06:25.393859Z","caller":"traceutil/trace.go:171","msg":"trace[992661344] transaction","detail":"{read_only:false; response_revision:1684; number_of_response:1; }","duration":"504.418363ms","start":"2026-04-26T10:06:24.889408Z","end":"2026-04-26T10:06:25.393826Z","steps":["trace[992661344] 'process raft request' (duration: 504.324881ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T10:06:25.393936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:06:24.89045Z","time spent":"503.419907ms","remote":"127.0.0.1:43426","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-26T10:06:25.393807Z","caller":"traceutil/trace.go:171","msg":"trace[1779550033] transaction","detail":"{read_only:false; response_revision:1683; number_of_response:1; }","duration":"505.141462ms","start":"2026-04-26T10:06:24.888635Z","end":"2026-04-26T10:06:25.393777Z","steps":["trace[1779550033] 'process raft request' (duration: 484.858649ms)","trace[1779550033] 'compare' (duration: 20.120889ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T10:06:25.393992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:06:24.889397Z","time spent":"504.519465ms","remote":"127.0.0.1:43426","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-26T10:06:25.394066Z","caller":"traceutil/trace.go:171","msg":"trace[1601575380] transaction","detail":"{read_only:false; response_revision:1686; number_of_response:1; }","duration":"223.446556ms","start":"2026-04-26T10:06:25.170556Z","end":"2026-04-26T10:06:25.394003Z","steps":["trace[1601575380] 'process raft request' (duration: 223.23316ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T10:06:25.394061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:06:24.888614Z","time spent":"505.409308ms","remote":"127.0.0.1:43426","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-26T10:06:45.940736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.086718ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-26T10:06:45.940853Z","caller":"traceutil/trace.go:171","msg":"trace[1745558528] transaction","detail":"{read_only:false; response_revision:1815; number_of_response:1; }","duration":"244.479507ms","start":"2026-04-26T10:06:45.696354Z","end":"2026-04-26T10:06:45.940834Z","steps":["trace[1745558528] 'process raft request' (duration: 19.200374ms)","trace[1745558528] 'compare' (duration: 224.941933ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T10:07:03.332573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"641.931025ms","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":"warn","ts":"2026-04-26T10:07:03.332646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"759.762159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-26T10:07:03.332682Z","caller":"traceutil/trace.go:171","msg":"trace[424496699] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1918; }","duration":"642.081378ms","start":"2026-04-26T10:07:02.690576Z","end":"2026-04-26T10:07:03.332657Z","steps":["trace[424496699] 'range keys from in-memory index tree' (duration: 641.72475ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:07:03.332722Z","caller":"traceutil/trace.go:171","msg":"trace[1831146301] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1918; }","duration":"759.874462ms","start":"2026-04-26T10:07:02.57283Z","end":"2026-04-26T10:07:03.332704Z","steps":["trace[1831146301] 'range keys from in-memory index tree' (duration: 759.637767ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T10:07:03.332745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:07:02.690558Z","time spent":"642.170621ms","remote":"127.0.0.1:43426","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":554,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-04-26T10:07:03.332773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:07:02.572815Z","time spent":"759.949404ms","remote":"127.0.0.1:43184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-26T10:07:03.492352Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15276101948698924592,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-26T10:07:03.738016Z","caller":"traceutil/trace.go:171","msg":"trace[472432457] transaction","detail":"{read_only:false; response_revision:1919; number_of_response:1; }","duration":"984.214201ms","start":"2026-04-26T10:07:02.753781Z","end":"2026-04-26T10:07:03.737995Z","steps":["trace[472432457] 'process raft request' (duration: 984.087218ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T10:07:03.738186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:07:02.753749Z","time spent":"984.363505ms","remote":"127.0.0.1:43426","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-26T10:07:03.745442Z","caller":"traceutil/trace.go:171","msg":"trace[240742882] transaction","detail":"{read_only:false; response_revision:1920; number_of_response:1; }","duration":"407.749213ms","start":"2026-04-26T10:07:03.337669Z","end":"2026-04-26T10:07:03.745419Z","steps":["trace[240742882] 'process raft request' (duration: 407.582308ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T10:07:03.745588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:07:03.337648Z","time spent":"407.862306ms","remote":"127.0.0.1:43426","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":517,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-26T10:07:03.74571Z","caller":"traceutil/trace.go:171","msg":"trace[16944553] linearizableReadLoop","detail":"{readStateIndex:2004; appliedIndex:2002; }","duration":"754.151555ms","start":"2026-04-26T10:07:02.991495Z","end":"2026-04-26T10:07:03.745646Z","steps":["trace[16944553] 'read index received' (duration: 746.455897ms)","trace[16944553] 'applied index is now lower than readState.Index' (duration: 7.693648ms)"],"step_count":2} {"level":"warn","ts":"2026-04-26T10:07:03.745897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"754.379071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-26T10:07:03.745986Z","caller":"traceutil/trace.go:171","msg":"trace[1862415294] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:1921; }","duration":"754.552315ms","start":"2026-04-26T10:07:02.991416Z","end":"2026-04-26T10:07:03.745968Z","steps":["trace[1862415294] 'agreement among raft nodes before linearized reading' (duration: 754.3744ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:07:03.745778Z","caller":"traceutil/trace.go:171","msg":"trace[276686919] transaction","detail":"{read_only:false; response_revision:1921; number_of_response:1; }","duration":"207.243268ms","start":"2026-04-26T10:07:03.538514Z","end":"2026-04-26T10:07:03.745758Z","steps":["trace[276686919] 'process raft request' (duration: 206.861429ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T10:07:03.746036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:07:02.991394Z","time spent":"754.631077ms","remote":"127.0.0.1:58400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-26T10:07:03.746194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.794392ms","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-26T10:07:03.746236Z","caller":"traceutil/trace.go:171","msg":"trace[478412824] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1921; }","duration":"153.839863ms","start":"2026-04-26T10:07:03.592387Z","end":"2026-04-26T10:07:03.746227Z","steps":["trace[478412824] 'agreement among raft nodes before linearized reading' (duration: 153.71016ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T10:07:03.745958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"658.996194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-26T10:07:03.746448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"520.167198ms","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-26T10:07:03.746482Z","caller":"traceutil/trace.go:171","msg":"trace[58000204] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1921; }","duration":"520.24655ms","start":"2026-04-26T10:07:03.226226Z","end":"2026-04-26T10:07:03.746473Z","steps":["trace[58000204] 'agreement among raft nodes before linearized reading' (duration: 520.169418ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T10:07:03.7465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"552.069719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:533"} {"level":"warn","ts":"2026-04-26T10:07:03.746516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:07:03.226202Z","time spent":"520.306992ms","remote":"127.0.0.1:43426","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-26T10:07:03.746535Z","caller":"traceutil/trace.go:171","msg":"trace[1752018267] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1921; }","duration":"552.142151ms","start":"2026-04-26T10:07:03.194382Z","end":"2026-04-26T10:07:03.746524Z","steps":["trace[1752018267] 'agreement among raft nodes before linearized reading' (duration: 552.016208ms)"],"step_count":1} {"level":"info","ts":"2026-04-26T10:07:03.746449Z","caller":"traceutil/trace.go:171","msg":"trace[1957863286] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1921; }","duration":"659.488957ms","start":"2026-04-26T10:07:03.086931Z","end":"2026-04-26T10:07:03.74642Z","steps":["trace[1957863286] 'agreement among raft nodes before linearized reading' (duration: 658.933412ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T10:07:03.746572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:07:03.194348Z","time spent":"552.217664ms","remote":"127.0.0.1:43426","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-26T10:07:03.746598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:07:03.086869Z","time spent":"659.720123ms","remote":"127.0.0.1:43298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":17,"response size":29,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "} {"level":"warn","ts":"2026-04-26T10:07:03.746671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.020582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-26T10:07:03.746729Z","caller":"traceutil/trace.go:171","msg":"trace[1595074443] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1921; }","duration":"412.077863ms","start":"2026-04-26T10:07:03.334627Z","end":"2026-04-26T10:07:03.746704Z","steps":["trace[1595074443] 'agreement among raft nodes before linearized reading' (duration: 411.95271ms)"],"step_count":1} {"level":"warn","ts":"2026-04-26T10:07:03.746784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-26T10:07:03.334612Z","time spent":"412.164056ms","remote":"127.0.0.1:43192","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}