{"level":"warn","ts":"2026-06-17T18:40:55.986954Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-17T18:40:55.987065Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.113:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.113:2380","--initial-cluster=instance=https://199.204.45.113:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.113:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.113: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-06-17T18:40:55.987175Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-17T18:40:55.987199Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.113:2380"]} {"level":"info","ts":"2026-06-17T18:40:55.987227Z","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-06-17T18:40:55.988075Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.113:2379"]} {"level":"info","ts":"2026-06-17T18:40:55.989506Z","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":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.113:2380"],"listen-peer-urls":["https://199.204.45.113:2380"],"advertise-client-urls":["https://199.204.45.113:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.113:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.113: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-06-17T18:40:55.992269Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.479721ms"} {"level":"info","ts":"2026-06-17T18:40:55.998132Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a31e123290fcf0df","cluster-id":"37661d6ee45ed9e8"} {"level":"info","ts":"2026-06-17T18:40:55.998209Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=()"} {"level":"info","ts":"2026-06-17T18:40:55.998235Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became follower at term 0"} {"level":"info","ts":"2026-06-17T18:40:55.998245Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a31e123290fcf0df [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-17T18:40:55.99826Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became follower at term 1"} {"level":"info","ts":"2026-06-17T18:40:55.998298Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=(11753852085873733855)"} {"level":"warn","ts":"2026-06-17T18:40:56.002698Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-17T18:40:56.004041Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-17T18:40:56.00535Z","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-06-17T18:40:56.007881Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a31e123290fcf0df","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-17T18:40:56.008201Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a31e123290fcf0df","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-17T18:40:56.008269Z","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-06-17T18:40:56.008378Z","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-06-17T18:40:56.008414Z","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-06-17T18:40:56.009713Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=(11753852085873733855)"} {"level":"info","ts":"2026-06-17T18:40:56.009864Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"37661d6ee45ed9e8","local-member-id":"a31e123290fcf0df","added-peer-id":"a31e123290fcf0df","added-peer-peer-urls":["https://199.204.45.113:2380"]} {"level":"info","ts":"2026-06-17T18:40:56.012915Z","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-06-17T18:40:56.013088Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.113:2380"} {"level":"info","ts":"2026-06-17T18:40:56.013133Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.113:2380"} {"level":"info","ts":"2026-06-17T18:40:56.01321Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a31e123290fcf0df","initial-advertise-peer-urls":["https://199.204.45.113:2380"],"listen-peer-urls":["https://199.204.45.113:2380"],"advertise-client-urls":["https://199.204.45.113:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.113:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-17T18:40:56.013273Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-17T18:40:56.298651Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df is starting a new election at term 1"} {"level":"info","ts":"2026-06-17T18:40:56.298714Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became pre-candidate at term 1"} {"level":"info","ts":"2026-06-17T18:40:56.298748Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df received MsgPreVoteResp from a31e123290fcf0df at term 1"} {"level":"info","ts":"2026-06-17T18:40:56.298763Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became candidate at term 2"} {"level":"info","ts":"2026-06-17T18:40:56.29877Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df received MsgVoteResp from a31e123290fcf0df at term 2"} {"level":"info","ts":"2026-06-17T18:40:56.29878Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became leader at term 2"} {"level":"info","ts":"2026-06-17T18:40:56.298788Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a31e123290fcf0df elected leader a31e123290fcf0df at term 2"} {"level":"info","ts":"2026-06-17T18:40:56.299582Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a31e123290fcf0df","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.113:2379]}","request-path":"/0/members/a31e123290fcf0df/attributes","cluster-id":"37661d6ee45ed9e8","publish-timeout":"7s"} {"level":"info","ts":"2026-06-17T18:40:56.299741Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-17T18:40:56.299769Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-17T18:40:56.299903Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-17T18:40:56.299969Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-17T18:40:56.3Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-17T18:40:56.3012Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"37661d6ee45ed9e8","local-member-id":"a31e123290fcf0df","cluster-version":"3.5"} {"level":"info","ts":"2026-06-17T18:40:56.301295Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-17T18:40:56.30144Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-17T18:40:56.301676Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.113:2379"} {"level":"info","ts":"2026-06-17T18:40:56.302368Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-17T18:41:34.357823Z","caller":"traceutil/trace.go:171","msg":"trace[569019999] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"100.670252ms","start":"2026-06-17T18:41:34.25713Z","end":"2026-06-17T18:41:34.357801Z","steps":["trace[569019999] 'process raft request' (duration: 95.844515ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:41:34.475849Z","caller":"traceutil/trace.go:171","msg":"trace[1688169098] transaction","detail":"{read_only:false; number_of_response:0; response_revision:540; }","duration":"211.054149ms","start":"2026-06-17T18:41:34.264762Z","end":"2026-06-17T18:41:34.475816Z","steps":["trace[1688169098] 'process raft request' (duration: 210.110606ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:41:34.476048Z","caller":"traceutil/trace.go:171","msg":"trace[675348288] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"211.224332ms","start":"2026-06-17T18:41:34.264788Z","end":"2026-06-17T18:41:34.476013Z","steps":["trace[675348288] 'process raft request' (duration: 210.974917ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:41:34.476306Z","caller":"traceutil/trace.go:171","msg":"trace[761721609] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"211.220153ms","start":"2026-06-17T18:41:34.265041Z","end":"2026-06-17T18:41:34.476261Z","steps":["trace[761721609] 'process raft request' (duration: 210.873224ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:41:34.476437Z","caller":"traceutil/trace.go:171","msg":"trace[174585568] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"210.358293ms","start":"2026-06-17T18:41:34.266061Z","end":"2026-06-17T18:41:34.47642Z","steps":["trace[174585568] 'process raft request' (duration: 210.084126ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:41:34.476523Z","caller":"traceutil/trace.go:171","msg":"trace[993598077] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"205.650748ms","start":"2026-06-17T18:41:34.27086Z","end":"2026-06-17T18:41:34.476511Z","steps":["trace[993598077] 'process raft request' (duration: 205.489085ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:41:34.476652Z","caller":"traceutil/trace.go:171","msg":"trace[117983970] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"201.941147ms","start":"2026-06-17T18:41:34.274699Z","end":"2026-06-17T18:41:34.47664Z","steps":["trace[117983970] 'process raft request' (duration: 201.822035ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:41:34.476665Z","caller":"traceutil/trace.go:171","msg":"trace[1565044182] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"204.432128ms","start":"2026-06-17T18:41:34.272204Z","end":"2026-06-17T18:41:34.476636Z","steps":["trace[1565044182] 'process raft request' (duration: 204.223283ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:41:34.476773Z","caller":"traceutil/trace.go:171","msg":"trace[2009903075] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"170.641418ms","start":"2026-06-17T18:41:34.306121Z","end":"2026-06-17T18:41:34.476762Z","steps":["trace[2009903075] 'process raft request' (duration: 170.540056ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:41:34.476783Z","caller":"traceutil/trace.go:171","msg":"trace[935314680] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"200.603186ms","start":"2026-06-17T18:41:34.276165Z","end":"2026-06-17T18:41:34.476769Z","steps":["trace[935314680] 'process raft request' (duration: 200.414681ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:41:34.476795Z","caller":"traceutil/trace.go:171","msg":"trace[1531212446] linearizableReadLoop","detail":"{readStateIndex:574; appliedIndex:564; }","duration":"128.149418ms","start":"2026-06-17T18:41:34.348615Z","end":"2026-06-17T18:41:34.476764Z","steps":["trace[1531212446] 'read index received' (duration: 4.416478ms)","trace[1531212446] 'applied index is now lower than readState.Index' (duration: 123.73207ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T18:41:34.476944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.310492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-17T18:41:34.477024Z","caller":"traceutil/trace.go:171","msg":"trace[2139524866] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:548; }","duration":"128.413314ms","start":"2026-06-17T18:41:34.3486Z","end":"2026-06-17T18:41:34.477013Z","steps":["trace[2139524866] 'agreement among raft nodes before linearized reading' (duration: 128.252391ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:41:34.485619Z","caller":"traceutil/trace.go:171","msg":"trace[420607330] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"121.24542ms","start":"2026-06-17T18:41:34.364347Z","end":"2026-06-17T18:41:34.485592Z","steps":["trace[420607330] 'process raft request' (duration: 120.0324ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:41:34.485995Z","caller":"traceutil/trace.go:171","msg":"trace[1533959016] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"116.355623ms","start":"2026-06-17T18:41:34.369624Z","end":"2026-06-17T18:41:34.48598Z","steps":["trace[1533959016] 'process raft request' (duration: 114.872426ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:41:40.731772Z","caller":"traceutil/trace.go:171","msg":"trace[982438111] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:654; }","duration":"202.347109ms","start":"2026-06-17T18:41:40.529395Z","end":"2026-06-17T18:41:40.731742Z","steps":["trace[982438111] 'read index received' (duration: 190.371298ms)","trace[982438111] 'applied index is now lower than readState.Index' (duration: 11.974731ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T18:41:40.731993Z","caller":"traceutil/trace.go:171","msg":"trace[39060095] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"320.472543ms","start":"2026-06-17T18:41:40.41143Z","end":"2026-06-17T18:41:40.731903Z","steps":["trace[39060095] 'process raft request' (duration: 308.673847ms)","trace[39060095] 'compare' (duration: 11.222522ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T18:41:40.732115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.705707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-17T18:41:40.732162Z","caller":"traceutil/trace.go:171","msg":"trace[403072783] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:627; }","duration":"202.813699ms","start":"2026-06-17T18:41:40.529335Z","end":"2026-06-17T18:41:40.732149Z","steps":["trace[403072783] 'agreement among raft nodes before linearized reading' (duration: 202.556643ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:41:40.732562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.409073ms","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-06-17T18:41:40.73266Z","caller":"traceutil/trace.go:171","msg":"trace[127226957] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:627; }","duration":"137.581957ms","start":"2026-06-17T18:41:40.595055Z","end":"2026-06-17T18:41:40.732637Z","steps":["trace[127226957] 'agreement among raft nodes before linearized reading' (duration: 137.094265ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:41:40.732715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T18:41:40.411405Z","time spent":"320.707848ms","remote":"127.0.0.1:39986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036109,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-17T18:41:40.90303Z","caller":"traceutil/trace.go:171","msg":"trace[358604009] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"165.167956ms","start":"2026-06-17T18:41:40.737825Z","end":"2026-06-17T18:41:40.902993Z","steps":["trace[358604009] 'process raft request' (duration: 93.941808ms)","trace[358604009] 'compare' (duration: 70.934661ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T18:41:40.903146Z","caller":"traceutil/trace.go:171","msg":"trace[653073947] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"109.496676ms","start":"2026-06-17T18:41:40.793617Z","end":"2026-06-17T18:41:40.903114Z","steps":["trace[653073947] 'process raft request' (duration: 109.269151ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:41:41.984707Z","caller":"traceutil/trace.go:171","msg":"trace[1945204928] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"531.222545ms","start":"2026-06-17T18:41:41.453459Z","end":"2026-06-17T18:41:41.984682Z","steps":["trace[1945204928] 'process raft request' (duration: 531.091402ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:41:41.98485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T18:41:41.453439Z","time spent":"531.353028ms","remote":"127.0.0.1:40210","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":897,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-17T18:41:43.642242Z","caller":"traceutil/trace.go:171","msg":"trace[1281344666] transaction","detail":"{read_only:false; response_revision:672; number_of_response:1; }","duration":"123.245659ms","start":"2026-06-17T18:41:43.518964Z","end":"2026-06-17T18:41:43.64221Z","steps":["trace[1281344666] 'process raft request' (duration: 122.628735ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:41:56.681417Z","caller":"traceutil/trace.go:171","msg":"trace[521069165] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"176.653764ms","start":"2026-06-17T18:41:56.504739Z","end":"2026-06-17T18:41:56.681393Z","steps":["trace[521069165] 'process raft request' (duration: 176.503821ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:43:13.781828Z","caller":"traceutil/trace.go:171","msg":"trace[2102517842] transaction","detail":"{read_only:false; response_revision:1879; number_of_response:1; }","duration":"147.828835ms","start":"2026-06-17T18:43:13.633965Z","end":"2026-06-17T18:43:13.781794Z","steps":["trace[2102517842] 'process raft request' (duration: 109.028103ms)","trace[2102517842] 'compare' (duration: 38.569946ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T18:43:14.273904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.581065ms","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-06-17T18:43:14.274009Z","caller":"traceutil/trace.go:171","msg":"trace[803143138] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1881; }","duration":"207.730598ms","start":"2026-06-17T18:43:14.066256Z","end":"2026-06-17T18:43:14.273986Z","steps":["trace[803143138] 'range keys from in-memory index tree' (duration: 207.203056ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:43:26.640999Z","caller":"traceutil/trace.go:171","msg":"trace[417405714] transaction","detail":"{read_only:false; response_revision:1981; number_of_response:1; }","duration":"251.511635ms","start":"2026-06-17T18:43:26.389463Z","end":"2026-06-17T18:43:26.640975Z","steps":["trace[417405714] 'process raft request' (duration: 251.378592ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:43:26.674325Z","caller":"traceutil/trace.go:171","msg":"trace[345729606] transaction","detail":"{read_only:false; response_revision:1982; number_of_response:1; }","duration":"216.117511ms","start":"2026-06-17T18:43:26.458183Z","end":"2026-06-17T18:43:26.674301Z","steps":["trace[345729606] 'process raft request' (duration: 215.909585ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:43:53.469839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.42146ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-17T18:43:53.469938Z","caller":"traceutil/trace.go:171","msg":"trace[1352361615] linearizableReadLoop","detail":"{readStateIndex:2225; appliedIndex:2224; }","duration":"624.142986ms","start":"2026-06-17T18:43:52.845783Z","end":"2026-06-17T18:43:53.469926Z","steps":["trace[1352361615] 'read index received' (duration: 383.116361ms)","trace[1352361615] 'applied index is now lower than readState.Index' (duration: 241.025565ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T18:43:53.470056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"624.2816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1982"} {"level":"info","ts":"2026-06-17T18:43:53.470025Z","caller":"traceutil/trace.go:171","msg":"trace[528599895] transaction","detail":"{read_only:false; response_revision:2142; number_of_response:1; }","duration":"667.925791ms","start":"2026-06-17T18:43:52.802042Z","end":"2026-06-17T18:43:53.469968Z","steps":["trace[528599895] 'process raft request' (duration: 426.768643ms)","trace[528599895] 'compare' (duration: 240.295347ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T18:43:53.470242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T18:43:52.802021Z","time spent":"668.110155ms","remote":"127.0.0.1:40146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-17T18:43:53.470088Z","caller":"traceutil/trace.go:171","msg":"trace[407366372] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:2142; }","duration":"624.420303ms","start":"2026-06-17T18:43:52.845658Z","end":"2026-06-17T18:43:53.470079Z","steps":["trace[407366372] 'agreement among raft nodes before linearized reading' (duration: 624.324901ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:43:53.470528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T18:43:52.845636Z","time spent":"624.820193ms","remote":"127.0.0.1:40078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":2005,"request content":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" "} {"level":"info","ts":"2026-06-17T18:43:53.525315Z","caller":"traceutil/trace.go:171","msg":"trace[112135644] transaction","detail":"{read_only:false; response_revision:2143; number_of_response:1; }","duration":"619.077916ms","start":"2026-06-17T18:43:52.906205Z","end":"2026-06-17T18:43:53.525283Z","steps":["trace[112135644] 'process raft request' (duration: 618.897012ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:43:53.525497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T18:43:52.906184Z","time spent":"619.20839ms","remote":"127.0.0.1:40146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-17T18:43:53.525488Z","caller":"traceutil/trace.go:171","msg":"trace[491339867] transaction","detail":"{read_only:false; response_revision:2144; number_of_response:1; }","duration":"538.042955ms","start":"2026-06-17T18:43:52.987423Z","end":"2026-06-17T18:43:53.525466Z","steps":["trace[491339867] 'process raft request' (duration: 537.819039ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:43:53.525584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T18:43:52.987396Z","time spent":"538.142388ms","remote":"127.0.0.1:40146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-17T18:43:53.525588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.283066ms","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-06-17T18:43:53.525703Z","caller":"traceutil/trace.go:171","msg":"trace[2128491398] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:2144; }","duration":"224.40732ms","start":"2026-06-17T18:43:53.301238Z","end":"2026-06-17T18:43:53.525645Z","steps":["trace[2128491398] 'agreement among raft nodes before linearized reading' (duration: 224.253697ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:43:53.525765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.50035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-17T18:43:53.525817Z","caller":"traceutil/trace.go:171","msg":"trace[1337242923] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2144; }","duration":"333.580801ms","start":"2026-06-17T18:43:53.192215Z","end":"2026-06-17T18:43:53.525796Z","steps":["trace[1337242923] 'agreement among raft nodes before linearized reading' (duration: 333.509859ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:43:53.525899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T18:43:53.192195Z","time spent":"333.673984ms","remote":"127.0.0.1:39880","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-06-17T18:43:53.525962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"673.339309ms","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-06-17T18:43:53.526095Z","caller":"traceutil/trace.go:171","msg":"trace[2132860571] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2144; }","duration":"673.532874ms","start":"2026-06-17T18:43:52.85253Z","end":"2026-06-17T18:43:53.526063Z","steps":["trace[2132860571] 'agreement among raft nodes before linearized reading' (duration: 673.031242ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:43:53.526218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T18:43:52.852518Z","time spent":"673.690828ms","remote":"127.0.0.1:40146","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-06-17T18:43:53.798628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.127897ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-17T18:43:53.798842Z","caller":"traceutil/trace.go:171","msg":"trace[724718698] linearizableReadLoop","detail":"{readStateIndex:2229; appliedIndex:2227; }","duration":"244.423625ms","start":"2026-06-17T18:43:53.554401Z","end":"2026-06-17T18:43:53.798825Z","steps":["trace[724718698] 'read index received' (duration: 122.768686ms)","trace[724718698] 'applied index is now lower than readState.Index' (duration: 121.653879ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T18:43:53.799025Z","caller":"traceutil/trace.go:171","msg":"trace[976756272] transaction","detail":"{read_only:false; response_revision:2145; number_of_response:1; }","duration":"268.722085ms","start":"2026-06-17T18:43:53.530283Z","end":"2026-06-17T18:43:53.799005Z","steps":["trace[976756272] 'process raft request' (duration: 146.852131ms)","trace[976756272] 'compare' (duration: 120.83929ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T18:43:53.799035Z","caller":"traceutil/trace.go:171","msg":"trace[1529578314] transaction","detail":"{read_only:false; response_revision:2147; number_of_response:1; }","duration":"215.285581ms","start":"2026-06-17T18:43:53.583719Z","end":"2026-06-17T18:43:53.799004Z","steps":["trace[1529578314] 'process raft request' (duration: 215.070356ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:43:53.798931Z","caller":"traceutil/trace.go:171","msg":"trace[653194700] transaction","detail":"{read_only:false; response_revision:2146; number_of_response:1; }","duration":"267.607308ms","start":"2026-06-17T18:43:53.531315Z","end":"2026-06-17T18:43:53.798922Z","steps":["trace[653194700] 'process raft request' (duration: 267.414014ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:43:53.79943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.501268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-17T18:43:53.799331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.865916ms","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-06-17T18:43:53.799504Z","caller":"traceutil/trace.go:171","msg":"trace[18557926] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2147; }","duration":"179.658222ms","start":"2026-06-17T18:43:53.619829Z","end":"2026-06-17T18:43:53.799488Z","steps":["trace[18557926] 'agreement among raft nodes before linearized reading' (duration: 179.339664ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:43:53.799536Z","caller":"traceutil/trace.go:171","msg":"trace[1663539293] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2147; }","duration":"245.141292ms","start":"2026-06-17T18:43:53.554373Z","end":"2026-06-17T18:43:53.799515Z","steps":["trace[1663539293] 'agreement among raft nodes before linearized reading' (duration: 244.567999ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:44:00.035832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.898775ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-17T18:44:00.035982Z","caller":"traceutil/trace.go:171","msg":"trace[1913825325] linearizableReadLoop","detail":"{readStateIndex:2257; appliedIndex:2256; }","duration":"664.487988ms","start":"2026-06-17T18:43:59.371451Z","end":"2026-06-17T18:44:00.035939Z","steps":["trace[1913825325] 'read index received' (duration: 117.332136ms)","trace[1913825325] 'applied index is now lower than readState.Index' (duration: 547.153242ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T18:44:00.036073Z","caller":"traceutil/trace.go:171","msg":"trace[110386969] transaction","detail":"{read_only:false; response_revision:2172; number_of_response:1; }","duration":"665.926632ms","start":"2026-06-17T18:43:59.370134Z","end":"2026-06-17T18:44:00.036061Z","steps":["trace[110386969] 'process raft request' (duration: 118.651717ms)","trace[110386969] 'compare' (duration: 546.612938ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T18:44:00.036143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T18:43:59.370108Z","time spent":"665.998654ms","remote":"127.0.0.1:39918","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-17T18:44:00.036472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"664.990271ms","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-06-17T18:44:00.036582Z","caller":"traceutil/trace.go:171","msg":"trace[1498039873] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:2172; }","duration":"665.145213ms","start":"2026-06-17T18:43:59.371408Z","end":"2026-06-17T18:44:00.036553Z","steps":["trace[1498039873] 'agreement among raft nodes before linearized reading' (duration: 664.892378ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:44:00.03664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T18:43:59.371384Z","time spent":"665.239816ms","remote":"127.0.0.1:40340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":11,"response size":30,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true "} {"level":"info","ts":"2026-06-17T18:44:00.03737Z","caller":"traceutil/trace.go:171","msg":"trace[467449308] transaction","detail":"{read_only:false; response_revision:2173; number_of_response:1; }","duration":"491.313399ms","start":"2026-06-17T18:43:59.54604Z","end":"2026-06-17T18:44:00.037354Z","steps":["trace[467449308] 'process raft request' (duration: 491.170896ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:44:00.037479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T18:43:59.546006Z","time spent":"491.422482ms","remote":"127.0.0.1:40146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-17T18:44:00.093024Z","caller":"traceutil/trace.go:171","msg":"trace[1802698175] transaction","detail":"{read_only:false; response_revision:2174; number_of_response:1; }","duration":"275.393924ms","start":"2026-06-17T18:43:59.817591Z","end":"2026-06-17T18:44:00.092985Z","steps":["trace[1802698175] 'process raft request' (duration: 275.116537ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:44:00.09309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.613789ms","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-06-17T18:44:00.093159Z","caller":"traceutil/trace.go:171","msg":"trace[1262968600] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2174; }","duration":"249.718101ms","start":"2026-06-17T18:43:59.843422Z","end":"2026-06-17T18:44:00.09314Z","steps":["trace[1262968600] 'agreement among raft nodes before linearized reading' (duration: 249.460865ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:44:00.093229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.609047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-17T18:44:00.093247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.253689ms","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-06-17T18:44:00.093254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"595.591536ms","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-06-17T18:44:00.093319Z","caller":"traceutil/trace.go:171","msg":"trace[485799699] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2174; }","duration":"272.324931ms","start":"2026-06-17T18:43:59.820975Z","end":"2026-06-17T18:44:00.0933Z","steps":["trace[485799699] 'agreement among raft nodes before linearized reading' (duration: 272.156037ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:44:00.093328Z","caller":"traceutil/trace.go:171","msg":"trace[2106627484] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2174; }","duration":"272.73045ms","start":"2026-06-17T18:43:59.820559Z","end":"2026-06-17T18:44:00.093289Z","steps":["trace[2106627484] 'agreement among raft nodes before linearized reading' (duration: 272.592656ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:44:00.09334Z","caller":"traceutil/trace.go:171","msg":"trace[329787056] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2174; }","duration":"595.723789ms","start":"2026-06-17T18:43:59.497591Z","end":"2026-06-17T18:44:00.093315Z","steps":["trace[329787056] 'agreement among raft nodes before linearized reading' (duration: 595.441233ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:44:00.093393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T18:43:59.497568Z","time spent":"595.811662ms","remote":"127.0.0.1:40146","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-06-17T18:44:00.09309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.802305ms","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-06-17T18:44:00.093558Z","caller":"traceutil/trace.go:171","msg":"trace[845939584] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2174; }","duration":"232.305526ms","start":"2026-06-17T18:43:59.86123Z","end":"2026-06-17T18:44:00.093536Z","steps":["trace[845939584] 'agreement among raft nodes before linearized reading' (duration: 231.636561ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:44:00.402234Z","caller":"traceutil/trace.go:171","msg":"trace[32310910] transaction","detail":"{read_only:false; response_revision:2175; number_of_response:1; }","duration":"304.114188ms","start":"2026-06-17T18:44:00.098084Z","end":"2026-06-17T18:44:00.402198Z","steps":["trace[32310910] 'process raft request' (duration: 303.926684ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:44:00.402447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T18:44:00.098051Z","time spent":"304.273822ms","remote":"127.0.0.1:40146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-17T18:44:00.460847Z","caller":"traceutil/trace.go:171","msg":"trace[1995153850] transaction","detail":"{read_only:false; response_revision:2177; number_of_response:1; }","duration":"362.137811ms","start":"2026-06-17T18:44:00.098674Z","end":"2026-06-17T18:44:00.460812Z","steps":["trace[1995153850] 'process raft request' (duration: 362.046879ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:44:00.460921Z","caller":"traceutil/trace.go:171","msg":"trace[7945471] transaction","detail":"{read_only:false; response_revision:2176; number_of_response:1; }","duration":"362.253084ms","start":"2026-06-17T18:44:00.098602Z","end":"2026-06-17T18:44:00.460855Z","steps":["trace[7945471] 'process raft request' (duration: 361.891836ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:44:00.461027Z","caller":"traceutil/trace.go:171","msg":"trace[831104837] linearizableReadLoop","detail":"{readStateIndex:2263; appliedIndex:2259; }","duration":"267.740361ms","start":"2026-06-17T18:44:00.193249Z","end":"2026-06-17T18:44:00.460989Z","steps":["trace[831104837] 'read index received' (duration: 208.801357ms)","trace[831104837] 'applied index is now lower than readState.Index' (duration: 58.935824ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T18:44:00.46107Z","caller":"traceutil/trace.go:171","msg":"trace[1703839764] transaction","detail":"{read_only:false; response_revision:2178; number_of_response:1; }","duration":"361.578878ms","start":"2026-06-17T18:44:00.099455Z","end":"2026-06-17T18:44:00.461034Z","steps":["trace[1703839764] 'process raft request' (duration: 361.311172ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:44:00.461104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T18:44:00.098665Z","time spent":"362.305735ms","remote":"127.0.0.1:40146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-17T18:44:00.46114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T18:44:00.098584Z","time spent":"362.429888ms","remote":"127.0.0.1:40146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-17T18:44:00.4612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T18:44:00.099444Z","time spent":"361.689211ms","remote":"127.0.0.1:40146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-17T18:44:00.461273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.026178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-17T18:44:00.461299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.419246ms","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-06-17T18:44:00.461343Z","caller":"traceutil/trace.go:171","msg":"trace[1075913379] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2178; }","duration":"268.14708ms","start":"2026-06-17T18:44:00.193177Z","end":"2026-06-17T18:44:00.461324Z","steps":["trace[1075913379] 'agreement among raft nodes before linearized reading' (duration: 267.999287ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:44:00.461353Z","caller":"traceutil/trace.go:171","msg":"trace[585464373] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2178; }","duration":"252.523129ms","start":"2026-06-17T18:44:00.208817Z","end":"2026-06-17T18:44:00.46134Z","steps":["trace[585464373] 'agreement among raft nodes before linearized reading' (duration: 252.362705ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:44:01.162233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"579.993374ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-17T18:44:01.162413Z","caller":"traceutil/trace.go:171","msg":"trace[1091490485] transaction","detail":"{read_only:false; response_revision:2180; number_of_response:1; }","duration":"635.391405ms","start":"2026-06-17T18:44:00.526996Z","end":"2026-06-17T18:44:01.162387Z","steps":["trace[1091490485] 'process raft request' (duration: 635.323333ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:44:01.162469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T18:44:00.526971Z","time spent":"635.474507ms","remote":"127.0.0.1:40146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-17T18:44:01.162644Z","caller":"traceutil/trace.go:171","msg":"trace[38595751] transaction","detail":"{read_only:false; response_revision:2179; number_of_response:1; }","duration":"697.151237ms","start":"2026-06-17T18:44:00.465455Z","end":"2026-06-17T18:44:01.162607Z","steps":["trace[38595751] 'process raft request' (duration: 116.703852ms)","trace[38595751] 'compare' (duration: 579.82397ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T18:44:01.162985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T18:44:00.465433Z","time spent":"697.30295ms","remote":"127.0.0.1:40146","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-06-17T18:44:01.50076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.329641ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-17T18:44:01.500923Z","caller":"traceutil/trace.go:171","msg":"trace[800411209] transaction","detail":"{read_only:false; response_revision:2181; number_of_response:1; }","duration":"741.982105ms","start":"2026-06-17T18:44:00.758921Z","end":"2026-06-17T18:44:01.500903Z","steps":["trace[800411209] 'process raft request' (duration: 547.426787ms)","trace[800411209] 'compare' (duration: 194.213829ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T18:44:01.500991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T18:44:00.758882Z","time spent":"742.079707ms","remote":"127.0.0.1:40146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-17T18:44:01.501378Z","caller":"traceutil/trace.go:171","msg":"trace[2096186385] transaction","detail":"{read_only:false; response_revision:2182; number_of_response:1; }","duration":"710.403572ms","start":"2026-06-17T18:44:00.79093Z","end":"2026-06-17T18:44:01.501333Z","steps":["trace[2096186385] 'process raft request' (duration: 709.92901ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:44:01.501615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T18:44:00.790893Z","time spent":"710.598407ms","remote":"127.0.0.1:40146","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-06-17T18:44:01.501759Z","caller":"traceutil/trace.go:171","msg":"trace[2043446824] linearizableReadLoop","detail":"{readStateIndex:2268; appliedIndex:2265; }","duration":"399.456222ms","start":"2026-06-17T18:44:01.102287Z","end":"2026-06-17T18:44:01.501743Z","steps":["trace[2043446824] 'read index received' (duration: 204.024883ms)","trace[2043446824] 'applied index is now lower than readState.Index' (duration: 195.430388ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T18:44:01.501854Z","caller":"traceutil/trace.go:171","msg":"trace[1883819876] transaction","detail":"{read_only:false; response_revision:2183; number_of_response:1; }","duration":"468.527847ms","start":"2026-06-17T18:44:01.033281Z","end":"2026-06-17T18:44:01.501809Z","steps":["trace[1883819876] 'process raft request' (duration: 467.904152ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:44:01.502021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.721998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-06-17T18:44:01.50205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T18:44:01.033252Z","time spent":"468.698331ms","remote":"127.0.0.1:40146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-17T18:44:01.502071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.284086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18b9f28e76cafc64\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-06-17T18:44:01.502097Z","caller":"traceutil/trace.go:171","msg":"trace[2134276536] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2183; }","duration":"399.83195ms","start":"2026-06-17T18:44:01.102239Z","end":"2026-06-17T18:44:01.502071Z","steps":["trace[2134276536] 'agreement among raft nodes before linearized reading' (duration: 399.607915ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:44:01.502141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T18:44:01.102215Z","time spent":"399.915752ms","remote":"127.0.0.1:45122","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-06-17T18:44:01.502146Z","caller":"traceutil/trace.go:171","msg":"trace[1790066992] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18b9f28e76cafc64; range_end:; response_count:1; response_revision:2183; }","duration":"198.361008ms","start":"2026-06-17T18:44:01.303743Z","end":"2026-06-17T18:44:01.502104Z","steps":["trace[1790066992] 'agreement among raft nodes before linearized reading' (duration: 198.130763ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:44:02.098273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.308927ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"warn","ts":"2026-06-17T18:44:02.098544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T18:44:01.504812Z","time spent":"593.72466ms","remote":"127.0.0.1:39966","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-17T18:44:02.098758Z","caller":"traceutil/trace.go:171","msg":"trace[2015680375] linearizableReadLoop","detail":"{readStateIndex:2269; appliedIndex:2268; }","duration":"587.794319ms","start":"2026-06-17T18:44:01.510943Z","end":"2026-06-17T18:44:02.098737Z","steps":["trace[2015680375] 'read index received' (duration: 93.881508ms)","trace[2015680375] 'applied index is now lower than readState.Index' (duration: 493.911411ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T18:44:02.099052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.641559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-17T18:44:02.099086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.598514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-17T18:44:02.099064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"588.056446ms","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-06-17T18:44:02.09918Z","caller":"traceutil/trace.go:171","msg":"trace[2142430912] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:2184; }","duration":"540.751108ms","start":"2026-06-17T18:44:01.558409Z","end":"2026-06-17T18:44:02.09916Z","steps":["trace[2142430912] 'agreement among raft nodes before linearized reading' (duration: 540.459571ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:44:02.099209Z","caller":"traceutil/trace.go:171","msg":"trace[205798715] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2184; }","duration":"588.26473ms","start":"2026-06-17T18:44:01.510916Z","end":"2026-06-17T18:44:02.09918Z","steps":["trace[205798715] 'agreement among raft nodes before linearized reading' (duration: 587.925622ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:44:02.099237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T18:44:01.558395Z","time spent":"540.831669ms","remote":"127.0.0.1:40210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":23,"response size":30,"request content":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true "} {"level":"warn","ts":"2026-06-17T18:44:02.099275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T18:44:01.510905Z","time spent":"588.358622ms","remote":"127.0.0.1:40340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":28,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"info","ts":"2026-06-17T18:44:02.099373Z","caller":"traceutil/trace.go:171","msg":"trace[1187492826] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:2184; }","duration":"356.821683ms","start":"2026-06-17T18:44:01.742312Z","end":"2026-06-17T18:44:02.099133Z","steps":["trace[1187492826] 'agreement among raft nodes before linearized reading' (duration: 356.583308ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:44:02.099698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T18:44:01.742286Z","time spent":"357.382297ms","remote":"127.0.0.1:52252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-17T18:44:02.099074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.756639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-06-17T18:44:02.099938Z","caller":"traceutil/trace.go:171","msg":"trace[147668360] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2184; }","duration":"489.641599ms","start":"2026-06-17T18:44:01.610256Z","end":"2026-06-17T18:44:02.099898Z","steps":["trace[147668360] 'agreement among raft nodes before linearized reading' (duration: 488.607495ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:44:02.09905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"550.035198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-17T18:44:02.100067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T18:44:01.610238Z","time spent":"489.790572ms","remote":"127.0.0.1:40146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":582,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"info","ts":"2026-06-17T18:44:02.100113Z","caller":"traceutil/trace.go:171","msg":"trace[142201724] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:2184; }","duration":"551.129084ms","start":"2026-06-17T18:44:01.548949Z","end":"2026-06-17T18:44:02.100078Z","steps":["trace[142201724] 'agreement among raft nodes before linearized reading' (duration: 549.922526ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:44:02.100202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T18:44:01.548931Z","time spent":"551.246977ms","remote":"127.0.0.1:40126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "} {"level":"info","ts":"2026-06-17T18:44:08.220687Z","caller":"traceutil/trace.go:171","msg":"trace[1870810707] transaction","detail":"{read_only:false; response_revision:2217; number_of_response:1; }","duration":"102.666716ms","start":"2026-06-17T18:44:08.117992Z","end":"2026-06-17T18:44:08.220659Z","steps":["trace[1870810707] 'process raft request' (duration: 102.467311ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:44:55.999567Z","caller":"traceutil/trace.go:171","msg":"trace[311714225] transaction","detail":"{read_only:false; response_revision:2649; number_of_response:1; }","duration":"270.570503ms","start":"2026-06-17T18:44:55.72897Z","end":"2026-06-17T18:44:55.999541Z","steps":["trace[311714225] 'process raft request' (duration: 270.402079ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:44:56.014067Z","caller":"traceutil/trace.go:171","msg":"trace[294045945] transaction","detail":"{read_only:false; response_revision:2650; number_of_response:1; }","duration":"281.363933ms","start":"2026-06-17T18:44:55.732683Z","end":"2026-06-17T18:44:56.014047Z","steps":["trace[294045945] 'process raft request' (duration: 281.264101ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:45:29.253877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.036806ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-17T18:45:29.254051Z","caller":"traceutil/trace.go:171","msg":"trace[252174899] transaction","detail":"{read_only:false; response_revision:2849; number_of_response:1; }","duration":"258.058852ms","start":"2026-06-17T18:45:28.995969Z","end":"2026-06-17T18:45:29.254028Z","steps":["trace[252174899] 'process raft request' (duration: 51.757258ms)","trace[252174899] 'compare' (duration: 205.860792ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T18:45:29.254645Z","caller":"traceutil/trace.go:171","msg":"trace[233826209] transaction","detail":"{read_only:false; response_revision:2851; number_of_response:1; }","duration":"256.675328ms","start":"2026-06-17T18:45:28.99794Z","end":"2026-06-17T18:45:29.254615Z","steps":["trace[233826209] 'process raft request' (duration: 256.629417ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:45:29.254671Z","caller":"traceutil/trace.go:171","msg":"trace[592057495] transaction","detail":"{read_only:false; response_revision:2850; number_of_response:1; }","duration":"258.093623ms","start":"2026-06-17T18:45:28.99655Z","end":"2026-06-17T18:45:29.254644Z","steps":["trace[592057495] 'process raft request' (duration: 257.878207ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:49:37.567714Z","caller":"traceutil/trace.go:171","msg":"trace[1465646789] transaction","detail":"{read_only:false; response_revision:5084; number_of_response:1; }","duration":"110.465269ms","start":"2026-06-17T18:49:37.457166Z","end":"2026-06-17T18:49:37.567632Z","steps":["trace[1465646789] 'process raft request' (duration: 110.251924ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:49:39.219881Z","caller":"traceutil/trace.go:171","msg":"trace[1830808333] transaction","detail":"{read_only:false; response_revision:5112; number_of_response:1; }","duration":"105.615917ms","start":"2026-06-17T18:49:39.114213Z","end":"2026-06-17T18:49:39.219829Z","steps":["trace[1830808333] 'process raft request' (duration: 105.534015ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:49:39.219878Z","caller":"traceutil/trace.go:171","msg":"trace[847417290] transaction","detail":"{read_only:false; response_revision:5111; number_of_response:1; }","duration":"106.849775ms","start":"2026-06-17T18:49:39.112969Z","end":"2026-06-17T18:49:39.219818Z","steps":["trace[847417290] 'process raft request' (duration: 75.542727ms)","trace[847417290] 'compare' (duration: 31.067393ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T18:49:51.805852Z","caller":"traceutil/trace.go:171","msg":"trace[1955702691] linearizableReadLoop","detail":"{readStateIndex:5563; appliedIndex:5562; }","duration":"142.787021ms","start":"2026-06-17T18:49:51.663034Z","end":"2026-06-17T18:49:51.805821Z","steps":["trace[1955702691] 'read index received' (duration: 142.611697ms)","trace[1955702691] 'applied index is now lower than readState.Index' (duration: 174.064µs)"],"step_count":2} {"level":"info","ts":"2026-06-17T18:49:51.805967Z","caller":"traceutil/trace.go:171","msg":"trace[571225206] transaction","detail":"{read_only:false; response_revision:5359; number_of_response:1; }","duration":"178.778044ms","start":"2026-06-17T18:49:51.627153Z","end":"2026-06-17T18:49:51.805931Z","steps":["trace[571225206] 'process raft request' (duration: 178.464727ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:49:51.806113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.046777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-84brq\" ","response":"range_response_count:1 size:6522"} {"level":"info","ts":"2026-06-17T18:49:51.806146Z","caller":"traceutil/trace.go:171","msg":"trace[493546541] range","detail":"{range_begin:/registry/pods/openstack/keepalived-84brq; range_end:; response_count:1; response_revision:5359; }","duration":"143.15639ms","start":"2026-06-17T18:49:51.662981Z","end":"2026-06-17T18:49:51.806138Z","steps":["trace[493546541] 'agreement among raft nodes before linearized reading' (duration: 142.958455ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:49:51.908486Z","caller":"traceutil/trace.go:171","msg":"trace[1306630529] transaction","detail":"{read_only:false; response_revision:5360; number_of_response:1; }","duration":"182.664557ms","start":"2026-06-17T18:49:51.725783Z","end":"2026-06-17T18:49:51.908448Z","steps":["trace[1306630529] 'process raft request' (duration: 182.349389ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:49:52.822063Z","caller":"traceutil/trace.go:171","msg":"trace[2127345971] transaction","detail":"{read_only:false; response_revision:5380; number_of_response:1; }","duration":"118.876215ms","start":"2026-06-17T18:49:52.703087Z","end":"2026-06-17T18:49:52.821963Z","steps":["trace[2127345971] 'process raft request' (duration: 105.592291ms)","trace[2127345971] 'compare' (duration: 13.121691ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T18:50:00.207149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.776752ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-17T18:50:00.207263Z","caller":"traceutil/trace.go:171","msg":"trace[714087226] linearizableReadLoop","detail":"{readStateIndex:5757; appliedIndex:5756; }","duration":"257.072268ms","start":"2026-06-17T18:49:59.950172Z","end":"2026-06-17T18:50:00.207244Z","steps":["trace[714087226] 'read index received' (duration: 65.03542ms)","trace[714087226] 'applied index is now lower than readState.Index' (duration: 192.035528ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T18:50:00.207339Z","caller":"traceutil/trace.go:171","msg":"trace[1007803695] transaction","detail":"{read_only:false; response_revision:5548; number_of_response:1; }","duration":"267.28841ms","start":"2026-06-17T18:49:59.940009Z","end":"2026-06-17T18:50:00.207298Z","steps":["trace[1007803695] 'process raft request' (duration: 75.280722ms)","trace[1007803695] 'compare' (duration: 191.518246ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T18:50:00.207466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.296323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-84brq\" ","response":"range_response_count:1 size:6522"} {"level":"info","ts":"2026-06-17T18:50:00.207513Z","caller":"traceutil/trace.go:171","msg":"trace[557897920] range","detail":"{range_begin:/registry/pods/openstack/keepalived-84brq; range_end:; response_count:1; response_revision:5548; }","duration":"257.387705ms","start":"2026-06-17T18:49:59.950113Z","end":"2026-06-17T18:50:00.207501Z","steps":["trace[557897920] 'agreement among raft nodes before linearized reading' (duration: 257.225831ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:50:56.33215Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3000} {"level":"info","ts":"2026-06-17T18:50:56.403102Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3000,"took":"69.221338ms","hash":1413723310,"current-db-size-bytes":57065472,"current-db-size":"57 MB","current-db-size-in-use-bytes":33808384,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-17T18:50:56.403182Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1413723310,"revision":3000,"compact-revision":-1} {"level":"info","ts":"2026-06-17T18:55:56.338282Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6048} {"level":"info","ts":"2026-06-17T18:55:56.436197Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6048,"took":"94.879864ms","hash":82521760,"current-db-size-bytes":57065472,"current-db-size":"57 MB","current-db-size-in-use-bytes":21700608,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-06-17T18:55:56.43645Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":82521760,"revision":6048,"compact-revision":3000} {"level":"warn","ts":"2026-06-17T18:56:21.943568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T18:56:21.605077Z","time spent":"338.476268ms","remote":"127.0.0.1:52682","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-06-17T18:56:21.943588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.953852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-55b9c5d644-5778r.18b9f33d26ac37cd\" ","response":"range_response_count:1 size:1135"} {"level":"info","ts":"2026-06-17T18:56:21.94369Z","caller":"traceutil/trace.go:171","msg":"trace[1433360706] range","detail":"{range_begin:/registry/events/openstack/barbican-api-55b9c5d644-5778r.18b9f33d26ac37cd; range_end:; response_count:1; response_revision:8424; }","duration":"375.097566ms","start":"2026-06-17T18:56:21.568569Z","end":"2026-06-17T18:56:21.943667Z","steps":["trace[1433360706] 'range keys from in-memory index tree' (duration: 374.804879ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:56:21.943731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T18:56:21.568553Z","time spent":"375.167797ms","remote":"127.0.0.1:39966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":1158,"request content":"key:\"/registry/events/openstack/barbican-api-55b9c5d644-5778r.18b9f33d26ac37cd\" "} {"level":"warn","ts":"2026-06-17T18:56:21.943879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.416286ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-17T18:56:21.943995Z","caller":"traceutil/trace.go:171","msg":"trace[606802811] transaction","detail":"{read_only:false; response_revision:8425; number_of_response:1; }","duration":"313.471246ms","start":"2026-06-17T18:56:21.630509Z","end":"2026-06-17T18:56:21.94398Z","steps":["trace[606802811] 'process raft request' (duration: 141.883115ms)","trace[606802811] 'compare' (duration: 171.155049ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T18:56:21.944054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T18:56:21.630488Z","time spent":"313.537947ms","remote":"127.0.0.1:40146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-17T18:56:33.371916Z","caller":"traceutil/trace.go:171","msg":"trace[1211368885] transaction","detail":"{read_only:false; response_revision:8485; number_of_response:1; }","duration":"126.463559ms","start":"2026-06-17T18:56:33.245415Z","end":"2026-06-17T18:56:33.371878Z","steps":["trace[1211368885] 'process raft request' (duration: 126.244504ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:56:35.04853Z","caller":"traceutil/trace.go:171","msg":"trace[70950803] transaction","detail":"{read_only:false; response_revision:8490; number_of_response:1; }","duration":"162.777951ms","start":"2026-06-17T18:56:34.885727Z","end":"2026-06-17T18:56:35.048505Z","steps":["trace[70950803] 'process raft request' (duration: 162.563206ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:56:35.103281Z","caller":"traceutil/trace.go:171","msg":"trace[1900908178] linearizableReadLoop","detail":"{readStateIndex:8797; appliedIndex:8795; }","duration":"168.560488ms","start":"2026-06-17T18:56:34.934689Z","end":"2026-06-17T18:56:35.103249Z","steps":["trace[1900908178] 'read index received' (duration: 113.617184ms)","trace[1900908178] 'applied index is now lower than readState.Index' (duration: 54.941674ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T18:56:35.10337Z","caller":"traceutil/trace.go:171","msg":"trace[980930167] transaction","detail":"{read_only:false; response_revision:8491; number_of_response:1; }","duration":"215.395079ms","start":"2026-06-17T18:56:34.887941Z","end":"2026-06-17T18:56:35.103336Z","steps":["trace[980930167] 'process raft request' (duration: 188.262335ms)","trace[980930167] 'compare' (duration: 26.878218ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T18:56:35.103487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.790323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-17T18:56:35.103526Z","caller":"traceutil/trace.go:171","msg":"trace[1309971160] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8491; }","duration":"168.884765ms","start":"2026-06-17T18:56:34.934632Z","end":"2026-06-17T18:56:35.103516Z","steps":["trace[1309971160] 'agreement among raft nodes before linearized reading' (duration: 168.731462ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:56:35.103534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.534446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-06-17T18:56:35.103565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.066673ms","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-06-17T18:56:35.103594Z","caller":"traceutil/trace.go:171","msg":"trace[472878503] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8491; }","duration":"165.636449ms","start":"2026-06-17T18:56:34.937944Z","end":"2026-06-17T18:56:35.10358Z","steps":["trace[472878503] 'agreement among raft nodes before linearized reading' (duration: 165.490485ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:56:35.10363Z","caller":"traceutil/trace.go:171","msg":"trace[518164120] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8491; }","duration":"159.146285ms","start":"2026-06-17T18:56:34.944469Z","end":"2026-06-17T18:56:35.103615Z","steps":["trace[518164120] 'agreement among raft nodes before linearized reading' (duration: 158.996301ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:57:02.283366Z","caller":"traceutil/trace.go:171","msg":"trace[1513111702] transaction","detail":"{read_only:false; response_revision:8694; number_of_response:1; }","duration":"184.490305ms","start":"2026-06-17T18:57:02.098857Z","end":"2026-06-17T18:57:02.283348Z","steps":["trace[1513111702] 'process raft request' (duration: 184.168738ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:57:02.481678Z","caller":"traceutil/trace.go:171","msg":"trace[1012182635] transaction","detail":"{read_only:false; response_revision:8695; number_of_response:1; }","duration":"170.967126ms","start":"2026-06-17T18:57:02.310691Z","end":"2026-06-17T18:57:02.481659Z","steps":["trace[1012182635] 'process raft request' (duration: 118.172433ms)","trace[1012182635] 'compare' (duration: 52.66511ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T18:57:14.891547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.026186ms","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-06-17T18:57:14.891632Z","caller":"traceutil/trace.go:171","msg":"trace[2134099041] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8800; }","duration":"136.160979ms","start":"2026-06-17T18:57:14.755451Z","end":"2026-06-17T18:57:14.891612Z","steps":["trace[2134099041] 'range keys from in-memory index tree' (duration: 135.80082ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:57:14.891883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.621332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-84brq\" ","response":"range_response_count:1 size:6522"} {"level":"info","ts":"2026-06-17T18:57:14.892032Z","caller":"traceutil/trace.go:171","msg":"trace[152066855] range","detail":"{range_begin:/registry/pods/openstack/keepalived-84brq; range_end:; response_count:1; response_revision:8800; }","duration":"123.861597ms","start":"2026-06-17T18:57:14.768145Z","end":"2026-06-17T18:57:14.892007Z","steps":["trace[152066855] 'range keys from in-memory index tree' (duration: 123.342206ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:57:15.638206Z","caller":"traceutil/trace.go:171","msg":"trace[1292762862] linearizableReadLoop","detail":"{readStateIndex:9129; appliedIndex:9128; }","duration":"133.110958ms","start":"2026-06-17T18:57:15.505074Z","end":"2026-06-17T18:57:15.638185Z","steps":["trace[1292762862] 'read index received' (duration: 132.980185ms)","trace[1292762862] 'applied index is now lower than readState.Index' (duration: 130.193µs)"],"step_count":2} {"level":"info","ts":"2026-06-17T18:57:15.638259Z","caller":"traceutil/trace.go:171","msg":"trace[778020064] transaction","detail":"{read_only:false; response_revision:8809; number_of_response:1; }","duration":"251.069446ms","start":"2026-06-17T18:57:15.387164Z","end":"2026-06-17T18:57:15.638233Z","steps":["trace[778020064] 'process raft request' (duration: 250.901182ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:57:15.638736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.65115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-17T18:57:15.638763Z","caller":"traceutil/trace.go:171","msg":"trace[2020315865] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:8809; }","duration":"133.738772ms","start":"2026-06-17T18:57:15.505019Z","end":"2026-06-17T18:57:15.638758Z","steps":["trace[2020315865] 'agreement among raft nodes before linearized reading' (duration: 133.250071ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:57:15.66084Z","caller":"traceutil/trace.go:171","msg":"trace[1701924028] transaction","detail":"{read_only:false; response_revision:8810; number_of_response:1; }","duration":"122.381903ms","start":"2026-06-17T18:57:15.538435Z","end":"2026-06-17T18:57:15.660817Z","steps":["trace[1701924028] 'process raft request' (duration: 121.812859ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T18:57:15.949383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.182338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-17T18:57:15.949656Z","caller":"traceutil/trace.go:171","msg":"trace[1057643648] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8811; }","duration":"111.502794ms","start":"2026-06-17T18:57:15.838135Z","end":"2026-06-17T18:57:15.949638Z","steps":["trace[1057643648] 'range keys from in-memory index tree' (duration: 110.995583ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:57:27.867812Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002405.wal"} {"level":"info","ts":"2026-06-17T18:58:34.802973Z","caller":"traceutil/trace.go:171","msg":"trace[828637765] transaction","detail":"{read_only:false; response_revision:9573; number_of_response:1; }","duration":"144.740895ms","start":"2026-06-17T18:58:34.6582Z","end":"2026-06-17T18:58:34.80294Z","steps":["trace[828637765] 'process raft request' (duration: 144.55748ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T18:58:45.464737Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a31e123290fcf0df","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-17T18:58:45.470547Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-06-17T18:58:45.470641Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-06-17T19:00:56.344947Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8111} {"level":"info","ts":"2026-06-17T19:00:56.406711Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8111,"took":"60.305578ms","hash":828298943,"current-db-size-bytes":57065472,"current-db-size":"57 MB","current-db-size-in-use-bytes":28532736,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-06-17T19:00:56.406829Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":828298943,"revision":8111,"compact-revision":6048} {"level":"warn","ts":"2026-06-17T19:04:07.648979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.347529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-17T19:04:07.64907Z","caller":"traceutil/trace.go:171","msg":"trace[865071284] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:11978; }","duration":"199.490133ms","start":"2026-06-17T19:04:07.449565Z","end":"2026-06-17T19:04:07.649055Z","steps":["trace[865071284] 'range keys from in-memory index tree' (duration: 199.177785ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T19:05:56.350417Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10523} {"level":"info","ts":"2026-06-17T19:05:56.427736Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10523,"took":"75.191603ms","hash":3342083097,"current-db-size-bytes":57065472,"current-db-size":"57 MB","current-db-size-in-use-bytes":26746880,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-06-17T19:05:56.427808Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3342083097,"revision":10523,"compact-revision":8111} {"level":"warn","ts":"2026-06-17T19:10:35.073879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.392586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-84brq\" ","response":"range_response_count:1 size:6522"} {"level":"info","ts":"2026-06-17T19:10:35.073964Z","caller":"traceutil/trace.go:171","msg":"trace[1283421150] range","detail":"{range_begin:/registry/pods/openstack/keepalived-84brq; range_end:; response_count:1; response_revision:14601; }","duration":"196.517399ms","start":"2026-06-17T19:10:34.877429Z","end":"2026-06-17T19:10:35.073946Z","steps":["trace[1283421150] 'range keys from in-memory index tree' (duration: 196.220062ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T19:10:50.884484Z","caller":"traceutil/trace.go:171","msg":"trace[533679476] linearizableReadLoop","detail":"{readStateIndex:15214; appliedIndex:15213; }","duration":"134.136108ms","start":"2026-06-17T19:10:50.750327Z","end":"2026-06-17T19:10:50.884463Z","steps":["trace[533679476] 'read index received' (duration: 133.971774ms)","trace[533679476] 'applied index is now lower than readState.Index' (duration: 163.624µs)"],"step_count":2} {"level":"info","ts":"2026-06-17T19:10:50.884573Z","caller":"traceutil/trace.go:171","msg":"trace[291807490] transaction","detail":"{read_only:false; response_revision:14698; number_of_response:1; }","duration":"243.653623ms","start":"2026-06-17T19:10:50.640912Z","end":"2026-06-17T19:10:50.884565Z","steps":["trace[291807490] 'process raft request' (duration: 243.440598ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T19:10:50.885023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.66577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/openvswitch-spx8k\" ","response":"range_response_count:1 size:12364"} {"level":"info","ts":"2026-06-17T19:10:50.885105Z","caller":"traceutil/trace.go:171","msg":"trace[550199786] range","detail":"{range_begin:/registry/pods/openstack/openvswitch-spx8k; range_end:; response_count:1; response_revision:14698; }","duration":"134.792404ms","start":"2026-06-17T19:10:50.750295Z","end":"2026-06-17T19:10:50.885087Z","steps":["trace[550199786] 'agreement among raft nodes before linearized reading' (duration: 134.512207ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T19:10:51.055914Z","caller":"traceutil/trace.go:171","msg":"trace[2044457495] transaction","detail":"{read_only:false; response_revision:14699; number_of_response:1; }","duration":"165.137994ms","start":"2026-06-17T19:10:50.890747Z","end":"2026-06-17T19:10:51.055885Z","steps":["trace[2044457495] 'process raft request' (duration: 146.818124ms)","trace[2044457495] 'compare' (duration: 18.157376ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T19:10:51.068329Z","caller":"traceutil/trace.go:171","msg":"trace[479381402] linearizableReadLoop","detail":"{readStateIndex:15216; appliedIndex:15214; }","duration":"142.809107ms","start":"2026-06-17T19:10:50.925506Z","end":"2026-06-17T19:10:51.068315Z","steps":["trace[479381402] 'read index received' (duration: 112.073017ms)","trace[479381402] 'applied index is now lower than readState.Index' (duration: 30.73508ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T19:10:51.068442Z","caller":"traceutil/trace.go:171","msg":"trace[554171346] transaction","detail":"{read_only:false; response_revision:14700; number_of_response:1; }","duration":"170.407162ms","start":"2026-06-17T19:10:50.898022Z","end":"2026-06-17T19:10:51.068429Z","steps":["trace[554171346] 'process raft request' (duration: 170.171126ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T19:10:51.068608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.088133ms","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-06-17T19:10:51.06864Z","caller":"traceutil/trace.go:171","msg":"trace[1387042309] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:14700; }","duration":"143.169645ms","start":"2026-06-17T19:10:50.925461Z","end":"2026-06-17T19:10:51.068631Z","steps":["trace[1387042309] 'agreement among raft nodes before linearized reading' (duration: 142.92603ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T19:10:56.356239Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12731} {"level":"info","ts":"2026-06-17T19:10:56.429579Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12731,"took":"71.478899ms","hash":3767540856,"current-db-size-bytes":57065472,"current-db-size":"57 MB","current-db-size-in-use-bytes":28020736,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-06-17T19:10:56.429626Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3767540856,"revision":12731,"compact-revision":10523} {"level":"warn","ts":"2026-06-17T19:11:03.552818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.363131ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-17T19:11:03.552971Z","caller":"traceutil/trace.go:171","msg":"trace[969255631] transaction","detail":"{read_only:false; response_revision:14882; number_of_response:1; }","duration":"142.242223ms","start":"2026-06-17T19:11:03.410696Z","end":"2026-06-17T19:11:03.552938Z","steps":["trace[969255631] 'process raft request' (duration: 32.647406ms)","trace[969255631] 'compare' (duration: 108.86055ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T19:11:03.553061Z","caller":"traceutil/trace.go:171","msg":"trace[1808148766] linearizableReadLoop","detail":"{readStateIndex:15403; appliedIndex:15402; }","duration":"103.00913ms","start":"2026-06-17T19:11:03.450038Z","end":"2026-06-17T19:11:03.553048Z","steps":["trace[1808148766] 'read index received' (duration: 27.531µs)","trace[1808148766] 'applied index is now lower than readState.Index' (duration: 102.980109ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T19:11:03.553752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.704036ms","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-06-17T19:11:03.553778Z","caller":"traceutil/trace.go:171","msg":"trace[44917972] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:14883; }","duration":"103.772128ms","start":"2026-06-17T19:11:03.450001Z","end":"2026-06-17T19:11:03.553773Z","steps":["trace[44917972] 'agreement among raft nodes before linearized reading' (duration: 103.172074ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T19:11:03.978467Z","caller":"traceutil/trace.go:171","msg":"trace[1052546480] transaction","detail":"{read_only:false; response_revision:14885; number_of_response:1; }","duration":"100.793036ms","start":"2026-06-17T19:11:03.877632Z","end":"2026-06-17T19:11:03.978425Z","steps":["trace[1052546480] 'process raft request' (duration: 100.54764ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T19:12:44.414785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.757785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-17T19:12:44.414908Z","caller":"traceutil/trace.go:171","msg":"trace[555209876] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:15977; }","duration":"222.191036ms","start":"2026-06-17T19:12:44.192692Z","end":"2026-06-17T19:12:44.414883Z","steps":["trace[555209876] 'range keys from in-memory index tree' (duration: 221.604232ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T19:12:45.383535Z","caller":"traceutil/trace.go:171","msg":"trace[2109660573] transaction","detail":"{read_only:false; response_revision:15983; number_of_response:1; }","duration":"114.047298ms","start":"2026-06-17T19:12:45.269467Z","end":"2026-06-17T19:12:45.383514Z","steps":["trace[2109660573] 'process raft request' (duration: 113.912155ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T19:15:56.387067Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14746} {"level":"info","ts":"2026-06-17T19:15:56.515027Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14746,"took":"125.007344ms","hash":1056647585,"current-db-size-bytes":57065472,"current-db-size":"57 MB","current-db-size-in-use-bytes":33853440,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-17T19:15:56.515082Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1056647585,"revision":14746,"compact-revision":12731} {"level":"warn","ts":"2026-06-17T19:18:24.74182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.662294ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-06-17T19:18:24.742238Z","caller":"traceutil/trace.go:171","msg":"trace[15313095] linearizableReadLoop","detail":"{readStateIndex:19112; appliedIndex:19111; }","duration":"154.197158ms","start":"2026-06-17T19:18:24.587997Z","end":"2026-06-17T19:18:24.742194Z","steps":["trace[15313095] 'read index received' (duration: 5.072263ms)","trace[15313095] 'applied index is now lower than readState.Index' (duration: 149.122085ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T19:18:24.742523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.512365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-nhnrk\" ","response":"range_response_count:1 size:9792"} {"level":"info","ts":"2026-06-17T19:18:24.742558Z","caller":"traceutil/trace.go:171","msg":"trace[1579767545] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-nhnrk; range_end:; response_count:1; response_revision:18474; }","duration":"154.625947ms","start":"2026-06-17T19:18:24.587922Z","end":"2026-06-17T19:18:24.742548Z","steps":["trace[1579767545] 'agreement among raft nodes before linearized reading' (duration: 154.435932ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T19:18:28.483822Z","caller":"traceutil/trace.go:171","msg":"trace[863352041] linearizableReadLoop","detail":"{readStateIndex:19142; appliedIndex:19141; }","duration":"114.215024ms","start":"2026-06-17T19:18:28.369582Z","end":"2026-06-17T19:18:28.483797Z","steps":["trace[863352041] 'read index received' (duration: 114.007359ms)","trace[863352041] 'applied index is now lower than readState.Index' (duration: 206.485µs)"],"step_count":2} {"level":"warn","ts":"2026-06-17T19:18:28.484087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.50139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-17T19:18:28.484142Z","caller":"traceutil/trace.go:171","msg":"trace[942460618] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:18503; }","duration":"114.603613ms","start":"2026-06-17T19:18:28.369527Z","end":"2026-06-17T19:18:28.48413Z","steps":["trace[942460618] 'agreement among raft nodes before linearized reading' (duration: 114.372117ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T19:18:28.484423Z","caller":"traceutil/trace.go:171","msg":"trace[1457062177] transaction","detail":"{read_only:false; response_revision:18503; number_of_response:1; }","duration":"145.024146ms","start":"2026-06-17T19:18:28.339386Z","end":"2026-06-17T19:18:28.48441Z","steps":["trace[1457062177] 'process raft request' (duration: 144.265058ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T19:18:28.715649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.998836ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-17T19:18:28.715753Z","caller":"traceutil/trace.go:171","msg":"trace[1561691387] linearizableReadLoop","detail":"{readStateIndex:19143; appliedIndex:19142; }","duration":"187.528471ms","start":"2026-06-17T19:18:28.528207Z","end":"2026-06-17T19:18:28.715736Z","steps":["trace[1561691387] 'read index received' (duration: 42.213577ms)","trace[1561691387] 'applied index is now lower than readState.Index' (duration: 145.313734ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T19:18:28.71599Z","caller":"traceutil/trace.go:171","msg":"trace[509147355] transaction","detail":"{read_only:false; response_revision:18504; number_of_response:1; }","duration":"226.88836ms","start":"2026-06-17T19:18:28.489058Z","end":"2026-06-17T19:18:28.715946Z","steps":["trace[509147355] 'process raft request' (duration: 81.491844ms)","trace[509147355] 'compare' (duration: 144.487074ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T19:18:28.716281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.066963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-06-17T19:18:28.716323Z","caller":"traceutil/trace.go:171","msg":"trace[1557518459] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:18504; }","duration":"188.108564ms","start":"2026-06-17T19:18:28.528202Z","end":"2026-06-17T19:18:28.716311Z","steps":["trace[1557518459] 'agreement among raft nodes before linearized reading' (duration: 187.969201ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T19:20:45.684366Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a31e123290fcf0df","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-17T19:20:45.689828Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-06-17T19:20:45.689969Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-06-17T19:20:56.394284Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17462} {"level":"info","ts":"2026-06-17T19:20:56.494361Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17462,"took":"96.509143ms","hash":1593190297,"current-db-size-bytes":57065472,"current-db-size":"57 MB","current-db-size-in-use-bytes":30142464,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-17T19:20:56.494492Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1593190297,"revision":17462,"compact-revision":14746} {"level":"info","ts":"2026-06-17T19:25:56.400581Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19383} {"level":"info","ts":"2026-06-17T19:25:56.486792Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19383,"took":"83.728782ms","hash":1101251087,"current-db-size-bytes":57065472,"current-db-size":"57 MB","current-db-size-in-use-bytes":24326144,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-06-17T19:25:56.486848Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1101251087,"revision":19383,"compact-revision":17462}