{"level":"warn","ts":"2026-08-11T08:11:42.568319Z","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-11T08:11:42.568429Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.140:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.140:2380","--initial-cluster=instance=https://199.19.213.140:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.140:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.140: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-11T08:11:42.568515Z","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-11T08:11:42.568527Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.140:2380"]} {"level":"info","ts":"2026-08-11T08:11:42.568553Z","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-11T08:11:42.569357Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.140:2379"]} {"level":"info","ts":"2026-08-11T08:11:42.56963Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.140:2380"],"listen-peer-urls":["https://199.19.213.140:2380"],"advertise-client-urls":["https://199.19.213.140:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.140:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.140: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-11T08:11:42.576823Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.933305ms"} {"level":"info","ts":"2026-08-11T08:11:42.586513Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b6366444c8cd268d","cluster-id":"b92fe020fa22927c"} {"level":"info","ts":"2026-08-11T08:11:42.586621Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6366444c8cd268d switched to configuration voters=()"} {"level":"info","ts":"2026-08-11T08:11:42.58665Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6366444c8cd268d became follower at term 0"} {"level":"info","ts":"2026-08-11T08:11:42.586665Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b6366444c8cd268d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-11T08:11:42.586681Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6366444c8cd268d became follower at term 1"} {"level":"info","ts":"2026-08-11T08:11:42.58674Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6366444c8cd268d switched to configuration voters=(13129792010234701453)"} {"level":"warn","ts":"2026-08-11T08:11:42.599497Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-11T08:11:42.607485Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-11T08:11:42.608776Z","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-11T08:11:42.610916Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b6366444c8cd268d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-11T08:11:42.611395Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b6366444c8cd268d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-11T08:11:42.611489Z","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-11T08:11:42.611526Z","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-11T08:11:42.611536Z","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-11T08:11:42.612062Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6366444c8cd268d switched to configuration voters=(13129792010234701453)"} {"level":"info","ts":"2026-08-11T08:11:42.616083Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b92fe020fa22927c","local-member-id":"b6366444c8cd268d","added-peer-id":"b6366444c8cd268d","added-peer-peer-urls":["https://199.19.213.140:2380"]} {"level":"info","ts":"2026-08-11T08:11:42.617855Z","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-11T08:11:42.617981Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.140:2380"} {"level":"info","ts":"2026-08-11T08:11:42.618044Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.140:2380"} {"level":"info","ts":"2026-08-11T08:11:42.619125Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b6366444c8cd268d","initial-advertise-peer-urls":["https://199.19.213.140:2380"],"listen-peer-urls":["https://199.19.213.140:2380"],"advertise-client-urls":["https://199.19.213.140:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.140:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-11T08:11:42.619156Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-11T08:11:43.287597Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6366444c8cd268d is starting a new election at term 1"} {"level":"info","ts":"2026-08-11T08:11:43.287663Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6366444c8cd268d became pre-candidate at term 1"} {"level":"info","ts":"2026-08-11T08:11:43.287685Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6366444c8cd268d received MsgPreVoteResp from b6366444c8cd268d at term 1"} {"level":"info","ts":"2026-08-11T08:11:43.287703Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6366444c8cd268d became candidate at term 2"} {"level":"info","ts":"2026-08-11T08:11:43.287713Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6366444c8cd268d received MsgVoteResp from b6366444c8cd268d at term 2"} {"level":"info","ts":"2026-08-11T08:11:43.287735Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6366444c8cd268d became leader at term 2"} {"level":"info","ts":"2026-08-11T08:11:43.287748Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b6366444c8cd268d elected leader b6366444c8cd268d at term 2"} {"level":"info","ts":"2026-08-11T08:11:43.288624Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T08:11:43.289271Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b6366444c8cd268d","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.140:2379]}","request-path":"/0/members/b6366444c8cd268d/attributes","cluster-id":"b92fe020fa22927c","publish-timeout":"7s"} {"level":"info","ts":"2026-08-11T08:11:43.289316Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-11T08:11:43.28947Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-11T08:11:43.292625Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-11T08:11:43.292785Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.140:2379"} {"level":"info","ts":"2026-08-11T08:11:43.294537Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-11T08:11:43.294576Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-11T08:11:43.303141Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b92fe020fa22927c","local-member-id":"b6366444c8cd268d","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T08:11:43.303335Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T08:11:43.303383Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-08-11T08:11:47.041613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.463045ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T08:11:47.04203Z","caller":"traceutil/trace.go:171","msg":"trace[387860867] linearizableReadLoop","detail":"{readStateIndex:204; appliedIndex:203; }","duration":"253.805739ms","start":"2026-08-11T08:11:46.788013Z","end":"2026-08-11T08:11:47.041819Z","steps":["trace[387860867] 'read index received' (duration: 9.008227ms)","trace[387860867] 'applied index is now lower than readState.Index' (duration: 244.795872ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:11:47.042149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.122748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T08:11:47.042075Z","caller":"traceutil/trace.go:171","msg":"trace[1887303710] transaction","detail":"{read_only:false; response_revision:199; number_of_response:1; }","duration":"295.572601ms","start":"2026-08-11T08:11:46.746465Z","end":"2026-08-11T08:11:47.042038Z","steps":["trace[1887303710] 'process raft request' (duration: 50.641144ms)","trace[1887303710] 'compare' (duration: 243.241859ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:11:47.04219Z","caller":"traceutil/trace.go:171","msg":"trace[1092542844] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:199; }","duration":"254.17595ms","start":"2026-08-11T08:11:46.788003Z","end":"2026-08-11T08:11:47.042179Z","steps":["trace[1092542844] 'agreement among raft nodes before linearized reading' (duration: 254.091797ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:11:47.407274Z","caller":"traceutil/trace.go:171","msg":"trace[141634756] transaction","detail":"{read_only:false; response_revision:200; number_of_response:1; }","duration":"361.011674ms","start":"2026-08-11T08:11:47.046219Z","end":"2026-08-11T08:11:47.40723Z","steps":["trace[141634756] 'process raft request' (duration: 360.666974ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:11:47.407531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:11:47.046198Z","time spent":"361.194359ms","remote":"127.0.0.1:40916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1069,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T08:11:47.411523Z","caller":"traceutil/trace.go:171","msg":"trace[1897839465] transaction","detail":"{read_only:false; response_revision:201; number_of_response:1; }","duration":"183.491437ms","start":"2026-08-11T08:11:47.227977Z","end":"2026-08-11T08:11:47.411468Z","steps":["trace[1897839465] 'process raft request' (duration: 183.377954ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:12:24.948741Z","caller":"traceutil/trace.go:171","msg":"trace[371897355] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"217.687256ms","start":"2026-08-11T08:12:24.731028Z","end":"2026-08-11T08:12:24.948715Z","steps":["trace[371897355] 'process raft request' (duration: 217.573534ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:12:25.213375Z","caller":"traceutil/trace.go:171","msg":"trace[560922642] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"465.950576ms","start":"2026-08-11T08:12:24.747331Z","end":"2026-08-11T08:12:25.213282Z","steps":["trace[560922642] 'process raft request' (duration: 464.994356ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:12:25.213551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:12:24.747294Z","time spent":"466.173151ms","remote":"127.0.0.1:40868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64392,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T08:12:25.223686Z","caller":"traceutil/trace.go:171","msg":"trace[621649587] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"267.625768ms","start":"2026-08-11T08:12:24.95603Z","end":"2026-08-11T08:12:25.223656Z","steps":["trace[621649587] 'process raft request' (duration: 267.406024ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:12:25.223772Z","caller":"traceutil/trace.go:171","msg":"trace[494211660] linearizableReadLoop","detail":"{readStateIndex:575; appliedIndex:572; }","duration":"235.570011ms","start":"2026-08-11T08:12:24.988186Z","end":"2026-08-11T08:12:25.223756Z","steps":["trace[494211660] 'read index received' (duration: 224.190793ms)","trace[494211660] 'applied index is now lower than readState.Index' (duration: 11.378548ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:12:25.223791Z","caller":"traceutil/trace.go:171","msg":"trace[1581903798] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"250.241731ms","start":"2026-08-11T08:12:24.973536Z","end":"2026-08-11T08:12:25.223778Z","steps":["trace[1581903798] 'process raft request' (duration: 250.081487ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:12:25.223863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.669073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T08:12:25.223893Z","caller":"traceutil/trace.go:171","msg":"trace[2016187999] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:550; }","duration":"235.735195ms","start":"2026-08-11T08:12:24.988149Z","end":"2026-08-11T08:12:25.223884Z","steps":["trace[2016187999] 'agreement among raft nodes before linearized reading' (duration: 235.678834ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:12:31.548564Z","caller":"traceutil/trace.go:171","msg":"trace[1076755583] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"132.504623ms","start":"2026-08-11T08:12:31.416033Z","end":"2026-08-11T08:12:31.548537Z","steps":["trace[1076755583] 'process raft request' (duration: 131.692096ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:12:31.771674Z","caller":"traceutil/trace.go:171","msg":"trace[2122964683] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"155.092738ms","start":"2026-08-11T08:12:31.616557Z","end":"2026-08-11T08:12:31.771649Z","steps":["trace[2122964683] 'process raft request' (duration: 154.950055ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:12:32.122523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.260526ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-08-11T08:12:32.122631Z","caller":"traceutil/trace.go:171","msg":"trace[611851817] linearizableReadLoop","detail":"{readStateIndex:635; appliedIndex:634; }","duration":"346.500643ms","start":"2026-08-11T08:12:31.776109Z","end":"2026-08-11T08:12:32.12261Z","steps":["trace[611851817] 'read index received' (duration: 8.090034ms)","trace[611851817] 'applied index is now lower than readState.Index' (duration: 338.408969ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:12:32.122944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.810114ms","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-11T08:12:32.123029Z","caller":"traceutil/trace.go:171","msg":"trace[1048032674] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:608; }","duration":"199.916187ms","start":"2026-08-11T08:12:31.923085Z","end":"2026-08-11T08:12:32.123002Z","steps":["trace[1048032674] 'agreement among raft nodes before linearized reading' (duration: 199.695632ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:12:32.123009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.805783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T08:12:32.123292Z","caller":"traceutil/trace.go:171","msg":"trace[371227292] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:608; }","duration":"133.14304ms","start":"2026-08-11T08:12:31.990117Z","end":"2026-08-11T08:12:32.12326Z","steps":["trace[371227292] 'agreement among raft nodes before linearized reading' (duration: 132.672191ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:12:32.123528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.106915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-08-11T08:12:32.123587Z","caller":"traceutil/trace.go:171","msg":"trace[993486579] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:608; }","duration":"347.505732ms","start":"2026-08-11T08:12:31.776063Z","end":"2026-08-11T08:12:32.123568Z","steps":["trace[993486579] 'agreement among raft nodes before linearized reading' (duration: 346.648265ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:12:32.123935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:12:31.776042Z","time spent":"347.86015ms","remote":"127.0.0.1:40994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":217,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"info","ts":"2026-08-11T08:12:32.350495Z","caller":"traceutil/trace.go:171","msg":"trace[1159316752] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"213.284714ms","start":"2026-08-11T08:12:32.137186Z","end":"2026-08-11T08:12:32.350471Z","steps":["trace[1159316752] 'process raft request' (duration: 213.040199ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:12:32.361208Z","caller":"traceutil/trace.go:171","msg":"trace[173229095] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"217.111641ms","start":"2026-08-11T08:12:32.144073Z","end":"2026-08-11T08:12:32.361185Z","steps":["trace[173229095] 'process raft request' (duration: 217.009469ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:12:47.653589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.537648ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T08:12:47.65376Z","caller":"traceutil/trace.go:171","msg":"trace[1164168207] linearizableReadLoop","detail":"{readStateIndex:800; appliedIndex:799; }","duration":"169.9047ms","start":"2026-08-11T08:12:47.483837Z","end":"2026-08-11T08:12:47.653742Z","steps":["trace[1164168207] 'read index received' (duration: 78.882µs)","trace[1164168207] 'applied index is now lower than readState.Index' (duration: 169.824298ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:12:47.653782Z","caller":"traceutil/trace.go:171","msg":"trace[310097519] transaction","detail":"{read_only:false; response_revision:769; number_of_response:1; }","duration":"326.042176ms","start":"2026-08-11T08:12:47.327717Z","end":"2026-08-11T08:12:47.653759Z","steps":["trace[310097519] 'process raft request' (duration: 31.231153ms)","trace[310097519] 'compare' (duration: 294.400266ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:12:47.653923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:12:47.327699Z","time spent":"326.154369ms","remote":"127.0.0.1:41056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T08:12:47.653946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.104023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-11T08:12:47.653996Z","caller":"traceutil/trace.go:171","msg":"trace[74364429] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:769; }","duration":"170.193905ms","start":"2026-08-11T08:12:47.483784Z","end":"2026-08-11T08:12:47.653978Z","steps":["trace[74364429] 'agreement among raft nodes before linearized reading' (duration: 170.089043ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:14:09.215361Z","caller":"traceutil/trace.go:171","msg":"trace[452174163] transaction","detail":"{read_only:false; response_revision:1866; number_of_response:1; }","duration":"132.378626ms","start":"2026-08-11T08:14:09.082956Z","end":"2026-08-11T08:14:09.215334Z","steps":["trace[452174163] 'process raft request' (duration: 132.230714ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:14:09.644003Z","caller":"traceutil/trace.go:171","msg":"trace[805524672] transaction","detail":"{read_only:false; response_revision:1867; number_of_response:1; }","duration":"107.013676ms","start":"2026-08-11T08:14:09.536962Z","end":"2026-08-11T08:14:09.643976Z","steps":["trace[805524672] 'process raft request' (duration: 106.806993ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:14:09.674546Z","caller":"traceutil/trace.go:171","msg":"trace[96287228] transaction","detail":"{read_only:false; response_revision:1868; number_of_response:1; }","duration":"137.499047ms","start":"2026-08-11T08:14:09.537013Z","end":"2026-08-11T08:14:09.674512Z","steps":["trace[96287228] 'process raft request' (duration: 137.248553ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:14:20.887861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.121084ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T08:14:20.887955Z","caller":"traceutil/trace.go:171","msg":"trace[361286236] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1966; }","duration":"117.227585ms","start":"2026-08-11T08:14:20.770714Z","end":"2026-08-11T08:14:20.887942Z","steps":["trace[361286236] 'range keys from in-memory index tree' (duration: 117.107853ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:14:23.827938Z","caller":"traceutil/trace.go:171","msg":"trace[1331689345] transaction","detail":"{read_only:false; response_revision:1992; number_of_response:1; }","duration":"105.900755ms","start":"2026-08-11T08:14:23.722009Z","end":"2026-08-11T08:14:23.827909Z","steps":["trace[1331689345] 'process raft request' (duration: 105.714332ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:14:42.429947Z","caller":"traceutil/trace.go:171","msg":"trace[78532972] transaction","detail":"{read_only:false; response_revision:2096; number_of_response:1; }","duration":"132.619006ms","start":"2026-08-11T08:14:42.297304Z","end":"2026-08-11T08:14:42.429923Z","steps":["trace[78532972] 'process raft request' (duration: 132.479174ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:14:42.430232Z","caller":"traceutil/trace.go:171","msg":"trace[1074805397] linearizableReadLoop","detail":"{readStateIndex:2178; appliedIndex:2178; }","duration":"131.053756ms","start":"2026-08-11T08:14:42.299162Z","end":"2026-08-11T08:14:42.430216Z","steps":["trace[1074805397] 'read index received' (duration: 131.046926ms)","trace[1074805397] 'applied index is now lower than readState.Index' (duration: 5.61µs)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:14:42.430557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.306099ms","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-11T08:14:42.43064Z","caller":"traceutil/trace.go:171","msg":"trace[1650012564] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2096; }","duration":"131.481771ms","start":"2026-08-11T08:14:42.299145Z","end":"2026-08-11T08:14:42.430627Z","steps":["trace[1650012564] 'agreement among raft nodes before linearized reading' (duration: 131.230378ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:14:42.598596Z","caller":"traceutil/trace.go:171","msg":"trace[1879848019] linearizableReadLoop","detail":"{readStateIndex:2180; appliedIndex:2178; }","duration":"168.02175ms","start":"2026-08-11T08:14:42.430554Z","end":"2026-08-11T08:14:42.598575Z","steps":["trace[1879848019] 'read index received' (duration: 167.873708ms)","trace[1879848019] 'applied index is now lower than readState.Index' (duration: 147.162µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:14:42.5987Z","caller":"traceutil/trace.go:171","msg":"trace[1836929616] transaction","detail":"{read_only:false; response_revision:2098; number_of_response:1; }","duration":"176.050335ms","start":"2026-08-11T08:14:42.422638Z","end":"2026-08-11T08:14:42.598688Z","steps":["trace[1836929616] 'process raft request' (duration: 175.897693ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:14:42.598703Z","caller":"traceutil/trace.go:171","msg":"trace[1144772609] transaction","detail":"{read_only:false; response_revision:2097; number_of_response:1; }","duration":"265.946512ms","start":"2026-08-11T08:14:42.332725Z","end":"2026-08-11T08:14:42.598672Z","steps":["trace[1144772609] 'process raft request' (duration: 265.656458ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:14:42.599112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.955809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12385"} {"level":"info","ts":"2026-08-11T08:14:42.599161Z","caller":"traceutil/trace.go:171","msg":"trace[1059065053] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2098; }","duration":"207.053411ms","start":"2026-08-11T08:14:42.392098Z","end":"2026-08-11T08:14:42.599151Z","steps":["trace[1059065053] 'agreement among raft nodes before linearized reading' (duration: 206.861808ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:14:42.599068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.921285ms","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-11T08:14:42.600528Z","caller":"traceutil/trace.go:171","msg":"trace[1357756036] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2098; }","duration":"249.419856ms","start":"2026-08-11T08:14:42.351083Z","end":"2026-08-11T08:14:42.600503Z","steps":["trace[1357756036] 'agreement among raft nodes before linearized reading' (duration: 247.785714ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:14:42.618781Z","caller":"traceutil/trace.go:171","msg":"trace[1631337618] transaction","detail":"{read_only:false; response_revision:2099; number_of_response:1; }","duration":"184.149471ms","start":"2026-08-11T08:14:42.434605Z","end":"2026-08-11T08:14:42.618755Z","steps":["trace[1631337618] 'process raft request' (duration: 183.804366ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:14:42.619008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.519719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-11T08:14:42.619093Z","caller":"traceutil/trace.go:171","msg":"trace[1991936529] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:2100; }","duration":"143.655901ms","start":"2026-08-11T08:14:42.475416Z","end":"2026-08-11T08:14:42.619072Z","steps":["trace[1991936529] 'agreement among raft nodes before linearized reading' (duration: 143.427918ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:14:42.61902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.096243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T08:14:42.619206Z","caller":"traceutil/trace.go:171","msg":"trace[252261749] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:2100; }","duration":"162.323225ms","start":"2026-08-11T08:14:42.456866Z","end":"2026-08-11T08:14:42.619189Z","steps":["trace[252261749] 'agreement among raft nodes before linearized reading' (duration: 162.090532ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:14:42.890912Z","caller":"traceutil/trace.go:171","msg":"trace[1386521547] linearizableReadLoop","detail":"{readStateIndex:2184; appliedIndex:2183; }","duration":"105.378209ms","start":"2026-08-11T08:14:42.785511Z","end":"2026-08-11T08:14:42.890889Z","steps":["trace[1386521547] 'read index received' (duration: 105.185327ms)","trace[1386521547] 'applied index is now lower than readState.Index' (duration: 192.052µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:14:42.891081Z","caller":"traceutil/trace.go:171","msg":"trace[1155430505] transaction","detail":"{read_only:false; response_revision:2102; number_of_response:1; }","duration":"140.001843ms","start":"2026-08-11T08:14:42.751003Z","end":"2026-08-11T08:14:42.891005Z","steps":["trace[1155430505] 'process raft request' (duration: 139.75606ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:14:42.891337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.807965ms","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-11T08:14:42.891391Z","caller":"traceutil/trace.go:171","msg":"trace[1293170999] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2102; }","duration":"105.913467ms","start":"2026-08-11T08:14:42.785463Z","end":"2026-08-11T08:14:42.891377Z","steps":["trace[1293170999] 'agreement among raft nodes before linearized reading' (duration: 105.528412ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:14:43.998789Z","caller":"traceutil/trace.go:171","msg":"trace[203456581] transaction","detail":"{read_only:false; response_revision:2106; number_of_response:1; }","duration":"108.902814ms","start":"2026-08-11T08:14:43.889865Z","end":"2026-08-11T08:14:43.998768Z","steps":["trace[203456581] 'process raft request' (duration: 108.751662ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:15:32.012607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.641816ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-08-11T08:15:33.418483Z","caller":"traceutil/trace.go:171","msg":"trace[879205665] linearizableReadLoop","detail":"{readStateIndex:2515; appliedIndex:2514; }","duration":"101.799675ms","start":"2026-08-11T08:15:33.316663Z","end":"2026-08-11T08:15:33.418462Z","steps":["trace[879205665] 'read index received' (duration: 101.503102ms)","trace[879205665] 'applied index is now lower than readState.Index' (duration: 295.713µs)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:15:33.41868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.008114ms","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-08-11T08:15:33.418711Z","caller":"traceutil/trace.go:171","msg":"trace[551420879] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2421; }","duration":"102.091298ms","start":"2026-08-11T08:15:33.31661Z","end":"2026-08-11T08:15:33.418701Z","steps":["trace[551420879] 'agreement among raft nodes before linearized reading' (duration: 101.935471ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:15:33.419054Z","caller":"traceutil/trace.go:171","msg":"trace[889123103] transaction","detail":"{read_only:false; response_revision:2421; number_of_response:1; }","duration":"293.450386ms","start":"2026-08-11T08:15:33.125594Z","end":"2026-08-11T08:15:33.419044Z","steps":["trace[889123103] 'process raft request' (duration: 292.626019ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:15:41.480309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.722182ms","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-11T08:15:41.480382Z","caller":"traceutil/trace.go:171","msg":"trace[1890519182] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2519; }","duration":"320.835877ms","start":"2026-08-11T08:15:41.15953Z","end":"2026-08-11T08:15:41.480366Z","steps":["trace[1890519182] 'range keys from in-memory index tree' (duration: 320.574346ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:15:41.480419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:15:41.159509Z","time spent":"320.90193ms","remote":"127.0.0.1:41056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-08-11T08:16:09.205255Z","caller":"traceutil/trace.go:171","msg":"trace[24818727] transaction","detail":"{read_only:false; response_revision:2673; number_of_response:1; }","duration":"124.542153ms","start":"2026-08-11T08:16:09.080696Z","end":"2026-08-11T08:16:09.205238Z","steps":["trace[24818727] 'process raft request' (duration: 124.446669ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:16:09.301765Z","caller":"traceutil/trace.go:171","msg":"trace[800375829] transaction","detail":"{read_only:false; response_revision:2674; number_of_response:1; }","duration":"129.644188ms","start":"2026-08-11T08:16:09.1721Z","end":"2026-08-11T08:16:09.301744Z","steps":["trace[800375829] 'process raft request' (duration: 79.71301ms)","trace[800375829] 'compare' (duration: 49.416998ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:16:15.180342Z","caller":"traceutil/trace.go:171","msg":"trace[1280663578] transaction","detail":"{read_only:false; response_revision:2704; number_of_response:1; }","duration":"103.161627ms","start":"2026-08-11T08:16:15.077105Z","end":"2026-08-11T08:16:15.180267Z","steps":["trace[1280663578] 'process raft request' (duration: 102.855085ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:16:15.631803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.996309ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T08:16:15.631899Z","caller":"traceutil/trace.go:171","msg":"trace[900876853] transaction","detail":"{read_only:false; response_revision:2705; number_of_response:1; }","duration":"393.186938ms","start":"2026-08-11T08:16:15.238694Z","end":"2026-08-11T08:16:15.631881Z","steps":["trace[900876853] 'process raft request' (duration: 136.037193ms)","trace[900876853] 'compare' (duration: 256.903286ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:16:15.632132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:16:15.238674Z","time spent":"393.428657ms","remote":"127.0.0.1:41056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T08:16:15.815094Z","caller":"traceutil/trace.go:171","msg":"trace[1235238256] transaction","detail":"{read_only:false; response_revision:2706; number_of_response:1; }","duration":"445.825716ms","start":"2026-08-11T08:16:15.369238Z","end":"2026-08-11T08:16:15.815063Z","steps":["trace[1235238256] 'process raft request' (duration: 445.532965ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:16:15.815272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:16:15.369214Z","time spent":"445.962841ms","remote":"127.0.0.1:41056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T08:16:15.815905Z","caller":"traceutil/trace.go:171","msg":"trace[1655441154] linearizableReadLoop","detail":"{readStateIndex:2810; appliedIndex:2808; }","duration":"434.068041ms","start":"2026-08-11T08:16:15.381816Z","end":"2026-08-11T08:16:15.815885Z","steps":["trace[1655441154] 'read index received' (duration: 432.911679ms)","trace[1655441154] 'applied index is now lower than readState.Index' (duration: 1.155292ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:16:15.81596Z","caller":"traceutil/trace.go:171","msg":"trace[1291047996] transaction","detail":"{read_only:false; response_revision:2707; number_of_response:1; }","duration":"443.104585ms","start":"2026-08-11T08:16:15.372833Z","end":"2026-08-11T08:16:15.815938Z","steps":["trace[1291047996] 'process raft request' (duration: 442.087238ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:16:15.816122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:16:15.372811Z","time spent":"443.22731ms","remote":"127.0.0.1:41056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T08:16:15.816234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.369332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T08:16:15.816285Z","caller":"traceutil/trace.go:171","msg":"trace[1761232660] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2707; }","duration":"434.506237ms","start":"2026-08-11T08:16:15.381765Z","end":"2026-08-11T08:16:15.816272Z","steps":["trace[1761232660] 'agreement among raft nodes before linearized reading' (duration: 434.353501ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:16:15.81636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:16:15.381743Z","time spent":"434.60479ms","remote":"127.0.0.1:40806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-11T08:16:15.817746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.310044ms","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-11T08:16:15.817785Z","caller":"traceutil/trace.go:171","msg":"trace[1835486908] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2708; }","duration":"426.373676ms","start":"2026-08-11T08:16:15.391402Z","end":"2026-08-11T08:16:15.817775Z","steps":["trace[1835486908] 'agreement among raft nodes before linearized reading' (duration: 426.263672ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:16:15.817881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:16:15.391388Z","time spent":"426.414358ms","remote":"127.0.0.1:41056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-11T08:16:15.818099Z","caller":"traceutil/trace.go:171","msg":"trace[1609668926] transaction","detail":"{read_only:false; response_revision:2708; number_of_response:1; }","duration":"171.274777ms","start":"2026-08-11T08:16:15.646814Z","end":"2026-08-11T08:16:15.818089Z","steps":["trace[1609668926] 'process raft request' (duration: 170.804719ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:20:14.56586Z","caller":"traceutil/trace.go:171","msg":"trace[2035982677] linearizableReadLoop","detail":"{readStateIndex:4869; appliedIndex:4868; }","duration":"109.920226ms","start":"2026-08-11T08:20:14.455913Z","end":"2026-08-11T08:20:14.565833Z","steps":["trace[2035982677] 'read index received' (duration: 109.638911ms)","trace[2035982677] 'applied index is now lower than readState.Index' (duration: 280.085µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:20:14.565973Z","caller":"traceutil/trace.go:171","msg":"trace[1108057996] transaction","detail":"{read_only:false; response_revision:4690; number_of_response:1; }","duration":"122.683883ms","start":"2026-08-11T08:20:14.443279Z","end":"2026-08-11T08:20:14.565963Z","steps":["trace[1108057996] 'process raft request' (duration: 122.381927ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:20:14.566363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.552138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:3958"} {"level":"info","ts":"2026-08-11T08:20:14.566518Z","caller":"traceutil/trace.go:171","msg":"trace[274664696] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4690; }","duration":"126.717151ms","start":"2026-08-11T08:20:14.439782Z","end":"2026-08-11T08:20:14.566499Z","steps":["trace[274664696] 'agreement among raft nodes before linearized reading' (duration: 126.248782ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:20:14.605589Z","caller":"traceutil/trace.go:171","msg":"trace[707621195] transaction","detail":"{read_only:false; response_revision:4691; number_of_response:1; }","duration":"146.534074ms","start":"2026-08-11T08:20:14.459031Z","end":"2026-08-11T08:20:14.605565Z","steps":["trace[707621195] 'process raft request' (duration: 146.241369ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:20:14.605663Z","caller":"traceutil/trace.go:171","msg":"trace[1615138676] transaction","detail":"{read_only:false; response_revision:4692; number_of_response:1; }","duration":"142.115708ms","start":"2026-08-11T08:20:14.463501Z","end":"2026-08-11T08:20:14.605617Z","steps":["trace[1615138676] 'process raft request' (duration: 141.974396ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:20:14.605783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.847696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-11T08:20:14.605918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.188219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-prometheus-node-exporter-xzj7c-tls\" ","response":"range_response_count:1 size:4432"} {"level":"info","ts":"2026-08-11T08:20:14.605945Z","caller":"traceutil/trace.go:171","msg":"trace[783466237] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:4692; }","duration":"107.05504ms","start":"2026-08-11T08:20:14.498871Z","end":"2026-08-11T08:20:14.605926Z","steps":["trace[783466237] 'agreement among raft nodes before linearized reading' (duration: 106.770895ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:20:14.605953Z","caller":"traceutil/trace.go:171","msg":"trace[1289569713] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-prometheus-node-exporter-xzj7c-tls; range_end:; response_count:1; response_revision:4692; }","duration":"143.255091ms","start":"2026-08-11T08:20:14.462688Z","end":"2026-08-11T08:20:14.605943Z","steps":["trace[1289569713] 'agreement among raft nodes before linearized reading' (duration: 143.045757ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:20:15.016916Z","caller":"traceutil/trace.go:171","msg":"trace[1245948234] linearizableReadLoop","detail":"{readStateIndex:4875; appliedIndex:4872; }","duration":"401.685128ms","start":"2026-08-11T08:20:14.615205Z","end":"2026-08-11T08:20:15.01689Z","steps":["trace[1245948234] 'read index received' (duration: 8.042315ms)","trace[1245948234] 'applied index is now lower than readState.Index' (duration: 393.641723ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:20:15.017002Z","caller":"traceutil/trace.go:171","msg":"trace[653603086] transaction","detail":"{read_only:false; response_revision:4695; number_of_response:1; }","duration":"403.491993ms","start":"2026-08-11T08:20:14.613499Z","end":"2026-08-11T08:20:15.016991Z","steps":["trace[653603086] 'process raft request' (duration: 369.885244ms)","trace[653603086] 'compare' (duration: 33.174451ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:20:15.017197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:20:14.61348Z","time spent":"403.614535ms","remote":"127.0.0.1:40886","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":814,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T08:20:15.016933Z","caller":"traceutil/trace.go:171","msg":"trace[1560426930] transaction","detail":"{read_only:false; response_revision:4696; number_of_response:1; }","duration":"403.256509ms","start":"2026-08-11T08:20:14.613641Z","end":"2026-08-11T08:20:15.016897Z","steps":["trace[1560426930] 'process raft request' (duration: 403.109576ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:20:15.01732Z","caller":"traceutil/trace.go:171","msg":"trace[336864405] transaction","detail":"{read_only:false; response_revision:4697; number_of_response:1; }","duration":"398.835753ms","start":"2026-08-11T08:20:14.618457Z","end":"2026-08-11T08:20:15.017292Z","steps":["trace[336864405] 'process raft request' (duration: 398.362844ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:20:15.017403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:20:14.613635Z","time spent":"403.695477ms","remote":"127.0.0.1:40976","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9164,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-11T08:20:15.017463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:20:14.618442Z","time spent":"398.942616ms","remote":"127.0.0.1:54576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2286,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T08:20:15.017696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.467654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3296"} {"level":"info","ts":"2026-08-11T08:20:15.017831Z","caller":"traceutil/trace.go:171","msg":"trace[555836830] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4697; }","duration":"402.624727ms","start":"2026-08-11T08:20:14.615183Z","end":"2026-08-11T08:20:15.017807Z","steps":["trace[555836830] 'agreement among raft nodes before linearized reading' (duration: 402.053176ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:20:15.017922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:20:14.615176Z","time spent":"402.733419ms","remote":"127.0.0.1:34348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":3320,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" "} {"level":"info","ts":"2026-08-11T08:20:15.032168Z","caller":"traceutil/trace.go:171","msg":"trace[973426575] transaction","detail":"{read_only:false; response_revision:4698; number_of_response:1; }","duration":"336.586879ms","start":"2026-08-11T08:20:14.695563Z","end":"2026-08-11T08:20:15.03215Z","steps":["trace[973426575] 'process raft request' (duration: 336.408516ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:20:15.032291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:20:14.695536Z","time spent":"336.691171ms","remote":"127.0.0.1:41056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T08:20:15.032507Z","caller":"traceutil/trace.go:171","msg":"trace[997495991] transaction","detail":"{read_only:false; response_revision:4699; number_of_response:1; }","duration":"326.344461ms","start":"2026-08-11T08:20:14.706154Z","end":"2026-08-11T08:20:15.032498Z","steps":["trace[997495991] 'process raft request' (duration: 325.961413ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:20:15.032551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:20:14.706128Z","time spent":"326.401091ms","remote":"127.0.0.1:41056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T08:20:15.033115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.368621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"} {"level":"info","ts":"2026-08-11T08:20:15.033181Z","caller":"traceutil/trace.go:171","msg":"trace[728864517] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4699; }","duration":"417.453383ms","start":"2026-08-11T08:20:14.61571Z","end":"2026-08-11T08:20:15.033163Z","steps":["trace[728864517] 'agreement among raft nodes before linearized reading' (duration: 416.7894ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:20:15.033225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:20:14.615706Z","time spent":"417.507764ms","remote":"127.0.0.1:40914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":1,"response size":1367,"request content":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" "} {"level":"warn","ts":"2026-08-11T08:20:15.033295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.392155ms","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-11T08:20:15.033371Z","caller":"traceutil/trace.go:171","msg":"trace[1246453834] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4699; }","duration":"412.494588ms","start":"2026-08-11T08:20:14.620864Z","end":"2026-08-11T08:20:15.033358Z","steps":["trace[1246453834] 'agreement among raft nodes before linearized reading' (duration: 411.528549ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:20:15.033434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:20:14.620858Z","time spent":"412.565199ms","remote":"127.0.0.1:40916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":47,"response size":2207442,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "} {"level":"info","ts":"2026-08-11T08:20:15.232864Z","caller":"traceutil/trace.go:171","msg":"trace[1977630968] linearizableReadLoop","detail":"{readStateIndex:4883; appliedIndex:4882; }","duration":"111.197848ms","start":"2026-08-11T08:20:15.121642Z","end":"2026-08-11T08:20:15.23284Z","steps":["trace[1977630968] 'read index received' (duration: 111.098396ms)","trace[1977630968] 'applied index is now lower than readState.Index' (duration: 98.602µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:20:15.232919Z","caller":"traceutil/trace.go:171","msg":"trace[667947095] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4704; }","duration":"114.37346ms","start":"2026-08-11T08:20:15.118515Z","end":"2026-08-11T08:20:15.232888Z","steps":["trace[667947095] 'process raft request' (duration: 114.173036ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:20:15.23356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.401572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rabbitmq-keystone-default-user\" ","response":"range_response_count:1 size:1321"} {"level":"info","ts":"2026-08-11T08:20:15.233605Z","caller":"traceutil/trace.go:171","msg":"trace[1912029725] range","detail":"{range_begin:/registry/secrets/openstack/rabbitmq-keystone-default-user; range_end:; response_count:1; response_revision:4704; }","duration":"111.978823ms","start":"2026-08-11T08:20:15.121616Z","end":"2026-08-11T08:20:15.233594Z","steps":["trace[1912029725] 'agreement among raft nodes before linearized reading' (duration: 111.331851ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:20:15.553642Z","caller":"traceutil/trace.go:171","msg":"trace[431457023] transaction","detail":"{read_only:false; response_revision:4706; number_of_response:1; }","duration":"417.579036ms","start":"2026-08-11T08:20:15.13604Z","end":"2026-08-11T08:20:15.553619Z","steps":["trace[431457023] 'process raft request' (duration: 417.471574ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:20:15.553682Z","caller":"traceutil/trace.go:171","msg":"trace[527854935] transaction","detail":"{read_only:false; response_revision:4705; number_of_response:1; }","duration":"431.25292ms","start":"2026-08-11T08:20:15.122403Z","end":"2026-08-11T08:20:15.553656Z","steps":["trace[527854935] 'process raft request' (duration: 430.962574ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:20:15.553784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:20:15.135979Z","time spent":"417.725699ms","remote":"127.0.0.1:41252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9560,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T08:20:15.553857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:20:15.122383Z","time spent":"431.396833ms","remote":"127.0.0.1:40946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1436,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T08:20:15.553627Z","caller":"traceutil/trace.go:171","msg":"trace[1007530110] linearizableReadLoop","detail":"{readStateIndex:4885; appliedIndex:4883; }","duration":"320.671174ms","start":"2026-08-11T08:20:15.232924Z","end":"2026-08-11T08:20:15.553595Z","steps":["trace[1007530110] 'read index received' (duration: 320.44324ms)","trace[1007530110] 'applied index is now lower than readState.Index' (duration: 226.404µs)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:20:15.5539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.828145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-08-11T08:20:15.554024Z","caller":"traceutil/trace.go:171","msg":"trace[77749475] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4706; }","duration":"411.965337ms","start":"2026-08-11T08:20:15.142045Z","end":"2026-08-11T08:20:15.55401Z","steps":["trace[77749475] 'agreement among raft nodes before linearized reading' (duration: 411.748743ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:20:15.554055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.583769ms","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-11T08:20:15.554115Z","caller":"traceutil/trace.go:171","msg":"trace[2096378985] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4706; }","duration":"412.662211ms","start":"2026-08-11T08:20:15.141432Z","end":"2026-08-11T08:20:15.554094Z","steps":["trace[2096378985] 'agreement among raft nodes before linearized reading' (duration: 412.530609ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:20:15.554109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:20:15.142037Z","time spent":"412.060689ms","remote":"127.0.0.1:40914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":3530,"request content":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" "} {"level":"warn","ts":"2026-08-11T08:20:15.554153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:20:15.141419Z","time spent":"412.727142ms","remote":"127.0.0.1:41056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-11T08:20:15.554349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.68194ms","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-11T08:20:15.554512Z","caller":"traceutil/trace.go:171","msg":"trace[306537956] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4706; }","duration":"400.935324ms","start":"2026-08-11T08:20:15.153539Z","end":"2026-08-11T08:20:15.554474Z","steps":["trace[306537956] 'agreement among raft nodes before linearized reading' (duration: 400.345193ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:20:15.55463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:20:15.153522Z","time spent":"401.089087ms","remote":"127.0.0.1:40976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-08-11T08:20:15.555137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.769689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:650"} {"level":"info","ts":"2026-08-11T08:20:15.555609Z","caller":"traceutil/trace.go:171","msg":"trace[476623903] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:4706; }","duration":"433.237198ms","start":"2026-08-11T08:20:15.122321Z","end":"2026-08-11T08:20:15.555558Z","steps":["trace[476623903] 'agreement among raft nodes before linearized reading' (duration: 431.361922ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:20:15.555709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:20:15.122305Z","time spent":"433.388681ms","remote":"127.0.0.1:40914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":91,"response count":1,"response size":674,"request content":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" "} {"level":"info","ts":"2026-08-11T08:20:15.598806Z","caller":"traceutil/trace.go:171","msg":"trace[1952398468] transaction","detail":"{read_only:false; response_revision:4707; number_of_response:1; }","duration":"357.518595ms","start":"2026-08-11T08:20:15.241269Z","end":"2026-08-11T08:20:15.598788Z","steps":["trace[1952398468] 'process raft request' (duration: 357.369792ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:20:15.599026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:20:15.241257Z","time spent":"357.608308ms","remote":"127.0.0.1:54576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1952,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T08:20:15.599358Z","caller":"traceutil/trace.go:171","msg":"trace[48813734] transaction","detail":"{read_only:false; response_revision:4708; number_of_response:1; }","duration":"344.229139ms","start":"2026-08-11T08:20:15.255092Z","end":"2026-08-11T08:20:15.599321Z","steps":["trace[48813734] 'process raft request' (duration: 343.651838ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:20:15.59952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:20:15.255071Z","time spent":"344.371762ms","remote":"127.0.0.1:40886","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":906,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T08:20:15.599505Z","caller":"traceutil/trace.go:171","msg":"trace[479760825] transaction","detail":"{read_only:false; response_revision:4709; number_of_response:1; }","duration":"239.038737ms","start":"2026-08-11T08:20:15.360368Z","end":"2026-08-11T08:20:15.599407Z","steps":["trace[479760825] 'process raft request' (duration: 238.859574ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:20:15.599865Z","caller":"traceutil/trace.go:171","msg":"trace[2121474876] transaction","detail":"{read_only:false; response_revision:4710; number_of_response:1; }","duration":"194.729691ms","start":"2026-08-11T08:20:15.405107Z","end":"2026-08-11T08:20:15.599837Z","steps":["trace[2121474876] 'process raft request' (duration: 194.255772ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:20:15.600121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.489903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-08-11T08:20:15.60013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.287839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-keystone-nodes\" ","response":"range_response_count:1 size:1265"} {"level":"info","ts":"2026-08-11T08:20:15.600178Z","caller":"traceutil/trace.go:171","msg":"trace[1386151845] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4710; }","duration":"360.570925ms","start":"2026-08-11T08:20:15.239594Z","end":"2026-08-11T08:20:15.600165Z","steps":["trace[1386151845] 'agreement among raft nodes before linearized reading' (duration: 360.371311ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:20:15.600194Z","caller":"traceutil/trace.go:171","msg":"trace[451664896] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-keystone-nodes; range_end:; response_count:1; response_revision:4710; }","duration":"360.432402ms","start":"2026-08-11T08:20:15.239744Z","end":"2026-08-11T08:20:15.600177Z","steps":["trace[451664896] 'agreement among raft nodes before linearized reading' (duration: 360.139026ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:20:15.6003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.83264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-xzj7c\" ","response":"range_response_count:1 size:9674"} {"level":"warn","ts":"2026-08-11T08:20:15.600353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:20:15.239724Z","time spent":"360.552714ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":1289,"request content":"key:\"/registry/services/specs/openstack/rabbitmq-keystone-nodes\" "} {"level":"info","ts":"2026-08-11T08:20:15.60038Z","caller":"traceutil/trace.go:171","msg":"trace[1956675318] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-xzj7c; range_end:; response_count:1; response_revision:4710; }","duration":"345.928002ms","start":"2026-08-11T08:20:15.254434Z","end":"2026-08-11T08:20:15.600362Z","steps":["trace[1956675318] 'agreement among raft nodes before linearized reading' (duration: 345.759078ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:20:15.600425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:20:15.254422Z","time spent":"345.991263ms","remote":"127.0.0.1:40976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":9698,"request content":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-xzj7c\" "} {"level":"warn","ts":"2026-08-11T08:20:15.600583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.981542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-08-11T08:20:15.600213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:20:15.239583Z","time spent":"360.621536ms","remote":"127.0.0.1:41056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-08-11T08:20:15.600813Z","caller":"traceutil/trace.go:171","msg":"trace[210108951] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4710; }","duration":"361.180876ms","start":"2026-08-11T08:20:15.239536Z","end":"2026-08-11T08:20:15.600717Z","steps":["trace[210108951] 'agreement among raft nodes before linearized reading' (duration: 360.569735ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:20:15.600926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:20:15.239516Z","time spent":"361.39236ms","remote":"127.0.0.1:41056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-11T08:20:15.601024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.843571ms","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-11T08:20:15.601478Z","caller":"traceutil/trace.go:171","msg":"trace[688121649] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4710; }","duration":"359.31011ms","start":"2026-08-11T08:20:15.242157Z","end":"2026-08-11T08:20:15.601467Z","steps":["trace[688121649] 'agreement among raft nodes before linearized reading' (duration: 358.105087ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:20:15.601521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:20:15.24215Z","time spent":"359.351771ms","remote":"127.0.0.1:41056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-11T08:20:15.765265Z","caller":"traceutil/trace.go:171","msg":"trace[1810441418] linearizableReadLoop","detail":"{readStateIndex:4896; appliedIndex:4891; }","duration":"138.342343ms","start":"2026-08-11T08:20:15.626899Z","end":"2026-08-11T08:20:15.765241Z","steps":["trace[1810441418] 'read index received' (duration: 138.096198ms)","trace[1810441418] 'applied index is now lower than readState.Index' (duration: 245.305µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:20:15.765316Z","caller":"traceutil/trace.go:171","msg":"trace[949616127] transaction","detail":"{read_only:false; response_revision:4715; number_of_response:1; }","duration":"158.269337ms","start":"2026-08-11T08:20:15.606995Z","end":"2026-08-11T08:20:15.765265Z","steps":["trace[949616127] 'process raft request' (duration: 158.111634ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:20:15.765409Z","caller":"traceutil/trace.go:171","msg":"trace[227042656] transaction","detail":"{read_only:false; response_revision:4716; number_of_response:1; }","duration":"156.892401ms","start":"2026-08-11T08:20:15.608502Z","end":"2026-08-11T08:20:15.765395Z","steps":["trace[227042656] 'process raft request' (duration: 156.643036ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:20:15.765714Z","caller":"traceutil/trace.go:171","msg":"trace[714024833] transaction","detail":"{read_only:false; response_revision:4713; number_of_response:1; }","duration":"160.392258ms","start":"2026-08-11T08:20:15.605304Z","end":"2026-08-11T08:20:15.765696Z","steps":["trace[714024833] 'process raft request' (duration: 159.590773ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:20:15.765751Z","caller":"traceutil/trace.go:171","msg":"trace[492179642] transaction","detail":"{read_only:false; response_revision:4717; number_of_response:1; }","duration":"153.547686ms","start":"2026-08-11T08:20:15.612177Z","end":"2026-08-11T08:20:15.765725Z","steps":["trace[492179642] 'process raft request' (duration: 153.015926ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:20:15.766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.105124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:1455"} {"level":"warn","ts":"2026-08-11T08:20:15.766048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.074823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-xzj7c-tls\" ","response":"range_response_count:1 size:1967"} {"level":"info","ts":"2026-08-11T08:20:15.766058Z","caller":"traceutil/trace.go:171","msg":"trace[1483993208] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4717; }","duration":"159.212705ms","start":"2026-08-11T08:20:15.606831Z","end":"2026-08-11T08:20:15.766044Z","steps":["trace[1483993208] 'agreement among raft nodes before linearized reading' (duration: 159.020731ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:20:15.766079Z","caller":"traceutil/trace.go:171","msg":"trace[1011521572] transaction","detail":"{read_only:false; response_revision:4714; number_of_response:1; }","duration":"159.060762ms","start":"2026-08-11T08:20:15.60699Z","end":"2026-08-11T08:20:15.766051Z","steps":["trace[1011521572] 'process raft request' (duration: 158.056423ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:20:15.766096Z","caller":"traceutil/trace.go:171","msg":"trace[1727264337] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-xzj7c-tls; range_end:; response_count:1; response_revision:4717; }","duration":"159.156175ms","start":"2026-08-11T08:20:15.606925Z","end":"2026-08-11T08:20:15.766081Z","steps":["trace[1727264337] 'agreement among raft nodes before linearized reading' (duration: 158.989332ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:20:15.807873Z","caller":"traceutil/trace.go:171","msg":"trace[1347992692] transaction","detail":"{read_only:false; response_revision:4718; number_of_response:1; }","duration":"175.606532ms","start":"2026-08-11T08:20:15.632241Z","end":"2026-08-11T08:20:15.807848Z","steps":["trace[1347992692] 'process raft request' (duration: 175.4648ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:20:15.808017Z","caller":"traceutil/trace.go:171","msg":"trace[1790023886] transaction","detail":"{read_only:false; response_revision:4719; number_of_response:1; }","duration":"175.48606ms","start":"2026-08-11T08:20:15.632522Z","end":"2026-08-11T08:20:15.808008Z","steps":["trace[1790023886] 'process raft request' (duration: 175.270265ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:20:15.80833Z","caller":"traceutil/trace.go:171","msg":"trace[1395420334] transaction","detail":"{read_only:false; response_revision:4720; number_of_response:1; }","duration":"163.465028ms","start":"2026-08-11T08:20:15.644853Z","end":"2026-08-11T08:20:15.808318Z","steps":["trace[1395420334] 'process raft request' (duration: 162.974168ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:20:15.808447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.445707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1346"} {"level":"info","ts":"2026-08-11T08:20:15.809214Z","caller":"traceutil/trace.go:171","msg":"trace[1104216781] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:4720; }","duration":"178.224953ms","start":"2026-08-11T08:20:15.630955Z","end":"2026-08-11T08:20:15.80918Z","steps":["trace[1104216781] 'agreement among raft nodes before linearized reading' (duration: 177.312356ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:20:15.808526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.583009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:9515"} {"level":"info","ts":"2026-08-11T08:20:15.809431Z","caller":"traceutil/trace.go:171","msg":"trace[554677221] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:4720; }","duration":"180.560138ms","start":"2026-08-11T08:20:15.62886Z","end":"2026-08-11T08:20:15.80942Z","steps":["trace[554677221] 'agreement among raft nodes before linearized reading' (duration: 179.504907ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:20:15.808568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.705482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"info","ts":"2026-08-11T08:20:15.80964Z","caller":"traceutil/trace.go:171","msg":"trace[2056510369] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:4720; }","duration":"178.804854ms","start":"2026-08-11T08:20:15.630822Z","end":"2026-08-11T08:20:15.809627Z","steps":["trace[2056510369] 'agreement among raft nodes before linearized reading' (duration: 177.683342ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:20:15.897888Z","caller":"traceutil/trace.go:171","msg":"trace[907724505] transaction","detail":"{read_only:false; response_revision:4721; number_of_response:1; }","duration":"125.008364ms","start":"2026-08-11T08:20:15.772812Z","end":"2026-08-11T08:20:15.89782Z","steps":["trace[907724505] 'process raft request' (duration: 124.76833ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:20:15.898084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.231019ms","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-11T08:20:15.898153Z","caller":"traceutil/trace.go:171","msg":"trace[1105828578] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4721; }","duration":"125.347092ms","start":"2026-08-11T08:20:15.772791Z","end":"2026-08-11T08:20:15.898138Z","steps":["trace[1105828578] 'agreement among raft nodes before linearized reading' (duration: 125.046866ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:20:16.076054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.022354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:6 size:60671"} {"level":"info","ts":"2026-08-11T08:20:16.076117Z","caller":"traceutil/trace.go:171","msg":"trace[1009565347] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:4723; }","duration":"109.106996ms","start":"2026-08-11T08:20:15.966995Z","end":"2026-08-11T08:20:16.076102Z","steps":["trace[1009565347] 'range keys from in-memory index tree' (duration: 108.85127ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:20:16.076145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.291348ms","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-11T08:20:16.076185Z","caller":"traceutil/trace.go:171","msg":"trace[1913481630] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4723; }","duration":"111.365169ms","start":"2026-08-11T08:20:15.964808Z","end":"2026-08-11T08:20:16.076173Z","steps":["trace[1913481630] 'range keys from in-memory index tree' (duration: 111.126805ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:20:16.076043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.478353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"warn","ts":"2026-08-11T08:20:16.076363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.462763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config\" ","response":"range_response_count:1 size:696"} {"level":"info","ts":"2026-08-11T08:20:16.076449Z","caller":"traceutil/trace.go:171","msg":"trace[1269596327] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config; range_end:; response_count:1; response_revision:4723; }","duration":"109.560374ms","start":"2026-08-11T08:20:15.966867Z","end":"2026-08-11T08:20:16.076428Z","steps":["trace[1269596327] 'range keys from in-memory index tree' (duration: 109.322589ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:20:16.076423Z","caller":"traceutil/trace.go:171","msg":"trace[1349984070] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4723; }","duration":"109.814009ms","start":"2026-08-11T08:20:15.966513Z","end":"2026-08-11T08:20:16.076327Z","steps":["trace[1349984070] 'range keys from in-memory index tree' (duration: 109.359571ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:20:16.272412Z","caller":"traceutil/trace.go:171","msg":"trace[311900300] transaction","detail":"{read_only:false; response_revision:4727; number_of_response:1; }","duration":"105.343292ms","start":"2026-08-11T08:20:16.167043Z","end":"2026-08-11T08:20:16.272386Z","steps":["trace[311900300] 'process raft request' (duration: 20.268541ms)","trace[311900300] 'compare' (duration: 84.948029ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:20:16.272831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.415563ms","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-11T08:20:16.273461Z","caller":"traceutil/trace.go:171","msg":"trace[813669863] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4727; }","duration":"107.146726ms","start":"2026-08-11T08:20:16.166293Z","end":"2026-08-11T08:20:16.27344Z","steps":["trace[813669863] 'agreement among raft nodes before linearized reading' (duration: 106.090366ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:20:28.800194Z","caller":"traceutil/trace.go:171","msg":"trace[395623474] transaction","detail":"{read_only:false; response_revision:4899; number_of_response:1; }","duration":"135.213ms","start":"2026-08-11T08:20:28.664962Z","end":"2026-08-11T08:20:28.800175Z","steps":["trace[395623474] 'process raft request' (duration: 135.060157ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:20:29.756901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.315003ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T08:20:29.75727Z","caller":"traceutil/trace.go:171","msg":"trace[217136744] transaction","detail":"{read_only:false; response_revision:4904; number_of_response:1; }","duration":"302.3196ms","start":"2026-08-11T08:20:29.454921Z","end":"2026-08-11T08:20:29.757241Z","steps":["trace[217136744] 'process raft request' (duration: 111.610449ms)","trace[217136744] 'compare' (duration: 190.13945ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:20:29.757414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:20:29.454898Z","time spent":"302.427812ms","remote":"127.0.0.1:40962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":905,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T08:20:29.757551Z","caller":"traceutil/trace.go:171","msg":"trace[65780383] transaction","detail":"{read_only:false; response_revision:4908; number_of_response:1; }","duration":"107.810777ms","start":"2026-08-11T08:20:29.64973Z","end":"2026-08-11T08:20:29.757541Z","steps":["trace[65780383] 'process raft request' (duration: 107.736016ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:20:29.757246Z","caller":"traceutil/trace.go:171","msg":"trace[170926017] transaction","detail":"{read_only:false; response_revision:4905; number_of_response:1; }","duration":"298.540108ms","start":"2026-08-11T08:20:29.458655Z","end":"2026-08-11T08:20:29.757195Z","steps":["trace[170926017] 'process raft request' (duration: 298.336574ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:20:29.75807Z","caller":"traceutil/trace.go:171","msg":"trace[1490197181] transaction","detail":"{read_only:false; response_revision:4906; number_of_response:1; }","duration":"299.383704ms","start":"2026-08-11T08:20:29.458672Z","end":"2026-08-11T08:20:29.758056Z","steps":["trace[1490197181] 'process raft request' (duration: 298.367065ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:20:29.758186Z","caller":"traceutil/trace.go:171","msg":"trace[1526763864] linearizableReadLoop","detail":"{readStateIndex:5089; appliedIndex:5088; }","duration":"299.73419ms","start":"2026-08-11T08:20:29.458443Z","end":"2026-08-11T08:20:29.758178Z","steps":["trace[1526763864] 'read index received' (duration: 59.490459ms)","trace[1526763864] 'applied index is now lower than readState.Index' (duration: 240.241971ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:20:29.75857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.369205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"info","ts":"2026-08-11T08:20:29.758623Z","caller":"traceutil/trace.go:171","msg":"trace[1680478814] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4908; }","duration":"141.453816ms","start":"2026-08-11T08:20:29.617155Z","end":"2026-08-11T08:20:29.758609Z","steps":["trace[1680478814] 'agreement among raft nodes before linearized reading' (duration: 141.313433ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:20:29.758768Z","caller":"traceutil/trace.go:171","msg":"trace[508127468] transaction","detail":"{read_only:false; response_revision:4907; number_of_response:1; }","duration":"292.159097ms","start":"2026-08-11T08:20:29.466585Z","end":"2026-08-11T08:20:29.758744Z","steps":["trace[508127468] 'process raft request' (duration: 290.483245ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:20:29.759151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.680938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-5b6bd877-08e3-40cd-847c-7367e66b0099\" ","response":"range_response_count:1 size:1322"} {"level":"info","ts":"2026-08-11T08:20:29.759249Z","caller":"traceutil/trace.go:171","msg":"trace[1598001434] range","detail":"{range_begin:/registry/persistentvolumes/pvc-5b6bd877-08e3-40cd-847c-7367e66b0099; range_end:; response_count:1; response_revision:4908; }","duration":"300.805601ms","start":"2026-08-11T08:20:29.458423Z","end":"2026-08-11T08:20:29.759229Z","steps":["trace[1598001434] 'agreement among raft nodes before linearized reading' (duration: 300.528056ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:20:29.759299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T08:20:29.458413Z","time spent":"300.874292ms","remote":"127.0.0.1:40944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1346,"request content":"key:\"/registry/persistentvolumes/pvc-5b6bd877-08e3-40cd-847c-7367e66b0099\" "} {"level":"info","ts":"2026-08-11T08:21:43.314254Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2852} {"level":"info","ts":"2026-08-11T08:21:43.404605Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2852,"took":"89.345384ms","hash":671578421,"current-db-size-bytes":54079488,"current-db-size":"54 MB","current-db-size-in-use-bytes":29130752,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-08-11T08:21:43.404677Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":671578421,"revision":2852,"compact-revision":-1} {"level":"info","ts":"2026-08-11T08:24:01.012697Z","caller":"traceutil/trace.go:171","msg":"trace[580071639] transaction","detail":"{read_only:false; response_revision:6469; number_of_response:1; }","duration":"169.863423ms","start":"2026-08-11T08:24:00.842802Z","end":"2026-08-11T08:24:01.012665Z","steps":["trace[580071639] 'process raft request' (duration: 88.786407ms)","trace[580071639] 'compare' (duration: 80.94932ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:24:01.050975Z","caller":"traceutil/trace.go:171","msg":"trace[110170859] transaction","detail":"{read_only:false; response_revision:6470; number_of_response:1; }","duration":"189.799017ms","start":"2026-08-11T08:24:00.861152Z","end":"2026-08-11T08:24:01.050951Z","steps":["trace[110170859] 'process raft request' (duration: 189.636231ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:24:01.051183Z","caller":"traceutil/trace.go:171","msg":"trace[1838104622] transaction","detail":"{read_only:false; response_revision:6471; number_of_response:1; }","duration":"189.938953ms","start":"2026-08-11T08:24:00.86123Z","end":"2026-08-11T08:24:01.051169Z","steps":["trace[1838104622] 'process raft request' (duration: 189.678833ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:24:01.051405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.58332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:1 size:4784"} {"level":"info","ts":"2026-08-11T08:24:01.051475Z","caller":"traceutil/trace.go:171","msg":"trace[1131119914] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:1; response_revision:6471; }","duration":"183.698195ms","start":"2026-08-11T08:24:00.867765Z","end":"2026-08-11T08:24:01.051463Z","steps":["trace[1131119914] 'agreement among raft nodes before linearized reading' (duration: 183.476255ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:24:01.051203Z","caller":"traceutil/trace.go:171","msg":"trace[80874238] linearizableReadLoop","detail":"{readStateIndex:6707; appliedIndex:6704; }","duration":"183.356361ms","start":"2026-08-11T08:24:00.867794Z","end":"2026-08-11T08:24:01.05115Z","steps":["trace[80874238] 'read index received' (duration: 63.80238ms)","trace[80874238] 'applied index is now lower than readState.Index' (duration: 119.552061ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T08:24:01.052023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.660241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-11T08:24:01.052343Z","caller":"traceutil/trace.go:171","msg":"trace[1029788701] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:6471; }","duration":"183.018786ms","start":"2026-08-11T08:24:00.869314Z","end":"2026-08-11T08:24:01.052332Z","steps":["trace[1029788701] 'agreement among raft nodes before linearized reading' (duration: 182.651721ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:24:11.575699Z","caller":"traceutil/trace.go:171","msg":"trace[541561451] transaction","detail":"{read_only:false; response_revision:6527; number_of_response:1; }","duration":"176.206351ms","start":"2026-08-11T08:24:11.399463Z","end":"2026-08-11T08:24:11.575669Z","steps":["trace[541561451] 'process raft request' (duration: 176.033664ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:24:27.151095Z","caller":"traceutil/trace.go:171","msg":"trace[1008802003] transaction","detail":"{read_only:false; response_revision:6660; number_of_response:1; }","duration":"133.264954ms","start":"2026-08-11T08:24:27.01781Z","end":"2026-08-11T08:24:27.151075Z","steps":["trace[1008802003] 'process raft request' (duration: 133.145959ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:24:27.352767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.217794ms","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-11T08:24:27.352889Z","caller":"traceutil/trace.go:171","msg":"trace[604842631] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6660; }","duration":"159.345759ms","start":"2026-08-11T08:24:27.193505Z","end":"2026-08-11T08:24:27.352851Z","steps":["trace[604842631] 'range keys from in-memory index tree' (duration: 159.052787ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:24:27.353668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.183621ms","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-11T08:24:27.35388Z","caller":"traceutil/trace.go:171","msg":"trace[1168441742] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6660; }","duration":"160.412981ms","start":"2026-08-11T08:24:27.193451Z","end":"2026-08-11T08:24:27.353864Z","steps":["trace[1168441742] 'range keys from in-memory index tree' (duration: 160.067758ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:24:27.353695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.249424ms","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-11T08:24:27.354036Z","caller":"traceutil/trace.go:171","msg":"trace[1019001995] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6660; }","duration":"160.64065ms","start":"2026-08-11T08:24:27.193377Z","end":"2026-08-11T08:24:27.354018Z","steps":["trace[1019001995] 'range keys from in-memory index tree' (duration: 160.043586ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T08:24:27.352791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.098654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-11T08:24:27.35411Z","caller":"traceutil/trace.go:171","msg":"trace[2027878214] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:6660; }","duration":"125.479008ms","start":"2026-08-11T08:24:27.228624Z","end":"2026-08-11T08:24:27.354103Z","steps":["trace[2027878214] 'count revisions from in-memory index tree' (duration: 124.026211ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:24:27.559747Z","caller":"traceutil/trace.go:171","msg":"trace[429233520] transaction","detail":"{read_only:false; response_revision:6662; number_of_response:1; }","duration":"200.579518ms","start":"2026-08-11T08:24:27.359141Z","end":"2026-08-11T08:24:27.559721Z","steps":["trace[429233520] 'process raft request' (duration: 173.349098ms)","trace[429233520] 'compare' (duration: 26.22047ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T08:24:27.55999Z","caller":"traceutil/trace.go:171","msg":"trace[773608814] transaction","detail":"{read_only:false; response_revision:6663; number_of_response:1; }","duration":"199.690113ms","start":"2026-08-11T08:24:27.360284Z","end":"2026-08-11T08:24:27.559974Z","steps":["trace[773608814] 'process raft request' (duration: 199.317108ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T08:26:43.324016Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5521} {"level":"info","ts":"2026-08-11T08:26:43.545782Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5521,"took":"220.051007ms","hash":3983655156,"current-db-size-bytes":54079488,"current-db-size":"54 MB","current-db-size-in-use-bytes":18329600,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-08-11T08:26:43.545918Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3983655156,"revision":5521,"compact-revision":2852}