{"level":"warn","ts":"2026-08-21T22:15:20.896332Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-21T22:15:20.896418Z","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-08-21T22:15:20.896472Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-21T22:15:20.896487Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.129:2380"]} {"level":"info","ts":"2026-08-21T22:15:20.896507Z","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-08-21T22:15:20.897927Z","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-08-21T22:15:20.898005Z","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-08-21T22:15:20.901841Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.630211ms"} {"level":"info","ts":"2026-08-21T22:15:20.911468Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3cec112083e8d3ff","cluster-id":"3f68255a3b440659"} {"level":"info","ts":"2026-08-21T22:15:20.911533Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=()"} {"level":"info","ts":"2026-08-21T22:15:20.911571Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became follower at term 0"} {"level":"info","ts":"2026-08-21T22:15:20.91159Z","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-08-21T22:15:20.911602Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became follower at term 1"} {"level":"info","ts":"2026-08-21T22:15:20.911636Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=(4389902568129090559)"} {"level":"warn","ts":"2026-08-21T22:15:20.920172Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-21T22:15:20.921169Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-21T22:15:20.921993Z","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-08-21T22:15:20.923761Z","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-08-21T22:15:20.924008Z","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-08-21T22:15:20.924228Z","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-08-21T22:15:20.924378Z","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-08-21T22:15:20.924423Z","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-08-21T22:15:20.926527Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=(4389902568129090559)"} {"level":"info","ts":"2026-08-21T22:15:20.926871Z","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-08-21T22:15:20.92909Z","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-08-21T22:15:20.929286Z","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-08-21T22:15:20.929316Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.129:2380"} {"level":"info","ts":"2026-08-21T22:15:20.929332Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-21T22:15:20.929366Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.129:2380"} {"level":"info","ts":"2026-08-21T22:15:21.711828Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff is starting a new election at term 1"} {"level":"info","ts":"2026-08-21T22:15:21.711893Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became pre-candidate at term 1"} {"level":"info","ts":"2026-08-21T22:15:21.711939Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff received MsgPreVoteResp from 3cec112083e8d3ff at term 1"} {"level":"info","ts":"2026-08-21T22:15:21.71196Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became candidate at term 2"} {"level":"info","ts":"2026-08-21T22:15:21.711973Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff received MsgVoteResp from 3cec112083e8d3ff at term 2"} {"level":"info","ts":"2026-08-21T22:15:21.71199Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became leader at term 2"} {"level":"info","ts":"2026-08-21T22:15:21.712004Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3cec112083e8d3ff elected leader 3cec112083e8d3ff at term 2"} {"level":"info","ts":"2026-08-21T22:15:21.713817Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-21T22:15:21.714242Z","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-08-21T22:15:21.71425Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-21T22:15:21.714273Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-21T22:15:21.714637Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-21T22:15:21.714671Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-21T22:15:21.716869Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.129:2379"} {"level":"info","ts":"2026-08-21T22:15:21.718054Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-21T22:15:21.734048Z","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-08-21T22:15:21.734225Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-21T22:15:21.734408Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-08-21T22:15:24.683473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.982272ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-08-21T22:15:24.683892Z","caller":"traceutil/trace.go:171","msg":"trace[26623200] transaction","detail":"{read_only:false; response_revision:125; number_of_response:1; }","duration":"349.761779ms","start":"2026-08-21T22:15:24.334109Z","end":"2026-08-21T22:15:24.68387Z","steps":["trace[26623200] 'process raft request' (duration: 128.805599ms)","trace[26623200] 'compare' (duration: 219.822261ms)"],"step_count":2} {"level":"warn","ts":"2026-08-21T22:15:24.684167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-21T22:15:24.334088Z","time spent":"350.045571ms","remote":"127.0.0.1:60978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":685,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-21T22:15:24.905728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.181855ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-08-21T22:15:24.905881Z","caller":"traceutil/trace.go:171","msg":"trace[1849296939] transaction","detail":"{read_only:false; response_revision:126; number_of_response:1; }","duration":"215.809167ms","start":"2026-08-21T22:15:24.690053Z","end":"2026-08-21T22:15:24.905862Z","steps":["trace[1849296939] 'process raft request' (duration: 106.450391ms)","trace[1849296939] 'compare' (duration: 109.075524ms)"],"step_count":2} {"level":"info","ts":"2026-08-21T22:15:59.403572Z","caller":"traceutil/trace.go:171","msg":"trace[1206870374] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"113.648558ms","start":"2026-08-21T22:15:59.289894Z","end":"2026-08-21T22:15:59.403543Z","steps":["trace[1206870374] 'process raft request' (duration: 113.518702ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T22:15:59.412559Z","caller":"traceutil/trace.go:171","msg":"trace[126446486] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"122.312307ms","start":"2026-08-21T22:15:59.29022Z","end":"2026-08-21T22:15:59.412532Z","steps":["trace[126446486] 'process raft request' (duration: 121.428853ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T22:15:59.412716Z","caller":"traceutil/trace.go:171","msg":"trace[1773408333] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"110.531384ms","start":"2026-08-21T22:15:59.302163Z","end":"2026-08-21T22:15:59.412695Z","steps":["trace[1773408333] 'process raft request' (duration: 109.881151ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T22:15:59.412936Z","caller":"traceutil/trace.go:171","msg":"trace[1793258082] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"110.987946ms","start":"2026-08-21T22:15:59.301898Z","end":"2026-08-21T22:15:59.412886Z","steps":["trace[1793258082] 'process raft request' (duration: 110.010888ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T22:15:59.412963Z","caller":"traceutil/trace.go:171","msg":"trace[1037385116] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"119.1412ms","start":"2026-08-21T22:15:59.293808Z","end":"2026-08-21T22:15:59.41295Z","steps":["trace[1037385116] 'process raft request' (duration: 118.063047ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T22:15:59.413038Z","caller":"traceutil/trace.go:171","msg":"trace[447772863] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"110.879531ms","start":"2026-08-21T22:15:59.302102Z","end":"2026-08-21T22:15:59.412981Z","steps":["trace[447772863] 'process raft request' (duration: 109.84488ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T22:15:59.413109Z","caller":"traceutil/trace.go:171","msg":"trace[1654684405] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"110.838768ms","start":"2026-08-21T22:15:59.302136Z","end":"2026-08-21T22:15:59.412975Z","steps":["trace[1654684405] 'process raft request' (duration: 109.85399ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T22:15:59.413048Z","caller":"traceutil/trace.go:171","msg":"trace[1516991504] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"119.158431ms","start":"2026-08-21T22:15:59.293771Z","end":"2026-08-21T22:15:59.412929Z","steps":["trace[1516991504] 'process raft request' (duration: 118.048316ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T22:16:05.507577Z","caller":"traceutil/trace.go:171","msg":"trace[1816056973] linearizableReadLoop","detail":"{readStateIndex:654; appliedIndex:653; }","duration":"122.484219ms","start":"2026-08-21T22:16:05.385061Z","end":"2026-08-21T22:16:05.507545Z","steps":["trace[1816056973] 'read index received' (duration: 49.478282ms)","trace[1816056973] 'applied index is now lower than readState.Index' (duration: 73.004376ms)"],"step_count":2} {"level":"info","ts":"2026-08-21T22:16:05.507675Z","caller":"traceutil/trace.go:171","msg":"trace[1881399657] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"161.329401ms","start":"2026-08-21T22:16:05.34629Z","end":"2026-08-21T22:16:05.507619Z","steps":["trace[1881399657] 'process raft request' (duration: 88.397067ms)","trace[1881399657] 'compare' (duration: 72.672172ms)"],"step_count":2} {"level":"warn","ts":"2026-08-21T22:16:05.507866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.767942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-tcb4b\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-08-21T22:16:05.507937Z","caller":"traceutil/trace.go:171","msg":"trace[1929101805] range","detail":"{range_begin:/registry/pods/kube-system/cilium-tcb4b; range_end:; response_count:1; response_revision:633; }","duration":"122.884738ms","start":"2026-08-21T22:16:05.385036Z","end":"2026-08-21T22:16:05.507921Z","steps":["trace[1929101805] 'agreement among raft nodes before linearized reading' (duration: 122.603725ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T22:16:05.939468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.386574ms","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-08-21T22:16:05.939546Z","caller":"traceutil/trace.go:171","msg":"trace[873189648] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:634; }","duration":"313.5358ms","start":"2026-08-21T22:16:05.625992Z","end":"2026-08-21T22:16:05.939528Z","steps":["trace[873189648] 'range keys from in-memory index tree' (duration: 313.222415ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T22:16:05.939687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-21T22:16:05.625966Z","time spent":"313.682667ms","remote":"127.0.0.1:60892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-21T22:16:06.015398Z","caller":"traceutil/trace.go:171","msg":"trace[1190347645] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:655; }","duration":"234.444597ms","start":"2026-08-21T22:16:05.780927Z","end":"2026-08-21T22:16:06.015372Z","steps":["trace[1190347645] 'read index received' (duration: 232.847445ms)","trace[1190347645] 'applied index is now lower than readState.Index' (duration: 1.595942ms)"],"step_count":2} {"level":"info","ts":"2026-08-21T22:16:06.015465Z","caller":"traceutil/trace.go:171","msg":"trace[144321092] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"265.572003ms","start":"2026-08-21T22:16:05.749837Z","end":"2026-08-21T22:16:06.015409Z","steps":["trace[144321092] 'process raft request' (duration: 264.455202ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T22:16:06.015596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.647397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-21T22:16:06.015687Z","caller":"traceutil/trace.go:171","msg":"trace[675435515] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:635; }","duration":"234.853337ms","start":"2026-08-21T22:16:05.780811Z","end":"2026-08-21T22:16:06.015665Z","steps":["trace[675435515] 'agreement among raft nodes before linearized reading' (duration: 234.686849ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T22:16:19.911662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.959431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-21T22:16:19.911747Z","caller":"traceutil/trace.go:171","msg":"trace[933181573] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:794; }","duration":"130.098047ms","start":"2026-08-21T22:16:19.781631Z","end":"2026-08-21T22:16:19.911729Z","steps":["trace[933181573] 'range keys from in-memory index tree' (duration: 129.843947ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T22:17:18.320061Z","caller":"traceutil/trace.go:171","msg":"trace[307154034] transaction","detail":"{read_only:false; response_revision:1620; number_of_response:1; }","duration":"109.281928ms","start":"2026-08-21T22:17:18.210751Z","end":"2026-08-21T22:17:18.320033Z","steps":["trace[307154034] 'process raft request' (duration: 51.241122ms)","trace[307154034] 'compare' (duration: 57.724719ms)"],"step_count":2} {"level":"warn","ts":"2026-08-21T22:17:32.58117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.29314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-bd75b0e7-6913-41c0-88a4-500467b2e169\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-08-21T22:17:32.581295Z","caller":"traceutil/trace.go:171","msg":"trace[605610077] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-bd75b0e7-6913-41c0-88a4-500467b2e169; range_end:; response_count:1; response_revision:1855; }","duration":"121.514934ms","start":"2026-08-21T22:17:32.459752Z","end":"2026-08-21T22:17:32.581267Z","steps":["trace[605610077] 'range keys from in-memory index tree' (duration: 121.070105ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T22:17:32.581393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.782358ms","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-08-21T22:17:32.581533Z","caller":"traceutil/trace.go:171","msg":"trace[360637425] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1855; }","duration":"118.933432ms","start":"2026-08-21T22:17:32.462558Z","end":"2026-08-21T22:17:32.581491Z","steps":["trace[360637425] 'range keys from in-memory index tree' (duration: 118.556414ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T22:17:33.018679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.295039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-bd75b0e7-6913-41c0-88a4-500467b2e169\" ","response":"range_response_count:1 size:3627"} {"level":"warn","ts":"2026-08-21T22:17:33.018712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.306999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-08-21T22:17:33.018807Z","caller":"traceutil/trace.go:171","msg":"trace[862013059] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1856; }","duration":"276.485103ms","start":"2026-08-21T22:17:32.742299Z","end":"2026-08-21T22:17:33.018784Z","steps":["trace[862013059] 'range keys from in-memory index tree' (duration: 276.079325ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T22:17:33.018794Z","caller":"traceutil/trace.go:171","msg":"trace[401044366] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-bd75b0e7-6913-41c0-88a4-500467b2e169; range_end:; response_count:1; response_revision:1856; }","duration":"182.473264ms","start":"2026-08-21T22:17:32.836293Z","end":"2026-08-21T22:17:33.018766Z","steps":["trace[401044366] 'range keys from in-memory index tree' (duration: 182.149157ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T22:17:33.019013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.328432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-08-21T22:17:33.019257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.957912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-21T22:17:33.019313Z","caller":"traceutil/trace.go:171","msg":"trace[1665950505] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1856; }","duration":"238.067654ms","start":"2026-08-21T22:17:32.781231Z","end":"2026-08-21T22:17:33.019299Z","steps":["trace[1665950505] 'range keys from in-memory index tree' (duration: 237.641405ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T22:17:33.020087Z","caller":"traceutil/trace.go:171","msg":"trace[1960867997] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1856; }","duration":"147.671168ms","start":"2026-08-21T22:17:32.871622Z","end":"2026-08-21T22:17:33.019293Z","steps":["trace[1960867997] 'range keys from in-memory index tree' (duration: 147.031956ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T22:17:49.251109Z","caller":"traceutil/trace.go:171","msg":"trace[785113713] transaction","detail":"{read_only:false; response_revision:1985; number_of_response:1; }","duration":"133.109799ms","start":"2026-08-21T22:17:49.11798Z","end":"2026-08-21T22:17:49.25109Z","steps":["trace[785113713] 'process raft request' (duration: 132.763543ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T22:18:07.666434Z","caller":"traceutil/trace.go:171","msg":"trace[1343185504] linearizableReadLoop","detail":"{readStateIndex:2172; appliedIndex:2170; }","duration":"309.898705ms","start":"2026-08-21T22:18:07.356505Z","end":"2026-08-21T22:18:07.666404Z","steps":["trace[1343185504] 'read index received' (duration: 70.516896ms)","trace[1343185504] 'applied index is now lower than readState.Index' (duration: 239.380659ms)"],"step_count":2} {"level":"info","ts":"2026-08-21T22:18:07.666464Z","caller":"traceutil/trace.go:171","msg":"trace[394437881] transaction","detail":"{read_only:false; response_revision:2096; number_of_response:1; }","duration":"316.806813ms","start":"2026-08-21T22:18:07.349614Z","end":"2026-08-21T22:18:07.666421Z","steps":["trace[394437881] 'process raft request' (duration: 316.440136ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T22:18:07.666883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-21T22:18:07.3496Z","time spent":"316.955945ms","remote":"127.0.0.1:60892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-21T22:18:07.667296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.322738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-08-21T22:18:07.667384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.871532ms","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-08-21T22:18:07.667403Z","caller":"traceutil/trace.go:171","msg":"trace[1879492654] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2097; }","duration":"299.450899ms","start":"2026-08-21T22:18:07.367917Z","end":"2026-08-21T22:18:07.667368Z","steps":["trace[1879492654] 'agreement among raft nodes before linearized reading' (duration: 299.221346ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T22:18:07.667434Z","caller":"traceutil/trace.go:171","msg":"trace[960457475] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2097; }","duration":"310.933213ms","start":"2026-08-21T22:18:07.356487Z","end":"2026-08-21T22:18:07.66742Z","steps":["trace[960457475] 'agreement among raft nodes before linearized reading' (duration: 310.768901ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T22:18:07.667473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-21T22:18:07.356479Z","time spent":"310.986614ms","remote":"127.0.0.1:60892","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":"warn","ts":"2026-08-21T22:18:07.667756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.458042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-21T22:18:07.667841Z","caller":"traceutil/trace.go:171","msg":"trace[1089054581] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:2097; }","duration":"188.593404ms","start":"2026-08-21T22:18:07.479228Z","end":"2026-08-21T22:18:07.667822Z","steps":["trace[1089054581] 'agreement among raft nodes before linearized reading' (duration: 188.434091ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T22:18:07.667945Z","caller":"traceutil/trace.go:171","msg":"trace[1761586357] transaction","detail":"{read_only:false; response_revision:2097; number_of_response:1; }","duration":"276.210758ms","start":"2026-08-21T22:18:07.390382Z","end":"2026-08-21T22:18:07.666592Z","steps":["trace[1761586357] 'process raft request' (duration: 275.960974ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T22:18:07.935148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.695357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-21T22:18:07.935261Z","caller":"traceutil/trace.go:171","msg":"trace[1613456059] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2098; }","duration":"153.87054ms","start":"2026-08-21T22:18:07.781355Z","end":"2026-08-21T22:18:07.935225Z","steps":["trace[1613456059] 'range keys from in-memory index tree' (duration: 153.533524ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T22:18:07.935378Z","caller":"traceutil/trace.go:171","msg":"trace[796300101] transaction","detail":"{read_only:false; response_revision:2099; number_of_response:1; }","duration":"139.873895ms","start":"2026-08-21T22:18:07.79546Z","end":"2026-08-21T22:18:07.935334Z","steps":["trace[796300101] 'process raft request' (duration: 81.697125ms)","trace[796300101] 'compare' (duration: 57.465838ms)"],"step_count":2} {"level":"info","ts":"2026-08-21T22:18:07.935385Z","caller":"traceutil/trace.go:171","msg":"trace[385489287] linearizableReadLoop","detail":"{readStateIndex:2175; appliedIndex:2174; }","duration":"129.754184ms","start":"2026-08-21T22:18:07.805597Z","end":"2026-08-21T22:18:07.935352Z","steps":["trace[385489287] 'read index received' (duration: 71.546254ms)","trace[385489287] 'applied index is now lower than readState.Index' (duration: 58.20662ms)"],"step_count":2} {"level":"warn","ts":"2026-08-21T22:18:07.935651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.031158ms","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-08-21T22:18:07.935705Z","caller":"traceutil/trace.go:171","msg":"trace[871156616] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2100; }","duration":"130.148461ms","start":"2026-08-21T22:18:07.805546Z","end":"2026-08-21T22:18:07.935694Z","steps":["trace[871156616] 'agreement among raft nodes before linearized reading' (duration: 129.912877ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T22:19:08.169161Z","caller":"traceutil/trace.go:171","msg":"trace[321743858] transaction","detail":"{read_only:false; response_revision:2529; number_of_response:1; }","duration":"191.756764ms","start":"2026-08-21T22:19:07.977372Z","end":"2026-08-21T22:19:08.169129Z","steps":["trace[321743858] 'process raft request' (duration: 132.677533ms)","trace[321743858] 'compare' (duration: 58.870898ms)"],"step_count":2} {"level":"info","ts":"2026-08-21T22:19:40.511915Z","caller":"traceutil/trace.go:171","msg":"trace[317473926] linearizableReadLoop","detail":"{readStateIndex:2807; appliedIndex:2806; }","duration":"198.232931ms","start":"2026-08-21T22:19:40.313629Z","end":"2026-08-21T22:19:40.511862Z","steps":["trace[317473926] 'read index received' (duration: 176.242816ms)","trace[317473926] 'applied index is now lower than readState.Index' (duration: 21.988715ms)"],"step_count":2} {"level":"info","ts":"2026-08-21T22:19:40.512061Z","caller":"traceutil/trace.go:171","msg":"trace[413029505] transaction","detail":"{read_only:false; response_revision:2710; number_of_response:1; }","duration":"209.859741ms","start":"2026-08-21T22:19:40.302187Z","end":"2026-08-21T22:19:40.512047Z","steps":["trace[413029505] 'process raft request' (duration: 187.786955ms)","trace[413029505] 'compare' (duration: 21.371657ms)"],"step_count":2} {"level":"warn","ts":"2026-08-21T22:19:40.512517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.862189ms","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-08-21T22:19:40.512564Z","caller":"traceutil/trace.go:171","msg":"trace[1221174114] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2710; }","duration":"198.96449ms","start":"2026-08-21T22:19:40.313588Z","end":"2026-08-21T22:19:40.512553Z","steps":["trace[1221174114] 'agreement among raft nodes before linearized reading' (duration: 198.763877ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T22:19:40.512597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.614907ms","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-08-21T22:19:40.512737Z","caller":"traceutil/trace.go:171","msg":"trace[1017292228] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2710; }","duration":"192.834021ms","start":"2026-08-21T22:19:40.319879Z","end":"2026-08-21T22:19:40.512713Z","steps":["trace[1017292228] 'agreement among raft nodes before linearized reading' (duration: 192.420975ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T22:19:40.784073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.225668ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-21T22:19:40.784287Z","caller":"traceutil/trace.go:171","msg":"trace[731290549] transaction","detail":"{read_only:false; response_revision:2712; number_of_response:1; }","duration":"266.696679ms","start":"2026-08-21T22:19:40.517551Z","end":"2026-08-21T22:19:40.784248Z","steps":["trace[731290549] 'process raft request' (duration: 142.771232ms)","trace[731290549] 'compare' (duration: 122.870303ms)"],"step_count":2} {"level":"info","ts":"2026-08-21T22:19:40.784322Z","caller":"traceutil/trace.go:171","msg":"trace[772610117] linearizableReadLoop","detail":"{readStateIndex:2809; appliedIndex:2808; }","duration":"162.970563ms","start":"2026-08-21T22:19:40.621323Z","end":"2026-08-21T22:19:40.784294Z","steps":["trace[772610117] 'read index received' (duration: 39.020416ms)","trace[772610117] 'applied index is now lower than readState.Index' (duration: 123.948047ms)"],"step_count":2} {"level":"warn","ts":"2026-08-21T22:19:40.854322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.970531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-21T22:19:40.854409Z","caller":"traceutil/trace.go:171","msg":"trace[1224987964] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:2712; }","duration":"233.078223ms","start":"2026-08-21T22:19:40.621309Z","end":"2026-08-21T22:19:40.854387Z","steps":["trace[1224987964] 'agreement among raft nodes before linearized reading' (duration: 163.093225ms)","trace[1224987964] 'count revisions from in-memory index tree' (duration: 69.831336ms)"],"step_count":2} {"level":"info","ts":"2026-08-21T22:19:46.060298Z","caller":"traceutil/trace.go:171","msg":"trace[605055783] transaction","detail":"{read_only:false; response_revision:2736; number_of_response:1; }","duration":"101.170752ms","start":"2026-08-21T22:19:45.959096Z","end":"2026-08-21T22:19:46.060267Z","steps":["trace[605055783] 'process raft request' (duration: 100.9707ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T22:23:25.601727Z","caller":"traceutil/trace.go:171","msg":"trace[117327572] transaction","detail":"{read_only:false; response_revision:4556; number_of_response:1; }","duration":"199.953811ms","start":"2026-08-21T22:23:25.401748Z","end":"2026-08-21T22:23:25.601702Z","steps":["trace[117327572] 'process raft request' (duration: 181.381991ms)","trace[117327572] 'compare' (duration: 18.453337ms)"],"step_count":2} {"level":"info","ts":"2026-08-21T22:23:25.770739Z","caller":"traceutil/trace.go:171","msg":"trace[2080332546] linearizableReadLoop","detail":"{readStateIndex:4726; appliedIndex:4724; }","duration":"193.488046ms","start":"2026-08-21T22:23:25.577231Z","end":"2026-08-21T22:23:25.770719Z","steps":["trace[2080332546] 'read index received' (duration: 5.859462ms)","trace[2080332546] 'applied index is now lower than readState.Index' (duration: 187.627754ms)"],"step_count":2} {"level":"info","ts":"2026-08-21T22:23:25.771029Z","caller":"traceutil/trace.go:171","msg":"trace[1087972686] transaction","detail":"{read_only:false; response_revision:4557; number_of_response:1; }","duration":"365.237244ms","start":"2026-08-21T22:23:25.405781Z","end":"2026-08-21T22:23:25.771018Z","steps":["trace[1087972686] 'process raft request' (duration: 298.9853ms)","trace[1087972686] 'compare' (duration: 65.858214ms)"],"step_count":2} {"level":"warn","ts":"2026-08-21T22:23:25.771115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-21T22:23:25.405759Z","time spent":"365.295955ms","remote":"127.0.0.1:59828","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7450,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-21T22:23:25.771303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.07161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c8131127-728e-4d3b-9e41-a46ef26f83b0\" ","response":"range_response_count:1 size:3774"} {"level":"info","ts":"2026-08-21T22:23:25.771326Z","caller":"traceutil/trace.go:171","msg":"trace[509169100] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c8131127-728e-4d3b-9e41-a46ef26f83b0; range_end:; response_count:1; response_revision:4557; }","duration":"194.09414ms","start":"2026-08-21T22:23:25.577226Z","end":"2026-08-21T22:23:25.77132Z","steps":["trace[509169100] 'agreement among raft nodes before linearized reading' (duration: 194.002268ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T22:23:25.77144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.141886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-08-21T22:23:25.771458Z","caller":"traceutil/trace.go:171","msg":"trace[539669841] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4557; }","duration":"188.192877ms","start":"2026-08-21T22:23:25.583261Z","end":"2026-08-21T22:23:25.771454Z","steps":["trace[539669841] 'agreement among raft nodes before linearized reading' (duration: 188.146436ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T22:23:25.772353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.417166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207418"} {"level":"info","ts":"2026-08-21T22:23:25.772375Z","caller":"traceutil/trace.go:171","msg":"trace[550892891] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4557; }","duration":"139.471907ms","start":"2026-08-21T22:23:25.632898Z","end":"2026-08-21T22:23:25.77237Z","steps":["trace[550892891] 'agreement among raft nodes before linearized reading' (duration: 138.643486ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T22:23:33.184987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.884453ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-21T22:23:33.185088Z","caller":"traceutil/trace.go:171","msg":"trace[64241951] linearizableReadLoop","detail":"{readStateIndex:4901; appliedIndex:4900; }","duration":"231.948683ms","start":"2026-08-21T22:23:32.953127Z","end":"2026-08-21T22:23:33.185075Z","steps":["trace[64241951] 'read index received' (duration: 74.986118ms)","trace[64241951] 'applied index is now lower than readState.Index' (duration: 156.961755ms)"],"step_count":2} {"level":"warn","ts":"2026-08-21T22:23:33.185315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.761883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-08-21T22:23:33.185365Z","caller":"traceutil/trace.go:171","msg":"trace[895065396] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:4727; }","duration":"232.838584ms","start":"2026-08-21T22:23:32.952498Z","end":"2026-08-21T22:23:33.185336Z","steps":["trace[895065396] 'agreement among raft nodes before linearized reading' (duration: 232.628389ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T22:23:33.185447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.892224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-053e3f11-24ab-4c78-8b5a-3701366c6db9\" ","response":"range_response_count:1 size:2580"} {"level":"warn","ts":"2026-08-21T22:23:33.185566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.650426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-053e3f11-24ab-4c78-8b5a-3701366c6db9\" ","response":"range_response_count:1 size:2580"} {"level":"info","ts":"2026-08-21T22:23:33.185585Z","caller":"traceutil/trace.go:171","msg":"trace[721738924] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-053e3f11-24ab-4c78-8b5a-3701366c6db9; range_end:; response_count:1; response_revision:4727; }","duration":"246.052108ms","start":"2026-08-21T22:23:32.939511Z","end":"2026-08-21T22:23:33.185563Z","steps":["trace[721738924] 'agreement among raft nodes before linearized reading' (duration: 245.73994ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T22:23:33.185627Z","caller":"traceutil/trace.go:171","msg":"trace[478664098] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-053e3f11-24ab-4c78-8b5a-3701366c6db9; range_end:; response_count:1; response_revision:4727; }","duration":"247.744998ms","start":"2026-08-21T22:23:32.937868Z","end":"2026-08-21T22:23:33.185613Z","steps":["trace[478664098] 'agreement among raft nodes before linearized reading' (duration: 247.444561ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T22:23:33.185138Z","caller":"traceutil/trace.go:171","msg":"trace[1597340787] transaction","detail":"{read_only:false; response_revision:4727; number_of_response:1; }","duration":"235.58984ms","start":"2026-08-21T22:23:32.949519Z","end":"2026-08-21T22:23:33.185108Z","steps":["trace[1597340787] 'process raft request' (duration: 78.509182ms)","trace[1597340787] 'compare' (duration: 156.781291ms)"],"step_count":2} {"level":"info","ts":"2026-08-21T22:23:33.276722Z","caller":"traceutil/trace.go:171","msg":"trace[510461335] transaction","detail":"{read_only:false; response_revision:4729; number_of_response:1; }","duration":"275.573202ms","start":"2026-08-21T22:23:33.001119Z","end":"2026-08-21T22:23:33.276692Z","steps":["trace[510461335] 'process raft request' (duration: 275.499ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T22:23:33.276769Z","caller":"traceutil/trace.go:171","msg":"trace[260746650] transaction","detail":"{read_only:false; response_revision:4728; number_of_response:1; }","duration":"320.122869ms","start":"2026-08-21T22:23:32.956618Z","end":"2026-08-21T22:23:33.276741Z","steps":["trace[260746650] 'process raft request' (duration: 319.70976ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T22:23:33.278156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-21T22:23:32.956599Z","time spent":"320.394875ms","remote":"127.0.0.1:60702","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":725,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-21T22:23:33.346689Z","caller":"traceutil/trace.go:171","msg":"trace[2101452515] linearizableReadLoop","detail":"{readStateIndex:4905; appliedIndex:4901; }","duration":"161.553783ms","start":"2026-08-21T22:23:33.185105Z","end":"2026-08-21T22:23:33.346659Z","steps":["trace[2101452515] 'read index received' (duration: 91.429954ms)","trace[2101452515] 'applied index is now lower than readState.Index' (duration: 70.122609ms)"],"step_count":2} {"level":"info","ts":"2026-08-21T22:23:33.346999Z","caller":"traceutil/trace.go:171","msg":"trace[1660703016] transaction","detail":"{read_only:false; response_revision:4730; number_of_response:1; }","duration":"258.829596ms","start":"2026-08-21T22:23:33.088152Z","end":"2026-08-21T22:23:33.346982Z","steps":["trace[1660703016] 'process raft request' (duration: 254.895023ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T22:23:33.347235Z","caller":"traceutil/trace.go:171","msg":"trace[1958860156] transaction","detail":"{read_only:false; response_revision:4731; number_of_response:1; }","duration":"250.379566ms","start":"2026-08-21T22:23:33.096846Z","end":"2026-08-21T22:23:33.347225Z","steps":["trace[1958860156] 'process raft request' (duration: 249.6944ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T22:23:33.347459Z","caller":"traceutil/trace.go:171","msg":"trace[1993681002] transaction","detail":"{read_only:false; response_revision:4732; number_of_response:1; }","duration":"156.062134ms","start":"2026-08-21T22:23:33.191386Z","end":"2026-08-21T22:23:33.347448Z","steps":["trace[1993681002] 'process raft request' (duration: 155.214534ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T22:23:33.347713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.731644ms","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-08-21T22:23:33.347757Z","caller":"traceutil/trace.go:171","msg":"trace[2007281270] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4732; }","duration":"209.822156ms","start":"2026-08-21T22:23:33.137926Z","end":"2026-08-21T22:23:33.347748Z","steps":["trace[2007281270] 'agreement among raft nodes before linearized reading' (duration: 209.650982ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T22:23:33.347949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.8748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:897"} {"level":"info","ts":"2026-08-21T22:23:33.34799Z","caller":"traceutil/trace.go:171","msg":"trace[1866309657] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:4732; }","duration":"226.941492ms","start":"2026-08-21T22:23:33.121039Z","end":"2026-08-21T22:23:33.34798Z","steps":["trace[1866309657] 'agreement among raft nodes before linearized reading' (duration: 226.832449ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T22:23:33.349111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.034825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207418"} {"level":"info","ts":"2026-08-21T22:23:33.349152Z","caller":"traceutil/trace.go:171","msg":"trace[1797861415] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4732; }","duration":"230.123857ms","start":"2026-08-21T22:23:33.11902Z","end":"2026-08-21T22:23:33.349143Z","steps":["trace[1797861415] 'agreement among raft nodes before linearized reading' (duration: 229.109183ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T22:23:33.3502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.42846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-21T22:23:33.350245Z","caller":"traceutil/trace.go:171","msg":"trace[205107372] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:4732; }","duration":"308.527692ms","start":"2026-08-21T22:23:33.041706Z","end":"2026-08-21T22:23:33.350234Z","steps":["trace[205107372] 'agreement among raft nodes before linearized reading' (duration: 308.44839ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T22:23:33.350285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-21T22:23:33.041683Z","time spent":"308.592534ms","remote":"127.0.0.1:35780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":9,"response size":29,"request content":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true "} {"level":"warn","ts":"2026-08-21T22:23:33.350493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.307168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9639"} {"level":"info","ts":"2026-08-21T22:23:33.350528Z","caller":"traceutil/trace.go:171","msg":"trace[232796179] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4732; }","duration":"392.361279ms","start":"2026-08-21T22:23:32.958159Z","end":"2026-08-21T22:23:33.35052Z","steps":["trace[232796179] 'agreement among raft nodes before linearized reading' (duration: 392.265236ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T22:23:33.35056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-21T22:23:32.958151Z","time spent":"392.40284ms","remote":"127.0.0.1:32842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":9661,"request content":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" "} {"level":"warn","ts":"2026-08-21T22:23:33.3508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.958785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:6 size:61071"} {"level":"info","ts":"2026-08-21T22:23:33.350836Z","caller":"traceutil/trace.go:171","msg":"trace[97095166] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:4732; }","duration":"157.17136ms","start":"2026-08-21T22:23:33.193657Z","end":"2026-08-21T22:23:33.350828Z","steps":["trace[97095166] 'agreement among raft nodes before linearized reading' (duration: 157.035087ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T22:23:33.935358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.30365ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-21T22:23:33.935572Z","caller":"traceutil/trace.go:171","msg":"trace[304272008] transaction","detail":"{read_only:false; response_revision:4744; number_of_response:1; }","duration":"271.912576ms","start":"2026-08-21T22:23:33.663625Z","end":"2026-08-21T22:23:33.935538Z","steps":["trace[304272008] 'process raft request' (duration: 44.35489ms)","trace[304272008] 'compare' (duration: 227.189167ms)"],"step_count":2} {"level":"info","ts":"2026-08-21T22:23:33.93567Z","caller":"traceutil/trace.go:171","msg":"trace[372858299] linearizableReadLoop","detail":"{readStateIndex:4918; appliedIndex:4917; }","duration":"271.986938ms","start":"2026-08-21T22:23:33.663674Z","end":"2026-08-21T22:23:33.935661Z","steps":["trace[372858299] 'read index received' (duration: 44.34674ms)","trace[372858299] 'applied index is now lower than readState.Index' (duration: 227.639118ms)"],"step_count":2} {"level":"info","ts":"2026-08-21T22:23:33.935629Z","caller":"traceutil/trace.go:171","msg":"trace[1136023895] transaction","detail":"{read_only:false; response_revision:4745; number_of_response:1; }","duration":"219.145047ms","start":"2026-08-21T22:23:33.716422Z","end":"2026-08-21T22:23:33.935567Z","steps":["trace[1136023895] 'process raft request' (duration: 219.036134ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T22:23:33.936471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.86352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-08-21T22:23:33.936517Z","caller":"traceutil/trace.go:171","msg":"trace[2094099777] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4745; }","duration":"267.922581ms","start":"2026-08-21T22:23:33.66858Z","end":"2026-08-21T22:23:33.936502Z","steps":["trace[2094099777] 'agreement among raft nodes before linearized reading' (duration: 267.814708ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T22:23:33.935988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.305185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-6b8867f586-f27wc.18cdf246b59c038e\" ","response":"range_response_count:1 size:898"} {"level":"info","ts":"2026-08-21T22:23:33.936695Z","caller":"traceutil/trace.go:171","msg":"trace[1714380529] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-6b8867f586-f27wc.18cdf246b59c038e; range_end:; response_count:1; response_revision:4745; }","duration":"273.042412ms","start":"2026-08-21T22:23:33.663642Z","end":"2026-08-21T22:23:33.936685Z","steps":["trace[1714380529] 'agreement among raft nodes before linearized reading' (duration: 272.167281ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T22:23:33.93778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.081481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-21T22:23:33.937845Z","caller":"traceutil/trace.go:171","msg":"trace[522727837] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4745; }","duration":"155.182123ms","start":"2026-08-21T22:23:33.782646Z","end":"2026-08-21T22:23:33.937828Z","steps":["trace[522727837] 'agreement among raft nodes before linearized reading' (duration: 155.072791ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T22:23:33.941859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.498037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207418"} {"level":"info","ts":"2026-08-21T22:23:33.941957Z","caller":"traceutil/trace.go:171","msg":"trace[1770417808] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4745; }","duration":"157.638741ms","start":"2026-08-21T22:23:33.784297Z","end":"2026-08-21T22:23:33.941935Z","steps":["trace[1770417808] 'agreement among raft nodes before linearized reading' (duration: 152.715415ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T22:23:33.937797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.295765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-08-21T22:23:33.942102Z","caller":"traceutil/trace.go:171","msg":"trace[545287502] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4745; }","duration":"227.635268ms","start":"2026-08-21T22:23:33.714451Z","end":"2026-08-21T22:23:33.942086Z","steps":["trace[545287502] 'agreement among raft nodes before linearized reading' (duration: 223.239754ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T22:25:21.747111Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2925} {"level":"info","ts":"2026-08-21T22:25:21.843404Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2925,"took":"95.061933ms","hash":119082004,"current-db-size-bytes":53252096,"current-db-size":"53 MB","current-db-size-in-use-bytes":29556736,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-08-21T22:25:21.843495Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":119082004,"revision":2925,"compact-revision":-1} {"level":"info","ts":"2026-08-21T22:27:22.378651Z","caller":"traceutil/trace.go:171","msg":"trace[1212312986] transaction","detail":"{read_only:false; response_revision:6502; number_of_response:1; }","duration":"107.154003ms","start":"2026-08-21T22:27:22.27147Z","end":"2026-08-21T22:27:22.378624Z","steps":["trace[1212312986] 'process raft request' (duration: 107.002801ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T22:27:43.406514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.541334ms","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-08-21T22:27:43.406656Z","caller":"traceutil/trace.go:171","msg":"trace[691020867] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6664; }","duration":"122.760737ms","start":"2026-08-21T22:27:43.283883Z","end":"2026-08-21T22:27:43.406643Z","steps":["trace[691020867] 'range keys from in-memory index tree' (duration: 122.34748ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T22:30:21.752828Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5685} {"level":"info","ts":"2026-08-21T22:30:21.864543Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5685,"took":"109.857375ms","hash":354561517,"current-db-size-bytes":53252096,"current-db-size":"53 MB","current-db-size-in-use-bytes":18407424,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-08-21T22:30:21.864607Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":354561517,"revision":5685,"compact-revision":2925}