{"level":"warn","ts":"2026-09-17T16:31:54.607738Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-17T16:31:54.607866Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.112:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.112:2380","--initial-cluster=instance=https://162.253.55.112:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.112:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.112:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-09-17T16:31:54.607945Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-17T16:31:54.607953Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.112:2380"]} {"level":"info","ts":"2026-09-17T16:31:54.60797Z","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-09-17T16:31:54.608678Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.112:2379"]} {"level":"info","ts":"2026-09-17T16:31:54.60875Z","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://162.253.55.112:2380"],"listen-peer-urls":["https://162.253.55.112:2380"],"advertise-client-urls":["https://162.253.55.112:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.112:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.112:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-09-17T16:31:54.623014Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"14.035546ms"} {"level":"info","ts":"2026-09-17T16:31:54.646831Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1b80133015df7bbe","cluster-id":"96c35284d1622e20"} {"level":"info","ts":"2026-09-17T16:31:54.647044Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1b80133015df7bbe switched to configuration voters=()"} {"level":"info","ts":"2026-09-17T16:31:54.647073Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1b80133015df7bbe became follower at term 0"} {"level":"info","ts":"2026-09-17T16:31:54.647084Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1b80133015df7bbe [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-17T16:31:54.647107Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1b80133015df7bbe became follower at term 1"} {"level":"info","ts":"2026-09-17T16:31:54.647174Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1b80133015df7bbe switched to configuration voters=(1981604933289343934)"} {"level":"warn","ts":"2026-09-17T16:31:54.67114Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-17T16:31:54.674735Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-17T16:31:54.677729Z","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-09-17T16:31:54.683697Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1b80133015df7bbe","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-17T16:31:54.684384Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1b80133015df7bbe","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-17T16:31:54.685245Z","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-09-17T16:31:54.685817Z","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-09-17T16:31:54.685834Z","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-09-17T16:31:54.68698Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1b80133015df7bbe switched to configuration voters=(1981604933289343934)"} {"level":"info","ts":"2026-09-17T16:31:54.687135Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"96c35284d1622e20","local-member-id":"1b80133015df7bbe","added-peer-id":"1b80133015df7bbe","added-peer-peer-urls":["https://162.253.55.112:2380"]} {"level":"info","ts":"2026-09-17T16:31:54.688474Z","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-09-17T16:31:54.688617Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.112:2380"} {"level":"info","ts":"2026-09-17T16:31:54.688651Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.112:2380"} {"level":"info","ts":"2026-09-17T16:31:54.689644Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1b80133015df7bbe","initial-advertise-peer-urls":["https://162.253.55.112:2380"],"listen-peer-urls":["https://162.253.55.112:2380"],"advertise-client-urls":["https://162.253.55.112:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.112:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-17T16:31:54.68969Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-17T16:31:55.347836Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1b80133015df7bbe is starting a new election at term 1"} {"level":"info","ts":"2026-09-17T16:31:55.347928Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1b80133015df7bbe became pre-candidate at term 1"} {"level":"info","ts":"2026-09-17T16:31:55.347974Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1b80133015df7bbe received MsgPreVoteResp from 1b80133015df7bbe at term 1"} {"level":"info","ts":"2026-09-17T16:31:55.348007Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1b80133015df7bbe became candidate at term 2"} {"level":"info","ts":"2026-09-17T16:31:55.348034Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1b80133015df7bbe received MsgVoteResp from 1b80133015df7bbe at term 2"} {"level":"info","ts":"2026-09-17T16:31:55.348139Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1b80133015df7bbe became leader at term 2"} {"level":"info","ts":"2026-09-17T16:31:55.348207Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1b80133015df7bbe elected leader 1b80133015df7bbe at term 2"} {"level":"info","ts":"2026-09-17T16:31:55.349467Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-17T16:31:55.350231Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1b80133015df7bbe","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.112:2379]}","request-path":"/0/members/1b80133015df7bbe/attributes","cluster-id":"96c35284d1622e20","publish-timeout":"7s"} {"level":"info","ts":"2026-09-17T16:31:55.35029Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-17T16:31:55.350279Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-17T16:31:55.350473Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-17T16:31:55.350498Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-17T16:31:55.351208Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"96c35284d1622e20","local-member-id":"1b80133015df7bbe","cluster-version":"3.5"} {"level":"info","ts":"2026-09-17T16:31:55.351389Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-17T16:31:55.35143Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-17T16:31:55.354349Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.112:2379"} {"level":"info","ts":"2026-09-17T16:31:55.354632Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-17T16:31:57.850374Z","caller":"traceutil/trace.go:171","msg":"trace[2057159348] transaction","detail":"{read_only:false; response_revision:81; number_of_response:1; }","duration":"122.898009ms","start":"2026-09-17T16:31:57.72743Z","end":"2026-09-17T16:31:57.850328Z","steps":["trace[2057159348] 'process raft request' (duration: 117.849693ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:32:02.635652Z","caller":"traceutil/trace.go:171","msg":"trace[1175846683] transaction","detail":"{read_only:false; response_revision:322; number_of_response:1; }","duration":"256.491241ms","start":"2026-09-17T16:32:02.379121Z","end":"2026-09-17T16:32:02.635612Z","steps":["trace[1175846683] 'process raft request' (duration: 256.355576ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:32:03.225248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.84989ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-17T16:32:03.22533Z","caller":"traceutil/trace.go:171","msg":"trace[1352259034] linearizableReadLoop","detail":"{readStateIndex:335; appliedIndex:334; }","duration":"740.566991ms","start":"2026-09-17T16:32:02.484751Z","end":"2026-09-17T16:32:03.225318Z","steps":["trace[1352259034] 'read index received' (duration: 150.873927ms)","trace[1352259034] 'applied index is now lower than readState.Index' (duration: 589.691754ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T16:32:03.225791Z","caller":"traceutil/trace.go:171","msg":"trace[788093050] transaction","detail":"{read_only:false; response_revision:323; number_of_response:1; }","duration":"805.352941ms","start":"2026-09-17T16:32:02.420427Z","end":"2026-09-17T16:32:03.22578Z","steps":["trace[788093050] 'process raft request' (duration: 433.63183ms)","trace[788093050] 'compare' (duration: 370.642512ms)"],"step_count":2} {"level":"warn","ts":"2026-09-17T16:32:03.225891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T16:32:02.420375Z","time spent":"805.439645ms","remote":"127.0.0.1:51334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":194,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-17T16:32:03.226168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"741.409802ms","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-09-17T16:32:03.226192Z","caller":"traceutil/trace.go:171","msg":"trace[411374391] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:323; }","duration":"741.473384ms","start":"2026-09-17T16:32:02.484712Z","end":"2026-09-17T16:32:03.226185Z","steps":["trace[411374391] 'agreement among raft nodes before linearized reading' (duration: 741.390701ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:32:03.226303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T16:32:02.484692Z","time spent":"741.588308ms","remote":"127.0.0.1:51404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-17T16:32:03.226553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.801873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-09-17T16:32:03.226576Z","caller":"traceutil/trace.go:171","msg":"trace[1068566013] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:323; }","duration":"301.852355ms","start":"2026-09-17T16:32:02.924718Z","end":"2026-09-17T16:32:03.22657Z","steps":["trace[1068566013] 'agreement among raft nodes before linearized reading' (duration: 301.799573ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:32:03.226592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T16:32:02.924696Z","time spent":"301.892206ms","remote":"127.0.0.1:51404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-09-17T16:32:14.903897Z","caller":"traceutil/trace.go:171","msg":"trace[365680772] transaction","detail":"{read_only:false; response_revision:419; number_of_response:1; }","duration":"193.968753ms","start":"2026-09-17T16:32:14.709892Z","end":"2026-09-17T16:32:14.90386Z","steps":["trace[365680772] 'process raft request' (duration: 193.760096ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:32:38.487157Z","caller":"traceutil/trace.go:171","msg":"trace[431193980] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"107.685007ms","start":"2026-09-17T16:32:38.379434Z","end":"2026-09-17T16:32:38.487119Z","steps":["trace[431193980] 'process raft request' (duration: 107.322653ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:32:38.493128Z","caller":"traceutil/trace.go:171","msg":"trace[149782288] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"105.702016ms","start":"2026-09-17T16:32:38.387403Z","end":"2026-09-17T16:32:38.493105Z","steps":["trace[149782288] 'process raft request' (duration: 105.553101ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:32:38.837371Z","caller":"traceutil/trace.go:171","msg":"trace[467650040] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"124.836201ms","start":"2026-09-17T16:32:38.712512Z","end":"2026-09-17T16:32:38.837348Z","steps":["trace[467650040] 'process raft request' (duration: 124.358473ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:32:38.8374Z","caller":"traceutil/trace.go:171","msg":"trace[2097983915] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"128.71799ms","start":"2026-09-17T16:32:38.708627Z","end":"2026-09-17T16:32:38.837345Z","steps":["trace[2097983915] 'process raft request' (duration: 97.070366ms)","trace[2097983915] 'compare' (duration: 30.940428ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T16:32:39.472929Z","caller":"traceutil/trace.go:171","msg":"trace[1682730192] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"570.886956ms","start":"2026-09-17T16:32:38.902018Z","end":"2026-09-17T16:32:39.472905Z","steps":["trace[1682730192] 'process raft request' (duration: 497.033002ms)","trace[1682730192] 'compare' (duration: 73.724169ms)"],"step_count":2} {"level":"warn","ts":"2026-09-17T16:32:39.473417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T16:32:38.902002Z","time spent":"570.99191ms","remote":"127.0.0.1:51188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":80679,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-17T16:32:39.482517Z","caller":"traceutil/trace.go:171","msg":"trace[1403534064] linearizableReadLoop","detail":"{readStateIndex:610; appliedIndex:607; }","duration":"457.61653ms","start":"2026-09-17T16:32:39.024877Z","end":"2026-09-17T16:32:39.482493Z","steps":["trace[1403534064] 'read index received' (duration: 374.031508ms)","trace[1403534064] 'applied index is now lower than readState.Index' (duration: 83.583932ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T16:32:39.482587Z","caller":"traceutil/trace.go:171","msg":"trace[747725057] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"542.713127ms","start":"2026-09-17T16:32:38.939835Z","end":"2026-09-17T16:32:39.482548Z","steps":["trace[747725057] 'process raft request' (duration: 542.495358ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:32:39.482576Z","caller":"traceutil/trace.go:171","msg":"trace[688150301] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"556.434409ms","start":"2026-09-17T16:32:38.926094Z","end":"2026-09-17T16:32:39.482529Z","steps":["trace[688150301] 'process raft request' (duration: 556.079606ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:32:39.482744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T16:32:38.939798Z","time spent":"542.865822ms","remote":"127.0.0.1:51188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65199,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-17T16:32:39.482768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T16:32:38.926076Z","time spent":"556.606805ms","remote":"127.0.0.1:51188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97665,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-17T16:32:39.482953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.043175ms","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-09-17T16:32:39.482999Z","caller":"traceutil/trace.go:171","msg":"trace[1552986521] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:584; }","duration":"458.122247ms","start":"2026-09-17T16:32:39.024863Z","end":"2026-09-17T16:32:39.482985Z","steps":["trace[1552986521] 'agreement among raft nodes before linearized reading' (duration: 457.945761ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:32:39.483034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T16:32:39.024807Z","time spent":"458.217931ms","remote":"127.0.0.1:51404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-09-17T16:32:45.275689Z","caller":"traceutil/trace.go:171","msg":"trace[2126738263] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"121.545246ms","start":"2026-09-17T16:32:45.154078Z","end":"2026-09-17T16:32:45.275623Z","steps":["trace[2126738263] 'process raft request' (duration: 120.817931ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:32:46.128825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.972343ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-17T16:32:46.128999Z","caller":"traceutil/trace.go:171","msg":"trace[1668481889] linearizableReadLoop","detail":"{readStateIndex:673; appliedIndex:672; }","duration":"609.23762ms","start":"2026-09-17T16:32:45.519736Z","end":"2026-09-17T16:32:46.128974Z","steps":["trace[1668481889] 'read index received' (duration: 405.035148ms)","trace[1668481889] 'applied index is now lower than readState.Index' (duration: 204.201112ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T16:32:46.129042Z","caller":"traceutil/trace.go:171","msg":"trace[1692526467] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"787.949335ms","start":"2026-09-17T16:32:45.341053Z","end":"2026-09-17T16:32:46.129002Z","steps":["trace[1692526467] 'process raft request' (duration: 583.688971ms)","trace[1692526467] 'compare' (duration: 203.663662ms)"],"step_count":2} {"level":"warn","ts":"2026-09-17T16:32:46.129211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.661924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-17T16:32:46.129235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T16:32:45.341019Z","time spent":"788.123171ms","remote":"127.0.0.1:51638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-17T16:32:46.12928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.368437ms","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-09-17T16:32:46.129246Z","caller":"traceutil/trace.go:171","msg":"trace[1846938768] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:646; }","duration":"332.758908ms","start":"2026-09-17T16:32:45.796474Z","end":"2026-09-17T16:32:46.129233Z","steps":["trace[1846938768] 'agreement among raft nodes before linearized reading' (duration: 332.649794ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:32:46.129371Z","caller":"traceutil/trace.go:171","msg":"trace[416572287] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:646; }","duration":"389.539972ms","start":"2026-09-17T16:32:45.739807Z","end":"2026-09-17T16:32:46.129347Z","steps":["trace[416572287] 'agreement among raft nodes before linearized reading' (duration: 389.306714ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:32:46.12939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T16:32:45.796457Z","time spent":"332.922553ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-17T16:32:46.129397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.660086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-09-17T16:32:46.129412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T16:32:45.739778Z","time spent":"389.624525ms","remote":"127.0.0.1:51404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-17T16:32:46.129415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.030252ms","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-09-17T16:32:46.129441Z","caller":"traceutil/trace.go:171","msg":"trace[1998594266] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:646; }","duration":"609.746658ms","start":"2026-09-17T16:32:45.519684Z","end":"2026-09-17T16:32:46.129431Z","steps":["trace[1998594266] 'agreement among raft nodes before linearized reading' (duration: 609.581282ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:32:46.129463Z","caller":"traceutil/trace.go:171","msg":"trace[20431180] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:646; }","duration":"609.070194ms","start":"2026-09-17T16:32:45.520377Z","end":"2026-09-17T16:32:46.129447Z","steps":["trace[20431180] 'agreement among raft nodes before linearized reading' (duration: 608.96676ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:32:46.129484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T16:32:45.519659Z","time spent":"609.816261ms","remote":"127.0.0.1:51404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-09-17T16:32:46.129491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T16:32:45.520338Z","time spent":"609.147476ms","remote":"127.0.0.1:51404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-17T16:32:46.129303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.379035ms","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-09-17T16:32:46.129576Z","caller":"traceutil/trace.go:171","msg":"trace[1768397545] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:646; }","duration":"609.686656ms","start":"2026-09-17T16:32:45.519878Z","end":"2026-09-17T16:32:46.129565Z","steps":["trace[1768397545] 'agreement among raft nodes before linearized reading' (duration: 609.2276ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:32:46.129612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T16:32:45.519828Z","time spent":"609.772079ms","remote":"127.0.0.1:51404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-09-17T16:33:02.919077Z","caller":"traceutil/trace.go:171","msg":"trace[137626892] linearizableReadLoop","detail":"{readStateIndex:849; appliedIndex:848; }","duration":"119.283984ms","start":"2026-09-17T16:33:02.799763Z","end":"2026-09-17T16:33:02.919047Z","steps":["trace[137626892] 'read index received' (duration: 119.034946ms)","trace[137626892] 'applied index is now lower than readState.Index' (duration: 244.838µs)"],"step_count":2} {"level":"warn","ts":"2026-09-17T16:33:02.91927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.453921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-17T16:33:02.919337Z","caller":"traceutil/trace.go:171","msg":"trace[776437958] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:817; }","duration":"119.616446ms","start":"2026-09-17T16:33:02.799682Z","end":"2026-09-17T16:33:02.919299Z","steps":["trace[776437958] 'agreement among raft nodes before linearized reading' (duration: 119.495342ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:33:02.919667Z","caller":"traceutil/trace.go:171","msg":"trace[1154055270] transaction","detail":"{read_only:false; response_revision:817; number_of_response:1; }","duration":"125.161482ms","start":"2026-09-17T16:33:02.79445Z","end":"2026-09-17T16:33:02.919612Z","steps":["trace[1154055270] 'process raft request' (duration: 124.369024ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:33:03.292514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.441002ms","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-09-17T16:33:03.29273Z","caller":"traceutil/trace.go:171","msg":"trace[2104852220] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:817; }","duration":"165.699181ms","start":"2026-09-17T16:33:03.126983Z","end":"2026-09-17T16:33:03.292682Z","steps":["trace[2104852220] 'count revisions from in-memory index tree' (duration: 165.342169ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:33:03.29307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.062414ms","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-09-17T16:33:03.293204Z","caller":"traceutil/trace.go:171","msg":"trace[380625804] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:817; }","duration":"262.310393ms","start":"2026-09-17T16:33:03.030865Z","end":"2026-09-17T16:33:03.293175Z","steps":["trace[380625804] 'range keys from in-memory index tree' (duration: 261.620359ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:33:35.590052Z","caller":"traceutil/trace.go:171","msg":"trace[544199420] transaction","detail":"{read_only:false; response_revision:1228; number_of_response:1; }","duration":"105.024085ms","start":"2026-09-17T16:33:35.485001Z","end":"2026-09-17T16:33:35.590025Z","steps":["trace[544199420] 'process raft request' (duration: 104.87671ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:33:45.840924Z","caller":"traceutil/trace.go:171","msg":"trace[471326332] transaction","detail":"{read_only:false; response_revision:1314; number_of_response:1; }","duration":"193.917836ms","start":"2026-09-17T16:33:45.646956Z","end":"2026-09-17T16:33:45.840873Z","steps":["trace[471326332] 'process raft request' (duration: 193.712639ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:33:46.671982Z","caller":"traceutil/trace.go:171","msg":"trace[362779109] transaction","detail":"{read_only:false; response_revision:1319; number_of_response:1; }","duration":"126.872709ms","start":"2026-09-17T16:33:46.545088Z","end":"2026-09-17T16:33:46.671961Z","steps":["trace[362779109] 'process raft request' (duration: 126.744085ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:33:46.671974Z","caller":"traceutil/trace.go:171","msg":"trace[697172317] linearizableReadLoop","detail":"{readStateIndex:1367; appliedIndex:1366; }","duration":"103.875156ms","start":"2026-09-17T16:33:46.568077Z","end":"2026-09-17T16:33:46.671953Z","steps":["trace[697172317] 'read index received' (duration: 103.850845ms)","trace[697172317] 'applied index is now lower than readState.Index' (duration: 22.551µs)"],"step_count":2} {"level":"warn","ts":"2026-09-17T16:33:46.67225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.158685ms","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-09-17T16:33:46.67231Z","caller":"traceutil/trace.go:171","msg":"trace[801467275] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1319; }","duration":"104.282109ms","start":"2026-09-17T16:33:46.568012Z","end":"2026-09-17T16:33:46.672294Z","steps":["trace[801467275] 'agreement among raft nodes before linearized reading' (duration: 104.094283ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:34:24.924412Z","caller":"traceutil/trace.go:171","msg":"trace[849872453] transaction","detail":"{read_only:false; response_revision:1846; number_of_response:1; }","duration":"101.301231ms","start":"2026-09-17T16:34:24.823088Z","end":"2026-09-17T16:34:24.924389Z","steps":["trace[849872453] 'process raft request' (duration: 101.070963ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:34:25.893177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.585065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-17T16:34:25.893295Z","caller":"traceutil/trace.go:171","msg":"trace[1615620251] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1897; }","duration":"126.784921ms","start":"2026-09-17T16:34:25.766481Z","end":"2026-09-17T16:34:25.893266Z","steps":["trace[1615620251] 'range keys from in-memory index tree' (duration: 126.261604ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:34:28.626676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.425357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-21ea3f58-73d4-4639-8735-74b11af1e0ea\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-09-17T16:34:28.626757Z","caller":"traceutil/trace.go:171","msg":"trace[151122428] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-21ea3f58-73d4-4639-8735-74b11af1e0ea; range_end:; response_count:1; response_revision:1922; }","duration":"407.51912ms","start":"2026-09-17T16:34:28.219219Z","end":"2026-09-17T16:34:28.626738Z","steps":["trace[151122428] 'range keys from in-memory index tree' (duration: 407.255452ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:34:28.626751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"552.845401ms","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":"warn","ts":"2026-09-17T16:34:28.626797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T16:34:28.219162Z","time spent":"407.625154ms","remote":"127.0.0.1:51318","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-21ea3f58-73d4-4639-8735-74b11af1e0ea\" "} {"level":"info","ts":"2026-09-17T16:34:28.626823Z","caller":"traceutil/trace.go:171","msg":"trace[127157417] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1922; }","duration":"552.953815ms","start":"2026-09-17T16:34:28.073851Z","end":"2026-09-17T16:34:28.626805Z","steps":["trace[127157417] 'range keys from in-memory index tree' (duration: 552.646425ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:34:28.626863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T16:34:28.073831Z","time spent":"553.022127ms","remote":"127.0.0.1:51404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-09-17T16:34:28.776422Z","caller":"traceutil/trace.go:171","msg":"trace[1408774818] transaction","detail":"{read_only:false; response_revision:1923; number_of_response:1; }","duration":"506.891649ms","start":"2026-09-17T16:34:28.269482Z","end":"2026-09-17T16:34:28.776374Z","steps":["trace[1408774818] 'process raft request' (duration: 506.678472ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:34:28.776869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T16:34:28.269453Z","time spent":"507.067135ms","remote":"127.0.0.1:51404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-17T16:34:29.004064Z","caller":"traceutil/trace.go:171","msg":"trace[1973731682] transaction","detail":"{read_only:false; response_revision:1924; number_of_response:1; }","duration":"672.450714ms","start":"2026-09-17T16:34:28.331535Z","end":"2026-09-17T16:34:29.003986Z","steps":["trace[1973731682] 'process raft request' (duration: 672.115102ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:34:29.00456Z","caller":"traceutil/trace.go:171","msg":"trace[348353151] transaction","detail":"{read_only:false; response_revision:1925; number_of_response:1; }","duration":"655.266113ms","start":"2026-09-17T16:34:28.349258Z","end":"2026-09-17T16:34:29.004524Z","steps":["trace[348353151] 'process raft request' (duration: 654.656191ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:34:29.004812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T16:34:28.349229Z","time spent":"655.464659ms","remote":"127.0.0.1:51404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-17T16:34:29.005189Z","caller":"traceutil/trace.go:171","msg":"trace[1534954823] transaction","detail":"{read_only:false; response_revision:1926; number_of_response:1; }","duration":"443.690813ms","start":"2026-09-17T16:34:28.561479Z","end":"2026-09-17T16:34:29.00517Z","steps":["trace[1534954823] 'process raft request' (duration: 442.835915ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:34:29.005236Z","caller":"traceutil/trace.go:171","msg":"trace[2081790574] linearizableReadLoop","detail":"{readStateIndex:2004; appliedIndex:2002; }","duration":"669.642167ms","start":"2026-09-17T16:34:28.335573Z","end":"2026-09-17T16:34:29.005216Z","steps":["trace[2081790574] 'read index received' (duration: 440.580078ms)","trace[2081790574] 'applied index is now lower than readState.Index' (duration: 229.060719ms)"],"step_count":2} {"level":"warn","ts":"2026-09-17T16:34:29.005303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T16:34:28.56146Z","time spent":"443.792797ms","remote":"127.0.0.1:51404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-17T16:34:29.005371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"669.793713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-21ea3f58-73d4-4639-8735-74b11af1e0ea\" ","response":"range_response_count:1 size:3744"} {"level":"info","ts":"2026-09-17T16:34:29.005418Z","caller":"traceutil/trace.go:171","msg":"trace[2039072122] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-21ea3f58-73d4-4639-8735-74b11af1e0ea; range_end:; response_count:1; response_revision:1928; }","duration":"669.884267ms","start":"2026-09-17T16:34:28.335518Z","end":"2026-09-17T16:34:29.005402Z","steps":["trace[2039072122] 'agreement among raft nodes before linearized reading' (duration: 669.780042ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:34:29.005481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T16:34:28.335496Z","time spent":"669.951309ms","remote":"127.0.0.1:51318","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3767,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-21ea3f58-73d4-4639-8735-74b11af1e0ea\" "} {"level":"info","ts":"2026-09-17T16:34:29.005935Z","caller":"traceutil/trace.go:171","msg":"trace[1284948489] transaction","detail":"{read_only:false; response_revision:1928; number_of_response:1; }","duration":"369.959162ms","start":"2026-09-17T16:34:28.635957Z","end":"2026-09-17T16:34:29.005916Z","steps":["trace[1284948489] 'process raft request' (duration: 369.191745ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:34:29.006059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T16:34:28.635926Z","time spent":"370.057225ms","remote":"127.0.0.1:51318","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3729,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-17T16:34:29.006622Z","caller":"traceutil/trace.go:171","msg":"trace[1180191266] transaction","detail":"{read_only:false; response_revision:1927; number_of_response:1; }","duration":"373.993938ms","start":"2026-09-17T16:34:28.632602Z","end":"2026-09-17T16:34:29.006596Z","steps":["trace[1180191266] 'process raft request' (duration: 372.458006ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:34:29.006758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T16:34:28.632578Z","time spent":"374.118992ms","remote":"127.0.0.1:51404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-17T16:34:29.004353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T16:34:28.331515Z","time spent":"672.679712ms","remote":"127.0.0.1:51404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-17T16:34:29.00789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.942574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.112\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-09-17T16:34:29.007992Z","caller":"traceutil/trace.go:171","msg":"trace[267048344] range","detail":"{range_begin:/registry/masterleases/162.253.55.112; range_end:; response_count:1; response_revision:1928; }","duration":"334.11334ms","start":"2026-09-17T16:34:28.673859Z","end":"2026-09-17T16:34:29.007973Z","steps":["trace[267048344] 'agreement among raft nodes before linearized reading' (duration: 333.848181ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:34:29.008069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T16:34:28.673836Z","time spent":"334.220193ms","remote":"127.0.0.1:51172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/162.253.55.112\" "} {"level":"warn","ts":"2026-09-17T16:34:29.009517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.766059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-17T16:34:29.009661Z","caller":"traceutil/trace.go:171","msg":"trace[1262757303] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:1928; }","duration":"109.893994ms","start":"2026-09-17T16:34:28.899683Z","end":"2026-09-17T16:34:29.009577Z","steps":["trace[1262757303] 'agreement among raft nodes before linearized reading' (duration: 109.755628ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:34:29.009669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.065678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-17T16:34:29.009732Z","caller":"traceutil/trace.go:171","msg":"trace[1295893860] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1928; }","duration":"210.168161ms","start":"2026-09-17T16:34:28.799548Z","end":"2026-09-17T16:34:29.009716Z","steps":["trace[1295893860] 'agreement among raft nodes before linearized reading' (duration: 210.075568ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:34:29.775087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"688.511484ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-17T16:34:29.775325Z","caller":"traceutil/trace.go:171","msg":"trace[1494005646] transaction","detail":"{read_only:false; response_revision:1933; number_of_response:1; }","duration":"733.70184ms","start":"2026-09-17T16:34:29.041606Z","end":"2026-09-17T16:34:29.775307Z","steps":["trace[1494005646] 'process raft request' (duration: 733.584286ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:34:29.775409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T16:34:29.041597Z","time spent":"733.769363ms","remote":"127.0.0.1:51404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-17T16:34:29.775607Z","caller":"traceutil/trace.go:171","msg":"trace[2094730367] transaction","detail":"{read_only:false; response_revision:1932; number_of_response:1; }","duration":"737.273022ms","start":"2026-09-17T16:34:29.038321Z","end":"2026-09-17T16:34:29.775594Z","steps":["trace[2094730367] 'process raft request' (duration: 48.120015ms)","trace[2094730367] 'compare' (duration: 688.07188ms)"],"step_count":2} {"level":"warn","ts":"2026-09-17T16:34:29.775655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T16:34:29.038305Z","time spent":"737.323514ms","remote":"127.0.0.1:51172","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-17T16:34:29.857432Z","caller":"traceutil/trace.go:171","msg":"trace[598705386] transaction","detail":"{read_only:false; response_revision:1934; number_of_response:1; }","duration":"694.713963ms","start":"2026-09-17T16:34:29.162688Z","end":"2026-09-17T16:34:29.857402Z","steps":["trace[598705386] 'process raft request' (duration: 694.029471ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:34:29.857742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T16:34:29.162655Z","time spent":"694.846608ms","remote":"127.0.0.1:51404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":542,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-17T16:34:41.446505Z","caller":"traceutil/trace.go:171","msg":"trace[1087431178] linearizableReadLoop","detail":"{readStateIndex:2113; appliedIndex:2112; }","duration":"285.059492ms","start":"2026-09-17T16:34:41.161398Z","end":"2026-09-17T16:34:41.446457Z","steps":["trace[1087431178] 'read index received' (duration: 267.165121ms)","trace[1087431178] 'applied index is now lower than readState.Index' (duration: 17.892441ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T16:34:41.446562Z","caller":"traceutil/trace.go:171","msg":"trace[1400832126] transaction","detail":"{read_only:false; response_revision:2029; number_of_response:1; }","duration":"292.238644ms","start":"2026-09-17T16:34:41.154252Z","end":"2026-09-17T16:34:41.44649Z","steps":["trace[1400832126] 'process raft request' (duration: 274.292131ms)","trace[1400832126] 'compare' (duration: 17.698364ms)"],"step_count":2} {"level":"warn","ts":"2026-09-17T16:34:41.44708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.308632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-17T16:34:41.447146Z","caller":"traceutil/trace.go:171","msg":"trace[858359366] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2029; }","duration":"285.754296ms","start":"2026-09-17T16:34:41.161364Z","end":"2026-09-17T16:34:41.447119Z","steps":["trace[858359366] 'agreement among raft nodes before linearized reading' (duration: 285.231849ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:34:41.470701Z","caller":"traceutil/trace.go:171","msg":"trace[89066794] transaction","detail":"{read_only:false; response_revision:2030; number_of_response:1; }","duration":"211.894165ms","start":"2026-09-17T16:34:41.258771Z","end":"2026-09-17T16:34:41.470665Z","steps":["trace[89066794] 'process raft request' (duration: 211.718909ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:34:41.47087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.447498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-cluster-operator-54f767cff8-tf27b\" ","response":"range_response_count:1 size:5855"} {"level":"warn","ts":"2026-09-17T16:34:41.470809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.909231ms","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-09-17T16:34:41.470961Z","caller":"traceutil/trace.go:171","msg":"trace[1376343118] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-cluster-operator-54f767cff8-tf27b; range_end:; response_count:1; response_revision:2030; }","duration":"149.557001ms","start":"2026-09-17T16:34:41.321355Z","end":"2026-09-17T16:34:41.470912Z","steps":["trace[1376343118] 'agreement among raft nodes before linearized reading' (duration: 149.279492ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:34:41.471017Z","caller":"traceutil/trace.go:171","msg":"trace[982460848] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2030; }","duration":"303.1458ms","start":"2026-09-17T16:34:41.167858Z","end":"2026-09-17T16:34:41.471004Z","steps":["trace[982460848] 'agreement among raft nodes before linearized reading' (duration: 302.762457ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:34:41.471169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T16:34:41.167847Z","time spent":"303.306975ms","remote":"127.0.0.1:51404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-09-17T16:34:41.471459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.257223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-09-17T16:34:41.471525Z","caller":"traceutil/trace.go:171","msg":"trace[715939216] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2030; }","duration":"300.331526ms","start":"2026-09-17T16:34:41.171178Z","end":"2026-09-17T16:34:41.471509Z","steps":["trace[715939216] 'agreement among raft nodes before linearized reading' (duration: 299.699134ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:34:41.471575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T16:34:41.171134Z","time spent":"300.425688ms","remote":"127.0.0.1:51404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-17T16:34:41.471543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.48226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-09-17T16:34:41.471488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.176531ms","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-09-17T16:34:41.471808Z","caller":"traceutil/trace.go:171","msg":"trace[1603703203] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2030; }","duration":"300.517092ms","start":"2026-09-17T16:34:41.171217Z","end":"2026-09-17T16:34:41.471734Z","steps":["trace[1603703203] 'agreement among raft nodes before linearized reading' (duration: 299.619542ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:34:41.471885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T16:34:41.171196Z","time spent":"300.676477ms","remote":"127.0.0.1:51404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-09-17T16:34:41.471627Z","caller":"traceutil/trace.go:171","msg":"trace[755011296] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2030; }","duration":"300.592994ms","start":"2026-09-17T16:34:41.171023Z","end":"2026-09-17T16:34:41.471616Z","steps":["trace[755011296] 'agreement among raft nodes before linearized reading' (duration: 299.944403ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:34:41.472883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T16:34:41.171009Z","time spent":"301.855046ms","remote":"127.0.0.1:51404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-09-17T16:34:41.715905Z","caller":"traceutil/trace.go:171","msg":"trace[1284800975] transaction","detail":"{read_only:false; response_revision:2032; number_of_response:1; }","duration":"239.113589ms","start":"2026-09-17T16:34:41.476764Z","end":"2026-09-17T16:34:41.715877Z","steps":["trace[1284800975] 'process raft request' (duration: 175.971569ms)","trace[1284800975] 'compare' (duration: 62.900362ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T16:34:41.716402Z","caller":"traceutil/trace.go:171","msg":"trace[1186050898] transaction","detail":"{read_only:false; response_revision:2033; number_of_response:1; }","duration":"239.546903ms","start":"2026-09-17T16:34:41.476831Z","end":"2026-09-17T16:34:41.716378Z","steps":["trace[1186050898] 'process raft request' (duration: 238.982544ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:34:41.716731Z","caller":"traceutil/trace.go:171","msg":"trace[218845934] transaction","detail":"{read_only:false; response_revision:2034; number_of_response:1; }","duration":"238.867422ms","start":"2026-09-17T16:34:41.477849Z","end":"2026-09-17T16:34:41.716717Z","steps":["trace[218845934] 'process raft request' (duration: 238.179459ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:34:41.716726Z","caller":"traceutil/trace.go:171","msg":"trace[786790485] transaction","detail":"{read_only:false; response_revision:2035; number_of_response:1; }","duration":"235.104685ms","start":"2026-09-17T16:34:41.481608Z","end":"2026-09-17T16:34:41.716712Z","steps":["trace[786790485] 'process raft request' (duration: 234.892479ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:34:41.990756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.825686ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-17T16:34:41.991355Z","caller":"traceutil/trace.go:171","msg":"trace[146666947] transaction","detail":"{read_only:false; response_revision:2039; number_of_response:1; }","duration":"211.407399ms","start":"2026-09-17T16:34:41.779741Z","end":"2026-09-17T16:34:41.991148Z","steps":["trace[146666947] 'process raft request' (duration: 68.055755ms)","trace[146666947] 'compare' (duration: 142.62276ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T16:34:42.014476Z","caller":"traceutil/trace.go:171","msg":"trace[771158607] transaction","detail":"{read_only:false; response_revision:2040; number_of_response:1; }","duration":"234.0548ms","start":"2026-09-17T16:34:41.780399Z","end":"2026-09-17T16:34:42.014454Z","steps":["trace[771158607] 'process raft request' (duration: 233.890604ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:34:42.015008Z","caller":"traceutil/trace.go:171","msg":"trace[600068217] transaction","detail":"{read_only:false; response_revision:2041; number_of_response:1; }","duration":"234.576047ms","start":"2026-09-17T16:34:41.780418Z","end":"2026-09-17T16:34:42.014994Z","steps":["trace[600068217] 'process raft request' (duration: 233.983587ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:34:42.015589Z","caller":"traceutil/trace.go:171","msg":"trace[467152681] linearizableReadLoop","detail":"{readStateIndex:2127; appliedIndex:2122; }","duration":"214.637948ms","start":"2026-09-17T16:34:41.800936Z","end":"2026-09-17T16:34:42.015574Z","steps":["trace[467152681] 'read index received' (duration: 47.02497ms)","trace[467152681] 'applied index is now lower than readState.Index' (duration: 167.612198ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T16:34:42.015776Z","caller":"traceutil/trace.go:171","msg":"trace[1331429412] transaction","detail":"{read_only:false; response_revision:2043; number_of_response:1; }","duration":"230.138309ms","start":"2026-09-17T16:34:41.785624Z","end":"2026-09-17T16:34:42.015762Z","steps":["trace[1331429412] 'process raft request' (duration: 229.90819ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:34:42.016022Z","caller":"traceutil/trace.go:171","msg":"trace[1314811243] transaction","detail":"{read_only:false; response_revision:2042; number_of_response:1; }","duration":"233.326665ms","start":"2026-09-17T16:34:41.782684Z","end":"2026-09-17T16:34:42.016011Z","steps":["trace[1314811243] 'process raft request' (duration: 232.723534ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:34:42.016618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.663112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-17T16:34:42.016686Z","caller":"traceutil/trace.go:171","msg":"trace[1664009873] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2043; }","duration":"215.769925ms","start":"2026-09-17T16:34:41.800896Z","end":"2026-09-17T16:34:42.016666Z","steps":["trace[1664009873] 'agreement among raft nodes before linearized reading' (duration: 215.623441ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:34:42.016617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.376328ms","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-09-17T16:34:42.016741Z","caller":"traceutil/trace.go:171","msg":"trace[1510942581] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2043; }","duration":"183.530022ms","start":"2026-09-17T16:34:41.833197Z","end":"2026-09-17T16:34:42.016727Z","steps":["trace[1510942581] 'agreement among raft nodes before linearized reading' (duration: 183.245913ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:34:44.793644Z","caller":"traceutil/trace.go:171","msg":"trace[304913726] transaction","detail":"{read_only:false; response_revision:2058; number_of_response:1; }","duration":"404.577816ms","start":"2026-09-17T16:34:44.389008Z","end":"2026-09-17T16:34:44.793586Z","steps":["trace[304913726] 'process raft request' (duration: 404.314016ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:34:44.793823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T16:34:44.388988Z","time spent":"404.741432ms","remote":"127.0.0.1:51404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-17T16:34:44.799412Z","caller":"traceutil/trace.go:171","msg":"trace[236609828] linearizableReadLoop","detail":"{readStateIndex:2143; appliedIndex:2141; }","duration":"330.370028ms","start":"2026-09-17T16:34:44.469019Z","end":"2026-09-17T16:34:44.79939Z","steps":["trace[236609828] 'read index received' (duration: 324.282633ms)","trace[236609828] 'applied index is now lower than readState.Index' (duration: 6.085995ms)"],"step_count":2} {"level":"warn","ts":"2026-09-17T16:34:44.799643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.610216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-17T16:34:44.799754Z","caller":"traceutil/trace.go:171","msg":"trace[809701393] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2058; }","duration":"330.772531ms","start":"2026-09-17T16:34:44.468957Z","end":"2026-09-17T16:34:44.799729Z","steps":["trace[809701393] 'agreement among raft nodes before linearized reading' (duration: 330.508142ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:34:44.799806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T16:34:44.468931Z","time spent":"330.863414ms","remote":"127.0.0.1:60486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-09-17T16:34:45.479459Z","caller":"traceutil/trace.go:171","msg":"trace[1895520770] linearizableReadLoop","detail":"{readStateIndex:2147; appliedIndex:2146; }","duration":"274.412038ms","start":"2026-09-17T16:34:45.205029Z","end":"2026-09-17T16:34:45.479441Z","steps":["trace[1895520770] 'read index received' (duration: 273.835419ms)","trace[1895520770] 'applied index is now lower than readState.Index' (duration: 575.909µs)"],"step_count":2} {"level":"info","ts":"2026-09-17T16:34:45.479527Z","caller":"traceutil/trace.go:171","msg":"trace[1002484747] transaction","detail":"{read_only:false; response_revision:2062; number_of_response:1; }","duration":"322.141757ms","start":"2026-09-17T16:34:45.157354Z","end":"2026-09-17T16:34:45.479495Z","steps":["trace[1002484747] 'process raft request' (duration: 321.380622ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:34:45.479642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.595655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-17T16:34:45.47967Z","caller":"traceutil/trace.go:171","msg":"trace[1791657424] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2062; }","duration":"274.667687ms","start":"2026-09-17T16:34:45.204992Z","end":"2026-09-17T16:34:45.47966Z","steps":["trace[1791657424] 'agreement among raft nodes before linearized reading' (duration: 274.537162ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:34:45.479691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T16:34:45.157333Z","time spent":"322.262952ms","remote":"127.0.0.1:51404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-17T16:34:45.488544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.104432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-17T16:34:45.488601Z","caller":"traceutil/trace.go:171","msg":"trace[265400552] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:2063; }","duration":"105.209166ms","start":"2026-09-17T16:34:45.383378Z","end":"2026-09-17T16:34:45.488587Z","steps":["trace[265400552] 'agreement among raft nodes before linearized reading' (duration: 105.065261ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:35:07.903824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.500314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-17T16:35:07.903892Z","caller":"traceutil/trace.go:171","msg":"trace[1253245953] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2187; }","duration":"103.670199ms","start":"2026-09-17T16:35:07.800205Z","end":"2026-09-17T16:35:07.903875Z","steps":["trace[1253245953] 'range keys from in-memory index tree' (duration: 103.300057ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:35:08.206699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.11009ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-17T16:35:08.206908Z","caller":"traceutil/trace.go:171","msg":"trace[69402808] linearizableReadLoop","detail":"{readStateIndex:2280; appliedIndex:2278; }","duration":"245.904134ms","start":"2026-09-17T16:35:07.96098Z","end":"2026-09-17T16:35:08.206884Z","steps":["trace[69402808] 'read index received' (duration: 88.499585ms)","trace[69402808] 'applied index is now lower than readState.Index' (duration: 157.402999ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T16:35:08.206993Z","caller":"traceutil/trace.go:171","msg":"trace[89546973] transaction","detail":"{read_only:false; response_revision:2189; number_of_response:1; }","duration":"297.01162ms","start":"2026-09-17T16:35:07.909951Z","end":"2026-09-17T16:35:08.206963Z","steps":["trace[89546973] 'process raft request' (duration: 139.522348ms)","trace[89546973] 'compare' (duration: 156.794659ms)"],"step_count":2} {"level":"warn","ts":"2026-09-17T16:35:08.207107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.836381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-17T16:35:08.207081Z","caller":"traceutil/trace.go:171","msg":"trace[1455232508] transaction","detail":"{read_only:false; response_revision:2190; number_of_response:1; }","duration":"294.971982ms","start":"2026-09-17T16:35:07.912029Z","end":"2026-09-17T16:35:08.207001Z","steps":["trace[1455232508] 'process raft request' (duration: 294.780805ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:35:08.207181Z","caller":"traceutil/trace.go:171","msg":"trace[958267235] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:2190; }","duration":"134.945676ms","start":"2026-09-17T16:35:08.072219Z","end":"2026-09-17T16:35:08.207165Z","steps":["trace[958267235] 'agreement among raft nodes before linearized reading' (duration: 134.828932ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:35:08.207325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.303297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-17T16:35:08.207427Z","caller":"traceutil/trace.go:171","msg":"trace[1021250339] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2190; }","duration":"246.456933ms","start":"2026-09-17T16:35:07.960936Z","end":"2026-09-17T16:35:08.207393Z","steps":["trace[1021250339] 'agreement among raft nodes before linearized reading' (duration: 246.093161ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:35:09.187439Z","caller":"traceutil/trace.go:171","msg":"trace[971814650] linearizableReadLoop","detail":"{readStateIndex:2284; appliedIndex:2283; }","duration":"218.12288ms","start":"2026-09-17T16:35:08.969289Z","end":"2026-09-17T16:35:09.187412Z","steps":["trace[971814650] 'read index received' (duration: 217.977746ms)","trace[971814650] 'applied index is now lower than readState.Index' (duration: 144.124µs)"],"step_count":2} {"level":"info","ts":"2026-09-17T16:35:09.187477Z","caller":"traceutil/trace.go:171","msg":"trace[1327515290] transaction","detail":"{read_only:false; response_revision:2193; number_of_response:1; }","duration":"229.419254ms","start":"2026-09-17T16:35:08.958041Z","end":"2026-09-17T16:35:09.187461Z","steps":["trace[1327515290] 'process raft request' (duration: 229.217117ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:35:09.187695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.360217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-17T16:35:09.187762Z","caller":"traceutil/trace.go:171","msg":"trace[567679019] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:2193; }","duration":"218.495831ms","start":"2026-09-17T16:35:08.96923Z","end":"2026-09-17T16:35:09.187726Z","steps":["trace[567679019] 'agreement among raft nodes before linearized reading' (duration: 218.294345ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:35:09.434327Z","caller":"traceutil/trace.go:171","msg":"trace[667341352] linearizableReadLoop","detail":"{readStateIndex:2285; appliedIndex:2284; }","duration":"246.791669ms","start":"2026-09-17T16:35:09.187506Z","end":"2026-09-17T16:35:09.434297Z","steps":["trace[667341352] 'read index received' (duration: 222.736752ms)","trace[667341352] 'applied index is now lower than readState.Index' (duration: 24.053527ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T16:35:09.434516Z","caller":"traceutil/trace.go:171","msg":"trace[449325252] transaction","detail":"{read_only:false; response_revision:2194; number_of_response:1; }","duration":"264.717183ms","start":"2026-09-17T16:35:09.169788Z","end":"2026-09-17T16:35:09.434506Z","steps":["trace[449325252] 'process raft request' (duration: 240.331725ms)","trace[449325252] 'compare' (duration: 22.867418ms)"],"step_count":2} {"level":"warn","ts":"2026-09-17T16:35:09.434757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.269719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-09-17T16:35:09.434799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.090477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-17T16:35:09.43487Z","caller":"traceutil/trace.go:171","msg":"trace[442366287] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2194; }","duration":"218.219872ms","start":"2026-09-17T16:35:09.21663Z","end":"2026-09-17T16:35:09.43485Z","steps":["trace[442366287] 'agreement among raft nodes before linearized reading' (duration: 217.932562ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:35:09.434834Z","caller":"traceutil/trace.go:171","msg":"trace[1368678769] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:2194; }","duration":"379.407404ms","start":"2026-09-17T16:35:09.055409Z","end":"2026-09-17T16:35:09.434816Z","steps":["trace[1368678769] 'agreement among raft nodes before linearized reading' (duration: 379.244828ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:35:09.435002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T16:35:09.055386Z","time spent":"379.603601ms","remote":"127.0.0.1:51420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":2,"response size":30,"request content":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-09-17T16:35:09.973507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.893884ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-17T16:35:09.973684Z","caller":"traceutil/trace.go:171","msg":"trace[1207311534] transaction","detail":"{read_only:false; response_revision:2195; number_of_response:1; }","duration":"409.197962ms","start":"2026-09-17T16:35:09.564428Z","end":"2026-09-17T16:35:09.973626Z","steps":["trace[1207311534] 'process raft request' (duration: 273.101751ms)","trace[1207311534] 'compare' (duration: 135.690458ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T16:35:09.973957Z","caller":"traceutil/trace.go:171","msg":"trace[907619528] linearizableReadLoop","detail":"{readStateIndex:2287; appliedIndex:2285; }","duration":"348.139739ms","start":"2026-09-17T16:35:09.625791Z","end":"2026-09-17T16:35:09.973931Z","steps":["trace[907619528] 'read index received' (duration: 211.706706ms)","trace[907619528] 'applied index is now lower than readState.Index' (duration: 136.431683ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T16:35:09.974379Z","caller":"traceutil/trace.go:171","msg":"trace[1851915291] transaction","detail":"{read_only:false; response_revision:2196; number_of_response:1; }","duration":"389.267721ms","start":"2026-09-17T16:35:09.585076Z","end":"2026-09-17T16:35:09.974344Z","steps":["trace[1851915291] 'process raft request' (duration: 388.518846ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:35:09.974412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T16:35:09.564399Z","time spent":"409.310155ms","remote":"127.0.0.1:51404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-17T16:35:09.974547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T16:35:09.585033Z","time spent":"389.394685ms","remote":"127.0.0.1:51404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-17T16:35:09.974885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.871386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-17T16:35:09.974952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.172551ms","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-09-17T16:35:09.974978Z","caller":"traceutil/trace.go:171","msg":"trace[1441000736] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2196; }","duration":"174.961389ms","start":"2026-09-17T16:35:09.8Z","end":"2026-09-17T16:35:09.974961Z","steps":["trace[1441000736] 'agreement among raft nodes before linearized reading' (duration: 174.842565ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:35:09.975019Z","caller":"traceutil/trace.go:171","msg":"trace[1533207704] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2196; }","duration":"349.293926ms","start":"2026-09-17T16:35:09.625716Z","end":"2026-09-17T16:35:09.97501Z","steps":["trace[1533207704] 'agreement among raft nodes before linearized reading' (duration: 349.13253ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:35:09.975621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T16:35:09.625689Z","time spent":"349.351568ms","remote":"127.0.0.1:51404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-17T16:35:10.278193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.02819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-17T16:35:10.278293Z","caller":"traceutil/trace.go:171","msg":"trace[262648091] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:2198; }","duration":"115.195395ms","start":"2026-09-17T16:35:10.16308Z","end":"2026-09-17T16:35:10.278276Z","steps":["trace[262648091] 'count revisions from in-memory index tree' (duration: 114.889836ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:36:41.64987Z","caller":"traceutil/trace.go:171","msg":"trace[812962020] transaction","detail":"{read_only:false; response_revision:2800; number_of_response:1; }","duration":"113.277769ms","start":"2026-09-17T16:36:41.536564Z","end":"2026-09-17T16:36:41.649841Z","steps":["trace[812962020] 'process raft request' (duration: 113.113534ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:41:03.579215Z","caller":"traceutil/trace.go:171","msg":"trace[1988759672] transaction","detail":"{read_only:false; response_revision:4358; number_of_response:1; }","duration":"154.253774ms","start":"2026-09-17T16:41:03.424936Z","end":"2026-09-17T16:41:03.579189Z","steps":["trace[1988759672] 'process raft request' (duration: 153.083459ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:41:03.57951Z","caller":"traceutil/trace.go:171","msg":"trace[1793124251] transaction","detail":"{read_only:false; response_revision:4359; number_of_response:1; }","duration":"144.771416ms","start":"2026-09-17T16:41:03.434708Z","end":"2026-09-17T16:41:03.57948Z","steps":["trace[1793124251] 'process raft request' (duration: 144.599681ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:41:11.423977Z","caller":"traceutil/trace.go:171","msg":"trace[2085885160] linearizableReadLoop","detail":"{readStateIndex:4930; appliedIndex:4929; }","duration":"175.37482ms","start":"2026-09-17T16:41:11.24857Z","end":"2026-09-17T16:41:11.423945Z","steps":["trace[2085885160] 'read index received' (duration: 175.169244ms)","trace[2085885160] 'applied index is now lower than readState.Index' (duration: 204.526µs)"],"step_count":2} {"level":"info","ts":"2026-09-17T16:41:11.424098Z","caller":"traceutil/trace.go:171","msg":"trace[860883611] transaction","detail":"{read_only:false; response_revision:4741; number_of_response:1; }","duration":"224.056152ms","start":"2026-09-17T16:41:11.2Z","end":"2026-09-17T16:41:11.424056Z","steps":["trace[860883611] 'process raft request' (duration: 223.801873ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:41:11.424235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.640509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-17T16:41:11.424309Z","caller":"traceutil/trace.go:171","msg":"trace[486217648] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4741; }","duration":"175.762932ms","start":"2026-09-17T16:41:11.248521Z","end":"2026-09-17T16:41:11.424284Z","steps":["trace[486217648] 'agreement among raft nodes before linearized reading' (duration: 175.584937ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:41:14.755712Z","caller":"traceutil/trace.go:171","msg":"trace[590361548] linearizableReadLoop","detail":"{readStateIndex:5008; appliedIndex:5006; }","duration":"160.335927ms","start":"2026-09-17T16:41:14.595358Z","end":"2026-09-17T16:41:14.755694Z","steps":["trace[590361548] 'read index received' (duration: 4.296055ms)","trace[590361548] 'applied index is now lower than readState.Index' (duration: 156.038982ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T16:41:14.755924Z","caller":"traceutil/trace.go:171","msg":"trace[759086638] transaction","detail":"{read_only:false; response_revision:4818; number_of_response:1; }","duration":"161.223763ms","start":"2026-09-17T16:41:14.594687Z","end":"2026-09-17T16:41:14.75591Z","steps":["trace[759086638] 'process raft request' (duration: 116.621532ms)","trace[759086638] 'compare' (duration: 44.19808ms)"],"step_count":2} {"level":"warn","ts":"2026-09-17T16:41:14.756135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.760869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-17T16:41:14.756197Z","caller":"traceutil/trace.go:171","msg":"trace[762740415] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1; range_end:; response_count:0; response_revision:4818; }","duration":"160.843252ms","start":"2026-09-17T16:41:14.595344Z","end":"2026-09-17T16:41:14.756187Z","steps":["trace[762740415] 'agreement among raft nodes before linearized reading' (duration: 160.747859ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:41:14.767786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.565962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-90e1374a-f99a-4ba9-8bd9-91faf67f4abb\" ","response":"range_response_count:1 size:2708"} {"level":"info","ts":"2026-09-17T16:41:14.767836Z","caller":"traceutil/trace.go:171","msg":"trace[66872234] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-90e1374a-f99a-4ba9-8bd9-91faf67f4abb; range_end:; response_count:1; response_revision:4819; }","duration":"163.648824ms","start":"2026-09-17T16:41:14.604175Z","end":"2026-09-17T16:41:14.767823Z","steps":["trace[66872234] 'agreement among raft nodes before linearized reading' (duration: 163.530491ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:41:14.76806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.535131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-90e1374a-f99a-4ba9-8bd9-91faf67f4abb\" ","response":"range_response_count:1 size:2708"} {"level":"info","ts":"2026-09-17T16:41:14.768093Z","caller":"traceutil/trace.go:171","msg":"trace[1199584688] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-90e1374a-f99a-4ba9-8bd9-91faf67f4abb; range_end:; response_count:1; response_revision:4819; }","duration":"163.579733ms","start":"2026-09-17T16:41:14.604505Z","end":"2026-09-17T16:41:14.768084Z","steps":["trace[1199584688] 'agreement among raft nodes before linearized reading' (duration: 163.49185ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:41:14.768501Z","caller":"traceutil/trace.go:171","msg":"trace[553646285] transaction","detail":"{read_only:false; response_revision:4819; number_of_response:1; }","duration":"157.546006ms","start":"2026-09-17T16:41:14.610938Z","end":"2026-09-17T16:41:14.768484Z","steps":["trace[553646285] 'process raft request' (duration: 156.409913ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:41:15.967935Z","caller":"traceutil/trace.go:171","msg":"trace[736184527] transaction","detail":"{read_only:false; response_revision:4857; number_of_response:1; }","duration":"117.665032ms","start":"2026-09-17T16:41:15.85024Z","end":"2026-09-17T16:41:15.967905Z","steps":["trace[736184527] 'process raft request' (duration: 117.468096ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:41:16.144927Z","caller":"traceutil/trace.go:171","msg":"trace[1660790780] transaction","detail":"{read_only:false; response_revision:4858; number_of_response:1; }","duration":"108.76581ms","start":"2026-09-17T16:41:16.036081Z","end":"2026-09-17T16:41:16.144847Z","steps":["trace[1660790780] 'process raft request' (duration: 11.637379ms)","trace[1660790780] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/kube-system/kube-controller-manager; req_size:487; } (duration: 96.563886ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T16:41:20.559094Z","caller":"traceutil/trace.go:171","msg":"trace[607743541] transaction","detail":"{read_only:false; response_revision:4947; number_of_response:1; }","duration":"112.640092ms","start":"2026-09-17T16:41:20.44643Z","end":"2026-09-17T16:41:20.55907Z","steps":["trace[607743541] 'process raft request' (duration: 88.634142ms)","trace[607743541] 'compare' (duration: 23.897127ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T16:41:20.591706Z","caller":"traceutil/trace.go:171","msg":"trace[738533106] transaction","detail":"{read_only:false; response_revision:4948; number_of_response:1; }","duration":"143.892472ms","start":"2026-09-17T16:41:20.447783Z","end":"2026-09-17T16:41:20.591676Z","steps":["trace[738533106] 'process raft request' (duration: 143.709707ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:41:25.262876Z","caller":"traceutil/trace.go:171","msg":"trace[1436756718] transaction","detail":"{read_only:false; response_revision:4990; number_of_response:1; }","duration":"311.378029ms","start":"2026-09-17T16:41:24.951459Z","end":"2026-09-17T16:41:25.262837Z","steps":["trace[1436756718] 'process raft request' (duration: 291.157491ms)","trace[1436756718] 'compare' (duration: 18.8993ms)"],"step_count":2} {"level":"warn","ts":"2026-09-17T16:41:25.263777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T16:41:24.951435Z","time spent":"311.585655ms","remote":"127.0.0.1:51404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-17T16:41:25.352033Z","caller":"traceutil/trace.go:171","msg":"trace[368876641] transaction","detail":"{read_only:false; response_revision:4991; number_of_response:1; }","duration":"222.758681ms","start":"2026-09-17T16:41:25.128345Z","end":"2026-09-17T16:41:25.351103Z","steps":["trace[368876641] 'process raft request' (duration: 222.473503ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:41:26.117855Z","caller":"traceutil/trace.go:171","msg":"trace[915053430] linearizableReadLoop","detail":"{readStateIndex:5201; appliedIndex:5199; }","duration":"315.080576ms","start":"2026-09-17T16:41:25.802749Z","end":"2026-09-17T16:41:26.117829Z","steps":["trace[915053430] 'read index received' (duration: 238.53852ms)","trace[915053430] 'applied index is now lower than readState.Index' (duration: 76.540976ms)"],"step_count":2} {"level":"warn","ts":"2026-09-17T16:41:26.118081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.309223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-17T16:41:26.118127Z","caller":"traceutil/trace.go:171","msg":"trace[1048756795] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5003; }","duration":"315.417225ms","start":"2026-09-17T16:41:25.802698Z","end":"2026-09-17T16:41:26.118115Z","steps":["trace[1048756795] 'agreement among raft nodes before linearized reading' (duration: 315.316033ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:41:26.118209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T16:41:25.802674Z","time spent":"315.522739ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-17T16:41:26.118324Z","caller":"traceutil/trace.go:171","msg":"trace[1895499891] transaction","detail":"{read_only:false; response_revision:5003; number_of_response:1; }","duration":"350.93183ms","start":"2026-09-17T16:41:25.767091Z","end":"2026-09-17T16:41:26.118023Z","steps":["trace[1895499891] 'process raft request' (duration: 350.671462ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:41:26.118576Z","caller":"traceutil/trace.go:171","msg":"trace[1473884352] transaction","detail":"{read_only:false; response_revision:5002; number_of_response:1; }","duration":"390.242363ms","start":"2026-09-17T16:41:25.728305Z","end":"2026-09-17T16:41:26.118547Z","steps":["trace[1473884352] 'process raft request' (duration: 312.968574ms)","trace[1473884352] 'compare' (duration: 76.272909ms)"],"step_count":2} {"level":"warn","ts":"2026-09-17T16:41:26.118607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T16:41:25.767049Z","time spent":"351.363272ms","remote":"127.0.0.1:51404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-17T16:41:26.118646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.89029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretimports/\" range_end:\"/registry/secretgen.carvel.dev/secretimports0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-17T16:41:26.118712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T16:41:25.728277Z","time spent":"390.354806ms","remote":"127.0.0.1:42174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2797,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-17T16:41:26.11873Z","caller":"traceutil/trace.go:171","msg":"trace[1860997872] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretimports/; range_end:/registry/secretgen.carvel.dev/secretimports0; response_count:0; response_revision:5003; }","duration":"283.004372ms","start":"2026-09-17T16:41:25.835704Z","end":"2026-09-17T16:41:26.118708Z","steps":["trace[1860997872] 'agreement among raft nodes before linearized reading' (duration: 282.863498ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:41:26.11872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.471304ms","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-09-17T16:41:26.118794Z","caller":"traceutil/trace.go:171","msg":"trace[192626938] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:5003; }","duration":"154.600247ms","start":"2026-09-17T16:41:25.964177Z","end":"2026-09-17T16:41:26.118777Z","steps":["trace[192626938] 'agreement among raft nodes before linearized reading' (duration: 154.408772ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:41:26.303841Z","caller":"traceutil/trace.go:171","msg":"trace[2015783455] transaction","detail":"{read_only:false; response_revision:5005; number_of_response:1; }","duration":"150.062295ms","start":"2026-09-17T16:41:26.153752Z","end":"2026-09-17T16:41:26.303814Z","steps":["trace[2015783455] 'process raft request' (duration: 149.909091ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:41:26.315612Z","caller":"traceutil/trace.go:171","msg":"trace[1007606647] linearizableReadLoop","detail":"{readStateIndex:5205; appliedIndex:5202; }","duration":"160.555129ms","start":"2026-09-17T16:41:26.155027Z","end":"2026-09-17T16:41:26.315582Z","steps":["trace[1007606647] 'read index received' (duration: 148.580971ms)","trace[1007606647] 'applied index is now lower than readState.Index' (duration: 11.972978ms)"],"step_count":2} {"level":"warn","ts":"2026-09-17T16:41:26.316299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.24358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:128288"} {"level":"info","ts":"2026-09-17T16:41:26.316353Z","caller":"traceutil/trace.go:171","msg":"trace[1229334148] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:5007; }","duration":"161.381823ms","start":"2026-09-17T16:41:26.154958Z","end":"2026-09-17T16:41:26.316339Z","steps":["trace[1229334148] 'agreement among raft nodes before linearized reading' (duration: 160.978211ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:41:26.316818Z","caller":"traceutil/trace.go:171","msg":"trace[1266622987] transaction","detail":"{read_only:false; response_revision:5006; number_of_response:1; }","duration":"162.405054ms","start":"2026-09-17T16:41:26.154389Z","end":"2026-09-17T16:41:26.316794Z","steps":["trace[1266622987] 'process raft request' (duration: 160.961162ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:41:26.315777Z","caller":"traceutil/trace.go:171","msg":"trace[82652344] transaction","detail":"{read_only:false; response_revision:5007; number_of_response:1; }","duration":"160.690683ms","start":"2026-09-17T16:41:26.155018Z","end":"2026-09-17T16:41:26.315709Z","steps":["trace[82652344] 'process raft request' (duration: 160.502798ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:41:26.485759Z","caller":"traceutil/trace.go:171","msg":"trace[1646935004] transaction","detail":"{read_only:false; response_revision:5008; number_of_response:1; }","duration":"164.204347ms","start":"2026-09-17T16:41:26.321382Z","end":"2026-09-17T16:41:26.485586Z","steps":["trace[1646935004] 'process raft request' (duration: 163.932049ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:41:26.493684Z","caller":"traceutil/trace.go:171","msg":"trace[1127379139] transaction","detail":"{read_only:false; response_revision:5009; number_of_response:1; }","duration":"171.19753ms","start":"2026-09-17T16:41:26.322431Z","end":"2026-09-17T16:41:26.493629Z","steps":["trace[1127379139] 'process raft request' (duration: 170.748857ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:41:26.494081Z","caller":"traceutil/trace.go:171","msg":"trace[1001065243] linearizableReadLoop","detail":"{readStateIndex:5208; appliedIndex:5205; }","duration":"120.238047ms","start":"2026-09-17T16:41:26.373803Z","end":"2026-09-17T16:41:26.494041Z","steps":["trace[1001065243] 'read index received' (duration: 111.384879ms)","trace[1001065243] 'applied index is now lower than readState.Index' (duration: 8.851838ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T16:41:26.494423Z","caller":"traceutil/trace.go:171","msg":"trace[149840473] transaction","detail":"{read_only:false; response_revision:5010; number_of_response:1; }","duration":"171.572311ms","start":"2026-09-17T16:41:26.322829Z","end":"2026-09-17T16:41:26.494401Z","steps":["trace[149840473] 'process raft request' (duration: 170.718116ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:41:26.495089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.154284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-576c764ffc-9m79w.18d62946a7c24363\" ","response":"range_response_count:1 size:898"} {"level":"info","ts":"2026-09-17T16:41:26.495163Z","caller":"traceutil/trace.go:171","msg":"trace[569932880] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-576c764ffc-9m79w.18d62946a7c24363; range_end:; response_count:1; response_revision:5011; }","duration":"121.297898ms","start":"2026-09-17T16:41:26.373851Z","end":"2026-09-17T16:41:26.495149Z","steps":["trace[569932880] 'agreement among raft nodes before linearized reading' (duration: 120.974859ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:41:26.494743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.877416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16086"} {"level":"info","ts":"2026-09-17T16:41:26.495248Z","caller":"traceutil/trace.go:171","msg":"trace[1981922619] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5010; }","duration":"121.473994ms","start":"2026-09-17T16:41:26.373752Z","end":"2026-09-17T16:41:26.495226Z","steps":["trace[1981922619] 'agreement among raft nodes before linearized reading' (duration: 120.747532ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:41:28.233Z","caller":"traceutil/trace.go:171","msg":"trace[1013710962] transaction","detail":"{read_only:false; response_revision:5087; number_of_response:1; }","duration":"107.29725ms","start":"2026-09-17T16:41:28.125677Z","end":"2026-09-17T16:41:28.232974Z","steps":["trace[1013710962] 'process raft request' (duration: 107.145306ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:41:29.849144Z","caller":"traceutil/trace.go:171","msg":"trace[1218961789] linearizableReadLoop","detail":"{readStateIndex:5302; appliedIndex:5301; }","duration":"125.498209ms","start":"2026-09-17T16:41:29.723603Z","end":"2026-09-17T16:41:29.849101Z","steps":["trace[1218961789] 'read index received' (duration: 125.338104ms)","trace[1218961789] 'applied index is now lower than readState.Index' (duration: 159.215µs)"],"step_count":2} {"level":"warn","ts":"2026-09-17T16:41:29.849378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.764346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-35754ddb-07f7-41ab-8505-a66c4f0b69fe\" ","response":"range_response_count:1 size:3939"} {"level":"info","ts":"2026-09-17T16:41:29.849434Z","caller":"traceutil/trace.go:171","msg":"trace[1036790731] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-35754ddb-07f7-41ab-8505-a66c4f0b69fe; range_end:; response_count:1; response_revision:5103; }","duration":"125.871039ms","start":"2026-09-17T16:41:29.723549Z","end":"2026-09-17T16:41:29.84942Z","steps":["trace[1036790731] 'agreement among raft nodes before linearized reading' (duration: 125.671843ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:41:29.849589Z","caller":"traceutil/trace.go:171","msg":"trace[1065039018] transaction","detail":"{read_only:false; response_revision:5103; number_of_response:1; }","duration":"129.083011ms","start":"2026-09-17T16:41:29.720471Z","end":"2026-09-17T16:41:29.849554Z","steps":["trace[1065039018] 'process raft request' (duration: 128.491985ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:41:40.492567Z","caller":"traceutil/trace.go:171","msg":"trace[2079065207] linearizableReadLoop","detail":"{readStateIndex:5448; appliedIndex:5447; }","duration":"197.354551ms","start":"2026-09-17T16:41:40.295188Z","end":"2026-09-17T16:41:40.492543Z","steps":["trace[2079065207] 'read index received' (duration: 197.172335ms)","trace[2079065207] 'applied index is now lower than readState.Index' (duration: 180.656µs)"],"step_count":2} {"level":"warn","ts":"2026-09-17T16:41:40.492698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.478404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-17T16:41:40.492727Z","caller":"traceutil/trace.go:171","msg":"trace[1441850082] range","detail":"{range_begin:/registry/rabbitmq.com/operatorpolicies/; range_end:/registry/rabbitmq.com/operatorpolicies0; response_count:0; response_revision:5243; }","duration":"197.564157ms","start":"2026-09-17T16:41:40.295153Z","end":"2026-09-17T16:41:40.492718Z","steps":["trace[1441850082] 'agreement among raft nodes before linearized reading' (duration: 197.480724ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:41:40.492875Z","caller":"traceutil/trace.go:171","msg":"trace[921423997] transaction","detail":"{read_only:false; response_revision:5243; number_of_response:1; }","duration":"222.351405ms","start":"2026-09-17T16:41:40.270487Z","end":"2026-09-17T16:41:40.492838Z","steps":["trace[921423997] 'process raft request' (duration: 221.883681ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:41:40.802058Z","caller":"traceutil/trace.go:171","msg":"trace[1358138038] transaction","detail":"{read_only:false; response_revision:5245; number_of_response:1; }","duration":"164.817508ms","start":"2026-09-17T16:41:40.637194Z","end":"2026-09-17T16:41:40.802011Z","steps":["trace[1358138038] 'process raft request' (duration: 97.881858ms)","trace[1358138038] 'compare' (duration: 66.6046ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T16:41:40.802267Z","caller":"traceutil/trace.go:171","msg":"trace[1289435197] transaction","detail":"{read_only:false; response_revision:5246; number_of_response:1; }","duration":"161.682288ms","start":"2026-09-17T16:41:40.64056Z","end":"2026-09-17T16:41:40.802243Z","steps":["trace[1289435197] 'process raft request' (duration: 161.40143ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:41:40.802268Z","caller":"traceutil/trace.go:171","msg":"trace[1373708762] linearizableReadLoop","detail":"{readStateIndex:5450; appliedIndex:5449; }","duration":"162.735497ms","start":"2026-09-17T16:41:40.639493Z","end":"2026-09-17T16:41:40.802229Z","steps":["trace[1373708762] 'read index received' (duration: 95.55609ms)","trace[1373708762] 'applied index is now lower than readState.Index' (duration: 67.176087ms)"],"step_count":2} {"level":"warn","ts":"2026-09-17T16:41:40.802705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.17614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-09-17T16:41:40.802754Z","caller":"traceutil/trace.go:171","msg":"trace[1182324875] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5246; }","duration":"163.255652ms","start":"2026-09-17T16:41:40.639487Z","end":"2026-09-17T16:41:40.802743Z","steps":["trace[1182324875] 'agreement among raft nodes before linearized reading' (duration: 163.020105ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:41:40.802986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.276472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:13878"} {"level":"info","ts":"2026-09-17T16:41:40.803042Z","caller":"traceutil/trace.go:171","msg":"trace[294457907] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5246; }","duration":"163.396206ms","start":"2026-09-17T16:41:40.639632Z","end":"2026-09-17T16:41:40.803028Z","steps":["trace[294457907] 'agreement among raft nodes before linearized reading' (duration: 163.155979ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:41:41.846896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.784303ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-17T16:41:41.847192Z","caller":"traceutil/trace.go:171","msg":"trace[1024597197] transaction","detail":"{read_only:false; response_revision:5255; number_of_response:1; }","duration":"177.204666ms","start":"2026-09-17T16:41:41.66995Z","end":"2026-09-17T16:41:41.847155Z","steps":["trace[1024597197] 'process raft request' (duration: 49.078913ms)","trace[1024597197] 'compare' (duration: 127.65165ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T16:41:41.847335Z","caller":"traceutil/trace.go:171","msg":"trace[1292737343] transaction","detail":"{read_only:false; response_revision:5256; number_of_response:1; }","duration":"177.292378ms","start":"2026-09-17T16:41:41.670023Z","end":"2026-09-17T16:41:41.847315Z","steps":["trace[1292737343] 'process raft request' (duration: 177.063181ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:41:41.847633Z","caller":"traceutil/trace.go:171","msg":"trace[2068275213] transaction","detail":"{read_only:false; response_revision:5258; number_of_response:1; }","duration":"166.772923ms","start":"2026-09-17T16:41:41.680841Z","end":"2026-09-17T16:41:41.847614Z","steps":["trace[2068275213] 'process raft request' (duration: 166.581498ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:41:41.847671Z","caller":"traceutil/trace.go:171","msg":"trace[1475162478] transaction","detail":"{read_only:false; response_revision:5257; number_of_response:1; }","duration":"176.649089ms","start":"2026-09-17T16:41:41.671004Z","end":"2026-09-17T16:41:41.847653Z","steps":["trace[1475162478] 'process raft request' (duration: 176.256488ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:41:41.847634Z","caller":"traceutil/trace.go:171","msg":"trace[248923787] linearizableReadLoop","detail":"{readStateIndex:5462; appliedIndex:5458; }","duration":"167.418051ms","start":"2026-09-17T16:41:41.680195Z","end":"2026-09-17T16:41:41.847613Z","steps":["trace[248923787] 'read index received' (duration: 11.471602ms)","trace[248923787] 'applied index is now lower than readState.Index' (duration: 155.945019ms)"],"step_count":2} {"level":"warn","ts":"2026-09-17T16:41:41.848015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.815564ms","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-09-17T16:41:41.848084Z","caller":"traceutil/trace.go:171","msg":"trace[264562481] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5259; }","duration":"167.927877ms","start":"2026-09-17T16:41:41.680145Z","end":"2026-09-17T16:41:41.848073Z","steps":["trace[264562481] 'agreement among raft nodes before linearized reading' (duration: 167.523835ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:41:55.392698Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2874} {"level":"info","ts":"2026-09-17T16:41:55.483484Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2874,"took":"89.573577ms","hash":1578378556,"current-db-size-bytes":52617216,"current-db-size":"53 MB","current-db-size-in-use-bytes":27860992,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-17T16:41:55.483548Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1578378556,"revision":2874,"compact-revision":-1} {"level":"info","ts":"2026-09-17T16:42:30.092768Z","caller":"traceutil/trace.go:171","msg":"trace[1106003318] transaction","detail":"{read_only:false; response_revision:5635; number_of_response:1; }","duration":"116.529099ms","start":"2026-09-17T16:42:29.976208Z","end":"2026-09-17T16:42:30.092737Z","steps":["trace[1106003318] 'process raft request' (duration: 116.369224ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:42:38.849273Z","caller":"traceutil/trace.go:171","msg":"trace[147433341] transaction","detail":"{read_only:false; response_revision:5702; number_of_response:1; }","duration":"122.420732ms","start":"2026-09-17T16:42:38.726831Z","end":"2026-09-17T16:42:38.849251Z","steps":["trace[147433341] 'process raft request' (duration: 121.796433ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:46:55.398653Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5337} {"level":"info","ts":"2026-09-17T16:46:55.501894Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5337,"took":"101.871203ms","hash":4276655096,"current-db-size-bytes":52617216,"current-db-size":"53 MB","current-db-size-in-use-bytes":18952192,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-17T16:46:55.50197Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4276655096,"revision":5337,"compact-revision":2874} {"level":"warn","ts":"2026-09-17T16:49:11.426077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.835231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-09-17T16:49:11.426162Z","caller":"traceutil/trace.go:171","msg":"trace[705191634] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8083; }","duration":"115.961645ms","start":"2026-09-17T16:49:11.310179Z","end":"2026-09-17T16:49:11.42614Z","steps":["trace[705191634] 'range keys from in-memory index tree' (duration: 115.599955ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T16:49:11.426486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.517449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-09-17T16:49:11.426557Z","caller":"traceutil/trace.go:171","msg":"trace[1014059907] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8083; }","duration":"104.61741ms","start":"2026-09-17T16:49:11.321922Z","end":"2026-09-17T16:49:11.42654Z","steps":["trace[1014059907] 'range keys from in-memory index tree' (duration: 104.043905ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:49:11.549173Z","caller":"traceutil/trace.go:171","msg":"trace[1658175196] transaction","detail":"{read_only:false; response_revision:8087; number_of_response:1; }","duration":"117.263839ms","start":"2026-09-17T16:49:11.431883Z","end":"2026-09-17T16:49:11.549146Z","steps":["trace[1658175196] 'process raft request' (duration: 116.867729ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:49:11.549197Z","caller":"traceutil/trace.go:171","msg":"trace[177413893] transaction","detail":"{read_only:false; response_revision:8088; number_of_response:1; }","duration":"117.155066ms","start":"2026-09-17T16:49:11.432018Z","end":"2026-09-17T16:49:11.549173Z","steps":["trace[177413893] 'process raft request' (duration: 116.776566ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T16:49:11.549238Z","caller":"traceutil/trace.go:171","msg":"trace[556841697] transaction","detail":"{read_only:false; response_revision:8086; number_of_response:1; }","duration":"117.419414ms","start":"2026-09-17T16:49:11.431739Z","end":"2026-09-17T16:49:11.549159Z","steps":["trace[556841697] 'process raft request' (duration: 103.472089ms)","trace[556841697] 'compare' (duration: 13.335819ms)"],"step_count":2}