{"level":"warn","ts":"2026-08-22T02:44:37.498547Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-22T02:44:37.498666Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.193:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.193:2380","--initial-cluster=instance=https://199.19.213.193:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.193:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.193:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-08-22T02:44:37.498746Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-22T02:44:37.498776Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.193:2380"]} {"level":"info","ts":"2026-08-22T02:44:37.498803Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-08-22T02:44:37.49993Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.193:2379"]} {"level":"info","ts":"2026-08-22T02:44:37.500022Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.193:2380"],"listen-peer-urls":["https://199.19.213.193:2380"],"advertise-client-urls":["https://199.19.213.193:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.193:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.193:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-08-22T02:44:37.504222Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.979006ms"} {"level":"info","ts":"2026-08-22T02:44:37.513078Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fc4b8086375a405d","cluster-id":"7155ef20751e16de"} {"level":"info","ts":"2026-08-22T02:44:37.513156Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fc4b8086375a405d switched to configuration voters=()"} {"level":"info","ts":"2026-08-22T02:44:37.513183Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fc4b8086375a405d became follower at term 0"} {"level":"info","ts":"2026-08-22T02:44:37.513197Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fc4b8086375a405d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-22T02:44:37.513212Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fc4b8086375a405d became follower at term 1"} {"level":"info","ts":"2026-08-22T02:44:37.513257Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fc4b8086375a405d switched to configuration voters=(18179765634753773661)"} {"level":"warn","ts":"2026-08-22T02:44:37.521434Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-22T02:44:37.522538Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-22T02:44:37.524302Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-08-22T02:44:37.526256Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fc4b8086375a405d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-22T02:44:37.52638Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fc4b8086375a405d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-22T02:44:37.526569Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-22T02:44:37.526685Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-22T02:44:37.526716Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-22T02:44:37.527115Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fc4b8086375a405d switched to configuration voters=(18179765634753773661)"} {"level":"info","ts":"2026-08-22T02:44:37.529472Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"7155ef20751e16de","local-member-id":"fc4b8086375a405d","added-peer-id":"fc4b8086375a405d","added-peer-peer-urls":["https://199.19.213.193:2380"]} {"level":"info","ts":"2026-08-22T02:44:37.532163Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-08-22T02:44:37.532438Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fc4b8086375a405d","initial-advertise-peer-urls":["https://199.19.213.193:2380"],"listen-peer-urls":["https://199.19.213.193:2380"],"advertise-client-urls":["https://199.19.213.193:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.193:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-22T02:44:37.532477Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-22T02:44:37.532685Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.193:2380"} {"level":"info","ts":"2026-08-22T02:44:37.532751Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.193:2380"} {"level":"info","ts":"2026-08-22T02:44:37.614111Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fc4b8086375a405d is starting a new election at term 1"} {"level":"info","ts":"2026-08-22T02:44:37.614165Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fc4b8086375a405d became pre-candidate at term 1"} {"level":"info","ts":"2026-08-22T02:44:37.614205Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fc4b8086375a405d received MsgPreVoteResp from fc4b8086375a405d at term 1"} {"level":"info","ts":"2026-08-22T02:44:37.614229Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fc4b8086375a405d became candidate at term 2"} {"level":"info","ts":"2026-08-22T02:44:37.614243Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fc4b8086375a405d received MsgVoteResp from fc4b8086375a405d at term 2"} {"level":"info","ts":"2026-08-22T02:44:37.614259Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fc4b8086375a405d became leader at term 2"} {"level":"info","ts":"2026-08-22T02:44:37.614311Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fc4b8086375a405d elected leader fc4b8086375a405d at term 2"} {"level":"info","ts":"2026-08-22T02:44:37.615496Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fc4b8086375a405d","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.193:2379]}","request-path":"/0/members/fc4b8086375a405d/attributes","cluster-id":"7155ef20751e16de","publish-timeout":"7s"} {"level":"info","ts":"2026-08-22T02:44:37.615699Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-22T02:44:37.615729Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-22T02:44:37.615958Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-22T02:44:37.61613Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-22T02:44:37.616168Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-22T02:44:37.617677Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"7155ef20751e16de","local-member-id":"fc4b8086375a405d","cluster-version":"3.5"} {"level":"info","ts":"2026-08-22T02:44:37.617895Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-22T02:44:37.61795Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-22T02:44:37.619471Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-22T02:44:37.61996Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.193:2379"} {"level":"warn","ts":"2026-08-22T02:44:41.756507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.65339ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-22T02:44:41.756655Z","caller":"traceutil/trace.go:171","msg":"trace[65613003] linearizableReadLoop","detail":"{readStateIndex:223; appliedIndex:222; }","duration":"421.569572ms","start":"2026-08-22T02:44:41.335065Z","end":"2026-08-22T02:44:41.756634Z","steps":["trace[65613003] 'read index received' (duration: 97.982795ms)","trace[65613003] 'applied index is now lower than readState.Index' (duration: 323.583247ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T02:44:41.756732Z","caller":"traceutil/trace.go:171","msg":"trace[110405672] transaction","detail":"{read_only:false; response_revision:218; number_of_response:1; }","duration":"425.249649ms","start":"2026-08-22T02:44:41.33139Z","end":"2026-08-22T02:44:41.75664Z","steps":["trace[110405672] 'process raft request' (duration: 101.734933ms)","trace[110405672] 'compare' (duration: 322.479687ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T02:44:41.756862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.782266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.18ce0085c2bee605\" ","response":"range_response_count:1 size:657"} {"level":"info","ts":"2026-08-22T02:44:41.756915Z","caller":"traceutil/trace.go:171","msg":"trace[1908967081] range","detail":"{range_begin:/registry/events/default/instance.18ce0085c2bee605; range_end:; response_count:1; response_revision:218; }","duration":"421.863898ms","start":"2026-08-22T02:44:41.335039Z","end":"2026-08-22T02:44:41.756903Z","steps":["trace[1908967081] 'agreement among raft nodes before linearized reading' (duration: 421.727916ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T02:44:41.756955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T02:44:41.335028Z","time spent":"421.918709ms","remote":"127.0.0.1:33854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":680,"request content":"key:\"/registry/events/default/instance.18ce0085c2bee605\" "} {"level":"warn","ts":"2026-08-22T02:44:41.757023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.81288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T02:44:41.757122Z","caller":"traceutil/trace.go:171","msg":"trace[1266895246] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:218; }","duration":"288.975593ms","start":"2026-08-22T02:44:41.468125Z","end":"2026-08-22T02:44:41.7571Z","steps":["trace[1266895246] 'agreement among raft nodes before linearized reading' (duration: 288.797959ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T02:44:41.757151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T02:44:41.331371Z","time spent":"425.550474ms","remote":"127.0.0.1:34088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":342,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-22T02:44:41.967815Z","caller":"traceutil/trace.go:171","msg":"trace[202346276] linearizableReadLoop","detail":"{readStateIndex:226; appliedIndex:224; }","duration":"173.184403ms","start":"2026-08-22T02:44:41.794599Z","end":"2026-08-22T02:44:41.967783Z","steps":["trace[202346276] 'read index received' (duration: 170.477143ms)","trace[202346276] 'applied index is now lower than readState.Index' (duration: 2.70592ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T02:44:41.968059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.411617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.18ce0085c2bf2863\" ","response":"range_response_count:1 size:653"} {"level":"info","ts":"2026-08-22T02:44:41.968115Z","caller":"traceutil/trace.go:171","msg":"trace[1086336657] range","detail":"{range_begin:/registry/events/default/instance.18ce0085c2bf2863; range_end:; response_count:1; response_revision:221; }","duration":"173.549479ms","start":"2026-08-22T02:44:41.794548Z","end":"2026-08-22T02:44:41.968097Z","steps":["trace[1086336657] 'agreement among raft nodes before linearized reading' (duration: 173.360386ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T02:44:41.968114Z","caller":"traceutil/trace.go:171","msg":"trace[900984122] transaction","detail":"{read_only:false; response_revision:221; number_of_response:1; }","duration":"205.134438ms","start":"2026-08-22T02:44:41.762924Z","end":"2026-08-22T02:44:41.968058Z","steps":["trace[900984122] 'process raft request' (duration: 204.745491ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T02:44:41.96829Z","caller":"traceutil/trace.go:171","msg":"trace[1731718502] transaction","detail":"{read_only:false; response_revision:220; number_of_response:1; }","duration":"205.461374ms","start":"2026-08-22T02:44:41.762652Z","end":"2026-08-22T02:44:41.968113Z","steps":["trace[1731718502] 'process raft request' (duration: 202.486699ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T02:45:16.007926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.756097ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-22T02:45:16.008197Z","caller":"traceutil/trace.go:171","msg":"trace[914434920] linearizableReadLoop","detail":"{readStateIndex:617; appliedIndex:615; }","duration":"101.950492ms","start":"2026-08-22T02:45:15.906229Z","end":"2026-08-22T02:45:16.00818Z","steps":["trace[914434920] 'read index received' (duration: 101.13441ms)","trace[914434920] 'applied index is now lower than readState.Index' (duration: 815.042µs)"],"step_count":2} {"level":"warn","ts":"2026-08-22T02:45:16.008279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.042034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-22T02:45:16.008321Z","caller":"traceutil/trace.go:171","msg":"trace[536758375] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:596; }","duration":"102.122956ms","start":"2026-08-22T02:45:15.906188Z","end":"2026-08-22T02:45:16.008311Z","steps":["trace[536758375] 'agreement among raft nodes before linearized reading' (duration: 102.046443ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T02:45:16.008393Z","caller":"traceutil/trace.go:171","msg":"trace[1962349241] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"267.96626ms","start":"2026-08-22T02:45:15.740404Z","end":"2026-08-22T02:45:16.00837Z","steps":["trace[1962349241] 'process raft request' (duration: 267.648245ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T02:45:16.008524Z","caller":"traceutil/trace.go:171","msg":"trace[1683473859] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"290.26174ms","start":"2026-08-22T02:45:15.718035Z","end":"2026-08-22T02:45:16.008297Z","steps":["trace[1683473859] 'process raft request' (duration: 158.053197ms)","trace[1683473859] 'compare' (duration: 130.946904ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T02:45:21.399201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.262217ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-22T02:45:21.39932Z","caller":"traceutil/trace.go:171","msg":"trace[1438626593] linearizableReadLoop","detail":"{readStateIndex:661; appliedIndex:660; }","duration":"314.792839ms","start":"2026-08-22T02:45:21.08451Z","end":"2026-08-22T02:45:21.399302Z","steps":["trace[1438626593] 'read index received' (duration: 211.75632ms)","trace[1438626593] 'applied index is now lower than readState.Index' (duration: 103.035409ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T02:45:21.399466Z","caller":"traceutil/trace.go:171","msg":"trace[1869330159] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"318.048358ms","start":"2026-08-22T02:45:21.081405Z","end":"2026-08-22T02:45:21.399454Z","steps":["trace[1869330159] 'process raft request' (duration: 215.310904ms)","trace[1869330159] 'compare' (duration: 101.826911ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T02:45:21.399582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T02:45:21.081388Z","time spent":"318.15615ms","remote":"127.0.0.1:33868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T02:45:21.399746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.217177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T02:45:21.399812Z","caller":"traceutil/trace.go:171","msg":"trace[676009107] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:638; }","duration":"251.376539ms","start":"2026-08-22T02:45:21.148417Z","end":"2026-08-22T02:45:21.399793Z","steps":["trace[676009107] 'agreement among raft nodes before linearized reading' (duration: 251.208276ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T02:45:21.39985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.325846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-22T02:45:21.400885Z","caller":"traceutil/trace.go:171","msg":"trace[1643678523] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:638; }","duration":"315.464068ms","start":"2026-08-22T02:45:21.084492Z","end":"2026-08-22T02:45:21.399956Z","steps":["trace[1643678523] 'agreement among raft nodes before linearized reading' (duration: 315.136973ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T02:45:21.400981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T02:45:21.084485Z","time spent":"316.461484ms","remote":"127.0.0.1:33808","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" "} {"level":"info","ts":"2026-08-22T02:46:05.95846Z","caller":"traceutil/trace.go:171","msg":"trace[34582173] transaction","detail":"{read_only:false; response_revision:1198; number_of_response:1; }","duration":"133.288612ms","start":"2026-08-22T02:46:05.825148Z","end":"2026-08-22T02:46:05.958436Z","steps":["trace[34582173] 'process raft request' (duration: 133.11675ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T02:46:52.119081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.301233ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-22T02:46:52.11919Z","caller":"traceutil/trace.go:171","msg":"trace[509390595] linearizableReadLoop","detail":"{readStateIndex:1936; appliedIndex:1935; }","duration":"151.032094ms","start":"2026-08-22T02:46:51.968141Z","end":"2026-08-22T02:46:52.119173Z","steps":["trace[509390595] 'read index received' (duration: 41.231µs)","trace[509390595] 'applied index is now lower than readState.Index' (duration: 150.989743ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T02:46:52.119503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.346138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cc246cf6-1fa8-4a15-a360-47904fc288e9\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-08-22T02:46:52.119562Z","caller":"traceutil/trace.go:171","msg":"trace[1257086389] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-cc246cf6-1fa8-4a15-a360-47904fc288e9; range_end:; response_count:1; response_revision:1866; }","duration":"151.441338ms","start":"2026-08-22T02:46:51.9681Z","end":"2026-08-22T02:46:52.119541Z","steps":["trace[1257086389] 'agreement among raft nodes before linearized reading' (duration: 151.165685ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T02:46:52.119547Z","caller":"traceutil/trace.go:171","msg":"trace[1868533155] transaction","detail":"{read_only:false; response_revision:1866; number_of_response:1; }","duration":"275.993361ms","start":"2026-08-22T02:46:51.843257Z","end":"2026-08-22T02:46:52.11925Z","steps":["trace[1868533155] 'process raft request' (duration: 44.414875ms)","trace[1868533155] 'compare' (duration: 231.198462ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T02:46:52.238126Z","caller":"traceutil/trace.go:171","msg":"trace[902061075] transaction","detail":"{read_only:false; response_revision:1867; number_of_response:1; }","duration":"107.934835ms","start":"2026-08-22T02:46:52.130164Z","end":"2026-08-22T02:46:52.238098Z","steps":["trace[902061075] 'process raft request' (duration: 99.07254ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T02:46:52.577578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.837968ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-22T02:46:52.577973Z","caller":"traceutil/trace.go:171","msg":"trace[392963121] transaction","detail":"{read_only:false; response_revision:1870; number_of_response:1; }","duration":"329.043846ms","start":"2026-08-22T02:46:52.248911Z","end":"2026-08-22T02:46:52.577954Z","steps":["trace[392963121] 'process raft request' (duration: 328.825843ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T02:46:52.578097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T02:46:52.248794Z","time spent":"329.263568ms","remote":"127.0.0.1:34018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1530,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T02:46:52.57823Z","caller":"traceutil/trace.go:171","msg":"trace[1772548067] transaction","detail":"{read_only:false; response_revision:1869; number_of_response:1; }","duration":"329.262608ms","start":"2026-08-22T02:46:52.248882Z","end":"2026-08-22T02:46:52.578144Z","steps":["trace[1772548067] 'process raft request' (duration: 107.763052ms)","trace[1772548067] 'compare' (duration: 220.713437ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T02:46:52.578373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T02:46:52.248873Z","time spent":"329.44514ms","remote":"127.0.0.1:33930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":978,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T02:46:52.578559Z","caller":"traceutil/trace.go:171","msg":"trace[1931220463] transaction","detail":"{read_only:false; response_revision:1871; number_of_response:1; }","duration":"329.46579ms","start":"2026-08-22T02:46:52.249061Z","end":"2026-08-22T02:46:52.578527Z","steps":["trace[1931220463] 'process raft request' (duration: 328.763502ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T02:46:52.578641Z","caller":"traceutil/trace.go:171","msg":"trace[1125504917] transaction","detail":"{read_only:false; response_revision:1872; number_of_response:1; }","duration":"327.577358ms","start":"2026-08-22T02:46:52.251041Z","end":"2026-08-22T02:46:52.578618Z","steps":["trace[1125504917] 'process raft request' (duration: 326.8621ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T02:46:52.578785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T02:46:52.251032Z","time spent":"327.67153ms","remote":"127.0.0.1:33946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3726,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T02:46:52.578794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T02:46:52.24904Z","time spent":"329.605191ms","remote":"127.0.0.1:33930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":894,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T02:47:25.559149Z","caller":"traceutil/trace.go:171","msg":"trace[1331124544] linearizableReadLoop","detail":"{readStateIndex:2179; appliedIndex:2178; }","duration":"115.375128ms","start":"2026-08-22T02:47:25.443746Z","end":"2026-08-22T02:47:25.559121Z","steps":["trace[1331124544] 'read index received' (duration: 80.406749ms)","trace[1331124544] 'applied index is now lower than readState.Index' (duration: 34.964409ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T02:47:25.559517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.756883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-22T02:47:25.559561Z","caller":"traceutil/trace.go:171","msg":"trace[1852770779] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2103; }","duration":"115.872875ms","start":"2026-08-22T02:47:25.443677Z","end":"2026-08-22T02:47:25.55955Z","steps":["trace[1852770779] 'agreement among raft nodes before linearized reading' (duration: 115.557452ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T02:47:25.559756Z","caller":"traceutil/trace.go:171","msg":"trace[1261005667] transaction","detail":"{read_only:false; response_revision:2103; number_of_response:1; }","duration":"125.466944ms","start":"2026-08-22T02:47:25.434222Z","end":"2026-08-22T02:47:25.559689Z","steps":["trace[1261005667] 'process raft request' (duration: 90.017458ms)","trace[1261005667] 'compare' (duration: 34.761207ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T02:47:25.963388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.805266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12386"} {"level":"info","ts":"2026-08-22T02:47:25.963535Z","caller":"traceutil/trace.go:171","msg":"trace[982938298] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2107; }","duration":"118.029078ms","start":"2026-08-22T02:47:25.84547Z","end":"2026-08-22T02:47:25.9635Z","steps":["trace[982938298] 'range keys from in-memory index tree' (duration: 116.950346ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T02:47:26.887621Z","caller":"traceutil/trace.go:171","msg":"trace[582265209] transaction","detail":"{read_only:false; response_revision:2109; number_of_response:1; }","duration":"140.9328ms","start":"2026-08-22T02:47:26.746659Z","end":"2026-08-22T02:47:26.887592Z","steps":["trace[582265209] 'process raft request' (duration: 140.746718ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T02:47:27.612673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.537835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T02:47:27.612776Z","caller":"traceutil/trace.go:171","msg":"trace[1917233496] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:2112; }","duration":"142.718188ms","start":"2026-08-22T02:47:27.47003Z","end":"2026-08-22T02:47:27.612748Z","steps":["trace[1917233496] 'count revisions from in-memory index tree' (duration: 142.436134ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T02:49:03.957275Z","caller":"traceutil/trace.go:171","msg":"trace[1940375177] transaction","detail":"{read_only:false; response_revision:2741; number_of_response:1; }","duration":"161.22733ms","start":"2026-08-22T02:49:03.796023Z","end":"2026-08-22T02:49:03.957251Z","steps":["trace[1940375177] 'process raft request' (duration: 161.061466ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T02:49:04.233527Z","caller":"traceutil/trace.go:171","msg":"trace[440081843] transaction","detail":"{read_only:false; response_revision:2743; number_of_response:1; }","duration":"115.870875ms","start":"2026-08-22T02:49:04.117635Z","end":"2026-08-22T02:49:04.233506Z","steps":["trace[440081843] 'process raft request' (duration: 115.730241ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T02:49:04.303129Z","caller":"traceutil/trace.go:171","msg":"trace[1706143913] linearizableReadLoop","detail":"{readStateIndex:2843; appliedIndex:2841; }","duration":"155.433622ms","start":"2026-08-22T02:49:04.147675Z","end":"2026-08-22T02:49:04.303108Z","steps":["trace[1706143913] 'read index received' (duration: 85.706788ms)","trace[1706143913] 'applied index is now lower than readState.Index' (duration: 69.725544ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T02:49:04.303208Z","caller":"traceutil/trace.go:171","msg":"trace[41478932] transaction","detail":"{read_only:false; response_revision:2744; number_of_response:1; }","duration":"175.928084ms","start":"2026-08-22T02:49:04.127249Z","end":"2026-08-22T02:49:04.303177Z","steps":["trace[41478932] 'process raft request' (duration: 175.735089ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T02:49:04.303316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.622967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T02:49:04.303406Z","caller":"traceutil/trace.go:171","msg":"trace[1627316730] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2744; }","duration":"155.723909ms","start":"2026-08-22T02:49:04.147661Z","end":"2026-08-22T02:49:04.303385Z","steps":["trace[1627316730] 'agreement among raft nodes before linearized reading' (duration: 155.575275ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T02:49:04.373303Z","caller":"traceutil/trace.go:171","msg":"trace[651605277] transaction","detail":"{read_only:false; response_revision:2745; number_of_response:1; }","duration":"125.663694ms","start":"2026-08-22T02:49:04.247614Z","end":"2026-08-22T02:49:04.373277Z","steps":["trace[651605277] 'process raft request' (duration: 99.80026ms)","trace[651605277] 'compare' (duration: 25.426782ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T02:49:04.373361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.47475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-22T02:49:04.373413Z","caller":"traceutil/trace.go:171","msg":"trace[483785766] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2745; }","duration":"195.570323ms","start":"2026-08-22T02:49:04.17783Z","end":"2026-08-22T02:49:04.3734Z","steps":["trace[483785766] 'agreement among raft nodes before linearized reading' (duration: 195.406179ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T02:49:04.373476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.805283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18ce00be3f82a551\" ","response":"range_response_count:1 size:779"} {"level":"info","ts":"2026-08-22T02:49:04.373669Z","caller":"traceutil/trace.go:171","msg":"trace[1923412749] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18ce00be3f82a551; range_end:; response_count:1; response_revision:2745; }","duration":"150.155192ms","start":"2026-08-22T02:49:04.223498Z","end":"2026-08-22T02:49:04.373653Z","steps":["trace[1923412749] 'agreement among raft nodes before linearized reading' (duration: 149.71479ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T02:49:04.373695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.238283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-22T02:49:04.374024Z","caller":"traceutil/trace.go:171","msg":"trace[142566598] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2745; }","duration":"198.584593ms","start":"2026-08-22T02:49:04.175415Z","end":"2026-08-22T02:49:04.374Z","steps":["trace[142566598] 'agreement among raft nodes before linearized reading' (duration: 198.043279ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T02:52:41.150769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.052471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.193\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-22T02:52:41.150901Z","caller":"traceutil/trace.go:171","msg":"trace[786992301] range","detail":"{range_begin:/registry/masterleases/199.19.213.193; range_end:; response_count:1; response_revision:4580; }","duration":"115.222583ms","start":"2026-08-22T02:52:41.035659Z","end":"2026-08-22T02:52:41.150881Z","steps":["trace[786992301] 'range keys from in-memory index tree' (duration: 114.876619ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T02:52:41.346912Z","caller":"traceutil/trace.go:171","msg":"trace[630353222] transaction","detail":"{read_only:false; response_revision:4582; number_of_response:1; }","duration":"165.53686ms","start":"2026-08-22T02:52:41.181348Z","end":"2026-08-22T02:52:41.346885Z","steps":["trace[630353222] 'process raft request' (duration: 160.783064ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T02:52:41.363369Z","caller":"traceutil/trace.go:171","msg":"trace[1097935751] linearizableReadLoop","detail":"{readStateIndex:4756; appliedIndex:4754; }","duration":"127.096943ms","start":"2026-08-22T02:52:41.236245Z","end":"2026-08-22T02:52:41.363342Z","steps":["trace[1097935751] 'read index received' (duration: 105.900317ms)","trace[1097935751] 'applied index is now lower than readState.Index' (duration: 21.195086ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T02:52:41.36343Z","caller":"traceutil/trace.go:171","msg":"trace[1348457304] transaction","detail":"{read_only:false; response_revision:4583; number_of_response:1; }","duration":"142.041038ms","start":"2026-08-22T02:52:41.221351Z","end":"2026-08-22T02:52:41.363392Z","steps":["trace[1348457304] 'process raft request' (duration: 141.849906ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T02:52:41.363707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.432068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-22T02:52:41.36379Z","caller":"traceutil/trace.go:171","msg":"trace[99519005] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4583; }","duration":"127.557899ms","start":"2026-08-22T02:52:41.236214Z","end":"2026-08-22T02:52:41.363772Z","steps":["trace[99519005] 'agreement among raft nodes before linearized reading' (duration: 127.253735ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T02:52:47.043173Z","caller":"traceutil/trace.go:171","msg":"trace[365346973] transaction","detail":"{read_only:false; response_revision:4678; number_of_response:1; }","duration":"339.272118ms","start":"2026-08-22T02:52:46.703869Z","end":"2026-08-22T02:52:47.043141Z","steps":["trace[365346973] 'process raft request' (duration: 284.61193ms)","trace[365346973] 'compare' (duration: 54.245832ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T02:52:47.043285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T02:52:46.70384Z","time spent":"339.392699ms","remote":"127.0.0.1:33854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":725,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-22T02:52:47.043309Z","caller":"traceutil/trace.go:171","msg":"trace[1202828154] linearizableReadLoop","detail":"{readStateIndex:4854; appliedIndex:4851; }","duration":"317.051088ms","start":"2026-08-22T02:52:46.726234Z","end":"2026-08-22T02:52:47.043285Z","steps":["trace[1202828154] 'read index received' (duration: 262.254178ms)","trace[1202828154] 'applied index is now lower than readState.Index' (duration: 54.79591ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T02:52:47.043423Z","caller":"traceutil/trace.go:171","msg":"trace[1261702205] transaction","detail":"{read_only:false; response_revision:4682; number_of_response:1; }","duration":"237.991954ms","start":"2026-08-22T02:52:46.80542Z","end":"2026-08-22T02:52:47.043412Z","steps":["trace[1261702205] 'process raft request' (duration: 237.818771ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T02:52:47.043411Z","caller":"traceutil/trace.go:171","msg":"trace[1830723958] transaction","detail":"{read_only:false; response_revision:4681; number_of_response:1; }","duration":"304.032733ms","start":"2026-08-22T02:52:46.739347Z","end":"2026-08-22T02:52:47.04338Z","steps":["trace[1830723958] 'process raft request' (duration: 303.83007ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T02:52:47.043534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T02:52:46.739323Z","time spent":"304.144215ms","remote":"127.0.0.1:34012","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-08-22T02:52:47.043564Z","caller":"traceutil/trace.go:171","msg":"trace[852085551] transaction","detail":"{read_only:false; response_revision:4679; number_of_response:1; }","duration":"326.219422ms","start":"2026-08-22T02:52:46.717336Z","end":"2026-08-22T02:52:47.043556Z","steps":["trace[852085551] 'process raft request' (duration: 325.683054ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T02:52:47.043631Z","caller":"traceutil/trace.go:171","msg":"trace[1349138532] transaction","detail":"{read_only:false; response_revision:4680; number_of_response:1; }","duration":"318.963378ms","start":"2026-08-22T02:52:46.724654Z","end":"2026-08-22T02:52:47.043617Z","steps":["trace[1349138532] 'process raft request' (duration: 318.475601ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T02:52:47.043683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T02:52:46.71732Z","time spent":"326.276353ms","remote":"127.0.0.1:34204","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9624,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T02:52:47.043716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T02:52:46.724638Z","time spent":"319.030009ms","remote":"127.0.0.1:34012","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T02:52:47.043691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.436284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1451"} {"level":"info","ts":"2026-08-22T02:52:47.043782Z","caller":"traceutil/trace.go:171","msg":"trace[1224573083] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4682; }","duration":"317.555115ms","start":"2026-08-22T02:52:46.726202Z","end":"2026-08-22T02:52:47.043757Z","steps":["trace[1224573083] 'agreement among raft nodes before linearized reading' (duration: 317.336152ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T02:52:47.043834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T02:52:46.726189Z","time spent":"317.635947ms","remote":"127.0.0.1:33918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1474,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"warn","ts":"2026-08-22T02:52:47.046537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.18439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16233"} {"level":"info","ts":"2026-08-22T02:52:47.046595Z","caller":"traceutil/trace.go:171","msg":"trace[1014714304] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4683; }","duration":"242.269061ms","start":"2026-08-22T02:52:46.804312Z","end":"2026-08-22T02:52:47.046581Z","steps":["trace[1014714304] 'agreement among raft nodes before linearized reading' (duration: 242.118479ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T02:52:47.047104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.199876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-08-22T02:52:47.04723Z","caller":"traceutil/trace.go:171","msg":"trace[1603146372] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4683; }","duration":"168.327597ms","start":"2026-08-22T02:52:46.878879Z","end":"2026-08-22T02:52:47.047207Z","steps":["trace[1603146372] 'agreement among raft nodes before linearized reading' (duration: 168.136385ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T02:52:47.047547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.800555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-08-22T02:52:47.047627Z","caller":"traceutil/trace.go:171","msg":"trace[4629889] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4683; }","duration":"166.879956ms","start":"2026-08-22T02:52:46.880736Z","end":"2026-08-22T02:52:47.047616Z","steps":["trace[4629889] 'agreement among raft nodes before linearized reading' (duration: 166.739384ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T02:52:47.048068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.422989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207418"} {"level":"info","ts":"2026-08-22T02:52:47.048126Z","caller":"traceutil/trace.go:171","msg":"trace[625484574] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4683; }","duration":"243.48169ms","start":"2026-08-22T02:52:46.804629Z","end":"2026-08-22T02:52:47.048111Z","steps":["trace[625484574] 'agreement among raft nodes before linearized reading' (duration: 242.442354ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T02:52:47.371255Z","caller":"traceutil/trace.go:171","msg":"trace[1524696566] linearizableReadLoop","detail":"{readStateIndex:4865; appliedIndex:4864; }","duration":"143.995463ms","start":"2026-08-22T02:52:47.227234Z","end":"2026-08-22T02:52:47.371229Z","steps":["trace[1524696566] 'read index received' (duration: 74.694815ms)","trace[1524696566] 'applied index is now lower than readState.Index' (duration: 69.299588ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T02:52:47.371463Z","caller":"traceutil/trace.go:171","msg":"trace[674812232] transaction","detail":"{read_only:false; response_revision:4691; number_of_response:1; }","duration":"145.624078ms","start":"2026-08-22T02:52:47.225806Z","end":"2026-08-22T02:52:47.37143Z","steps":["trace[674812232] 'process raft request' (duration: 76.100856ms)","trace[674812232] 'compare' (duration: 69.179987ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T02:52:47.371505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.857128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9639"} {"level":"info","ts":"2026-08-22T02:52:47.371542Z","caller":"traceutil/trace.go:171","msg":"trace[1288063818] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4691; }","duration":"132.935419ms","start":"2026-08-22T02:52:47.238596Z","end":"2026-08-22T02:52:47.371531Z","steps":["trace[1288063818] 'agreement among raft nodes before linearized reading' (duration: 132.776516ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T02:52:47.371554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.299558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"} {"level":"info","ts":"2026-08-22T02:52:47.371637Z","caller":"traceutil/trace.go:171","msg":"trace[1864120291] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:4691; }","duration":"144.406269ms","start":"2026-08-22T02:52:47.227212Z","end":"2026-08-22T02:52:47.371618Z","steps":["trace[1864120291] 'agreement among raft nodes before linearized reading' (duration: 144.159525ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T02:52:47.652638Z","caller":"traceutil/trace.go:171","msg":"trace[420291047] transaction","detail":"{read_only:false; response_revision:4698; number_of_response:1; }","duration":"122.210241ms","start":"2026-08-22T02:52:47.530408Z","end":"2026-08-22T02:52:47.652618Z","steps":["trace[420291047] 'process raft request' (duration: 112.63428ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T02:53:02.336059Z","caller":"traceutil/trace.go:171","msg":"trace[899017335] transaction","detail":"{read_only:false; response_revision:4869; number_of_response:1; }","duration":"326.420159ms","start":"2026-08-22T02:53:02.009612Z","end":"2026-08-22T02:53:02.336032Z","steps":["trace[899017335] 'process raft request' (duration: 266.070626ms)","trace[899017335] 'compare' (duration: 60.19352ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T02:53:02.336206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T02:53:02.009585Z","time spent":"326.548151ms","remote":"127.0.0.1:34018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1428,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T02:53:02.350119Z","caller":"traceutil/trace.go:171","msg":"trace[1025067045] linearizableReadLoop","detail":"{readStateIndex:5051; appliedIndex:5047; }","duration":"327.995224ms","start":"2026-08-22T02:53:02.022103Z","end":"2026-08-22T02:53:02.350098Z","steps":["trace[1025067045] 'read index received' (duration: 253.743646ms)","trace[1025067045] 'applied index is now lower than readState.Index' (duration: 74.250578ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T02:53:02.350203Z","caller":"traceutil/trace.go:171","msg":"trace[1784206517] transaction","detail":"{read_only:false; response_revision:4871; number_of_response:1; }","duration":"339.319219ms","start":"2026-08-22T02:53:02.010872Z","end":"2026-08-22T02:53:02.350191Z","steps":["trace[1784206517] 'process raft request' (duration: 339.094755ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T02:53:02.350276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T02:53:02.010862Z","time spent":"339.36736ms","remote":"127.0.0.1:33930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":892,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T02:53:02.35037Z","caller":"traceutil/trace.go:171","msg":"trace[1966611710] transaction","detail":"{read_only:false; response_revision:4872; number_of_response:1; }","duration":"338.523426ms","start":"2026-08-22T02:53:02.011831Z","end":"2026-08-22T02:53:02.350354Z","steps":["trace[1966611710] 'process raft request' (duration: 338.213552ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T02:53:02.350362Z","caller":"traceutil/trace.go:171","msg":"trace[179599592] transaction","detail":"{read_only:false; response_revision:4870; number_of_response:1; }","duration":"339.763446ms","start":"2026-08-22T02:53:02.010568Z","end":"2026-08-22T02:53:02.350331Z","steps":["trace[179599592] 'process raft request' (duration: 339.259578ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T02:53:02.350479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T02:53:02.01182Z","time spent":"338.600247ms","remote":"127.0.0.1:34018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1505,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T02:53:02.350515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.408991ms","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":"warn","ts":"2026-08-22T02:53:02.350527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T02:53:02.010541Z","time spent":"339.894858ms","remote":"127.0.0.1:33930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":950,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T02:53:02.350547Z","caller":"traceutil/trace.go:171","msg":"trace[461879763] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4872; }","duration":"328.466221ms","start":"2026-08-22T02:53:02.022073Z","end":"2026-08-22T02:53:02.350539Z","steps":["trace[461879763] 'agreement among raft nodes before linearized reading' (duration: 328.36868ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T02:53:02.350577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T02:53:02.022062Z","time spent":"328.510362ms","remote":"127.0.0.1:33918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1888,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"warn","ts":"2026-08-22T02:53:02.364358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.867625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-22T02:53:02.364407Z","caller":"traceutil/trace.go:171","msg":"trace[1344678458] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:4874; }","duration":"152.961565ms","start":"2026-08-22T02:53:02.211436Z","end":"2026-08-22T02:53:02.364398Z","steps":["trace[1344678458] 'agreement among raft nodes before linearized reading' (duration: 152.860134ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T02:53:02.364519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.278984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T02:53:02.364558Z","caller":"traceutil/trace.go:171","msg":"trace[630624922] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4874; }","duration":"214.361646ms","start":"2026-08-22T02:53:02.150187Z","end":"2026-08-22T02:53:02.364549Z","steps":["trace[630624922] 'agreement among raft nodes before linearized reading' (duration: 214.296085ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T02:54:38.028271Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2919} {"level":"info","ts":"2026-08-22T02:54:38.105666Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2919,"took":"76.293109ms","hash":611802320,"current-db-size-bytes":55427072,"current-db-size":"55 MB","current-db-size-in-use-bytes":29888512,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-08-22T02:54:38.105738Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":611802320,"revision":2919,"compact-revision":-1} {"level":"info","ts":"2026-08-22T02:59:38.033496Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5643} {"level":"info","ts":"2026-08-22T02:59:38.151669Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5643,"took":"116.539515ms","hash":2265754548,"current-db-size-bytes":55427072,"current-db-size":"55 MB","current-db-size-in-use-bytes":18411520,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-08-22T02:59:38.151718Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2265754548,"revision":5643,"compact-revision":2919}