{"level":"warn","ts":"2026-10-15T06:28:55.155266Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-15T06:28:55.155375Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.32:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.32:2380","--initial-cluster=instance=https://162.253.55.32:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.32:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.32: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-10-15T06:28:55.155458Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-15T06:28:55.155471Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.32:2380"]} {"level":"info","ts":"2026-10-15T06:28:55.155498Z","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-10-15T06:28:55.156412Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.32:2379"]} {"level":"info","ts":"2026-10-15T06:28:55.156507Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.32:2380"],"listen-peer-urls":["https://162.253.55.32:2380"],"advertise-client-urls":["https://162.253.55.32:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.32:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.32: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-10-15T06:28:55.162231Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.430168ms"} {"level":"info","ts":"2026-10-15T06:28:55.176754Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c665390cd9eacc14","cluster-id":"d19b610fbe64baae"} {"level":"info","ts":"2026-10-15T06:28:55.176845Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c665390cd9eacc14 switched to configuration voters=()"} {"level":"info","ts":"2026-10-15T06:28:55.176869Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c665390cd9eacc14 became follower at term 0"} {"level":"info","ts":"2026-10-15T06:28:55.176883Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c665390cd9eacc14 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-15T06:28:55.176892Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c665390cd9eacc14 became follower at term 1"} {"level":"info","ts":"2026-10-15T06:28:55.176931Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c665390cd9eacc14 switched to configuration voters=(14295895319515941908)"} {"level":"warn","ts":"2026-10-15T06:28:55.192165Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-15T06:28:55.194207Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-15T06:28:55.195443Z","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-10-15T06:28:55.199851Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c665390cd9eacc14","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-15T06:28:55.199978Z","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-10-15T06:28:55.200078Z","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-10-15T06:28:55.20009Z","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-10-15T06:28:55.200366Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c665390cd9eacc14","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-15T06:28:55.201155Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c665390cd9eacc14 switched to configuration voters=(14295895319515941908)"} {"level":"info","ts":"2026-10-15T06:28:55.20731Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"d19b610fbe64baae","local-member-id":"c665390cd9eacc14","added-peer-id":"c665390cd9eacc14","added-peer-peer-urls":["https://162.253.55.32:2380"]} {"level":"info","ts":"2026-10-15T06:28:55.207859Z","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-10-15T06:28:55.208136Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c665390cd9eacc14","initial-advertise-peer-urls":["https://162.253.55.32:2380"],"listen-peer-urls":["https://162.253.55.32:2380"],"advertise-client-urls":["https://162.253.55.32:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.32:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-15T06:28:55.208171Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-15T06:28:55.208784Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.32:2380"} {"level":"info","ts":"2026-10-15T06:28:55.208818Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.32:2380"} {"level":"info","ts":"2026-10-15T06:28:55.977154Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c665390cd9eacc14 is starting a new election at term 1"} {"level":"info","ts":"2026-10-15T06:28:55.977197Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c665390cd9eacc14 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-15T06:28:55.97723Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c665390cd9eacc14 received MsgPreVoteResp from c665390cd9eacc14 at term 1"} {"level":"info","ts":"2026-10-15T06:28:55.977242Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c665390cd9eacc14 became candidate at term 2"} {"level":"info","ts":"2026-10-15T06:28:55.977249Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c665390cd9eacc14 received MsgVoteResp from c665390cd9eacc14 at term 2"} {"level":"info","ts":"2026-10-15T06:28:55.977259Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c665390cd9eacc14 became leader at term 2"} {"level":"info","ts":"2026-10-15T06:28:55.977277Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c665390cd9eacc14 elected leader c665390cd9eacc14 at term 2"} {"level":"info","ts":"2026-10-15T06:28:55.978212Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T06:28:55.978891Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c665390cd9eacc14","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.32:2379]}","request-path":"/0/members/c665390cd9eacc14/attributes","cluster-id":"d19b610fbe64baae","publish-timeout":"7s"} {"level":"info","ts":"2026-10-15T06:28:55.978944Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-15T06:28:55.978973Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-15T06:28:55.979355Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-15T06:28:55.979477Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-15T06:28:55.979486Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"d19b610fbe64baae","local-member-id":"c665390cd9eacc14","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T06:28:55.979602Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T06:28:55.979628Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T06:28:55.981503Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-15T06:28:55.985476Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.32:2379"} {"level":"info","ts":"2026-10-15T06:28:57.554955Z","caller":"traceutil/trace.go:171","msg":"trace[310379295] linearizableReadLoop","detail":"{readStateIndex:14; appliedIndex:7; }","duration":"101.668843ms","start":"2026-10-15T06:28:57.453266Z","end":"2026-10-15T06:28:57.554935Z","steps":["trace[310379295] 'read index received' (duration: 37.140508ms)","trace[310379295] 'applied index is now lower than readState.Index' (duration: 64.527355ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:28:57.555147Z","caller":"traceutil/trace.go:171","msg":"trace[1909339158] transaction","detail":"{read_only:false; number_of_response:0; response_revision:10; }","duration":"103.331949ms","start":"2026-10-15T06:28:57.451768Z","end":"2026-10-15T06:28:57.5551Z","steps":["trace[1909339158] 'process raft request' (duration: 70.964914ms)","trace[1909339158] 'compare' (duration: 32.012327ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T06:28:57.555346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.052881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-15T06:28:57.555502Z","caller":"traceutil/trace.go:171","msg":"trace[2022173743] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:13; }","duration":"102.373708ms","start":"2026-10-15T06:28:57.453106Z","end":"2026-10-15T06:28:57.55548Z","steps":["trace[2022173743] 'agreement among raft nodes before linearized reading' (duration: 102.040511ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:28:59.765578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.406045ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-15T06:28:59.765797Z","caller":"traceutil/trace.go:171","msg":"trace[1313886531] linearizableReadLoop","detail":"{readStateIndex:247; appliedIndex:246; }","duration":"168.694194ms","start":"2026-10-15T06:28:59.597087Z","end":"2026-10-15T06:28:59.765781Z","steps":["trace[1313886531] 'read index received' (duration: 45.861µs)","trace[1313886531] 'applied index is now lower than readState.Index' (duration: 168.646813ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T06:28:59.766027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.94131ms","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-10-15T06:28:59.766115Z","caller":"traceutil/trace.go:171","msg":"trace[1743269978] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:241; }","duration":"169.089943ms","start":"2026-10-15T06:28:59.597012Z","end":"2026-10-15T06:28:59.766102Z","steps":["trace[1743269978] 'agreement among raft nodes before linearized reading' (duration: 168.836568ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:28:59.765964Z","caller":"traceutil/trace.go:171","msg":"trace[1944819675] transaction","detail":"{read_only:false; response_revision:241; number_of_response:1; }","duration":"416.907458ms","start":"2026-10-15T06:28:59.348998Z","end":"2026-10-15T06:28:59.765906Z","steps":["trace[1944819675] 'process raft request' (duration: 145.698935ms)","trace[1944819675] 'compare' (duration: 270.263912ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T06:28:59.766483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:28:59.348951Z","time spent":"417.420289ms","remote":"127.0.0.1:50848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-15T06:28:59.986442Z","caller":"traceutil/trace.go:171","msg":"trace[1395664555] transaction","detail":"{read_only:false; response_revision:243; number_of_response:1; }","duration":"214.602329ms","start":"2026-10-15T06:28:59.77182Z","end":"2026-10-15T06:28:59.986422Z","steps":["trace[1395664555] 'process raft request' (duration: 214.460746ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:28:59.987251Z","caller":"traceutil/trace.go:171","msg":"trace[1761880979] transaction","detail":"{read_only:false; response_revision:244; number_of_response:1; }","duration":"116.143368ms","start":"2026-10-15T06:28:59.871083Z","end":"2026-10-15T06:28:59.987226Z","steps":["trace[1761880979] 'process raft request' (duration: 116.008764ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:29:46.903806Z","caller":"traceutil/trace.go:171","msg":"trace[15177201] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"104.276531ms","start":"2026-10-15T06:29:46.799503Z","end":"2026-10-15T06:29:46.903779Z","steps":["trace[15177201] 'process raft request' (duration: 104.021586ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:29:47.317328Z","caller":"traceutil/trace.go:171","msg":"trace[1557172872] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"355.114686ms","start":"2026-10-15T06:29:46.962168Z","end":"2026-10-15T06:29:47.317283Z","steps":["trace[1557172872] 'process raft request' (duration: 352.404229ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:29:47.317859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:29:46.962136Z","time spent":"355.29761ms","remote":"127.0.0.1:50616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T06:29:47.940607Z","caller":"traceutil/trace.go:171","msg":"trace[930109214] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"535.336452ms","start":"2026-10-15T06:29:47.405245Z","end":"2026-10-15T06:29:47.940582Z","steps":["trace[930109214] 'process raft request' (duration: 535.137698ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:29:47.940742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:29:47.4052Z","time spent":"535.475594ms","remote":"127.0.0.1:50750","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-15T06:29:53.138928Z","caller":"traceutil/trace.go:171","msg":"trace[1724836686] linearizableReadLoop","detail":"{readStateIndex:762; appliedIndex:761; }","duration":"132.896483ms","start":"2026-10-15T06:29:53.006012Z","end":"2026-10-15T06:29:53.138908Z","steps":["trace[1724836686] 'read index received' (duration: 132.535837ms)","trace[1724836686] 'applied index is now lower than readState.Index' (duration: 359.976µs)"],"step_count":2} {"level":"warn","ts":"2026-10-15T06:29:53.139084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.062236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:1 size:13229"} {"level":"info","ts":"2026-10-15T06:29:53.139111Z","caller":"traceutil/trace.go:171","msg":"trace[1108452840] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:1; response_revision:737; }","duration":"133.141417ms","start":"2026-10-15T06:29:53.005961Z","end":"2026-10-15T06:29:53.139103Z","steps":["trace[1108452840] 'agreement among raft nodes before linearized reading' (duration: 133.022645ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:29:53.139251Z","caller":"traceutil/trace.go:171","msg":"trace[1742751465] transaction","detail":"{read_only:false; response_revision:737; number_of_response:1; }","duration":"181.962406ms","start":"2026-10-15T06:29:52.95727Z","end":"2026-10-15T06:29:53.139232Z","steps":["trace[1742751465] 'process raft request' (duration: 181.364286ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:30:05.08416Z","caller":"traceutil/trace.go:171","msg":"trace[1932268778] linearizableReadLoop","detail":"{readStateIndex:851; appliedIndex:850; }","duration":"153.736382ms","start":"2026-10-15T06:30:04.930385Z","end":"2026-10-15T06:30:05.084122Z","steps":["trace[1932268778] 'read index received' (duration: 153.444588ms)","trace[1932268778] 'applied index is now lower than readState.Index' (duration: 290.354µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:30:05.084883Z","caller":"traceutil/trace.go:171","msg":"trace[1484943997] transaction","detail":"{read_only:false; response_revision:821; number_of_response:1; }","duration":"194.258904ms","start":"2026-10-15T06:30:04.89061Z","end":"2026-10-15T06:30:05.084869Z","steps":["trace[1484943997] 'process raft request' (duration: 193.310799ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:30:05.085176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.75791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T06:30:05.085223Z","caller":"traceutil/trace.go:171","msg":"trace[2008171077] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:821; }","duration":"154.832081ms","start":"2026-10-15T06:30:04.930377Z","end":"2026-10-15T06:30:05.08521Z","steps":["trace[2008171077] 'agreement among raft nodes before linearized reading' (duration: 154.728228ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:30:05.08542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.954812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T06:30:05.085453Z","caller":"traceutil/trace.go:171","msg":"trace[1446973504] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:821; }","duration":"154.990273ms","start":"2026-10-15T06:30:04.930455Z","end":"2026-10-15T06:30:05.085445Z","steps":["trace[1446973504] 'agreement among raft nodes before linearized reading' (duration: 154.936922ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:30:05.086054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.697412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T06:30:05.086083Z","caller":"traceutil/trace.go:171","msg":"trace[1124270290] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:821; }","duration":"120.745623ms","start":"2026-10-15T06:30:04.96533Z","end":"2026-10-15T06:30:05.086075Z","steps":["trace[1124270290] 'agreement among raft nodes before linearized reading' (duration: 120.666462ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:30:05.086242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.296762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T06:30:05.086266Z","caller":"traceutil/trace.go:171","msg":"trace[494886849] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:821; }","duration":"121.357763ms","start":"2026-10-15T06:30:04.964901Z","end":"2026-10-15T06:30:05.086259Z","steps":["trace[494886849] 'agreement among raft nodes before linearized reading' (duration: 121.316172ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:30:05.086444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.527956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T06:30:05.08652Z","caller":"traceutil/trace.go:171","msg":"trace[1439846669] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:821; }","duration":"121.601838ms","start":"2026-10-15T06:30:04.964889Z","end":"2026-10-15T06:30:05.086491Z","steps":["trace[1439846669] 'agreement among raft nodes before linearized reading' (duration: 121.514436ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:30:53.553641Z","caller":"traceutil/trace.go:171","msg":"trace[859257741] transaction","detail":"{read_only:false; response_revision:1373; number_of_response:1; }","duration":"455.737026ms","start":"2026-10-15T06:30:53.097877Z","end":"2026-10-15T06:30:53.553614Z","steps":["trace[859257741] 'process raft request' (duration: 455.593754ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:30:53.553803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:30:53.097858Z","time spent":"455.861808ms","remote":"127.0.0.1:50704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4331,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T06:31:01.84087Z","caller":"traceutil/trace.go:171","msg":"trace[1346853365] linearizableReadLoop","detail":"{readStateIndex:1548; appliedIndex:1547; }","duration":"192.071447ms","start":"2026-10-15T06:31:01.648774Z","end":"2026-10-15T06:31:01.840845Z","steps":["trace[1346853365] 'read index received' (duration: 191.931445ms)","trace[1346853365] 'applied index is now lower than readState.Index' (duration: 138.622µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:31:01.840967Z","caller":"traceutil/trace.go:171","msg":"trace[1984466365] transaction","detail":"{read_only:false; response_revision:1501; number_of_response:1; }","duration":"212.000597ms","start":"2026-10-15T06:31:01.628921Z","end":"2026-10-15T06:31:01.840922Z","steps":["trace[1984466365] 'process raft request' (duration: 211.774973ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:31:01.841138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.565996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-10-15T06:31:01.841138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.348001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/ingress-nginx/ingress-nginx-admission-patch-npd5v\" ","response":"range_response_count:1 size:4506"} {"level":"info","ts":"2026-10-15T06:31:01.841175Z","caller":"traceutil/trace.go:171","msg":"trace[1920983710] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1501; }","duration":"145.624786ms","start":"2026-10-15T06:31:01.695538Z","end":"2026-10-15T06:31:01.841163Z","steps":["trace[1920983710] 'agreement among raft nodes before linearized reading' (duration: 145.448904ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:31:01.8412Z","caller":"traceutil/trace.go:171","msg":"trace[1862295311] range","detail":"{range_begin:/registry/pods/ingress-nginx/ingress-nginx-admission-patch-npd5v; range_end:; response_count:1; response_revision:1501; }","duration":"192.456563ms","start":"2026-10-15T06:31:01.648729Z","end":"2026-10-15T06:31:01.841185Z","steps":["trace[1862295311] 'agreement among raft nodes before linearized reading' (duration: 192.25247ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:31:18.021871Z","caller":"traceutil/trace.go:171","msg":"trace[627579977] transaction","detail":"{read_only:false; response_revision:1747; number_of_response:1; }","duration":"106.349418ms","start":"2026-10-15T06:31:17.915488Z","end":"2026-10-15T06:31:18.021837Z","steps":["trace[627579977] 'process raft request' (duration: 105.954943ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:31:18.021985Z","caller":"traceutil/trace.go:171","msg":"trace[29615263] transaction","detail":"{read_only:false; response_revision:1748; number_of_response:1; }","duration":"106.46666ms","start":"2026-10-15T06:31:17.915497Z","end":"2026-10-15T06:31:18.021964Z","steps":["trace[29615263] 'process raft request' (duration: 106.083375ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:31:18.022271Z","caller":"traceutil/trace.go:171","msg":"trace[481406798] transaction","detail":"{read_only:false; response_revision:1749; number_of_response:1; }","duration":"105.571817ms","start":"2026-10-15T06:31:17.916623Z","end":"2026-10-15T06:31:18.022195Z","steps":["trace[481406798] 'process raft request' (duration: 105.254802ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:31:18.022565Z","caller":"traceutil/trace.go:171","msg":"trace[1947931965] transaction","detail":"{read_only:false; response_revision:1750; number_of_response:1; }","duration":"105.500356ms","start":"2026-10-15T06:31:17.917054Z","end":"2026-10-15T06:31:18.022554Z","steps":["trace[1947931965] 'process raft request' (duration: 105.242622ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:31:18.022628Z","caller":"traceutil/trace.go:171","msg":"trace[2145083610] transaction","detail":"{read_only:false; response_revision:1751; number_of_response:1; }","duration":"104.817146ms","start":"2026-10-15T06:31:17.917789Z","end":"2026-10-15T06:31:18.022607Z","steps":["trace[2145083610] 'process raft request' (duration: 104.683854ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:31:18.022981Z","caller":"traceutil/trace.go:171","msg":"trace[425644082] transaction","detail":"{read_only:false; response_revision:1752; number_of_response:1; }","duration":"102.732375ms","start":"2026-10-15T06:31:17.920151Z","end":"2026-10-15T06:31:18.022884Z","steps":["trace[425644082] 'process raft request' (duration: 102.375729ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:31:26.438732Z","caller":"traceutil/trace.go:171","msg":"trace[2110980904] linearizableReadLoop","detail":"{readStateIndex:1955; appliedIndex:1954; }","duration":"177.408734ms","start":"2026-10-15T06:31:26.261289Z","end":"2026-10-15T06:31:26.438698Z","steps":["trace[2110980904] 'read index received' (duration: 177.220541ms)","trace[2110980904] 'applied index is now lower than readState.Index' (duration: 186.723µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:31:26.438883Z","caller":"traceutil/trace.go:171","msg":"trace[307681202] transaction","detail":"{read_only:false; response_revision:1897; number_of_response:1; }","duration":"334.213694ms","start":"2026-10-15T06:31:26.104657Z","end":"2026-10-15T06:31:26.438871Z","steps":["trace[307681202] 'process raft request' (duration: 333.826379ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:31:26.439057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:31:26.104637Z","time spent":"334.275316ms","remote":"127.0.0.1:50768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T06:31:26.439091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.776579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4cf19c12-241c-494e-8fc5-6ba114a93cfa\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-10-15T06:31:26.439165Z","caller":"traceutil/trace.go:171","msg":"trace[1418471776] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4cf19c12-241c-494e-8fc5-6ba114a93cfa; range_end:; response_count:1; response_revision:1897; }","duration":"177.894761ms","start":"2026-10-15T06:31:26.26125Z","end":"2026-10-15T06:31:26.439145Z","steps":["trace[1418471776] 'agreement among raft nodes before linearized reading' (duration: 177.670178ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:31:26.471559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.785807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T06:31:26.471765Z","caller":"traceutil/trace.go:171","msg":"trace[454530800] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:1898; }","duration":"154.00202ms","start":"2026-10-15T06:31:26.31774Z","end":"2026-10-15T06:31:26.471742Z","steps":["trace[454530800] 'agreement among raft nodes before linearized reading' (duration: 153.744776ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:31:26.471788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.87824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:659"} {"level":"info","ts":"2026-10-15T06:31:26.471459Z","caller":"traceutil/trace.go:171","msg":"trace[640386965] transaction","detail":"{read_only:false; response_revision:1898; number_of_response:1; }","duration":"118.534686ms","start":"2026-10-15T06:31:26.352896Z","end":"2026-10-15T06:31:26.471431Z","steps":["trace[640386965] 'process raft request' (duration: 118.405384ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:31:26.472104Z","caller":"traceutil/trace.go:171","msg":"trace[781755316] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:1898; }","duration":"201.249746ms","start":"2026-10-15T06:31:26.270709Z","end":"2026-10-15T06:31:26.471959Z","steps":["trace[781755316] 'agreement among raft nodes before linearized reading' (duration: 200.744489ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:31:32.469968Z","caller":"traceutil/trace.go:171","msg":"trace[850207394] linearizableReadLoop","detail":"{readStateIndex:2034; appliedIndex:2033; }","duration":"128.48468ms","start":"2026-10-15T06:31:32.341465Z","end":"2026-10-15T06:31:32.469949Z","steps":["trace[850207394] 'read index received' (duration: 128.317197ms)","trace[850207394] 'applied index is now lower than readState.Index' (duration: 166.583µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:31:32.47009Z","caller":"traceutil/trace.go:171","msg":"trace[596448735] transaction","detail":"{read_only:false; response_revision:1974; number_of_response:1; }","duration":"140.320495ms","start":"2026-10-15T06:31:32.329751Z","end":"2026-10-15T06:31:32.470071Z","steps":["trace[596448735] 'process raft request' (duration: 140.056499ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:31:32.470477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.994791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1853"} {"level":"info","ts":"2026-10-15T06:31:32.470538Z","caller":"traceutil/trace.go:171","msg":"trace[1836684465] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:1974; }","duration":"129.160664ms","start":"2026-10-15T06:31:32.341361Z","end":"2026-10-15T06:31:32.470522Z","steps":["trace[1836684465] 'agreement among raft nodes before linearized reading' (duration: 128.991641ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:31:32.579288Z","caller":"traceutil/trace.go:171","msg":"trace[1087018096] transaction","detail":"{read_only:false; response_revision:1976; number_of_response:1; }","duration":"101.828117ms","start":"2026-10-15T06:31:32.477436Z","end":"2026-10-15T06:31:32.579264Z","steps":["trace[1087018096] 'process raft request' (duration: 95.192325ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:31:32.579634Z","caller":"traceutil/trace.go:171","msg":"trace[965734291] transaction","detail":"{read_only:false; response_revision:1977; number_of_response:1; }","duration":"102.075802ms","start":"2026-10-15T06:31:32.477542Z","end":"2026-10-15T06:31:32.579618Z","steps":["trace[965734291] 'process raft request' (duration: 101.681024ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:31:32.579806Z","caller":"traceutil/trace.go:171","msg":"trace[663106607] transaction","detail":"{read_only:false; response_revision:1978; number_of_response:1; }","duration":"102.063733ms","start":"2026-10-15T06:31:32.477729Z","end":"2026-10-15T06:31:32.579793Z","steps":["trace[663106607] 'process raft request' (duration: 101.766275ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:31:32.579858Z","caller":"traceutil/trace.go:171","msg":"trace[1136311114] transaction","detail":"{read_only:false; response_revision:1979; number_of_response:1; }","duration":"101.133993ms","start":"2026-10-15T06:31:32.478698Z","end":"2026-10-15T06:31:32.579832Z","steps":["trace[1136311114] 'process raft request' (duration: 100.923138ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:31:58.989274Z","caller":"traceutil/trace.go:171","msg":"trace[57422151] linearizableReadLoop","detail":"{readStateIndex:2239; appliedIndex:2238; }","duration":"236.612194ms","start":"2026-10-15T06:31:58.752635Z","end":"2026-10-15T06:31:58.989247Z","steps":["trace[57422151] 'read index received' (duration: 159.685145ms)","trace[57422151] 'applied index is now lower than readState.Index' (duration: 76.925549ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:31:58.98943Z","caller":"traceutil/trace.go:171","msg":"trace[651733378] transaction","detail":"{read_only:false; response_revision:2169; number_of_response:1; }","duration":"313.516773ms","start":"2026-10-15T06:31:58.675897Z","end":"2026-10-15T06:31:58.989414Z","steps":["trace[651733378] 'process raft request' (duration: 236.524912ms)","trace[651733378] 'compare' (duration: 76.650684ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T06:31:58.989541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:31:58.675873Z","time spent":"313.581743ms","remote":"127.0.0.1:50768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T06:31:58.990082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.38232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T06:31:58.990219Z","caller":"traceutil/trace.go:171","msg":"trace[1548522994] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:2169; }","duration":"237.615445ms","start":"2026-10-15T06:31:58.752569Z","end":"2026-10-15T06:31:58.990184Z","steps":["trace[1548522994] 'agreement among raft nodes before linearized reading' (duration: 237.37709ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:31:59.222394Z","caller":"traceutil/trace.go:171","msg":"trace[1431919912] transaction","detail":"{read_only:false; response_revision:2171; number_of_response:1; }","duration":"224.763925ms","start":"2026-10-15T06:31:58.997597Z","end":"2026-10-15T06:31:59.222361Z","steps":["trace[1431919912] 'process raft request' (duration: 163.919384ms)","trace[1431919912] 'compare' (duration: 60.465893ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:31:59.223005Z","caller":"traceutil/trace.go:171","msg":"trace[896309924] transaction","detail":"{read_only:false; response_revision:2172; number_of_response:1; }","duration":"223.0918ms","start":"2026-10-15T06:31:58.999887Z","end":"2026-10-15T06:31:59.222978Z","steps":["trace[896309924] 'process raft request' (duration: 222.346935ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:31:59.223152Z","caller":"traceutil/trace.go:171","msg":"trace[377140021] linearizableReadLoop","detail":"{readStateIndex:2242; appliedIndex:2239; }","duration":"212.304783ms","start":"2026-10-15T06:31:59.010606Z","end":"2026-10-15T06:31:59.222911Z","steps":["trace[377140021] 'read index received' (duration: 6.980382ms)","trace[377140021] 'applied index is now lower than readState.Index' (duration: 205.323241ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T06:31:59.223273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.65954ms","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-10-15T06:31:59.223346Z","caller":"traceutil/trace.go:171","msg":"trace[158604256] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2172; }","duration":"212.790062ms","start":"2026-10-15T06:31:59.010537Z","end":"2026-10-15T06:31:59.223327Z","steps":["trace[158604256] 'agreement among raft nodes before linearized reading' (duration: 212.549657ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:31:59.223419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.918467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:644"} {"level":"info","ts":"2026-10-15T06:31:59.223484Z","caller":"traceutil/trace.go:171","msg":"trace[829592379] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2172; }","duration":"132.010109ms","start":"2026-10-15T06:31:59.091453Z","end":"2026-10-15T06:31:59.223463Z","steps":["trace[829592379] 'agreement among raft nodes before linearized reading' (duration: 131.832085ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:31:59.223535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.277914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:4591"} {"level":"info","ts":"2026-10-15T06:31:59.223575Z","caller":"traceutil/trace.go:171","msg":"trace[597172296] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2172; }","duration":"133.349906ms","start":"2026-10-15T06:31:59.090211Z","end":"2026-10-15T06:31:59.223561Z","steps":["trace[597172296] 'agreement among raft nodes before linearized reading' (duration: 133.241284ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:31:59.224077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.15238ms","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-10-15T06:31:59.224194Z","caller":"traceutil/trace.go:171","msg":"trace[346200140] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2172; }","duration":"211.299783ms","start":"2026-10-15T06:31:59.012877Z","end":"2026-10-15T06:31:59.224177Z","steps":["trace[346200140] 'agreement among raft nodes before linearized reading' (duration: 210.399874ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:31:59.407012Z","caller":"traceutil/trace.go:171","msg":"trace[1770203938] linearizableReadLoop","detail":"{readStateIndex:2245; appliedIndex:2243; }","duration":"158.912354ms","start":"2026-10-15T06:31:59.248075Z","end":"2026-10-15T06:31:59.406988Z","steps":["trace[1770203938] 'read index received' (duration: 158.765911ms)","trace[1770203938] 'applied index is now lower than readState.Index' (duration: 145.443µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:31:59.407087Z","caller":"traceutil/trace.go:171","msg":"trace[1846246101] transaction","detail":"{read_only:false; response_revision:2173; number_of_response:1; }","duration":"178.878867ms","start":"2026-10-15T06:31:59.228165Z","end":"2026-10-15T06:31:59.407043Z","steps":["trace[1846246101] 'process raft request' (duration: 178.623152ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:31:59.407253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.328765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T06:31:59.407139Z","caller":"traceutil/trace.go:171","msg":"trace[284638983] transaction","detail":"{read_only:false; response_revision:2174; number_of_response:1; }","duration":"178.919048ms","start":"2026-10-15T06:31:59.228204Z","end":"2026-10-15T06:31:59.407123Z","steps":["trace[284638983] 'process raft request' (duration: 178.732154ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:31:59.407306Z","caller":"traceutil/trace.go:171","msg":"trace[1537917267] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2174; }","duration":"175.474348ms","start":"2026-10-15T06:31:59.231821Z","end":"2026-10-15T06:31:59.407295Z","steps":["trace[1537917267] 'agreement among raft nodes before linearized reading' (duration: 175.343305ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:31:59.40747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.99941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:567"} {"level":"info","ts":"2026-10-15T06:31:59.407598Z","caller":"traceutil/trace.go:171","msg":"trace[1943409631] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2174; }","duration":"179.161392ms","start":"2026-10-15T06:31:59.228408Z","end":"2026-10-15T06:31:59.407569Z","steps":["trace[1943409631] 'agreement among raft nodes before linearized reading' (duration: 178.775835ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:31:59.408482Z","caller":"traceutil/trace.go:171","msg":"trace[645644732] transaction","detail":"{read_only:false; response_revision:2175; number_of_response:1; }","duration":"158.766639ms","start":"2026-10-15T06:31:59.249699Z","end":"2026-10-15T06:31:59.408466Z","steps":["trace[645644732] 'process raft request' (duration: 158.32313ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:31:59.408526Z","caller":"traceutil/trace.go:171","msg":"trace[1732862988] transaction","detail":"{read_only:false; response_revision:2176; number_of_response:1; }","duration":"154.77228ms","start":"2026-10-15T06:31:59.253738Z","end":"2026-10-15T06:31:59.408511Z","steps":["trace[1732862988] 'process raft request' (duration: 154.380681ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:32:51.192032Z","caller":"traceutil/trace.go:171","msg":"trace[1181734027] transaction","detail":"{read_only:false; response_revision:2631; number_of_response:1; }","duration":"231.324374ms","start":"2026-10-15T06:32:50.960678Z","end":"2026-10-15T06:32:51.192003Z","steps":["trace[1181734027] 'process raft request' (duration: 230.63472ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:33:19.252236Z","caller":"traceutil/trace.go:171","msg":"trace[431720159] transaction","detail":"{read_only:false; response_revision:2827; number_of_response:1; }","duration":"136.112572ms","start":"2026-10-15T06:33:19.116072Z","end":"2026-10-15T06:33:19.252184Z","steps":["trace[431720159] 'process raft request' (duration: 124.465946ms)","trace[431720159] 'compare' (duration: 11.410992ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:33:19.413438Z","caller":"traceutil/trace.go:171","msg":"trace[646387763] transaction","detail":"{read_only:false; response_revision:2828; number_of_response:1; }","duration":"125.993333ms","start":"2026-10-15T06:33:19.287394Z","end":"2026-10-15T06:33:19.413387Z","steps":["trace[646387763] 'process raft request' (duration: 96.074122ms)","trace[646387763] 'compare' (duration: 29.733577ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:33:19.589575Z","caller":"traceutil/trace.go:171","msg":"trace[395296331] transaction","detail":"{read_only:false; response_revision:2830; number_of_response:1; }","duration":"120.270751ms","start":"2026-10-15T06:33:19.469279Z","end":"2026-10-15T06:33:19.58955Z","steps":["trace[395296331] 'process raft request' (duration: 119.846464ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:35:44.769603Z","caller":"traceutil/trace.go:171","msg":"trace[334793454] linearizableReadLoop","detail":"{readStateIndex:4658; appliedIndex:4657; }","duration":"115.749377ms","start":"2026-10-15T06:35:44.653831Z","end":"2026-10-15T06:35:44.769581Z","steps":["trace[334793454] 'read index received' (duration: 115.480282ms)","trace[334793454] 'applied index is now lower than readState.Index' (duration: 268.245µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:35:44.769726Z","caller":"traceutil/trace.go:171","msg":"trace[1894764605] transaction","detail":"{read_only:false; response_revision:4468; number_of_response:1; }","duration":"139.397049ms","start":"2026-10-15T06:35:44.63029Z","end":"2026-10-15T06:35:44.769687Z","steps":["trace[1894764605] 'process raft request' (duration: 139.145315ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:35:44.769855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.015171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-10-15T06:35:44.769888Z","caller":"traceutil/trace.go:171","msg":"trace[1225395556] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4468; }","duration":"116.108112ms","start":"2026-10-15T06:35:44.65377Z","end":"2026-10-15T06:35:44.769878Z","steps":["trace[1225395556] 'agreement among raft nodes before linearized reading' (duration: 115.93715ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:35:44.769906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.565136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-10-15T06:35:44.769948Z","caller":"traceutil/trace.go:171","msg":"trace[1105891802] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4468; }","duration":"105.625266ms","start":"2026-10-15T06:35:44.664311Z","end":"2026-10-15T06:35:44.769936Z","steps":["trace[1105891802] 'agreement among raft nodes before linearized reading' (duration: 105.501264ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:35:50.084517Z","caller":"traceutil/trace.go:171","msg":"trace[2144450883] transaction","detail":"{read_only:false; response_revision:4584; number_of_response:1; }","duration":"126.289756ms","start":"2026-10-15T06:35:49.958199Z","end":"2026-10-15T06:35:50.084488Z","steps":["trace[2144450883] 'process raft request' (duration: 126.051743ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:35:50.263573Z","caller":"traceutil/trace.go:171","msg":"trace[1493805451] transaction","detail":"{read_only:false; response_revision:4586; number_of_response:1; }","duration":"173.679292ms","start":"2026-10-15T06:35:50.089862Z","end":"2026-10-15T06:35:50.263541Z","steps":["trace[1493805451] 'process raft request' (duration: 153.923901ms)","trace[1493805451] 'compare' (duration: 19.617909ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:35:50.26359Z","caller":"traceutil/trace.go:171","msg":"trace[1570504398] linearizableReadLoop","detail":"{readStateIndex:4779; appliedIndex:4778; }","duration":"113.931643ms","start":"2026-10-15T06:35:50.149583Z","end":"2026-10-15T06:35:50.263515Z","steps":["trace[1570504398] 'read index received' (duration: 94.182742ms)","trace[1570504398] 'applied index is now lower than readState.Index' (duration: 19.747851ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T06:35:50.263831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.227097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:551"} {"level":"info","ts":"2026-10-15T06:35:50.263872Z","caller":"traceutil/trace.go:171","msg":"trace[1902603689] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4586; }","duration":"114.311709ms","start":"2026-10-15T06:35:50.149547Z","end":"2026-10-15T06:35:50.263859Z","steps":["trace[1902603689] 'agreement among raft nodes before linearized reading' (duration: 114.170887ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:36:02.696906Z","caller":"traceutil/trace.go:171","msg":"trace[1693073326] linearizableReadLoop","detail":"{readStateIndex:4971; appliedIndex:4970; }","duration":"280.182056ms","start":"2026-10-15T06:36:02.416693Z","end":"2026-10-15T06:36:02.696875Z","steps":["trace[1693073326] 'read index received' (duration: 279.901081ms)","trace[1693073326] 'applied index is now lower than readState.Index' (duration: 279.915µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:36:02.697024Z","caller":"traceutil/trace.go:171","msg":"trace[2039465085] transaction","detail":"{read_only:false; response_revision:4769; number_of_response:1; }","duration":"280.867007ms","start":"2026-10-15T06:36:02.416137Z","end":"2026-10-15T06:36:02.697004Z","steps":["trace[2039465085] 'process raft request' (duration: 280.541032ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:36:02.697097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.372579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T06:36:02.697148Z","caller":"traceutil/trace.go:171","msg":"trace[1269240927] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:4769; }","duration":"280.476411ms","start":"2026-10-15T06:36:02.416659Z","end":"2026-10-15T06:36:02.697135Z","steps":["trace[1269240927] 'agreement among raft nodes before linearized reading' (duration: 280.370539ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:36:02.697147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.529206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:645"} {"level":"warn","ts":"2026-10-15T06:36:02.697283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.986565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-10-15T06:36:02.697309Z","caller":"traceutil/trace.go:171","msg":"trace[1110913309] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4769; }","duration":"268.053565ms","start":"2026-10-15T06:36:02.429247Z","end":"2026-10-15T06:36:02.697301Z","steps":["trace[1110913309] 'agreement among raft nodes before linearized reading' (duration: 267.972384ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:36:02.697346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.660492ms","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-10-15T06:36:02.697414Z","caller":"traceutil/trace.go:171","msg":"trace[1880649435] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4769; }","duration":"103.779245ms","start":"2026-10-15T06:36:02.593619Z","end":"2026-10-15T06:36:02.697399Z","steps":["trace[1880649435] 'agreement among raft nodes before linearized reading' (duration: 103.567911ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:36:02.697628Z","caller":"traceutil/trace.go:171","msg":"trace[616796400] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4769; }","duration":"280.012123ms","start":"2026-10-15T06:36:02.417607Z","end":"2026-10-15T06:36:02.697619Z","steps":["trace[616796400] 'agreement among raft nodes before linearized reading' (duration: 279.451534ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:38:56.012941Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3078} {"level":"info","ts":"2026-10-15T06:38:56.149595Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3078,"took":"134.943333ms","hash":714893536,"current-db-size-bytes":56897536,"current-db-size":"57 MB","current-db-size-in-use-bytes":30928896,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-15T06:38:56.149678Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":714893536,"revision":3078,"compact-revision":-1} {"level":"info","ts":"2026-10-15T06:40:01.703019Z","caller":"traceutil/trace.go:171","msg":"trace[1351293163] transaction","detail":"{read_only:false; response_revision:6867; number_of_response:1; }","duration":"111.082723ms","start":"2026-10-15T06:40:01.591908Z","end":"2026-10-15T06:40:01.702991Z","steps":["trace[1351293163] 'process raft request' (duration: 75.382908ms)","trace[1351293163] 'compare' (duration: 35.576574ms)"],"step_count":2}