{"level":"warn","ts":"2026-06-19T17:57:40.21328Z","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-19T17:57:40.213397Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.38: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.38:2380","--initial-cluster=instance=https://199.204.45.38:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.38:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.38: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-19T17:57:40.21348Z","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-19T17:57:40.213495Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.38:2380"]} {"level":"info","ts":"2026-06-19T17:57:40.213519Z","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-19T17:57:40.214424Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"]} {"level":"info","ts":"2026-06-19T17:57:40.214852Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.38: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-19T17:57:40.218987Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.863574ms"} {"level":"info","ts":"2026-06-19T17:57:40.230783Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"331455d6226d3423","cluster-id":"25c7803fb83a1455"} {"level":"info","ts":"2026-06-19T17:57:40.23087Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=()"} {"level":"info","ts":"2026-06-19T17:57:40.230894Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became follower at term 0"} {"level":"info","ts":"2026-06-19T17:57:40.230906Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 331455d6226d3423 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-19T17:57:40.230918Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became follower at term 1"} {"level":"info","ts":"2026-06-19T17:57:40.230967Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"} {"level":"warn","ts":"2026-06-19T17:57:40.238274Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-19T17:57:40.240835Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-19T17:57:40.243326Z","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-19T17:57:40.247683Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"331455d6226d3423","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-19T17:57:40.24793Z","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-19T17:57:40.248041Z","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-19T17:57:40.248055Z","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-19T17:57:40.248332Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"331455d6226d3423","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-19T17:57:40.253749Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"} {"level":"info","ts":"2026-06-19T17:57:40.253875Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"25c7803fb83a1455","local-member-id":"331455d6226d3423","added-peer-id":"331455d6226d3423","added-peer-peer-urls":["https://199.204.45.38:2380"]} {"level":"info","ts":"2026-06-19T17:57:40.255507Z","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-19T17:57:40.255724Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"331455d6226d3423","initial-advertise-peer-urls":["https://199.204.45.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-19T17:57:40.255756Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-19T17:57:40.256142Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.38:2380"} {"level":"info","ts":"2026-06-19T17:57:40.256162Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.38:2380"} {"level":"info","ts":"2026-06-19T17:57:40.632068Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 is starting a new election at term 1"} {"level":"info","ts":"2026-06-19T17:57:40.632149Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-19T17:57:40.63218Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 received MsgPreVoteResp from 331455d6226d3423 at term 1"} {"level":"info","ts":"2026-06-19T17:57:40.632201Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became candidate at term 2"} {"level":"info","ts":"2026-06-19T17:57:40.632218Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 received MsgVoteResp from 331455d6226d3423 at term 2"} {"level":"info","ts":"2026-06-19T17:57:40.632275Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became leader at term 2"} {"level":"info","ts":"2026-06-19T17:57:40.632294Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 331455d6226d3423 elected leader 331455d6226d3423 at term 2"} {"level":"info","ts":"2026-06-19T17:57:40.633134Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"331455d6226d3423","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.38:2379]}","request-path":"/0/members/331455d6226d3423/attributes","cluster-id":"25c7803fb83a1455","publish-timeout":"7s"} {"level":"info","ts":"2026-06-19T17:57:40.633337Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-19T17:57:40.633419Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-19T17:57:40.63359Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-19T17:57:40.633925Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-19T17:57:40.633969Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-19T17:57:40.63443Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"25c7803fb83a1455","local-member-id":"331455d6226d3423","cluster-version":"3.5"} {"level":"info","ts":"2026-06-19T17:57:40.63455Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-19T17:57:40.634581Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-19T17:57:40.636959Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.38:2379"} {"level":"info","ts":"2026-06-19T17:57:40.638681Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-19T17:57:43.803542Z","caller":"traceutil/trace.go:171","msg":"trace[1172406282] transaction","detail":"{read_only:false; response_revision:190; number_of_response:1; }","duration":"105.701267ms","start":"2026-06-19T17:57:43.697801Z","end":"2026-06-19T17:57:43.803502Z","steps":["trace[1172406282] 'process raft request' (duration: 76.424326ms)","trace[1172406282] 'compare' (duration: 29.11839ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T17:57:49.172669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.143121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-06-19T17:57:49.172822Z","caller":"traceutil/trace.go:171","msg":"trace[1283104523] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:330; }","duration":"133.354123ms","start":"2026-06-19T17:57:49.039438Z","end":"2026-06-19T17:57:49.172792Z","steps":["trace[1283104523] 'range keys from in-memory index tree' (duration: 132.94898ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T17:57:49.559086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.814801ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-19T17:57:49.559204Z","caller":"traceutil/trace.go:171","msg":"trace[344943566] linearizableReadLoop","detail":"{readStateIndex:345; appliedIndex:344; }","duration":"282.632617ms","start":"2026-06-19T17:57:49.276554Z","end":"2026-06-19T17:57:49.559187Z","steps":["trace[344943566] 'read index received' (duration: 155.95842ms)","trace[344943566] 'applied index is now lower than readState.Index' (duration: 126.673047ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T17:57:49.559278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.720298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-06-19T17:57:49.559314Z","caller":"traceutil/trace.go:171","msg":"trace[912857067] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:332; }","duration":"282.800898ms","start":"2026-06-19T17:57:49.276504Z","end":"2026-06-19T17:57:49.559305Z","steps":["trace[912857067] 'agreement among raft nodes before linearized reading' (duration: 282.729287ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T17:57:49.559313Z","caller":"traceutil/trace.go:171","msg":"trace[1192193951] transaction","detail":"{read_only:false; response_revision:332; number_of_response:1; }","duration":"283.810106ms","start":"2026-06-19T17:57:49.275396Z","end":"2026-06-19T17:57:49.559206Z","steps":["trace[1192193951] 'process raft request' (duration: 157.195409ms)","trace[1192193951] 'compare' (duration: 125.67243ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T17:58:18.096878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.108619ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-19T17:58:18.097155Z","caller":"traceutil/trace.go:171","msg":"trace[98148570] linearizableReadLoop","detail":"{readStateIndex:576; appliedIndex:574; }","duration":"264.222176ms","start":"2026-06-19T17:58:17.832913Z","end":"2026-06-19T17:58:18.097135Z","steps":["trace[98148570] 'read index received' (duration: 7.426062ms)","trace[98148570] 'applied index is now lower than readState.Index' (duration: 256.795144ms)"],"step_count":2} {"level":"info","ts":"2026-06-19T17:58:18.09724Z","caller":"traceutil/trace.go:171","msg":"trace[2071350275] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"260.637875ms","start":"2026-06-19T17:58:17.836594Z","end":"2026-06-19T17:58:18.097232Z","steps":["trace[2071350275] 'process raft request' (duration: 260.397225ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T17:58:18.097305Z","caller":"traceutil/trace.go:171","msg":"trace[572316632] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"167.345703ms","start":"2026-06-19T17:58:17.929929Z","end":"2026-06-19T17:58:18.097275Z","steps":["trace[572316632] 'process raft request' (duration: 167.156045ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T17:58:18.097378Z","caller":"traceutil/trace.go:171","msg":"trace[1747603272] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"264.568081ms","start":"2026-06-19T17:58:17.832771Z","end":"2026-06-19T17:58:18.097339Z","steps":["trace[1747603272] 'process raft request' (duration: 113.90985ms)","trace[1747603272] 'compare' (duration: 149.953941ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T17:58:18.097441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.523788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-19T17:58:18.097473Z","caller":"traceutil/trace.go:171","msg":"trace[108480658] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:556; }","duration":"264.573401ms","start":"2026-06-19T17:58:17.83289Z","end":"2026-06-19T17:58:18.097463Z","steps":["trace[108480658] 'agreement among raft nodes before linearized reading' (duration: 264.498298ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T17:58:18.097495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.013929ms","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-19T17:58:18.097561Z","caller":"traceutil/trace.go:171","msg":"trace[1361792578] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:556; }","duration":"153.128225ms","start":"2026-06-19T17:58:17.944413Z","end":"2026-06-19T17:58:18.097542Z","steps":["trace[1361792578] 'agreement among raft nodes before linearized reading' (duration: 152.943757ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T17:58:24.149261Z","caller":"traceutil/trace.go:171","msg":"trace[10525982] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"109.584597ms","start":"2026-06-19T17:58:24.039648Z","end":"2026-06-19T17:58:24.149233Z","steps":["trace[10525982] 'process raft request' (duration: 108.745844ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T17:58:24.308434Z","caller":"traceutil/trace.go:171","msg":"trace[799926484] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"155.934427ms","start":"2026-06-19T17:58:24.15247Z","end":"2026-06-19T17:58:24.308405Z","steps":["trace[799926484] 'process raft request' (duration: 121.046802ms)","trace[799926484] 'compare' (duration: 34.678197ms)"],"step_count":2} {"level":"info","ts":"2026-06-19T17:58:24.308686Z","caller":"traceutil/trace.go:171","msg":"trace[347400216] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"102.22506ms","start":"2026-06-19T17:58:24.206398Z","end":"2026-06-19T17:58:24.308623Z","steps":["trace[347400216] 'process raft request' (duration: 101.95952ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T17:58:25.043874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.863191ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-19T17:58:25.044029Z","caller":"traceutil/trace.go:171","msg":"trace[381787389] linearizableReadLoop","detail":"{readStateIndex:657; appliedIndex:656; }","duration":"327.155782ms","start":"2026-06-19T17:58:24.716822Z","end":"2026-06-19T17:58:25.043978Z","steps":["trace[381787389] 'read index received' (duration: 27.151µs)","trace[381787389] 'applied index is now lower than readState.Index' (duration: 327.126911ms)"],"step_count":2} {"level":"info","ts":"2026-06-19T17:58:25.044421Z","caller":"traceutil/trace.go:171","msg":"trace[804971555] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"720.529371ms","start":"2026-06-19T17:58:24.323852Z","end":"2026-06-19T17:58:25.044382Z","steps":["trace[804971555] 'process raft request' (duration: 254.053818ms)","trace[804971555] 'compare' (duration: 465.441474ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T17:58:25.044584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.746494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-bdzsj\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-06-19T17:58:25.044754Z","caller":"traceutil/trace.go:171","msg":"trace[2042798732] range","detail":"{range_begin:/registry/pods/kube-system/cilium-bdzsj; range_end:; response_count:1; response_revision:633; }","duration":"327.938681ms","start":"2026-06-19T17:58:24.716792Z","end":"2026-06-19T17:58:25.044731Z","steps":["trace[2042798732] 'agreement among raft nodes before linearized reading' (duration: 327.686302ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T17:58:25.044808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T17:58:24.716777Z","time spent":"328.015975ms","remote":"127.0.0.1:33956","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16983,"request content":"key:\"/registry/pods/kube-system/cilium-bdzsj\" "} {"level":"warn","ts":"2026-06-19T17:58:25.044696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T17:58:24.323838Z","time spent":"720.709737ms","remote":"127.0.0.1:34044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-19T17:58:25.334069Z","caller":"traceutil/trace.go:171","msg":"trace[135473383] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"604.991239ms","start":"2026-06-19T17:58:24.729057Z","end":"2026-06-19T17:58:25.334049Z","steps":["trace[135473383] 'process raft request' (duration: 603.70796ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T17:58:25.334319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"490.463229ms","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-19T17:58:25.334297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.270086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-19T17:58:25.334373Z","caller":"traceutil/trace.go:171","msg":"trace[245440514] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:634; }","duration":"490.557764ms","start":"2026-06-19T17:58:24.843806Z","end":"2026-06-19T17:58:25.334363Z","steps":["trace[245440514] 'agreement among raft nodes before linearized reading' (duration: 490.248432ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T17:58:25.334435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T17:58:24.843795Z","time spent":"490.631996ms","remote":"127.0.0.1:34044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-19T17:58:25.33446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T17:58:24.729032Z","time spent":"605.174616ms","remote":"127.0.0.1:33862","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036301,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-19T17:58:25.334421Z","caller":"traceutil/trace.go:171","msg":"trace[1170489573] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:634; }","duration":"504.444133ms","start":"2026-06-19T17:58:24.829946Z","end":"2026-06-19T17:58:25.33439Z","steps":["trace[1170489573] 'agreement among raft nodes before linearized reading' (duration: 504.232735ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T17:58:25.33455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T17:58:24.829926Z","time spent":"504.609389ms","remote":"127.0.0.1:33772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-19T17:58:25.334Z","caller":"traceutil/trace.go:171","msg":"trace[1557223336] linearizableReadLoop","detail":"{readStateIndex:658; appliedIndex:657; }","duration":"289.914666ms","start":"2026-06-19T17:58:25.044063Z","end":"2026-06-19T17:58:25.333978Z","steps":["trace[1557223336] 'read index received' (duration: 288.549054ms)","trace[1557223336] 'applied index is now lower than readState.Index' (duration: 1.364972ms)"],"step_count":2} {"level":"info","ts":"2026-06-19T17:58:25.346709Z","caller":"traceutil/trace.go:171","msg":"trace[235957542] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"289.254312ms","start":"2026-06-19T17:58:25.05743Z","end":"2026-06-19T17:58:25.346685Z","steps":["trace[235957542] 'process raft request' (duration: 289.124467ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T17:58:28.598727Z","caller":"traceutil/trace.go:171","msg":"trace[1831623565] transaction","detail":"{read_only:false; response_revision:696; number_of_response:1; }","duration":"102.924815ms","start":"2026-06-19T17:58:28.495773Z","end":"2026-06-19T17:58:28.598698Z","steps":["trace[1831623565] 'process raft request' (duration: 102.211818ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T17:58:30.058144Z","caller":"traceutil/trace.go:171","msg":"trace[540355029] transaction","detail":"{read_only:false; response_revision:713; number_of_response:1; }","duration":"157.642125ms","start":"2026-06-19T17:58:29.900473Z","end":"2026-06-19T17:58:30.058115Z","steps":["trace[540355029] 'process raft request' (duration: 157.297922ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T17:58:40.971447Z","caller":"traceutil/trace.go:171","msg":"trace[1444151827] linearizableReadLoop","detail":"{readStateIndex:825; appliedIndex:824; }","duration":"153.557165ms","start":"2026-06-19T17:58:40.817871Z","end":"2026-06-19T17:58:40.971429Z","steps":["trace[1444151827] 'read index received' (duration: 153.380439ms)","trace[1444151827] 'applied index is now lower than readState.Index' (duration: 176.085µs)"],"step_count":2} {"level":"warn","ts":"2026-06-19T17:58:40.971639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.73629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-scgdb\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-06-19T17:58:40.971671Z","caller":"traceutil/trace.go:171","msg":"trace[1584262983] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-scgdb; range_end:; response_count:1; response_revision:797; }","duration":"153.846043ms","start":"2026-06-19T17:58:40.817817Z","end":"2026-06-19T17:58:40.971663Z","steps":["trace[1584262983] 'agreement among raft nodes before linearized reading' (duration: 153.690198ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T17:58:40.971645Z","caller":"traceutil/trace.go:171","msg":"trace[271245233] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"295.142985ms","start":"2026-06-19T17:58:40.676345Z","end":"2026-06-19T17:58:40.971488Z","steps":["trace[271245233] 'process raft request' (duration: 294.96781ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T17:59:11.691047Z","caller":"traceutil/trace.go:171","msg":"trace[1733479428] transaction","detail":"{read_only:false; response_revision:1204; number_of_response:1; }","duration":"120.6518ms","start":"2026-06-19T17:59:11.570369Z","end":"2026-06-19T17:59:11.691021Z","steps":["trace[1733479428] 'process raft request' (duration: 120.522167ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T17:59:31.98911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.77134ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-19T17:59:31.989286Z","caller":"traceutil/trace.go:171","msg":"trace[716017486] transaction","detail":"{read_only:false; response_revision:1437; number_of_response:1; }","duration":"230.295995ms","start":"2026-06-19T17:59:31.758972Z","end":"2026-06-19T17:59:31.989268Z","steps":["trace[716017486] 'process raft request' (duration: 59.061815ms)","trace[716017486] 'compare' (duration: 170.557146ms)"],"step_count":2} {"level":"info","ts":"2026-06-19T17:59:31.989378Z","caller":"traceutil/trace.go:171","msg":"trace[833908541] transaction","detail":"{read_only:false; response_revision:1438; number_of_response:1; }","duration":"193.684589ms","start":"2026-06-19T17:59:31.79568Z","end":"2026-06-19T17:59:31.989364Z","steps":["trace[833908541] 'process raft request' (duration: 193.598197ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T17:59:31.989396Z","caller":"traceutil/trace.go:171","msg":"trace[869989852] linearizableReadLoop","detail":"{readStateIndex:1482; appliedIndex:1481; }","duration":"193.693539ms","start":"2026-06-19T17:59:31.795681Z","end":"2026-06-19T17:59:31.989375Z","steps":["trace[869989852] 'read index received' (duration: 22.441349ms)","trace[869989852] 'applied index is now lower than readState.Index' (duration: 171.25023ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T17:59:31.989611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.888833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-19T17:59:31.989616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.913013ms","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-19T17:59:31.989641Z","caller":"traceutil/trace.go:171","msg":"trace[324369430] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1438; }","duration":"159.961505ms","start":"2026-06-19T17:59:31.829671Z","end":"2026-06-19T17:59:31.989632Z","steps":["trace[324369430] 'agreement among raft nodes before linearized reading' (duration: 159.901153ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T17:59:31.989661Z","caller":"traceutil/trace.go:171","msg":"trace[1825244505] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1438; }","duration":"194.019606ms","start":"2026-06-19T17:59:31.795629Z","end":"2026-06-19T17:59:31.989649Z","steps":["trace[1825244505] 'agreement among raft nodes before linearized reading' (duration: 193.809792ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T18:00:00.938739Z","caller":"traceutil/trace.go:171","msg":"trace[1265011365] linearizableReadLoop","detail":"{readStateIndex:1962; appliedIndex:1961; }","duration":"136.429623ms","start":"2026-06-19T18:00:00.802288Z","end":"2026-06-19T18:00:00.938718Z","steps":["trace[1265011365] 'read index received' (duration: 136.143148ms)","trace[1265011365] 'applied index is now lower than readState.Index' (duration: 285.475µs)"],"step_count":2} {"level":"info","ts":"2026-06-19T18:00:00.938792Z","caller":"traceutil/trace.go:171","msg":"trace[1110040618] transaction","detail":"{read_only:false; response_revision:1888; number_of_response:1; }","duration":"151.357463ms","start":"2026-06-19T18:00:00.787394Z","end":"2026-06-19T18:00:00.938751Z","steps":["trace[1110040618] 'process raft request' (duration: 151.146849ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T18:00:00.938955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.653218ms","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-19T18:00:00.938989Z","caller":"traceutil/trace.go:171","msg":"trace[1855055207] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1888; }","duration":"136.740469ms","start":"2026-06-19T18:00:00.802241Z","end":"2026-06-19T18:00:00.938981Z","steps":["trace[1855055207] 'agreement among raft nodes before linearized reading' (duration: 136.599306ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T18:00:00.939046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.370743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-19T18:00:00.939193Z","caller":"traceutil/trace.go:171","msg":"trace[694637367] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1888; }","duration":"109.578686ms","start":"2026-06-19T18:00:00.829565Z","end":"2026-06-19T18:00:00.939144Z","steps":["trace[694637367] 'agreement among raft nodes before linearized reading' (duration: 109.308511ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T18:00:01.471222Z","caller":"traceutil/trace.go:171","msg":"trace[1624741313] transaction","detail":"{read_only:false; response_revision:1890; number_of_response:1; }","duration":"256.146391ms","start":"2026-06-19T18:00:01.215046Z","end":"2026-06-19T18:00:01.471192Z","steps":["trace[1624741313] 'process raft request' (duration: 255.619222ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T18:00:14.557062Z","caller":"traceutil/trace.go:171","msg":"trace[1721526251] transaction","detail":"{read_only:false; response_revision:1998; number_of_response:1; }","duration":"232.323102ms","start":"2026-06-19T18:00:14.324716Z","end":"2026-06-19T18:00:14.557039Z","steps":["trace[1721526251] 'process raft request' (duration: 232.086208ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T18:00:14.645965Z","caller":"traceutil/trace.go:171","msg":"trace[1792969494] transaction","detail":"{read_only:false; response_revision:1999; number_of_response:1; }","duration":"321.008579ms","start":"2026-06-19T18:00:14.324924Z","end":"2026-06-19T18:00:14.645933Z","steps":["trace[1792969494] 'process raft request' (duration: 308.274013ms)","trace[1792969494] 'compare' (duration: 12.519612ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T18:00:14.646115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T18:00:14.32492Z","time spent":"321.123201ms","remote":"127.0.0.1:34044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-19T18:00:14.646325Z","caller":"traceutil/trace.go:171","msg":"trace[1446657012] linearizableReadLoop","detail":"{readStateIndex:2078; appliedIndex:2074; }","duration":"198.234011ms","start":"2026-06-19T18:00:14.44806Z","end":"2026-06-19T18:00:14.646293Z","steps":["trace[1446657012] 'read index received' (duration: 108.809362ms)","trace[1446657012] 'applied index is now lower than readState.Index' (duration: 89.422579ms)"],"step_count":2} {"level":"info","ts":"2026-06-19T18:00:14.646398Z","caller":"traceutil/trace.go:171","msg":"trace[1469536408] transaction","detail":"{read_only:false; response_revision:2000; number_of_response:1; }","duration":"321.370574ms","start":"2026-06-19T18:00:14.325002Z","end":"2026-06-19T18:00:14.646373Z","steps":["trace[1469536408] 'process raft request' (duration: 320.873956ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T18:00:14.646468Z","caller":"traceutil/trace.go:171","msg":"trace[272748283] transaction","detail":"{read_only:false; response_revision:2001; number_of_response:1; }","duration":"275.124385ms","start":"2026-06-19T18:00:14.371237Z","end":"2026-06-19T18:00:14.646361Z","steps":["trace[272748283] 'process raft request' (duration: 274.921601ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T18:00:14.646548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T18:00:14.324999Z","time spent":"321.439205ms","remote":"127.0.0.1:34100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1712,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-19T18:00:14.646627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.543295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-19T18:00:14.646718Z","caller":"traceutil/trace.go:171","msg":"trace[1767046660] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2001; }","duration":"198.673757ms","start":"2026-06-19T18:00:14.448021Z","end":"2026-06-19T18:00:14.646695Z","steps":["trace[1767046660] 'agreement among raft nodes before linearized reading' (duration: 198.401053ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T18:00:14.671061Z","caller":"traceutil/trace.go:171","msg":"trace[1061539496] transaction","detail":"{read_only:false; response_revision:2002; number_of_response:1; }","duration":"103.75772ms","start":"2026-06-19T18:00:14.567273Z","end":"2026-06-19T18:00:14.671031Z","steps":["trace[1061539496] 'process raft request' (duration: 103.387844ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T18:00:14.671045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.831202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11980"} {"level":"info","ts":"2026-06-19T18:00:14.671289Z","caller":"traceutil/trace.go:171","msg":"trace[2126351878] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2002; }","duration":"180.122756ms","start":"2026-06-19T18:00:14.491144Z","end":"2026-06-19T18:00:14.671267Z","steps":["trace[2126351878] 'agreement among raft nodes before linearized reading' (duration: 179.72777ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T18:00:41.955652Z","caller":"traceutil/trace.go:171","msg":"trace[1681134387] linearizableReadLoop","detail":"{readStateIndex:2242; appliedIndex:2241; }","duration":"229.496809ms","start":"2026-06-19T18:00:41.726135Z","end":"2026-06-19T18:00:41.955631Z","steps":["trace[1681134387] 'read index received' (duration: 218.341578ms)","trace[1681134387] 'applied index is now lower than readState.Index' (duration: 11.154291ms)"],"step_count":2} {"level":"info","ts":"2026-06-19T18:00:41.95567Z","caller":"traceutil/trace.go:171","msg":"trace[1909557014] transaction","detail":"{read_only:false; response_revision:2160; number_of_response:1; }","duration":"230.628225ms","start":"2026-06-19T18:00:41.725011Z","end":"2026-06-19T18:00:41.95564Z","steps":["trace[1909557014] 'process raft request' (duration: 219.348162ms)","trace[1909557014] 'compare' (duration: 11.181122ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T18:00:41.955838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.672752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-19T18:00:41.955866Z","caller":"traceutil/trace.go:171","msg":"trace[853581427] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2160; }","duration":"229.760224ms","start":"2026-06-19T18:00:41.726098Z","end":"2026-06-19T18:00:41.955859Z","steps":["trace[853581427] 'agreement among raft nodes before linearized reading' (duration: 229.635192ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T18:00:41.98074Z","caller":"traceutil/trace.go:171","msg":"trace[84998977] transaction","detail":"{read_only:false; response_revision:2161; number_of_response:1; }","duration":"185.095065ms","start":"2026-06-19T18:00:41.795619Z","end":"2026-06-19T18:00:41.980714Z","steps":["trace[84998977] 'process raft request' (duration: 184.868312ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T18:00:41.980793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.506224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-19T18:00:41.980978Z","caller":"traceutil/trace.go:171","msg":"trace[1086997459] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2161; }","duration":"150.733297ms","start":"2026-06-19T18:00:41.830226Z","end":"2026-06-19T18:00:41.980959Z","steps":["trace[1086997459] 'agreement among raft nodes before linearized reading' (duration: 150.496033ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T18:01:30.509385Z","caller":"traceutil/trace.go:171","msg":"trace[325406807] transaction","detail":"{read_only:false; response_revision:2467; number_of_response:1; }","duration":"263.113756ms","start":"2026-06-19T18:01:30.24624Z","end":"2026-06-19T18:01:30.509354Z","steps":["trace[325406807] 'process raft request' (duration: 262.936304ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T18:01:30.570087Z","caller":"traceutil/trace.go:171","msg":"trace[1121795311] transaction","detail":"{read_only:false; response_revision:2468; number_of_response:1; }","duration":"243.104152ms","start":"2026-06-19T18:01:30.326955Z","end":"2026-06-19T18:01:30.570059Z","steps":["trace[1121795311] 'process raft request' (duration: 242.787178ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T18:01:32.585554Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757021203496639274,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-19T18:01:33.079139Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.191491044s","expected-duration":"1s"} {"level":"info","ts":"2026-06-19T18:01:33.079498Z","caller":"traceutil/trace.go:171","msg":"trace[1747279008] transaction","detail":"{read_only:false; response_revision:2475; number_of_response:1; }","duration":"1.191903029s","start":"2026-06-19T18:01:31.887571Z","end":"2026-06-19T18:01:33.079475Z","steps":["trace[1747279008] 'process raft request' (duration: 1.191773078s)"],"step_count":1} {"level":"warn","ts":"2026-06-19T18:01:33.079626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T18:01:31.887561Z","time spent":"1.191996081s","remote":"127.0.0.1:34044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-19T18:01:33.101065Z","caller":"traceutil/trace.go:171","msg":"trace[1417600923] transaction","detail":"{read_only:false; response_revision:2476; number_of_response:1; }","duration":"944.539082ms","start":"2026-06-19T18:01:32.156504Z","end":"2026-06-19T18:01:33.101043Z","steps":["trace[1417600923] 'process raft request' (duration: 944.39072ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T18:01:33.10119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T18:01:32.156482Z","time spent":"944.646263ms","remote":"127.0.0.1:34044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-19T18:01:33.101303Z","caller":"traceutil/trace.go:171","msg":"trace[85346085] linearizableReadLoop","detail":"{readStateIndex:2570; appliedIndex:2568; }","duration":"1.168719132s","start":"2026-06-19T18:01:31.932562Z","end":"2026-06-19T18:01:33.101281Z","steps":["trace[85346085] 'read index received' (duration: 1.146869935s)","trace[85346085] 'applied index is now lower than readState.Index' (duration: 21.848147ms)"],"step_count":2} {"level":"info","ts":"2026-06-19T18:01:33.101349Z","caller":"traceutil/trace.go:171","msg":"trace[39956744] transaction","detail":"{read_only:false; response_revision:2477; number_of_response:1; }","duration":"512.769807ms","start":"2026-06-19T18:01:32.588569Z","end":"2026-06-19T18:01:33.101339Z","steps":["trace[39956744] 'process raft request' (duration: 512.434573ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T18:01:33.101404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T18:01:32.588561Z","time spent":"512.812497ms","remote":"127.0.0.1:34044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-19T18:01:33.101462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.168880404s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-19T18:01:33.101532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"513.133581ms","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-19T18:01:33.101535Z","caller":"traceutil/trace.go:171","msg":"trace[1369340082] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2478; }","duration":"1.168975575s","start":"2026-06-19T18:01:31.932527Z","end":"2026-06-19T18:01:33.101503Z","steps":["trace[1369340082] 'agreement among raft nodes before linearized reading' (duration: 1.168882154s)"],"step_count":1} {"level":"info","ts":"2026-06-19T18:01:33.101569Z","caller":"traceutil/trace.go:171","msg":"trace[316794518] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2478; }","duration":"513.192303ms","start":"2026-06-19T18:01:32.588366Z","end":"2026-06-19T18:01:33.101558Z","steps":["trace[316794518] 'agreement among raft nodes before linearized reading' (duration: 513.098631ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T18:01:33.101594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T18:01:32.588354Z","time spent":"513.234823ms","remote":"127.0.0.1:34044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-19T18:01:33.101582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T18:01:31.932511Z","time spent":"1.169058446s","remote":"127.0.0.1:34228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":27,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-06-19T18:01:33.101667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.202822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-19T18:01:33.101691Z","caller":"traceutil/trace.go:171","msg":"trace[1052441325] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:2478; }","duration":"295.243313ms","start":"2026-06-19T18:01:32.806442Z","end":"2026-06-19T18:01:33.101685Z","steps":["trace[1052441325] 'agreement among raft nodes before linearized reading' (duration: 295.206453ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T18:01:33.101594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.402606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-19T18:01:33.101764Z","caller":"traceutil/trace.go:171","msg":"trace[1759614428] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2478; }","duration":"274.58574ms","start":"2026-06-19T18:01:32.827162Z","end":"2026-06-19T18:01:33.101747Z","steps":["trace[1759614428] 'agreement among raft nodes before linearized reading' (duration: 274.402147ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T18:01:33.101795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.052221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-19T18:01:33.101815Z","caller":"traceutil/trace.go:171","msg":"trace[319015602] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:2478; }","duration":"346.073342ms","start":"2026-06-19T18:01:32.755735Z","end":"2026-06-19T18:01:33.101809Z","steps":["trace[319015602] 'agreement among raft nodes before linearized reading' (duration: 346.039391ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T18:01:33.101838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T18:01:32.755687Z","time spent":"346.146753ms","remote":"127.0.0.1:45378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-19T18:01:33.101961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"513.547698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-06-19T18:01:33.101982Z","caller":"traceutil/trace.go:171","msg":"trace[810654670] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2478; }","duration":"513.568498ms","start":"2026-06-19T18:01:32.588409Z","end":"2026-06-19T18:01:33.101977Z","steps":["trace[810654670] 'agreement among raft nodes before linearized reading' (duration: 513.512827ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T18:01:33.102004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T18:01:32.588397Z","time spent":"513.601268ms","remote":"127.0.0.1:34044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-19T18:01:33.725578Z","caller":"traceutil/trace.go:171","msg":"trace[764525044] transaction","detail":"{read_only:false; response_revision:2484; number_of_response:1; }","duration":"230.25675ms","start":"2026-06-19T18:01:33.4953Z","end":"2026-06-19T18:01:33.725557Z","steps":["trace[764525044] 'process raft request' (duration: 229.874075ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T18:02:15.775347Z","caller":"traceutil/trace.go:171","msg":"trace[1136282239] transaction","detail":"{read_only:false; response_revision:2774; number_of_response:1; }","duration":"105.494202ms","start":"2026-06-19T18:02:15.669833Z","end":"2026-06-19T18:02:15.775327Z","steps":["trace[1136282239] 'process raft request' (duration: 105.361871ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T18:02:16.195665Z","caller":"traceutil/trace.go:171","msg":"trace[559542674] transaction","detail":"{read_only:false; response_revision:2775; number_of_response:1; }","duration":"120.755823ms","start":"2026-06-19T18:02:16.074882Z","end":"2026-06-19T18:02:16.195638Z","steps":["trace[559542674] 'process raft request' (duration: 120.605652ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T18:06:06.76875Z","caller":"traceutil/trace.go:171","msg":"trace[1618034871] transaction","detail":"{read_only:false; response_revision:4753; number_of_response:1; }","duration":"121.190103ms","start":"2026-06-19T18:06:06.647535Z","end":"2026-06-19T18:06:06.768725Z","steps":["trace[1618034871] 'process raft request' (duration: 120.950468ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T18:06:06.780649Z","caller":"traceutil/trace.go:171","msg":"trace[626345698] transaction","detail":"{read_only:false; response_revision:4755; number_of_response:1; }","duration":"132.26962ms","start":"2026-06-19T18:06:06.648359Z","end":"2026-06-19T18:06:06.780628Z","steps":["trace[626345698] 'process raft request' (duration: 132.227059ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T18:06:06.780789Z","caller":"traceutil/trace.go:171","msg":"trace[14973499] transaction","detail":"{read_only:false; response_revision:4754; number_of_response:1; }","duration":"132.993642ms","start":"2026-06-19T18:06:06.647728Z","end":"2026-06-19T18:06:06.780721Z","steps":["trace[14973499] 'process raft request' (duration: 132.717578ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T18:06:06.884994Z","caller":"traceutil/trace.go:171","msg":"trace[983631745] transaction","detail":"{read_only:false; response_revision:4756; number_of_response:1; }","duration":"110.056945ms","start":"2026-06-19T18:06:06.774892Z","end":"2026-06-19T18:06:06.884949Z","steps":["trace[983631745] 'process raft request' (duration: 93.088334ms)","trace[983631745] 'compare' (duration: 16.635385ms)"],"step_count":2} {"level":"info","ts":"2026-06-19T18:06:07.287304Z","caller":"traceutil/trace.go:171","msg":"trace[596416233] transaction","detail":"{read_only:false; response_revision:4760; number_of_response:1; }","duration":"110.043191ms","start":"2026-06-19T18:06:07.177225Z","end":"2026-06-19T18:06:07.287268Z","steps":["trace[596416233] 'process raft request' (duration: 109.810557ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T18:06:20.585394Z","caller":"traceutil/trace.go:171","msg":"trace[2053378919] linearizableReadLoop","detail":"{readStateIndex:5109; appliedIndex:5106; }","duration":"307.392891ms","start":"2026-06-19T18:06:20.277969Z","end":"2026-06-19T18:06:20.585362Z","steps":["trace[2053378919] 'read index received' (duration: 307.147927ms)","trace[2053378919] 'applied index is now lower than readState.Index' (duration: 243.774µs)"],"step_count":2} {"level":"info","ts":"2026-06-19T18:06:20.585533Z","caller":"traceutil/trace.go:171","msg":"trace[690467350] transaction","detail":"{read_only:false; response_revision:4922; number_of_response:1; }","duration":"433.084236ms","start":"2026-06-19T18:06:20.152435Z","end":"2026-06-19T18:06:20.585519Z","steps":["trace[690467350] 'process raft request' (duration: 432.889363ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T18:06:20.585591Z","caller":"traceutil/trace.go:171","msg":"trace[2104008122] transaction","detail":"{read_only:false; response_revision:4920; number_of_response:1; }","duration":"433.34618ms","start":"2026-06-19T18:06:20.15218Z","end":"2026-06-19T18:06:20.585526Z","steps":["trace[2104008122] 'process raft request' (duration: 432.991964ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T18:06:20.585673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T18:06:20.152405Z","time spent":"433.160178ms","remote":"127.0.0.1:34044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-19T18:06:20.585647Z","caller":"traceutil/trace.go:171","msg":"trace[382267345] transaction","detail":"{read_only:false; response_revision:4921; number_of_response:1; }","duration":"433.35793ms","start":"2026-06-19T18:06:20.152243Z","end":"2026-06-19T18:06:20.585601Z","steps":["trace[382267345] 'process raft request' (duration: 433.046215ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T18:06:20.585871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T18:06:20.152159Z","time spent":"433.568725ms","remote":"127.0.0.1:34044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-19T18:06:20.585872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.669583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"warn","ts":"2026-06-19T18:06:20.585898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T18:06:20.152216Z","time spent":"433.591375ms","remote":"127.0.0.1:34044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-19T18:06:20.585957Z","caller":"traceutil/trace.go:171","msg":"trace[349529289] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4922; }","duration":"281.809026ms","start":"2026-06-19T18:06:20.304128Z","end":"2026-06-19T18:06:20.585937Z","steps":["trace[349529289] 'agreement among raft nodes before linearized reading' (duration: 281.554252ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T18:06:20.586004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.018303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10391"} {"level":"warn","ts":"2026-06-19T18:06:20.586066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.656445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-06-19T18:06:20.586092Z","caller":"traceutil/trace.go:171","msg":"trace[1184169825] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4922; }","duration":"308.112934ms","start":"2026-06-19T18:06:20.277955Z","end":"2026-06-19T18:06:20.586067Z","steps":["trace[1184169825] 'agreement among raft nodes before linearized reading' (duration: 307.83862ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T18:06:20.586198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-19T18:06:20.2779Z","time spent":"308.287607ms","remote":"127.0.0.1:33956","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":10413,"request content":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" "} {"level":"info","ts":"2026-06-19T18:06:20.586212Z","caller":"traceutil/trace.go:171","msg":"trace[1922710698] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4922; }","duration":"231.784986ms","start":"2026-06-19T18:06:20.354345Z","end":"2026-06-19T18:06:20.58613Z","steps":["trace[1922710698] 'agreement among raft nodes before linearized reading' (duration: 231.582763ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T18:06:20.802815Z","caller":"traceutil/trace.go:171","msg":"trace[155172786] linearizableReadLoop","detail":"{readStateIndex:5110; appliedIndex:5109; }","duration":"209.615662ms","start":"2026-06-19T18:06:20.593179Z","end":"2026-06-19T18:06:20.802794Z","steps":["trace[155172786] 'read index received' (duration: 161.749541ms)","trace[155172786] 'applied index is now lower than readState.Index' (duration: 47.865321ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T18:06:20.803116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.926578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rabbitmq-keystone-default-user\" ","response":"range_response_count:1 size:1321"} {"level":"info","ts":"2026-06-19T18:06:20.803148Z","caller":"traceutil/trace.go:171","msg":"trace[1006936532] range","detail":"{range_begin:/registry/secrets/openstack/rabbitmq-keystone-default-user; range_end:; response_count:1; response_revision:4923; }","duration":"210.02518ms","start":"2026-06-19T18:06:20.593115Z","end":"2026-06-19T18:06:20.803141Z","steps":["trace[1006936532] 'agreement among raft nodes before linearized reading' (duration: 209.750525ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T18:06:20.803278Z","caller":"traceutil/trace.go:171","msg":"trace[1473596999] transaction","detail":"{read_only:false; response_revision:4923; number_of_response:1; }","duration":"210.984997ms","start":"2026-06-19T18:06:20.592245Z","end":"2026-06-19T18:06:20.80323Z","steps":["trace[1473596999] 'process raft request' (duration: 162.632937ms)","trace[1473596999] 'compare' (duration: 47.831201ms)"],"step_count":2} {"level":"info","ts":"2026-06-19T18:06:20.858174Z","caller":"traceutil/trace.go:171","msg":"trace[1746851176] transaction","detail":"{read_only:false; response_revision:4924; number_of_response:1; }","duration":"261.805359ms","start":"2026-06-19T18:06:20.596349Z","end":"2026-06-19T18:06:20.858154Z","steps":["trace[1746851176] 'process raft request' (duration: 261.665087ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T18:06:21.023264Z","caller":"traceutil/trace.go:171","msg":"trace[1260386835] transaction","detail":"{read_only:false; response_revision:4926; number_of_response:1; }","duration":"159.235097ms","start":"2026-06-19T18:06:20.863998Z","end":"2026-06-19T18:06:21.023233Z","steps":["trace[1260386835] 'process raft request' (duration: 66.627188ms)","trace[1260386835] 'compare' (duration: 92.188002ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T18:06:21.023859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.058065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-19T18:06:21.023977Z","caller":"traceutil/trace.go:171","msg":"trace[1769613112] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4929; }","duration":"178.191106ms","start":"2026-06-19T18:06:20.84573Z","end":"2026-06-19T18:06:21.023921Z","steps":["trace[1769613112] 'agreement among raft nodes before linearized reading' (duration: 177.944111ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T18:06:21.024214Z","caller":"traceutil/trace.go:171","msg":"trace[1885864273] transaction","detail":"{read_only:false; response_revision:4928; number_of_response:1; }","duration":"158.83274ms","start":"2026-06-19T18:06:20.865355Z","end":"2026-06-19T18:06:21.024188Z","steps":["trace[1885864273] 'process raft request' (duration: 157.74376ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T18:06:21.024049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.103487ms","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-19T18:06:21.024354Z","caller":"traceutil/trace.go:171","msg":"trace[1748189084] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4929; }","duration":"181.469804ms","start":"2026-06-19T18:06:20.842874Z","end":"2026-06-19T18:06:21.024344Z","steps":["trace[1748189084] 'agreement among raft nodes before linearized reading' (duration: 181.007126ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T18:06:21.024369Z","caller":"traceutil/trace.go:171","msg":"trace[580269243] transaction","detail":"{read_only:false; response_revision:4929; number_of_response:1; }","duration":"158.84238ms","start":"2026-06-19T18:06:20.865506Z","end":"2026-06-19T18:06:21.024348Z","steps":["trace[580269243] 'process raft request' (duration: 157.662319ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T18:06:21.02481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.11189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-19T18:06:21.024864Z","caller":"traceutil/trace.go:171","msg":"trace[530787055] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4929; }","duration":"195.177751ms","start":"2026-06-19T18:06:20.829671Z","end":"2026-06-19T18:06:21.024849Z","steps":["trace[530787055] 'agreement among raft nodes before linearized reading' (duration: 195.10144ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T18:06:21.025085Z","caller":"traceutil/trace.go:171","msg":"trace[1939397579] linearizableReadLoop","detail":"{readStateIndex:5116; appliedIndex:5112; }","duration":"146.486025ms","start":"2026-06-19T18:06:20.877162Z","end":"2026-06-19T18:06:21.023648Z","steps":["trace[1939397579] 'read index received' (duration: 53.605661ms)","trace[1939397579] 'applied index is now lower than readState.Index' (duration: 92.879354ms)"],"step_count":2} {"level":"info","ts":"2026-06-19T18:06:21.023379Z","caller":"traceutil/trace.go:171","msg":"trace[1664957262] transaction","detail":"{read_only:false; response_revision:4927; number_of_response:1; }","duration":"158.524354ms","start":"2026-06-19T18:06:20.864821Z","end":"2026-06-19T18:06:21.023345Z","steps":["trace[1664957262] 'process raft request' (duration: 158.202518ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T18:06:21.025255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.941515ms","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-19T18:06:21.025291Z","caller":"traceutil/trace.go:171","msg":"trace[2103614517] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4929; }","duration":"196.005445ms","start":"2026-06-19T18:06:20.829276Z","end":"2026-06-19T18:06:21.025282Z","steps":["trace[2103614517] 'agreement among raft nodes before linearized reading' (duration: 195.899854ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T18:06:21.025416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.167838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/rabbitmq-keystone.18ba8daa6813d4d6\" ","response":"range_response_count:1 size:746"} {"level":"info","ts":"2026-06-19T18:06:21.025471Z","caller":"traceutil/trace.go:171","msg":"trace[237009426] range","detail":"{range_begin:/registry/events/openstack/rabbitmq-keystone.18ba8daa6813d4d6; range_end:; response_count:1; response_revision:4929; }","duration":"143.303969ms","start":"2026-06-19T18:06:20.882149Z","end":"2026-06-19T18:06:21.025453Z","steps":["trace[237009426] 'agreement among raft nodes before linearized reading' (duration: 143.081326ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T18:06:21.025744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.438082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:1451"} {"level":"info","ts":"2026-06-19T18:06:21.025785Z","caller":"traceutil/trace.go:171","msg":"trace[215253919] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4929; }","duration":"143.497423ms","start":"2026-06-19T18:06:20.882278Z","end":"2026-06-19T18:06:21.025775Z","steps":["trace[215253919] 'agreement among raft nodes before linearized reading' (duration: 143.391491ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T18:06:21.234853Z","caller":"traceutil/trace.go:171","msg":"trace[35118822] linearizableReadLoop","detail":"{readStateIndex:5122; appliedIndex:5121; }","duration":"129.11419ms","start":"2026-06-19T18:06:21.105714Z","end":"2026-06-19T18:06:21.234828Z","steps":["trace[35118822] 'read index received' (duration: 52.720185ms)","trace[35118822] 'applied index is now lower than readState.Index' (duration: 76.393035ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T18:06:21.235069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.330124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-06-19T18:06:21.235112Z","caller":"traceutil/trace.go:171","msg":"trace[1776596213] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4935; }","duration":"129.407715ms","start":"2026-06-19T18:06:21.105691Z","end":"2026-06-19T18:06:21.235099Z","steps":["trace[1776596213] 'agreement among raft nodes before linearized reading' (duration: 129.253222ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T18:06:21.235182Z","caller":"traceutil/trace.go:171","msg":"trace[1144954079] transaction","detail":"{read_only:false; response_revision:4935; number_of_response:1; }","duration":"131.055264ms","start":"2026-06-19T18:06:21.104103Z","end":"2026-06-19T18:06:21.235159Z","steps":["trace[1144954079] 'process raft request' (duration: 54.539957ms)","trace[1144954079] 'compare' (duration: 76.058769ms)"],"step_count":2} {"level":"info","ts":"2026-06-19T18:06:21.607876Z","caller":"traceutil/trace.go:171","msg":"trace[360678527] transaction","detail":"{read_only:false; response_revision:4937; number_of_response:1; }","duration":"297.462811ms","start":"2026-06-19T18:06:21.310393Z","end":"2026-06-19T18:06:21.607856Z","steps":["trace[360678527] 'process raft request' (duration: 297.331128ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T18:06:21.902209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.624278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-grafana-7c7b46dd78-9kqdc\" ","response":"range_response_count:1 size:11847"} {"level":"info","ts":"2026-06-19T18:06:21.90238Z","caller":"traceutil/trace.go:171","msg":"trace[1687355700] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-grafana-7c7b46dd78-9kqdc; range_end:; response_count:1; response_revision:4937; }","duration":"216.851052ms","start":"2026-06-19T18:06:21.685506Z","end":"2026-06-19T18:06:21.902357Z","steps":["trace[1687355700] 'range keys from in-memory index tree' (duration: 216.411005ms)"],"step_count":1} {"level":"warn","ts":"2026-06-19T18:07:20.939686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.124028ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-19T18:07:20.939928Z","caller":"traceutil/trace.go:171","msg":"trace[1072214297] linearizableReadLoop","detail":"{readStateIndex:5617; appliedIndex:5616; }","duration":"110.308759ms","start":"2026-06-19T18:07:20.829583Z","end":"2026-06-19T18:07:20.939892Z","steps":["trace[1072214297] 'read index received' (duration: 50.281µs)","trace[1072214297] 'applied index is now lower than readState.Index' (duration: 110.257798ms)"],"step_count":2} {"level":"info","ts":"2026-06-19T18:07:20.940029Z","caller":"traceutil/trace.go:171","msg":"trace[194820008] transaction","detail":"{read_only:false; response_revision:5416; number_of_response:1; }","duration":"142.66501ms","start":"2026-06-19T18:07:20.797354Z","end":"2026-06-19T18:07:20.94002Z","steps":["trace[194820008] 'process raft request' (duration: 25.093385ms)","trace[194820008] 'compare' (duration: 117.041157ms)"],"step_count":2} {"level":"warn","ts":"2026-06-19T18:07:20.940212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.630104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-19T18:07:20.940245Z","caller":"traceutil/trace.go:171","msg":"trace[28722807] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5417; }","duration":"110.705465ms","start":"2026-06-19T18:07:20.829531Z","end":"2026-06-19T18:07:20.940237Z","steps":["trace[28722807] 'agreement among raft nodes before linearized reading' (duration: 110.489812ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T18:07:20.974541Z","caller":"traceutil/trace.go:171","msg":"trace[1320615280] transaction","detail":"{read_only:false; response_revision:5418; number_of_response:1; }","duration":"117.681797ms","start":"2026-06-19T18:07:20.856842Z","end":"2026-06-19T18:07:20.974523Z","steps":["trace[1320615280] 'process raft request' (duration: 117.423993ms)"],"step_count":1} {"level":"info","ts":"2026-06-19T18:07:40.670999Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2904} {"level":"info","ts":"2026-06-19T18:07:40.770972Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2904,"took":"98.192763ms","hash":1009435344,"current-db-size-bytes":54603776,"current-db-size":"55 MB","current-db-size-in-use-bytes":29249536,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-06-19T18:07:40.771038Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1009435344,"revision":2904,"compact-revision":-1} {"level":"info","ts":"2026-06-19T18:12:40.677296Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5575} {"level":"info","ts":"2026-06-19T18:12:40.795181Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5575,"took":"116.486789ms","hash":1645500754,"current-db-size-bytes":54603776,"current-db-size":"55 MB","current-db-size-in-use-bytes":18485248,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-06-19T18:12:40.79526Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1645500754,"revision":5575,"compact-revision":2904}