{"level":"warn","ts":"2026-10-15T14:09:42.159321Z","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-15T14:09:42.159407Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.176: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.176:2380","--initial-cluster=instance=https://162.253.55.176:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.176:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.176: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-15T14:09:42.159481Z","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-15T14:09:42.159496Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.176:2380"]} {"level":"info","ts":"2026-10-15T14:09:42.159519Z","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-15T14:09:42.160272Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.176:2379"]} {"level":"info","ts":"2026-10-15T14:09:42.16041Z","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.176:2380"],"listen-peer-urls":["https://162.253.55.176:2380"],"advertise-client-urls":["https://162.253.55.176:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.176:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.176: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-15T14:09:42.164143Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.498091ms"} {"level":"info","ts":"2026-10-15T14:09:42.171782Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"590b810b00f00655","cluster-id":"dcc6923d0deac545"} {"level":"info","ts":"2026-10-15T14:09:42.171867Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 switched to configuration voters=()"} {"level":"info","ts":"2026-10-15T14:09:42.171891Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 became follower at term 0"} {"level":"info","ts":"2026-10-15T14:09:42.171904Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 590b810b00f00655 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-15T14:09:42.171911Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 became follower at term 1"} {"level":"info","ts":"2026-10-15T14:09:42.171949Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 switched to configuration voters=(6416363978379757141)"} {"level":"warn","ts":"2026-10-15T14:09:42.17978Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-15T14:09:42.183194Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-15T14:09:42.185101Z","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-15T14:09:42.187831Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"590b810b00f00655","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-15T14:09:42.187996Z","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-15T14:09:42.188089Z","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-15T14:09:42.188099Z","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-15T14:09:42.188197Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"590b810b00f00655","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-15T14:09:42.192719Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 switched to configuration voters=(6416363978379757141)"} {"level":"info","ts":"2026-10-15T14:09:42.192815Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"dcc6923d0deac545","local-member-id":"590b810b00f00655","added-peer-id":"590b810b00f00655","added-peer-peer-urls":["https://162.253.55.176:2380"]} {"level":"info","ts":"2026-10-15T14:09:42.193358Z","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-15T14:09:42.193425Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.176:2380"} {"level":"info","ts":"2026-10-15T14:09:42.193449Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.176:2380"} {"level":"info","ts":"2026-10-15T14:09:42.193583Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"590b810b00f00655","initial-advertise-peer-urls":["https://162.253.55.176:2380"],"listen-peer-urls":["https://162.253.55.176:2380"],"advertise-client-urls":["https://162.253.55.176:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.176:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-15T14:09:42.193618Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-15T14:09:42.773713Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 is starting a new election at term 1"} {"level":"info","ts":"2026-10-15T14:09:42.773843Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-15T14:09:42.773949Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 received MsgPreVoteResp from 590b810b00f00655 at term 1"} {"level":"info","ts":"2026-10-15T14:09:42.773999Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 became candidate at term 2"} {"level":"info","ts":"2026-10-15T14:09:42.774038Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 received MsgVoteResp from 590b810b00f00655 at term 2"} {"level":"info","ts":"2026-10-15T14:09:42.774083Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 became leader at term 2"} {"level":"info","ts":"2026-10-15T14:09:42.774106Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 590b810b00f00655 elected leader 590b810b00f00655 at term 2"} {"level":"info","ts":"2026-10-15T14:09:42.775241Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"590b810b00f00655","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.176:2379]}","request-path":"/0/members/590b810b00f00655/attributes","cluster-id":"dcc6923d0deac545","publish-timeout":"7s"} {"level":"info","ts":"2026-10-15T14:09:42.775273Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-15T14:09:42.775291Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-15T14:09:42.775443Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T14:09:42.775962Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-15T14:09:42.776003Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-15T14:09:42.77643Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"dcc6923d0deac545","local-member-id":"590b810b00f00655","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T14:09:42.776645Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T14:09:42.776694Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T14:09:42.777086Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-15T14:09:42.792487Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.176:2379"} {"level":"info","ts":"2026-10-15T14:10:13.761857Z","caller":"traceutil/trace.go:171","msg":"trace[1707942317] transaction","detail":"{read_only:false; response_revision:453; number_of_response:1; }","duration":"113.355748ms","start":"2026-10-15T14:10:13.648464Z","end":"2026-10-15T14:10:13.76182Z","steps":["trace[1707942317] 'process raft request' (duration: 47.027442ms)","trace[1707942317] 'compare' (duration: 65.978642ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:10:13.761957Z","caller":"traceutil/trace.go:171","msg":"trace[682556477] transaction","detail":"{read_only:false; response_revision:454; number_of_response:1; }","duration":"111.500761ms","start":"2026-10-15T14:10:13.650386Z","end":"2026-10-15T14:10:13.761887Z","steps":["trace[682556477] 'process raft request' (duration: 111.258351ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:10:34.271032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.762482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T14:10:34.271159Z","caller":"traceutil/trace.go:171","msg":"trace[894913742] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:652; }","duration":"154.949641ms","start":"2026-10-15T14:10:34.116187Z","end":"2026-10-15T14:10:34.271137Z","steps":["trace[894913742] 'range keys from in-memory index tree' (duration: 149.690938ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:10:34.291502Z","caller":"traceutil/trace.go:171","msg":"trace[1391271969] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"167.015857ms","start":"2026-10-15T14:10:34.124445Z","end":"2026-10-15T14:10:34.291461Z","steps":["trace[1391271969] 'process raft request' (duration: 166.234181ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:10:34.716518Z","caller":"traceutil/trace.go:171","msg":"trace[1094357796] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"350.267221ms","start":"2026-10-15T14:10:34.366179Z","end":"2026-10-15T14:10:34.716446Z","steps":["trace[1094357796] 'process raft request' (duration: 266.822356ms)","trace[1094357796] 'compare' (duration: 82.856928ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T14:10:34.716871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.580076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-ms5wj\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-10-15T14:10:34.716958Z","caller":"traceutil/trace.go:171","msg":"trace[1038275207] range","detail":"{range_begin:/registry/pods/kube-system/cilium-ms5wj; range_end:; response_count:1; response_revision:654; }","duration":"332.707761ms","start":"2026-10-15T14:10:34.384229Z","end":"2026-10-15T14:10:34.716936Z","steps":["trace[1038275207] 'agreement among raft nodes before linearized reading' (duration: 332.480801ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:10:34.717004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T14:10:34.384212Z","time spent":"332.783855ms","remote":"127.0.0.1:41896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-ms5wj\" "} {"level":"info","ts":"2026-10-15T14:10:34.716831Z","caller":"traceutil/trace.go:171","msg":"trace[2081375264] linearizableReadLoop","detail":"{readStateIndex:675; appliedIndex:674; }","duration":"332.306764ms","start":"2026-10-15T14:10:34.384265Z","end":"2026-10-15T14:10:34.716572Z","steps":["trace[2081375264] 'read index received' (duration: 248.593346ms)","trace[2081375264] 'applied index is now lower than readState.Index' (duration: 83.708477ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T14:10:34.718553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T14:10:34.366155Z","time spent":"350.4754ms","remote":"127.0.0.1:42232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-15T14:11:58.300362Z","caller":"traceutil/trace.go:171","msg":"trace[2095874413] transaction","detail":"{read_only:false; response_revision:1700; number_of_response:1; }","duration":"110.234792ms","start":"2026-10-15T14:11:58.190094Z","end":"2026-10-15T14:11:58.300329Z","steps":["trace[2095874413] 'process raft request' (duration: 110.066413ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:12:13.403786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.058329ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-15T14:12:13.404238Z","caller":"traceutil/trace.go:171","msg":"trace[1637141254] linearizableReadLoop","detail":"{readStateIndex:1969; appliedIndex:1966; }","duration":"289.946404ms","start":"2026-10-15T14:12:13.11427Z","end":"2026-10-15T14:12:13.404216Z","steps":["trace[1637141254] 'read index received' (duration: 25.098778ms)","trace[1637141254] 'applied index is now lower than readState.Index' (duration: 264.846426ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:12:13.404332Z","caller":"traceutil/trace.go:171","msg":"trace[2095118593] transaction","detail":"{read_only:false; response_revision:1897; number_of_response:1; }","duration":"368.659885ms","start":"2026-10-15T14:12:13.035658Z","end":"2026-10-15T14:12:13.404318Z","steps":["trace[2095118593] 'process raft request' (duration: 103.835449ms)","trace[2095118593] 'compare' (duration: 262.781284ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T14:12:13.404422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T14:12:13.03562Z","time spent":"368.76041ms","remote":"127.0.0.1:41984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1472,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T14:12:13.404762Z","caller":"traceutil/trace.go:171","msg":"trace[1379660548] transaction","detail":"{read_only:false; response_revision:1898; number_of_response:1; }","duration":"368.948321ms","start":"2026-10-15T14:12:13.035802Z","end":"2026-10-15T14:12:13.404751Z","steps":["trace[1379660548] 'process raft request' (duration: 368.123585ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:12:13.404831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T14:12:13.03577Z","time spent":"369.025584ms","remote":"127.0.0.1:41984","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-10-15T14:12:13.405089Z","caller":"traceutil/trace.go:171","msg":"trace[468906001] transaction","detail":"{read_only:false; response_revision:1899; number_of_response:1; }","duration":"369.220476ms","start":"2026-10-15T14:12:13.035857Z","end":"2026-10-15T14:12:13.405078Z","steps":["trace[468906001] 'process raft request' (duration: 368.281054ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:12:13.405453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T14:12:13.035846Z","time spent":"369.264687ms","remote":"127.0.0.1:41880","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":894,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T14:12:13.405514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.212064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T14:12:13.406698Z","caller":"traceutil/trace.go:171","msg":"trace[1582735107] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1899; }","duration":"291.405114ms","start":"2026-10-15T14:12:13.114193Z","end":"2026-10-15T14:12:13.405598Z","steps":["trace[1582735107] 'agreement among raft nodes before linearized reading' (duration: 290.974801ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:12:13.556978Z","caller":"traceutil/trace.go:171","msg":"trace[830596384] transaction","detail":"{read_only:false; response_revision:1901; number_of_response:1; }","duration":"116.676385ms","start":"2026-10-15T14:12:13.440273Z","end":"2026-10-15T14:12:13.556949Z","steps":["trace[830596384] 'process raft request' (duration: 116.485574ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:12:13.895601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.096878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T14:12:13.895734Z","caller":"traceutil/trace.go:171","msg":"trace[1732786760] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1904; }","duration":"199.271787ms","start":"2026-10-15T14:12:13.696402Z","end":"2026-10-15T14:12:13.895674Z","steps":["trace[1732786760] 'count revisions from in-memory index tree' (duration: 198.968251ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:12:48.549919Z","caller":"traceutil/trace.go:171","msg":"trace[1696980754] transaction","detail":"{read_only:false; response_revision:2144; number_of_response:1; }","duration":"163.024056ms","start":"2026-10-15T14:12:48.386867Z","end":"2026-10-15T14:12:48.549891Z","steps":["trace[1696980754] 'process raft request' (duration: 162.881478ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:12:49.033782Z","caller":"traceutil/trace.go:171","msg":"trace[1715425632] linearizableReadLoop","detail":"{readStateIndex:2223; appliedIndex:2222; }","duration":"131.1125ms","start":"2026-10-15T14:12:48.902653Z","end":"2026-10-15T14:12:49.033765Z","steps":["trace[1715425632] 'read index received' (duration: 130.991912ms)","trace[1715425632] 'applied index is now lower than readState.Index' (duration: 119.538µs)"],"step_count":2} {"level":"warn","ts":"2026-10-15T14:12:49.034073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.392557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-10-15T14:12:49.034149Z","caller":"traceutil/trace.go:171","msg":"trace[154971146] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2145; }","duration":"131.513025ms","start":"2026-10-15T14:12:48.902618Z","end":"2026-10-15T14:12:49.034131Z","steps":["trace[154971146] 'agreement among raft nodes before linearized reading' (duration: 131.272779ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:12:49.033955Z","caller":"traceutil/trace.go:171","msg":"trace[1337921786] transaction","detail":"{read_only:false; response_revision:2145; number_of_response:1; }","duration":"143.2296ms","start":"2026-10-15T14:12:48.890637Z","end":"2026-10-15T14:12:49.033867Z","steps":["trace[1337921786] 'process raft request' (duration: 143.018933ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:12:49.86956Z","caller":"traceutil/trace.go:171","msg":"trace[1903091257] linearizableReadLoop","detail":"{readStateIndex:2226; appliedIndex:2225; }","duration":"127.657318ms","start":"2026-10-15T14:12:49.741876Z","end":"2026-10-15T14:12:49.869533Z","steps":["trace[1903091257] 'read index received' (duration: 107.04361ms)","trace[1903091257] 'applied index is now lower than readState.Index' (duration: 20.612308ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:12:49.869678Z","caller":"traceutil/trace.go:171","msg":"trace[724751915] transaction","detail":"{read_only:false; response_revision:2148; number_of_response:1; }","duration":"155.723266ms","start":"2026-10-15T14:12:49.713942Z","end":"2026-10-15T14:12:49.869665Z","steps":["trace[724751915] 'process raft request' (duration: 135.126366ms)","trace[724751915] 'compare' (duration: 20.153396ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T14:12:49.869992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.108582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-15T14:12:49.870067Z","caller":"traceutil/trace.go:171","msg":"trace[1953322958] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2148; }","duration":"128.25413ms","start":"2026-10-15T14:12:49.741796Z","end":"2026-10-15T14:12:49.87005Z","steps":["trace[1953322958] 'agreement among raft nodes before linearized reading' (duration: 128.111532ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:12:50.004936Z","caller":"traceutil/trace.go:171","msg":"trace[1434704315] transaction","detail":"{read_only:false; response_revision:2149; number_of_response:1; }","duration":"128.136411ms","start":"2026-10-15T14:12:49.876769Z","end":"2026-10-15T14:12:50.004906Z","steps":["trace[1434704315] 'process raft request' (duration: 127.434541ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:12:50.010418Z","caller":"traceutil/trace.go:171","msg":"trace[250390470] transaction","detail":"{read_only:false; response_revision:2150; number_of_response:1; }","duration":"133.392303ms","start":"2026-10-15T14:12:49.877005Z","end":"2026-10-15T14:12:50.010397Z","steps":["trace[250390470] 'process raft request' (duration: 133.272454ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:14:31.790319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.991743ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-10-15T14:14:31.790433Z","caller":"traceutil/trace.go:171","msg":"trace[1295677415] linearizableReadLoop","detail":"{readStateIndex:2902; appliedIndex:2901; }","duration":"236.103576ms","start":"2026-10-15T14:14:31.554307Z","end":"2026-10-15T14:14:31.790411Z","steps":["trace[1295677415] 'read index received' (duration: 33.187214ms)","trace[1295677415] 'applied index is now lower than readState.Index' (duration: 202.914832ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T14:14:31.791126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.81886ms","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-15T14:14:31.791207Z","caller":"traceutil/trace.go:171","msg":"trace[1271657611] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2801; }","duration":"236.958024ms","start":"2026-10-15T14:14:31.554233Z","end":"2026-10-15T14:14:31.791191Z","steps":["trace[1271657611] 'agreement among raft nodes before linearized reading' (duration: 236.686008ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:14:31.791205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.939238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-10-15T14:14:31.791288Z","caller":"traceutil/trace.go:171","msg":"trace[106732256] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2801; }","duration":"179.08282ms","start":"2026-10-15T14:14:31.612187Z","end":"2026-10-15T14:14:31.791269Z","steps":["trace[106732256] 'agreement among raft nodes before linearized reading' (duration: 178.890766ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:14:37.25264Z","caller":"traceutil/trace.go:171","msg":"trace[2025532847] transaction","detail":"{read_only:false; response_revision:2831; number_of_response:1; }","duration":"143.766828ms","start":"2026-10-15T14:14:37.108845Z","end":"2026-10-15T14:14:37.252612Z","steps":["trace[2025532847] 'process raft request' (duration: 143.386159ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:19:15.541635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.678322ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-15T14:19:15.541837Z","caller":"traceutil/trace.go:171","msg":"trace[148162858] transaction","detail":"{read_only:false; response_revision:5049; number_of_response:1; }","duration":"285.037152ms","start":"2026-10-15T14:19:15.256781Z","end":"2026-10-15T14:19:15.541818Z","steps":["trace[148162858] 'process raft request' (duration: 284.952628ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:19:15.54188Z","caller":"traceutil/trace.go:171","msg":"trace[1925302069] transaction","detail":"{read_only:false; response_revision:5048; number_of_response:1; }","duration":"375.346714ms","start":"2026-10-15T14:19:15.166498Z","end":"2026-10-15T14:19:15.541845Z","steps":["trace[1925302069] 'process raft request' (duration: 170.359208ms)","trace[1925302069] 'compare' (duration: 204.236622ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:19:15.541928Z","caller":"traceutil/trace.go:171","msg":"trace[2055831800] linearizableReadLoop","detail":"{readStateIndex:5232; appliedIndex:5230; }","duration":"350.282143ms","start":"2026-10-15T14:19:15.191629Z","end":"2026-10-15T14:19:15.541911Z","steps":["trace[2055831800] 'read index received' (duration: 8.589961ms)","trace[2055831800] 'applied index is now lower than readState.Index' (duration: 341.690692ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T14:19:15.542015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T14:19:15.166482Z","time spent":"375.462889ms","remote":"127.0.0.1:41968","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T14:19:15.542151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.525473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e869e331-311b-4b02-9e88-303dbb5068fe\" ","response":"range_response_count:1 size:3646"} {"level":"warn","ts":"2026-10-15T14:19:15.542207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.583173ms","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-15T14:19:15.542212Z","caller":"traceutil/trace.go:171","msg":"trace[186871075] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-e869e331-311b-4b02-9e88-303dbb5068fe; range_end:; response_count:1; response_revision:5049; }","duration":"350.623428ms","start":"2026-10-15T14:19:15.191579Z","end":"2026-10-15T14:19:15.542202Z","steps":["trace[186871075] 'agreement among raft nodes before linearized reading' (duration: 350.44539ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:19:15.542242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.480186ms","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-10-15T14:19:15.542288Z","caller":"traceutil/trace.go:171","msg":"trace[1896631683] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5049; }","duration":"239.56019ms","start":"2026-10-15T14:19:15.302718Z","end":"2026-10-15T14:19:15.542278Z","steps":["trace[1896631683] 'agreement among raft nodes before linearized reading' (duration: 239.428144ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:19:15.542296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T14:19:15.191561Z","time spent":"350.708382ms","remote":"127.0.0.1:41896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3669,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e869e331-311b-4b02-9e88-303dbb5068fe\" "} {"level":"info","ts":"2026-10-15T14:19:15.542238Z","caller":"traceutil/trace.go:171","msg":"trace[1596009498] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5049; }","duration":"252.647546ms","start":"2026-10-15T14:19:15.289582Z","end":"2026-10-15T14:19:15.542229Z","steps":["trace[1596009498] 'agreement among raft nodes before linearized reading' (duration: 252.556762ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:19:15.710095Z","caller":"traceutil/trace.go:171","msg":"trace[378126040] transaction","detail":"{read_only:false; response_revision:5050; number_of_response:1; }","duration":"163.928236ms","start":"2026-10-15T14:19:15.546132Z","end":"2026-10-15T14:19:15.71006Z","steps":["trace[378126040] 'process raft request' (duration: 113.935509ms)","trace[378126040] 'compare' (duration: 49.795248ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:19:15.750859Z","caller":"traceutil/trace.go:171","msg":"trace[2079767608] transaction","detail":"{read_only:false; response_revision:5051; number_of_response:1; }","duration":"204.516464ms","start":"2026-10-15T14:19:15.546308Z","end":"2026-10-15T14:19:15.750825Z","steps":["trace[2079767608] 'process raft request' (duration: 204.246042ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:19:15.750853Z","caller":"traceutil/trace.go:171","msg":"trace[1827457104] transaction","detail":"{read_only:false; response_revision:5052; number_of_response:1; }","duration":"188.19106ms","start":"2026-10-15T14:19:15.5626Z","end":"2026-10-15T14:19:15.750791Z","steps":["trace[1827457104] 'process raft request' (duration: 188.083305ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:19:16.228186Z","caller":"traceutil/trace.go:171","msg":"trace[373001583] transaction","detail":"{read_only:false; response_revision:5056; number_of_response:1; }","duration":"115.641149ms","start":"2026-10-15T14:19:16.112517Z","end":"2026-10-15T14:19:16.228158Z","steps":["trace[373001583] 'process raft request' (duration: 113.093073ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:19:16.402197Z","caller":"traceutil/trace.go:171","msg":"trace[616938777] linearizableReadLoop","detail":"{readStateIndex:5241; appliedIndex:5239; }","duration":"250.936184ms","start":"2026-10-15T14:19:16.151215Z","end":"2026-10-15T14:19:16.402151Z","steps":["trace[616938777] 'read index received' (duration: 74.40844ms)","trace[616938777] 'applied index is now lower than readState.Index' (duration: 176.526864ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T14:19:16.403119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.92325ms","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-10-15T14:19:16.403195Z","caller":"traceutil/trace.go:171","msg":"trace[1268734193] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5057; }","duration":"236.029205ms","start":"2026-10-15T14:19:16.167154Z","end":"2026-10-15T14:19:16.403184Z","steps":["trace[1268734193] 'agreement among raft nodes before linearized reading' (duration: 235.779294ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:19:16.403305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.984511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-10-15T14:19:16.403406Z","caller":"traceutil/trace.go:171","msg":"trace[1922310837] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5057; }","duration":"205.101186ms","start":"2026-10-15T14:19:16.198278Z","end":"2026-10-15T14:19:16.403379Z","steps":["trace[1922310837] 'agreement among raft nodes before linearized reading' (duration: 204.817773ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T14:19:16.403135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.729605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"warn","ts":"2026-10-15T14:19:16.403592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.360549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-15T14:19:16.403684Z","caller":"traceutil/trace.go:171","msg":"trace[1223570656] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5057; }","duration":"252.502695ms","start":"2026-10-15T14:19:16.151168Z","end":"2026-10-15T14:19:16.403671Z","steps":["trace[1223570656] 'agreement among raft nodes before linearized reading' (duration: 251.994512ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:19:16.40367Z","caller":"traceutil/trace.go:171","msg":"trace[1365844733] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5057; }","duration":"102.237318ms","start":"2026-10-15T14:19:16.301348Z","end":"2026-10-15T14:19:16.403586Z","steps":["trace[1365844733] 'agreement among raft nodes before linearized reading' (duration: 101.628631ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:19:16.402579Z","caller":"traceutil/trace.go:171","msg":"trace[770169365] transaction","detail":"{read_only:false; response_revision:5057; number_of_response:1; }","duration":"286.116227ms","start":"2026-10-15T14:19:16.116447Z","end":"2026-10-15T14:19:16.402564Z","steps":["trace[770169365] 'process raft request' (duration: 218.241814ms)","trace[770169365] 'compare' (duration: 67.288566ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:19:27.688416Z","caller":"traceutil/trace.go:171","msg":"trace[1976438876] transaction","detail":"{read_only:false; response_revision:5200; number_of_response:1; }","duration":"108.456599ms","start":"2026-10-15T14:19:27.579934Z","end":"2026-10-15T14:19:27.688391Z","steps":["trace[1976438876] 'process raft request' (duration: 108.255519ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:19:27.867862Z","caller":"traceutil/trace.go:171","msg":"trace[495683383] transaction","detail":"{read_only:false; response_revision:5201; number_of_response:1; }","duration":"105.406579ms","start":"2026-10-15T14:19:27.76243Z","end":"2026-10-15T14:19:27.867837Z","steps":["trace[495683383] 'process raft request' (duration: 105.262942ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:19:27.900467Z","caller":"traceutil/trace.go:171","msg":"trace[2065992922] transaction","detail":"{read_only:false; response_revision:5202; number_of_response:1; }","duration":"109.359699ms","start":"2026-10-15T14:19:27.791081Z","end":"2026-10-15T14:19:27.90044Z","steps":["trace[2065992922] 'process raft request' (duration: 109.093377ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:19:42.844028Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2861} {"level":"info","ts":"2026-10-15T14:19:42.926022Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2861,"took":"79.310848ms","hash":518935109,"current-db-size-bytes":52498432,"current-db-size":"52 MB","current-db-size-in-use-bytes":27508736,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-15T14:19:42.9261Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":518935109,"revision":2861,"compact-revision":-1} {"level":"info","ts":"2026-10-15T14:23:07.852672Z","caller":"traceutil/trace.go:171","msg":"trace[726823598] transaction","detail":"{read_only:false; response_revision:6825; number_of_response:1; }","duration":"117.673165ms","start":"2026-10-15T14:23:07.734978Z","end":"2026-10-15T14:23:07.852651Z","steps":["trace[726823598] 'process raft request' (duration: 73.654941ms)","trace[726823598] 'compare' (duration: 43.771201ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T14:23:32.265685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.429783ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-15T14:23:32.265779Z","caller":"traceutil/trace.go:171","msg":"trace[1314721168] linearizableReadLoop","detail":"{readStateIndex:7260; appliedIndex:7259; }","duration":"147.448378ms","start":"2026-10-15T14:23:32.118316Z","end":"2026-10-15T14:23:32.265765Z","steps":["trace[1314721168] 'read index received' (duration: 44.797643ms)","trace[1314721168] 'applied index is now lower than readState.Index' (duration: 102.649655ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T14:23:32.265859Z","caller":"traceutil/trace.go:171","msg":"trace[1038903998] transaction","detail":"{read_only:false; response_revision:7009; number_of_response:1; }","duration":"167.761757ms","start":"2026-10-15T14:23:32.098086Z","end":"2026-10-15T14:23:32.265848Z","steps":["trace[1038903998] 'process raft request' (duration: 65.07915ms)","trace[1038903998] 'compare' (duration: 102.17037ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T14:23:32.266254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.911176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-15T14:23:32.26633Z","caller":"traceutil/trace.go:171","msg":"trace[1624833972] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:7009; }","duration":"148.032417ms","start":"2026-10-15T14:23:32.11828Z","end":"2026-10-15T14:23:32.266313Z","steps":["trace[1624833972] 'agreement among raft nodes before linearized reading' (duration: 147.847434ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T14:24:42.850706Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5337} {"level":"info","ts":"2026-10-15T14:24:42.945686Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5337,"took":"93.318156ms","hash":572408015,"current-db-size-bytes":52498432,"current-db-size":"52 MB","current-db-size-in-use-bytes":18694144,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-10-15T14:24:42.945756Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":572408015,"revision":5337,"compact-revision":2861}