{"level":"warn","ts":"2026-05-30T01:54:04.570102Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-30T01:54:04.570195Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.115: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.115:2380","--initial-cluster=instance=https://199.204.45.115:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.115:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.115: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-05-30T01:54:04.570256Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-30T01:54:04.57027Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.115:2380"]} {"level":"info","ts":"2026-05-30T01:54:04.570296Z","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-05-30T01:54:04.570986Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"]} {"level":"info","ts":"2026-05-30T01:54:04.571057Z","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.115:2380"],"listen-peer-urls":["https://199.204.45.115:2380"],"advertise-client-urls":["https://199.204.45.115:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.115: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-05-30T01:54:04.575705Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.418038ms"} {"level":"info","ts":"2026-05-30T01:54:04.584918Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e3aaa5c123e150e0","cluster-id":"61ec519698823541"} {"level":"info","ts":"2026-05-30T01:54:04.584993Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=()"} {"level":"info","ts":"2026-05-30T01:54:04.585017Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became follower at term 0"} {"level":"info","ts":"2026-05-30T01:54:04.585031Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e3aaa5c123e150e0 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-30T01:54:04.585055Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became follower at term 1"} {"level":"info","ts":"2026-05-30T01:54:04.585093Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=(16405106841599693024)"} {"level":"warn","ts":"2026-05-30T01:54:04.598454Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-30T01:54:04.601172Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-30T01:54:04.602334Z","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-05-30T01:54:04.607252Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e3aaa5c123e150e0","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-30T01:54:04.610218Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e3aaa5c123e150e0","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-30T01:54:04.609807Z","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-05-30T01:54:04.610741Z","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-05-30T01:54:04.610772Z","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-05-30T01:54:04.613209Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=(16405106841599693024)"} {"level":"info","ts":"2026-05-30T01:54:04.613331Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"61ec519698823541","local-member-id":"e3aaa5c123e150e0","added-peer-id":"e3aaa5c123e150e0","added-peer-peer-urls":["https://199.204.45.115:2380"]} {"level":"info","ts":"2026-05-30T01:54:04.614277Z","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-05-30T01:54:04.614623Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e3aaa5c123e150e0","initial-advertise-peer-urls":["https://199.204.45.115:2380"],"listen-peer-urls":["https://199.204.45.115:2380"],"advertise-client-urls":["https://199.204.45.115:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-30T01:54:04.614662Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-30T01:54:04.614824Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.115:2380"} {"level":"info","ts":"2026-05-30T01:54:04.614843Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.115:2380"} {"level":"info","ts":"2026-05-30T01:54:05.585735Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 is starting a new election at term 1"} {"level":"info","ts":"2026-05-30T01:54:05.585785Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-30T01:54:05.585816Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 received MsgPreVoteResp from e3aaa5c123e150e0 at term 1"} {"level":"info","ts":"2026-05-30T01:54:05.58583Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became candidate at term 2"} {"level":"info","ts":"2026-05-30T01:54:05.585837Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 received MsgVoteResp from e3aaa5c123e150e0 at term 2"} {"level":"info","ts":"2026-05-30T01:54:05.585847Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became leader at term 2"} {"level":"info","ts":"2026-05-30T01:54:05.585864Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e3aaa5c123e150e0 elected leader e3aaa5c123e150e0 at term 2"} {"level":"info","ts":"2026-05-30T01:54:05.586929Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-30T01:54:05.587791Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-30T01:54:05.587785Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e3aaa5c123e150e0","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.115:2379]}","request-path":"/0/members/e3aaa5c123e150e0/attributes","cluster-id":"61ec519698823541","publish-timeout":"7s"} {"level":"info","ts":"2026-05-30T01:54:05.587823Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-30T01:54:05.588437Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-30T01:54:05.588476Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-30T01:54:05.588491Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"61ec519698823541","local-member-id":"e3aaa5c123e150e0","cluster-version":"3.5"} {"level":"info","ts":"2026-05-30T01:54:05.588581Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-30T01:54:05.588611Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-30T01:54:05.590486Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.115:2379"} {"level":"info","ts":"2026-05-30T01:54:05.591944Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-05-30T01:54:07.64081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.704266ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"info","ts":"2026-05-30T01:54:07.640929Z","caller":"traceutil/trace.go:171","msg":"trace[2105919067] linearizableReadLoop","detail":"{readStateIndex:95; appliedIndex:94; }","duration":"400.992721ms","start":"2026-05-30T01:54:07.239922Z","end":"2026-05-30T01:54:07.640915Z","steps":["trace[2105919067] 'read index received' (duration: 96.644208ms)","trace[2105919067] 'applied index is now lower than readState.Index' (duration: 304.347563ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T01:54:07.641013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.096834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-30T01:54:07.641041Z","caller":"traceutil/trace.go:171","msg":"trace[1584524643] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:90; }","duration":"401.160407ms","start":"2026-05-30T01:54:07.239872Z","end":"2026-05-30T01:54:07.641033Z","steps":["trace[1584524643] 'agreement among raft nodes before linearized reading' (duration: 401.082894ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:54:07.641064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:54:07.23985Z","time spent":"401.208778ms","remote":"127.0.0.1:42360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"info","ts":"2026-05-30T01:54:07.641114Z","caller":"traceutil/trace.go:171","msg":"trace[1281620134] transaction","detail":"{read_only:false; response_revision:90; number_of_response:1; }","duration":"441.425476ms","start":"2026-05-30T01:54:07.199572Z","end":"2026-05-30T01:54:07.640998Z","steps":["trace[1281620134] 'process raft request' (duration: 137.098043ms)","trace[1281620134] 'compare' (duration: 303.604393ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T01:54:07.641335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:54:07.199554Z","time spent":"441.673272ms","remote":"127.0.0.1:42068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":642,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T01:54:07.991858Z","caller":"traceutil/trace.go:171","msg":"trace[210579207] transaction","detail":"{read_only:false; response_revision:91; number_of_response:1; }","duration":"345.492365ms","start":"2026-05-30T01:54:07.646345Z","end":"2026-05-30T01:54:07.991837Z","steps":["trace[210579207] 'process raft request' (duration: 344.58401ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:54:07.992005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:54:07.646301Z","time spent":"345.61978ms","remote":"127.0.0.1:42068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":638,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T01:54:07.992755Z","caller":"traceutil/trace.go:171","msg":"trace[296508850] linearizableReadLoop","detail":"{readStateIndex:97; appliedIndex:95; }","duration":"114.001074ms","start":"2026-05-30T01:54:07.878743Z","end":"2026-05-30T01:54:07.992744Z","steps":["trace[296508850] 'read index received' (duration: 112.199787ms)","trace[296508850] 'applied index is now lower than readState.Index' (duration: 1.800317ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:54:07.992893Z","caller":"traceutil/trace.go:171","msg":"trace[1738922847] transaction","detail":"{read_only:false; response_revision:92; number_of_response:1; }","duration":"344.839699ms","start":"2026-05-30T01:54:07.648047Z","end":"2026-05-30T01:54:07.992886Z","steps":["trace[1738922847] 'process raft request' (duration: 344.657613ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:54:07.992929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:54:07.648032Z","time spent":"344.878469ms","remote":"127.0.0.1:42360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":651,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-30T01:54:07.993076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.334033ms","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-05-30T01:54:07.993101Z","caller":"traceutil/trace.go:171","msg":"trace[1917998049] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:92; }","duration":"114.391945ms","start":"2026-05-30T01:54:07.878703Z","end":"2026-05-30T01:54:07.993095Z","steps":["trace[1917998049] 'agreement among raft nodes before linearized reading' (duration: 114.309893ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:54:07.993265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.442647ms","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-05-30T01:54:07.993335Z","caller":"traceutil/trace.go:171","msg":"trace[1066774124] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:92; }","duration":"114.617341ms","start":"2026-05-30T01:54:07.878703Z","end":"2026-05-30T01:54:07.99332Z","steps":["trace[1066774124] 'agreement among raft nodes before linearized reading' (duration: 114.501068ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:54:08.207438Z","caller":"traceutil/trace.go:171","msg":"trace[15281384] linearizableReadLoop","detail":"{readStateIndex:99; appliedIndex:97; }","duration":"209.72292ms","start":"2026-05-30T01:54:07.997697Z","end":"2026-05-30T01:54:08.20742Z","steps":["trace[15281384] 'read index received' (duration: 199.423673ms)","trace[15281384] 'applied index is now lower than readState.Index' (duration: 10.298397ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:54:08.207607Z","caller":"traceutil/trace.go:171","msg":"trace[2006541949] transaction","detail":"{read_only:false; response_revision:94; number_of_response:1; }","duration":"210.344835ms","start":"2026-05-30T01:54:07.997233Z","end":"2026-05-30T01:54:08.207578Z","steps":["trace[2006541949] 'process raft request' (duration: 210.111909ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:54:08.20768Z","caller":"traceutil/trace.go:171","msg":"trace[363131169] transaction","detail":"{read_only:false; response_revision:93; number_of_response:1; }","duration":"211.705621ms","start":"2026-05-30T01:54:07.995863Z","end":"2026-05-30T01:54:08.207569Z","steps":["trace[363131169] 'process raft request' (duration: 201.124738ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:54:08.207776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.911524ms","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-05-30T01:54:08.207873Z","caller":"traceutil/trace.go:171","msg":"trace[241587004] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-admin; range_end:; response_count:0; response_revision:94; }","duration":"210.183211ms","start":"2026-05-30T01:54:07.99767Z","end":"2026-05-30T01:54:08.207854Z","steps":["trace[241587004] 'agreement among raft nodes before linearized reading' (duration: 209.896263ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:54:42.924856Z","caller":"traceutil/trace.go:171","msg":"trace[1197095829] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"113.147488ms","start":"2026-05-30T01:54:42.811682Z","end":"2026-05-30T01:54:42.92483Z","steps":["trace[1197095829] 'process raft request' (duration: 112.945942ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:54:43.034277Z","caller":"traceutil/trace.go:171","msg":"trace[1923133499] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"174.487171ms","start":"2026-05-30T01:54:42.859759Z","end":"2026-05-30T01:54:43.034246Z","steps":["trace[1923133499] 'process raft request' (duration: 174.377628ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:54:43.034456Z","caller":"traceutil/trace.go:171","msg":"trace[404111563] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"181.051058ms","start":"2026-05-30T01:54:42.853391Z","end":"2026-05-30T01:54:43.034442Z","steps":["trace[404111563] 'process raft request' (duration: 180.595636ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:54:43.034573Z","caller":"traceutil/trace.go:171","msg":"trace[2016797646] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"157.255627ms","start":"2026-05-30T01:54:42.877269Z","end":"2026-05-30T01:54:43.034525Z","steps":["trace[2016797646] 'process raft request' (duration: 156.994649ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:54:43.034643Z","caller":"traceutil/trace.go:171","msg":"trace[1219765164] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"174.811859ms","start":"2026-05-30T01:54:42.859815Z","end":"2026-05-30T01:54:43.034627Z","steps":["trace[1219765164] 'process raft request' (duration: 174.356007ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:54:43.034739Z","caller":"traceutil/trace.go:171","msg":"trace[364295177] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"111.285689ms","start":"2026-05-30T01:54:42.923434Z","end":"2026-05-30T01:54:43.03472Z","steps":["trace[364295177] 'process raft request' (duration: 111.063113ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:54:43.034841Z","caller":"traceutil/trace.go:171","msg":"trace[1659429722] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"162.336884ms","start":"2026-05-30T01:54:42.872496Z","end":"2026-05-30T01:54:43.034833Z","steps":["trace[1659429722] 'process raft request' (duration: 161.735838ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:54:43.034824Z","caller":"traceutil/trace.go:171","msg":"trace[1575415379] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"148.029158ms","start":"2026-05-30T01:54:42.886755Z","end":"2026-05-30T01:54:43.034784Z","steps":["trace[1575415379] 'process raft request' (duration: 147.588036ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:54:43.034933Z","caller":"traceutil/trace.go:171","msg":"trace[3344704] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"152.112409ms","start":"2026-05-30T01:54:42.882809Z","end":"2026-05-30T01:54:43.034921Z","steps":["trace[3344704] 'process raft request' (duration: 151.482942ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:54:43.034886Z","caller":"traceutil/trace.go:171","msg":"trace[1823814289] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"163.621068ms","start":"2026-05-30T01:54:42.871173Z","end":"2026-05-30T01:54:43.034794Z","steps":["trace[1823814289] 'process raft request' (duration: 163.025033ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:54:43.035036Z","caller":"traceutil/trace.go:171","msg":"trace[1534359444] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"130.62711ms","start":"2026-05-30T01:54:42.904402Z","end":"2026-05-30T01:54:43.035029Z","steps":["trace[1534359444] 'process raft request' (duration: 130.057954ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:54:43.03501Z","caller":"traceutil/trace.go:171","msg":"trace[1530627853] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"133.390763ms","start":"2026-05-30T01:54:42.901609Z","end":"2026-05-30T01:54:43.035Z","steps":["trace[1530627853] 'process raft request' (duration: 132.814748ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:54:44.16174Z","caller":"traceutil/trace.go:171","msg":"trace[1095262152] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"158.271264ms","start":"2026-05-30T01:54:44.003439Z","end":"2026-05-30T01:54:44.16171Z","steps":["trace[1095262152] 'process raft request' (duration: 89.382039ms)","trace[1095262152] 'compare' (duration: 68.665869ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:54:49.475589Z","caller":"traceutil/trace.go:171","msg":"trace[1346635260] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"110.105156ms","start":"2026-05-30T01:54:49.365465Z","end":"2026-05-30T01:54:49.47557Z","steps":["trace[1346635260] 'process raft request' (duration: 109.898571ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:54:51.77873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.099049ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-30T01:54:51.778844Z","caller":"traceutil/trace.go:171","msg":"trace[1412812325] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"189.064603ms","start":"2026-05-30T01:54:51.589761Z","end":"2026-05-30T01:54:51.778826Z","steps":["trace[1412812325] 'process raft request' (duration: 79.80417ms)","trace[1412812325] 'compare' (duration: 108.844962ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:54:51.800461Z","caller":"traceutil/trace.go:171","msg":"trace[1538631855] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"199.712492ms","start":"2026-05-30T01:54:51.600733Z","end":"2026-05-30T01:54:51.800446Z","steps":["trace[1538631855] 'process raft request' (duration: 199.574618ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:54:52.507791Z","caller":"traceutil/trace.go:171","msg":"trace[668436156] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"239.094601ms","start":"2026-05-30T01:54:52.268676Z","end":"2026-05-30T01:54:52.507771Z","steps":["trace[668436156] 'process raft request' (duration: 162.419786ms)","trace[668436156] 'compare' (duration: 76.415978ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:54:57.676096Z","caller":"traceutil/trace.go:171","msg":"trace[925588738] transaction","detail":"{read_only:false; response_revision:731; number_of_response:1; }","duration":"161.83685ms","start":"2026-05-30T01:54:57.514241Z","end":"2026-05-30T01:54:57.676078Z","steps":["trace[925588738] 'process raft request' (duration: 159.709013ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:54:57.676454Z","caller":"traceutil/trace.go:171","msg":"trace[1958584907] transaction","detail":"{read_only:false; response_revision:732; number_of_response:1; }","duration":"161.040269ms","start":"2026-05-30T01:54:57.515402Z","end":"2026-05-30T01:54:57.676443Z","steps":["trace[1958584907] 'process raft request' (duration: 160.648359ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:54:57.676416Z","caller":"traceutil/trace.go:171","msg":"trace[1948028320] linearizableReadLoop","detail":"{readStateIndex:755; appliedIndex:752; }","duration":"158.804259ms","start":"2026-05-30T01:54:57.517577Z","end":"2026-05-30T01:54:57.676381Z","steps":["trace[1948028320] 'read index received' (duration: 17.900683ms)","trace[1948028320] 'applied index is now lower than readState.Index' (duration: 140.901266ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T01:54:57.677218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.60158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-30T01:54:57.677281Z","caller":"traceutil/trace.go:171","msg":"trace[1021016148] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:732; }","duration":"159.704143ms","start":"2026-05-30T01:54:57.51756Z","end":"2026-05-30T01:54:57.677264Z","steps":["trace[1021016148] 'agreement among raft nodes before linearized reading' (duration: 158.956663ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:54:57.702074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.524726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188495"} {"level":"info","ts":"2026-05-30T01:54:57.702152Z","caller":"traceutil/trace.go:171","msg":"trace[870164725] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:733; }","duration":"107.611459ms","start":"2026-05-30T01:54:57.594522Z","end":"2026-05-30T01:54:57.702133Z","steps":["trace[870164725] 'agreement among raft nodes before linearized reading' (duration: 107.362412ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:55:03.163074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.766691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T01:55:03.163149Z","caller":"traceutil/trace.go:171","msg":"trace[1811183163] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:783; }","duration":"134.887153ms","start":"2026-05-30T01:55:03.028245Z","end":"2026-05-30T01:55:03.163132Z","steps":["trace[1811183163] 'range keys from in-memory index tree' (duration: 134.690408ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:55:05.875101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.778362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-5gtc7\" ","response":"range_response_count:1 size:3965"} {"level":"warn","ts":"2026-05-30T01:55:05.875235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.126989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-30T01:55:05.875258Z","caller":"traceutil/trace.go:171","msg":"trace[186943147] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-5gtc7; range_end:; response_count:1; response_revision:798; }","duration":"199.971787ms","start":"2026-05-30T01:55:05.675268Z","end":"2026-05-30T01:55:05.87524Z","steps":["trace[186943147] 'range keys from in-memory index tree' (duration: 199.622008ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:55:05.875301Z","caller":"traceutil/trace.go:171","msg":"trace[1912211356] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:798; }","duration":"165.231502ms","start":"2026-05-30T01:55:05.710053Z","end":"2026-05-30T01:55:05.875285Z","steps":["trace[1912211356] 'range keys from in-memory index tree' (duration: 164.990035ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:55:05.875329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.448077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-30T01:55:05.875415Z","caller":"traceutil/trace.go:171","msg":"trace[1507258670] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:798; }","duration":"100.58715ms","start":"2026-05-30T01:55:05.774807Z","end":"2026-05-30T01:55:05.875394Z","steps":["trace[1507258670] 'range keys from in-memory index tree' (duration: 100.277001ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:55:35.196876Z","caller":"traceutil/trace.go:171","msg":"trace[1894132956] transaction","detail":"{read_only:false; response_revision:990; number_of_response:1; }","duration":"111.253097ms","start":"2026-05-30T01:55:35.085593Z","end":"2026-05-30T01:55:35.196846Z","steps":["trace[1894132956] 'process raft request' (duration: 111.070403ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:55:41.024282Z","caller":"traceutil/trace.go:171","msg":"trace[144994950] transaction","detail":"{read_only:false; response_revision:1013; number_of_response:1; }","duration":"145.09874ms","start":"2026-05-30T01:55:40.879165Z","end":"2026-05-30T01:55:41.024263Z","steps":["trace[144994950] 'process raft request' (duration: 144.971957ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:55:41.329279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.499066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T01:55:41.329382Z","caller":"traceutil/trace.go:171","msg":"trace[1112475676] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1013; }","duration":"205.674892ms","start":"2026-05-30T01:55:41.123684Z","end":"2026-05-30T01:55:41.329359Z","steps":["trace[1112475676] 'range keys from in-memory index tree' (duration: 205.401664ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:55:41.32946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.223803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-30T01:55:41.329518Z","caller":"traceutil/trace.go:171","msg":"trace[1448209529] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1013; }","duration":"112.320356ms","start":"2026-05-30T01:55:41.217182Z","end":"2026-05-30T01:55:41.329503Z","steps":["trace[1448209529] 'range keys from in-memory index tree' (duration: 112.032208ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:56:02.602473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.314564ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-30T01:56:02.6026Z","caller":"traceutil/trace.go:171","msg":"trace[1324104801] linearizableReadLoop","detail":"{readStateIndex:1123; appliedIndex:1122; }","duration":"308.634203ms","start":"2026-05-30T01:56:02.293944Z","end":"2026-05-30T01:56:02.602578Z","steps":["trace[1324104801] 'read index received' (duration: 11.754451ms)","trace[1324104801] 'applied index is now lower than readState.Index' (duration: 296.877582ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T01:56:02.602698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.742926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T01:56:02.60276Z","caller":"traceutil/trace.go:171","msg":"trace[199545186] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1084; }","duration":"308.854759ms","start":"2026-05-30T01:56:02.29389Z","end":"2026-05-30T01:56:02.602744Z","steps":["trace[199545186] 'agreement among raft nodes before linearized reading' (duration: 308.758756ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:56:02.602812Z","caller":"traceutil/trace.go:171","msg":"trace[1879774164] transaction","detail":"{read_only:false; response_revision:1084; number_of_response:1; }","duration":"348.675606ms","start":"2026-05-30T01:56:02.254095Z","end":"2026-05-30T01:56:02.60277Z","steps":["trace[1879774164] 'process raft request' (duration: 215.998481ms)","trace[1879774164] 'compare' (duration: 132.026107ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T01:56:02.602841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:56:02.293864Z","time spent":"308.95992ms","remote":"127.0.0.1:42354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":28,"request content":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true "} {"level":"warn","ts":"2026-05-30T01:56:02.602881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:56:02.25407Z","time spent":"348.7753ms","remote":"127.0.0.1:42232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T01:56:03.70771Z","caller":"traceutil/trace.go:171","msg":"trace[1874029225] linearizableReadLoop","detail":"{readStateIndex:1126; appliedIndex:1125; }","duration":"165.383049ms","start":"2026-05-30T01:56:03.542299Z","end":"2026-05-30T01:56:03.707682Z","steps":["trace[1874029225] 'read index received' (duration: 165.200694ms)","trace[1874029225] 'applied index is now lower than readState.Index' (duration: 181.475µs)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:56:03.707747Z","caller":"traceutil/trace.go:171","msg":"trace[810135802] transaction","detail":"{read_only:false; response_revision:1087; number_of_response:1; }","duration":"188.773588ms","start":"2026-05-30T01:56:03.518951Z","end":"2026-05-30T01:56:03.707725Z","steps":["trace[810135802] 'process raft request' (duration: 188.596402ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:56:03.707956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.208357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-30T01:56:03.707996Z","caller":"traceutil/trace.go:171","msg":"trace[912821292] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1087; }","duration":"138.326658ms","start":"2026-05-30T01:56:03.569659Z","end":"2026-05-30T01:56:03.707985Z","steps":["trace[912821292] 'agreement among raft nodes before linearized reading' (duration: 138.163644ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:56:03.708041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.732178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-30T01:56:03.708097Z","caller":"traceutil/trace.go:171","msg":"trace[1085467018] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1087; }","duration":"165.847621ms","start":"2026-05-30T01:56:03.542234Z","end":"2026-05-30T01:56:03.708081Z","steps":["trace[1085467018] 'agreement among raft nodes before linearized reading' (duration: 165.562764ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:56:04.640906Z","caller":"traceutil/trace.go:171","msg":"trace[1740932006] linearizableReadLoop","detail":"{readStateIndex:1129; appliedIndex:1128; }","duration":"331.640631ms","start":"2026-05-30T01:56:04.309235Z","end":"2026-05-30T01:56:04.640876Z","steps":["trace[1740932006] 'read index received' (duration: 232.515472ms)","trace[1740932006] 'applied index is now lower than readState.Index' (duration: 99.123499ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T01:56:04.64121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.896389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-30T01:56:04.64134Z","caller":"traceutil/trace.go:171","msg":"trace[2038649855] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1089; }","duration":"309.077334ms","start":"2026-05-30T01:56:04.33224Z","end":"2026-05-30T01:56:04.641318Z","steps":["trace[2038649855] 'agreement among raft nodes before linearized reading' (duration: 308.887098ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:56:04.641446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:56:04.332222Z","time spent":"309.201408ms","remote":"127.0.0.1:51654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":30,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-05-30T01:56:04.641277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.990841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-30T01:56:04.641573Z","caller":"traceutil/trace.go:171","msg":"trace[1871121907] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1089; }","duration":"332.32061ms","start":"2026-05-30T01:56:04.309231Z","end":"2026-05-30T01:56:04.641552Z","steps":["trace[1871121907] 'agreement among raft nodes before linearized reading' (duration: 331.795886ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:56:04.641642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:56:04.30919Z","time spent":"332.432822ms","remote":"127.0.0.1:42232","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-30T01:56:04.779825Z","caller":"traceutil/trace.go:171","msg":"trace[143135802] transaction","detail":"{read_only:false; response_revision:1090; number_of_response:1; }","duration":"134.647849ms","start":"2026-05-30T01:56:04.645154Z","end":"2026-05-30T01:56:04.779802Z","steps":["trace[143135802] 'process raft request' (duration: 134.516666ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:56:04.817124Z","caller":"traceutil/trace.go:171","msg":"trace[327479342] transaction","detail":"{read_only:false; response_revision:1091; number_of_response:1; }","duration":"171.502705ms","start":"2026-05-30T01:56:04.645595Z","end":"2026-05-30T01:56:04.817097Z","steps":["trace[327479342] 'process raft request' (duration: 171.346351ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:56:04.975231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.592738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T01:56:04.975323Z","caller":"traceutil/trace.go:171","msg":"trace[482088365] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:1091; }","duration":"104.762833ms","start":"2026-05-30T01:56:04.870538Z","end":"2026-05-30T01:56:04.975301Z","steps":["trace[482088365] 'count revisions from in-memory index tree' (duration: 104.349951ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:56:37.411002Z","caller":"traceutil/trace.go:171","msg":"trace[1269453724] transaction","detail":"{read_only:false; response_revision:1269; number_of_response:1; }","duration":"167.425584ms","start":"2026-05-30T01:56:37.243552Z","end":"2026-05-30T01:56:37.410977Z","steps":["trace[1269453724] 'process raft request' (duration: 167.243179ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:56:38.032998Z","caller":"traceutil/trace.go:171","msg":"trace[1619907834] transaction","detail":"{read_only:false; response_revision:1271; number_of_response:1; }","duration":"103.055436ms","start":"2026-05-30T01:56:37.92992Z","end":"2026-05-30T01:56:38.032976Z","steps":["trace[1619907834] 'process raft request' (duration: 34.546945ms)","trace[1619907834] 'compare' (duration: 68.352037ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:56:38.10527Z","caller":"traceutil/trace.go:171","msg":"trace[1247642410] transaction","detail":"{read_only:false; response_revision:1272; number_of_response:1; }","duration":"174.469996ms","start":"2026-05-30T01:56:37.930777Z","end":"2026-05-30T01:56:38.105247Z","steps":["trace[1247642410] 'process raft request' (duration: 174.122747ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:56:38.105613Z","caller":"traceutil/trace.go:171","msg":"trace[1219131415] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"151.677914ms","start":"2026-05-30T01:56:37.953925Z","end":"2026-05-30T01:56:38.105603Z","steps":["trace[1219131415] 'process raft request' (duration: 151.079908ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:56:38.321877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.515285ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-30T01:56:38.322007Z","caller":"traceutil/trace.go:171","msg":"trace[870274303] transaction","detail":"{read_only:false; response_revision:1274; number_of_response:1; }","duration":"211.897429ms","start":"2026-05-30T01:56:38.110089Z","end":"2026-05-30T01:56:38.321986Z","steps":["trace[870274303] 'process raft request' (duration: 32.1906ms)","trace[870274303] 'compare' (duration: 179.265048ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:56:38.555034Z","caller":"traceutil/trace.go:171","msg":"trace[1914166639] transaction","detail":"{read_only:false; response_revision:1277; number_of_response:1; }","duration":"222.691404ms","start":"2026-05-30T01:56:38.332319Z","end":"2026-05-30T01:56:38.55501Z","steps":["trace[1914166639] 'process raft request' (duration: 222.522079ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:56:38.555309Z","caller":"traceutil/trace.go:171","msg":"trace[1170139311] transaction","detail":"{read_only:false; response_revision:1278; number_of_response:1; }","duration":"222.91226ms","start":"2026-05-30T01:56:38.33235Z","end":"2026-05-30T01:56:38.555263Z","steps":["trace[1170139311] 'process raft request' (duration: 222.614682ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:56:49.571295Z","caller":"traceutil/trace.go:171","msg":"trace[405703899] transaction","detail":"{read_only:false; response_revision:1357; number_of_response:1; }","duration":"124.283779ms","start":"2026-05-30T01:56:49.446993Z","end":"2026-05-30T01:56:49.571276Z","steps":["trace[405703899] 'process raft request' (duration: 124.141825ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:56:50.136894Z","caller":"traceutil/trace.go:171","msg":"trace[800945308] linearizableReadLoop","detail":"{readStateIndex:1409; appliedIndex:1408; }","duration":"198.606512ms","start":"2026-05-30T01:56:49.938265Z","end":"2026-05-30T01:56:50.136871Z","steps":["trace[800945308] 'read index received' (duration: 198.350775ms)","trace[800945308] 'applied index is now lower than readState.Index' (duration: 254.837µs)"],"step_count":2} {"level":"warn","ts":"2026-05-30T01:56:50.137137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.86343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-05-30T01:56:50.137198Z","caller":"traceutil/trace.go:171","msg":"trace[1061561839] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1358; }","duration":"198.991384ms","start":"2026-05-30T01:56:49.938188Z","end":"2026-05-30T01:56:50.137179Z","steps":["trace[1061561839] 'agreement among raft nodes before linearized reading' (duration: 198.810828ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:56:50.137091Z","caller":"traceutil/trace.go:171","msg":"trace[1159741727] transaction","detail":"{read_only:false; response_revision:1358; number_of_response:1; }","duration":"319.189283ms","start":"2026-05-30T01:56:49.8178Z","end":"2026-05-30T01:56:50.136989Z","steps":["trace[1159741727] 'process raft request' (duration: 318.896155ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:56:50.137509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.564856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T01:56:50.137585Z","caller":"traceutil/trace.go:171","msg":"trace[1129210528] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1358; }","duration":"108.636618ms","start":"2026-05-30T01:56:50.028928Z","end":"2026-05-30T01:56:50.137565Z","steps":["trace[1129210528] 'agreement among raft nodes before linearized reading' (duration: 108.535976ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:56:50.137242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.257259ms","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-05-30T01:56:50.137675Z","caller":"traceutil/trace.go:171","msg":"trace[1065239802] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1358; }","duration":"173.726372ms","start":"2026-05-30T01:56:49.96393Z","end":"2026-05-30T01:56:50.137656Z","steps":["trace[1065239802] 'agreement among raft nodes before linearized reading' (duration: 173.228238ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:56:50.137614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:56:49.817781Z","time spent":"319.622335ms","remote":"127.0.0.1:42232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"}