{"level":"warn","ts":"2026-10-19T01:44:36.180925Z","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-19T01:44:36.181038Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.79: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.79:2380","--initial-cluster=instance=https://162.253.55.79:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.79:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.79: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-19T01:44:36.181112Z","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-19T01:44:36.181119Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.79:2380"]} {"level":"info","ts":"2026-10-19T01:44:36.181138Z","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-19T01:44:36.181817Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.79:2379"]} {"level":"info","ts":"2026-10-19T01:44:36.181886Z","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.79:2380"],"listen-peer-urls":["https://162.253.55.79:2380"],"advertise-client-urls":["https://162.253.55.79:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.79:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.79: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-19T01:44:36.186972Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.882819ms"} {"level":"info","ts":"2026-10-19T01:44:36.194387Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"401ca643156fc5da","cluster-id":"e9f568c3681bb0d0"} {"level":"info","ts":"2026-10-19T01:44:36.19445Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da switched to configuration voters=()"} {"level":"info","ts":"2026-10-19T01:44:36.194472Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da became follower at term 0"} {"level":"info","ts":"2026-10-19T01:44:36.19448Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 401ca643156fc5da [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-19T01:44:36.194488Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da became follower at term 1"} {"level":"info","ts":"2026-10-19T01:44:36.194519Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da switched to configuration voters=(4619750124827952602)"} {"level":"warn","ts":"2026-10-19T01:44:36.200392Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-19T01:44:36.201673Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-19T01:44:36.202681Z","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-19T01:44:36.205529Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"401ca643156fc5da","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-19T01:44:36.205727Z","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-19T01:44:36.205778Z","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-19T01:44:36.205789Z","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-19T01:44:36.205847Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"401ca643156fc5da","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-19T01:44:36.208559Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da switched to configuration voters=(4619750124827952602)"} {"level":"info","ts":"2026-10-19T01:44:36.208678Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e9f568c3681bb0d0","local-member-id":"401ca643156fc5da","added-peer-id":"401ca643156fc5da","added-peer-peer-urls":["https://162.253.55.79:2380"]} {"level":"info","ts":"2026-10-19T01:44:36.210398Z","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-19T01:44:36.210521Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.79:2380"} {"level":"info","ts":"2026-10-19T01:44:36.210564Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.79:2380"} {"level":"info","ts":"2026-10-19T01:44:36.210803Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"401ca643156fc5da","initial-advertise-peer-urls":["https://162.253.55.79:2380"],"listen-peer-urls":["https://162.253.55.79:2380"],"advertise-client-urls":["https://162.253.55.79:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.79:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-19T01:44:36.210861Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-19T01:44:36.694855Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da is starting a new election at term 1"} {"level":"info","ts":"2026-10-19T01:44:36.694947Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da became pre-candidate at term 1"} {"level":"info","ts":"2026-10-19T01:44:36.695008Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da received MsgPreVoteResp from 401ca643156fc5da at term 1"} {"level":"info","ts":"2026-10-19T01:44:36.695032Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da became candidate at term 2"} {"level":"info","ts":"2026-10-19T01:44:36.69505Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da received MsgVoteResp from 401ca643156fc5da at term 2"} {"level":"info","ts":"2026-10-19T01:44:36.695073Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da became leader at term 2"} {"level":"info","ts":"2026-10-19T01:44:36.695098Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 401ca643156fc5da elected leader 401ca643156fc5da at term 2"} {"level":"info","ts":"2026-10-19T01:44:36.696321Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"401ca643156fc5da","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.79:2379]}","request-path":"/0/members/401ca643156fc5da/attributes","cluster-id":"e9f568c3681bb0d0","publish-timeout":"7s"} {"level":"info","ts":"2026-10-19T01:44:36.696775Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-19T01:44:36.697734Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-19T01:44:36.698277Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-19T01:44:36.70008Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-19T01:44:36.700138Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-19T01:44:36.700149Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e9f568c3681bb0d0","local-member-id":"401ca643156fc5da","cluster-version":"3.5"} {"level":"info","ts":"2026-10-19T01:44:36.700305Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-19T01:44:36.700342Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-19T01:44:36.701677Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.79:2379"} {"level":"info","ts":"2026-10-19T01:44:36.702958Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-10-19T01:44:39.804322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.741844ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-10-19T01:44:39.804439Z","caller":"traceutil/trace.go:171","msg":"trace[1576594364] linearizableReadLoop","detail":"{readStateIndex:115; appliedIndex:114; }","duration":"359.65468ms","start":"2026-10-19T01:44:39.444768Z","end":"2026-10-19T01:44:39.804423Z","steps":["trace[1576594364] 'read index received' (duration: 183.190223ms)","trace[1576594364] 'applied index is now lower than readState.Index' (duration: 176.463377ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:44:39.804571Z","caller":"traceutil/trace.go:171","msg":"trace[1025728993] transaction","detail":"{read_only:false; response_revision:111; number_of_response:1; }","duration":"360.971156ms","start":"2026-10-19T01:44:39.443577Z","end":"2026-10-19T01:44:39.804548Z","steps":["trace[1025728993] 'process raft request' (duration: 184.450908ms)","trace[1025728993] 'compare' (duration: 175.615344ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:44:39.80472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:44:39.44355Z","time spent":"361.104906ms","remote":"127.0.0.1:45032","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-19T01:44:39.804867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.083922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-edit\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-19T01:44:39.804951Z","caller":"traceutil/trace.go:171","msg":"trace[679571372] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-edit; range_end:; response_count:0; response_revision:111; }","duration":"360.190742ms","start":"2026-10-19T01:44:39.444749Z","end":"2026-10-19T01:44:39.80494Z","steps":["trace[679571372] 'agreement among raft nodes before linearized reading' (duration: 359.929781ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:44:39.805133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:44:39.44474Z","time spent":"360.386643ms","remote":"127.0.0.1:45018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/system:aggregate-to-edit\" "} {"level":"warn","ts":"2026-10-19T01:44:39.805074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.309427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-19T01:44:39.805202Z","caller":"traceutil/trace.go:171","msg":"trace[1304432373] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:111; }","duration":"294.435157ms","start":"2026-10-19T01:44:39.510729Z","end":"2026-10-19T01:44:39.805164Z","steps":["trace[1304432373] 'agreement among raft nodes before linearized reading' (duration: 293.995326ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:44:40.023163Z","caller":"traceutil/trace.go:171","msg":"trace[937087784] transaction","detail":"{read_only:false; response_revision:112; number_of_response:1; }","duration":"204.876128ms","start":"2026-10-19T01:44:39.81826Z","end":"2026-10-19T01:44:40.023136Z","steps":["trace[937087784] 'process raft request' (duration: 171.591699ms)","trace[937087784] 'compare' (duration: 33.049308ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:44:43.723102Z","caller":"traceutil/trace.go:171","msg":"trace[2027256685] linearizableReadLoop","detail":"{readStateIndex:319; appliedIndex:318; }","duration":"218.53846ms","start":"2026-10-19T01:44:43.504538Z","end":"2026-10-19T01:44:43.723077Z","steps":["trace[2027256685] 'read index received' (duration: 210.87143ms)","trace[2027256685] 'applied index is now lower than readState.Index' (duration: 7.66593ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:44:43.723941Z","caller":"traceutil/trace.go:171","msg":"trace[1945126549] transaction","detail":"{read_only:false; response_revision:310; number_of_response:1; }","duration":"222.939097ms","start":"2026-10-19T01:44:43.500987Z","end":"2026-10-19T01:44:43.723926Z","steps":["trace[1945126549] 'process raft request' (duration: 214.478655ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:44:43.724333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.786965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:3974"} {"level":"info","ts":"2026-10-19T01:44:43.724417Z","caller":"traceutil/trace.go:171","msg":"trace[1847229502] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:310; }","duration":"219.922916ms","start":"2026-10-19T01:44:43.504481Z","end":"2026-10-19T01:44:43.724404Z","steps":["trace[1847229502] 'agreement among raft nodes before linearized reading' (duration: 219.723675ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:44:43.736368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.483342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/namespace-controller\" ","response":"range_response_count:1 size:205"} {"level":"info","ts":"2026-10-19T01:44:43.736531Z","caller":"traceutil/trace.go:171","msg":"trace[225187267] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/namespace-controller; range_end:; response_count:1; response_revision:310; }","duration":"226.674633ms","start":"2026-10-19T01:44:43.509837Z","end":"2026-10-19T01:44:43.736512Z","steps":["trace[225187267] 'agreement among raft nodes before linearized reading' (duration: 226.443362ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:44:43.736777Z","caller":"traceutil/trace.go:171","msg":"trace[1378748265] transaction","detail":"{read_only:false; number_of_response:0; response_revision:310; }","duration":"230.105436ms","start":"2026-10-19T01:44:43.506662Z","end":"2026-10-19T01:44:43.736768Z","steps":["trace[1378748265] 'process raft request' (duration: 229.544674ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:45:20.16263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.111132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:3 size:12673"} {"level":"info","ts":"2026-10-19T01:45:20.162755Z","caller":"traceutil/trace.go:171","msg":"trace[1354932525] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:3; response_revision:502; }","duration":"129.271832ms","start":"2026-10-19T01:45:20.033437Z","end":"2026-10-19T01:45:20.162709Z","steps":["trace[1354932525] 'range keys from in-memory index tree' (duration: 128.952482ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:45:23.152917Z","caller":"traceutil/trace.go:171","msg":"trace[1825752075] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"124.350163ms","start":"2026-10-19T01:45:23.028536Z","end":"2026-10-19T01:45:23.152887Z","steps":["trace[1825752075] 'process raft request' (duration: 124.204482ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:45:23.200499Z","caller":"traceutil/trace.go:171","msg":"trace[1526660252] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"171.566187ms","start":"2026-10-19T01:45:23.028905Z","end":"2026-10-19T01:45:23.200472Z","steps":["trace[1526660252] 'process raft request' (duration: 171.216866ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:45:23.200647Z","caller":"traceutil/trace.go:171","msg":"trace[490525829] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"157.02189ms","start":"2026-10-19T01:45:23.043617Z","end":"2026-10-19T01:45:23.200639Z","steps":["trace[490525829] 'process raft request' (duration: 156.780939ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:45:23.200723Z","caller":"traceutil/trace.go:171","msg":"trace[1084884699] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"171.595227ms","start":"2026-10-19T01:45:23.029118Z","end":"2026-10-19T01:45:23.200714Z","steps":["trace[1084884699] 'process raft request' (duration: 171.160496ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:45:23.200765Z","caller":"traceutil/trace.go:171","msg":"trace[1898553930] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"162.778373ms","start":"2026-10-19T01:45:23.03798Z","end":"2026-10-19T01:45:23.200759Z","steps":["trace[1898553930] 'process raft request' (duration: 162.343951ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:45:23.200806Z","caller":"traceutil/trace.go:171","msg":"trace[1310234296] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"157.250931ms","start":"2026-10-19T01:45:23.04355Z","end":"2026-10-19T01:45:23.200801Z","steps":["trace[1310234296] 'process raft request' (duration: 156.813539ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:45:23.200884Z","caller":"traceutil/trace.go:171","msg":"trace[945358877] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"147.181103ms","start":"2026-10-19T01:45:23.053698Z","end":"2026-10-19T01:45:23.200879Z","steps":["trace[945358877] 'process raft request' (duration: 146.808531ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:45:23.200955Z","caller":"traceutil/trace.go:171","msg":"trace[702679267] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"139.487273ms","start":"2026-10-19T01:45:23.06145Z","end":"2026-10-19T01:45:23.200937Z","steps":["trace[702679267] 'process raft request' (duration: 139.104412ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:45:23.201001Z","caller":"traceutil/trace.go:171","msg":"trace[332034548] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"157.11787ms","start":"2026-10-19T01:45:23.043876Z","end":"2026-10-19T01:45:23.200994Z","steps":["trace[332034548] 'process raft request' (duration: 156.558388ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:45:23.201061Z","caller":"traceutil/trace.go:171","msg":"trace[167683987] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"151.852971ms","start":"2026-10-19T01:45:23.049203Z","end":"2026-10-19T01:45:23.201056Z","steps":["trace[167683987] 'process raft request' (duration: 151.265658ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:45:23.201067Z","caller":"traceutil/trace.go:171","msg":"trace[1345894110] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"127.152175ms","start":"2026-10-19T01:45:23.073905Z","end":"2026-10-19T01:45:23.201057Z","steps":["trace[1345894110] 'process raft request' (duration: 126.696523ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:45:23.420514Z","caller":"traceutil/trace.go:171","msg":"trace[1303568569] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"122.121625ms","start":"2026-10-19T01:45:23.298376Z","end":"2026-10-19T01:45:23.420498Z","steps":["trace[1303568569] 'process raft request' (duration: 88.740475ms)","trace[1303568569] 'compare' (duration: 33.046698ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:45:23.420621Z","caller":"traceutil/trace.go:171","msg":"trace[1062947539] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"119.220523ms","start":"2026-10-19T01:45:23.301394Z","end":"2026-10-19T01:45:23.420615Z","steps":["trace[1062947539] 'process raft request' (duration: 118.867732ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:45:23.580089Z","caller":"traceutil/trace.go:171","msg":"trace[1872938054] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"143.570318ms","start":"2026-10-19T01:45:23.436491Z","end":"2026-10-19T01:45:23.580061Z","steps":["trace[1872938054] 'process raft request' (duration: 86.407056ms)","trace[1872938054] 'compare' (duration: 57.024551ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:45:23.584108Z","caller":"traceutil/trace.go:171","msg":"trace[1671258011] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"147.507354ms","start":"2026-10-19T01:45:23.43658Z","end":"2026-10-19T01:45:23.584087Z","steps":["trace[1671258011] 'process raft request' (duration: 147.201072ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:45:23.584247Z","caller":"traceutil/trace.go:171","msg":"trace[739745941] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"144.16469ms","start":"2026-10-19T01:45:23.440071Z","end":"2026-10-19T01:45:23.584235Z","steps":["trace[739745941] 'process raft request' (duration: 143.849389ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:45:23.584227Z","caller":"traceutil/trace.go:171","msg":"trace[1543399672] linearizableReadLoop","detail":"{readStateIndex:599; appliedIndex:595; }","duration":"113.724162ms","start":"2026-10-19T01:45:23.470455Z","end":"2026-10-19T01:45:23.584179Z","steps":["trace[1543399672] 'read index received' (duration: 52.428764ms)","trace[1543399672] 'applied index is now lower than readState.Index' (duration: 61.294288ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:45:23.584325Z","caller":"traceutil/trace.go:171","msg":"trace[771948404] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"135.611588ms","start":"2026-10-19T01:45:23.448705Z","end":"2026-10-19T01:45:23.584316Z","steps":["trace[771948404] 'process raft request' (duration: 135.303716ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:45:23.584562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.985193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-10-19T01:45:23.584602Z","caller":"traceutil/trace.go:171","msg":"trace[1244774617] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:576; }","duration":"114.170704ms","start":"2026-10-19T01:45:23.470422Z","end":"2026-10-19T01:45:23.584592Z","steps":["trace[1244774617] 'agreement among raft nodes before linearized reading' (duration: 113.888753ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:45:23.958036Z","caller":"traceutil/trace.go:171","msg":"trace[777018602] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"142.772915ms","start":"2026-10-19T01:45:23.815141Z","end":"2026-10-19T01:45:23.957914Z","steps":["trace[777018602] 'process raft request' (duration: 50.018524ms)","trace[777018602] 'compare' (duration: 92.53548ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:45:23.958425Z","caller":"traceutil/trace.go:171","msg":"trace[2090799334] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"113.671091ms","start":"2026-10-19T01:45:23.84473Z","end":"2026-10-19T01:45:23.958401Z","steps":["trace[2090799334] 'process raft request' (duration: 113.624941ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:45:23.958498Z","caller":"traceutil/trace.go:171","msg":"trace[395492413] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"121.857653ms","start":"2026-10-19T01:45:23.836623Z","end":"2026-10-19T01:45:23.958481Z","steps":["trace[395492413] 'process raft request' (duration: 121.612302ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:45:29.87899Z","caller":"traceutil/trace.go:171","msg":"trace[1075014501] linearizableReadLoop","detail":"{readStateIndex:674; appliedIndex:673; }","duration":"260.459412ms","start":"2026-10-19T01:45:29.618508Z","end":"2026-10-19T01:45:29.878968Z","steps":["trace[1075014501] 'read index received' (duration: 259.715089ms)","trace[1075014501] 'applied index is now lower than readState.Index' (duration: 743.423µs)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:45:29.8791Z","caller":"traceutil/trace.go:171","msg":"trace[1659544311] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"282.146075ms","start":"2026-10-19T01:45:29.596943Z","end":"2026-10-19T01:45:29.879089Z","steps":["trace[1659544311] 'process raft request' (duration: 281.479323ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:45:29.879972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.435116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-10-19T01:45:29.880166Z","caller":"traceutil/trace.go:171","msg":"trace[625263615] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:650; }","duration":"261.660897ms","start":"2026-10-19T01:45:29.618454Z","end":"2026-10-19T01:45:29.880115Z","steps":["trace[625263615] 'agreement among raft nodes before linearized reading' (duration: 260.735263ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:45:29.898438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.695882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-gdphr\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-10-19T01:45:29.898591Z","caller":"traceutil/trace.go:171","msg":"trace[1292975969] range","detail":"{range_begin:/registry/pods/kube-system/cilium-gdphr; range_end:; response_count:1; response_revision:651; }","duration":"278.849513ms","start":"2026-10-19T01:45:29.619724Z","end":"2026-10-19T01:45:29.898574Z","steps":["trace[1292975969] 'agreement among raft nodes before linearized reading' (duration: 278.621372ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:45:29.898998Z","caller":"traceutil/trace.go:171","msg":"trace[983594437] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"273.095451ms","start":"2026-10-19T01:45:29.625891Z","end":"2026-10-19T01:45:29.898986Z","steps":["trace[983594437] 'process raft request' (duration: 272.286437ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:45:30.220501Z","caller":"traceutil/trace.go:171","msg":"trace[122677396] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"334.046728ms","start":"2026-10-19T01:45:29.886425Z","end":"2026-10-19T01:45:30.220472Z","steps":["trace[122677396] 'process raft request' (duration: 271.511795ms)","trace[122677396] 'compare' (duration: 62.366962ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:45:30.22104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:45:29.886397Z","time spent":"334.239888ms","remote":"127.0.0.1:44938","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T01:45:30.240837Z","caller":"traceutil/trace.go:171","msg":"trace[2003612776] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"324.470011ms","start":"2026-10-19T01:45:29.91635Z","end":"2026-10-19T01:45:30.24082Z","steps":["trace[2003612776] 'process raft request' (duration: 324.133459ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:45:30.241034Z","caller":"traceutil/trace.go:171","msg":"trace[1227023388] linearizableReadLoop","detail":"{readStateIndex:678; appliedIndex:675; }","duration":"229.02367ms","start":"2026-10-19T01:45:30.011992Z","end":"2026-10-19T01:45:30.241016Z","steps":["trace[1227023388] 'read index received' (duration: 146.073988ms)","trace[1227023388] 'applied index is now lower than readState.Index' (duration: 82.948372ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:45:30.241071Z","caller":"traceutil/trace.go:171","msg":"trace[797612155] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"274.632067ms","start":"2026-10-19T01:45:29.966403Z","end":"2026-10-19T01:45:30.241035Z","steps":["trace[797612155] 'process raft request' (duration: 274.327866ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:45:30.24118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:45:29.916242Z","time spent":"324.688471ms","remote":"127.0.0.1:44864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T01:45:30.241392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.038935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:45:30.241537Z","caller":"traceutil/trace.go:171","msg":"trace[800684775] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:654; }","duration":"112.206247ms","start":"2026-10-19T01:45:30.129266Z","end":"2026-10-19T01:45:30.241472Z","steps":["trace[800684775] 'agreement among raft nodes before linearized reading' (duration: 112.026216ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:45:30.241596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.598622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-10-19T01:45:30.241767Z","caller":"traceutil/trace.go:171","msg":"trace[1662489560] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:654; }","duration":"229.797183ms","start":"2026-10-19T01:45:30.011957Z","end":"2026-10-19T01:45:30.241754Z","steps":["trace[1662489560] 'agreement among raft nodes before linearized reading' (duration: 229.17674ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:45:30.995261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.743789ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:45:30.995393Z","caller":"traceutil/trace.go:171","msg":"trace[2093732996] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:656; }","duration":"447.8859ms","start":"2026-10-19T01:45:30.54749Z","end":"2026-10-19T01:45:30.995376Z","steps":["trace[2093732996] 'range keys from in-memory index tree' (duration: 447.728979ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:45:31.031632Z","caller":"traceutil/trace.go:171","msg":"trace[1375165975] linearizableReadLoop","detail":"{readStateIndex:681; appliedIndex:680; }","duration":"205.728769ms","start":"2026-10-19T01:45:30.825877Z","end":"2026-10-19T01:45:31.031606Z","steps":["trace[1375165975] 'read index received' (duration: 204.813426ms)","trace[1375165975] 'applied index is now lower than readState.Index' (duration: 914.203µs)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:45:31.031756Z","caller":"traceutil/trace.go:171","msg":"trace[546865873] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"359.806147ms","start":"2026-10-19T01:45:30.671934Z","end":"2026-10-19T01:45:31.03174Z","steps":["trace[546865873] 'process raft request' (duration: 359.002665ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:45:31.031914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.495267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.79\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-10-19T01:45:31.031994Z","caller":"traceutil/trace.go:171","msg":"trace[341726827] range","detail":"{range_begin:/registry/masterleases/162.253.55.79; range_end:; response_count:1; response_revision:657; }","duration":"117.639637ms","start":"2026-10-19T01:45:30.914341Z","end":"2026-10-19T01:45:31.031981Z","steps":["trace[341726827] 'agreement among raft nodes before linearized reading' (duration: 117.495977ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:45:31.032004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.08998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-19T01:45:31.032089Z","caller":"traceutil/trace.go:171","msg":"trace[547228012] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:657; }","duration":"206.201671ms","start":"2026-10-19T01:45:30.825832Z","end":"2026-10-19T01:45:31.032034Z","steps":["trace[547228012] 'agreement among raft nodes before linearized reading' (duration: 205.90426ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:45:31.032185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:45:30.671907Z","time spent":"360.074518ms","remote":"127.0.0.1:44760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T01:45:46.663219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.509232ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-10-19T01:45:46.663368Z","caller":"traceutil/trace.go:171","msg":"trace[1730974221] linearizableReadLoop","detail":"{readStateIndex:847; appliedIndex:846; }","duration":"330.833925ms","start":"2026-10-19T01:45:46.332514Z","end":"2026-10-19T01:45:46.663348Z","steps":["trace[1730974221] 'read index received' (duration: 93.105612ms)","trace[1730974221] 'applied index is now lower than readState.Index' (duration: 237.726603ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:45:46.66362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.023332ms","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-19T01:45:46.663659Z","caller":"traceutil/trace.go:171","msg":"trace[971795485] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:817; }","duration":"289.106533ms","start":"2026-10-19T01:45:46.374542Z","end":"2026-10-19T01:45:46.663648Z","steps":["trace[971795485] 'agreement among raft nodes before linearized reading' (duration: 288.947753ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:45:46.66362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.467452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:45:46.663775Z","caller":"traceutil/trace.go:171","msg":"trace[1092200023] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:817; }","duration":"201.677423ms","start":"2026-10-19T01:45:46.462078Z","end":"2026-10-19T01:45:46.663756Z","steps":["trace[1092200023] 'agreement among raft nodes before linearized reading' (duration: 201.443482ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:45:46.663798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.919872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:45:46.663898Z","caller":"traceutil/trace.go:171","msg":"trace[1224863754] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:817; }","duration":"232.037052ms","start":"2026-10-19T01:45:46.431838Z","end":"2026-10-19T01:45:46.663875Z","steps":["trace[1224863754] 'agreement among raft nodes before linearized reading' (duration: 231.862152ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:45:46.663887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.098999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-10-19T01:45:46.663797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.626026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-19T01:45:46.66407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.965744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:45:46.664106Z","caller":"traceutil/trace.go:171","msg":"trace[348706755] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:817; }","duration":"202.052854ms","start":"2026-10-19T01:45:46.462043Z","end":"2026-10-19T01:45:46.664096Z","steps":["trace[348706755] 'agreement among raft nodes before linearized reading' (duration: 201.975064ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:45:46.664022Z","caller":"traceutil/trace.go:171","msg":"trace[243713914] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:817; }","duration":"230.886086ms","start":"2026-10-19T01:45:46.433118Z","end":"2026-10-19T01:45:46.664004Z","steps":["trace[243713914] 'agreement among raft nodes before linearized reading' (duration: 230.507595ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:45:46.664131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.533525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:45:46.664181Z","caller":"traceutil/trace.go:171","msg":"trace[636967716] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:817; }","duration":"176.634105ms","start":"2026-10-19T01:45:46.487526Z","end":"2026-10-19T01:45:46.66416Z","steps":["trace[636967716] 'agreement among raft nodes before linearized reading' (duration: 176.569874ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:45:46.664279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.407095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:45:46.664306Z","caller":"traceutil/trace.go:171","msg":"trace[1798043886] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:817; }","duration":"176.435155ms","start":"2026-10-19T01:45:46.487862Z","end":"2026-10-19T01:45:46.664297Z","steps":["trace[1798043886] 'agreement among raft nodes before linearized reading' (duration: 176.396585ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:45:46.664341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.217372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:45:46.663969Z","caller":"traceutil/trace.go:171","msg":"trace[498863224] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:817; }","duration":"288.197419ms","start":"2026-10-19T01:45:46.375754Z","end":"2026-10-19T01:45:46.663952Z","steps":["trace[498863224] 'agreement among raft nodes before linearized reading' (duration: 287.991249ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:45:46.66455Z","caller":"traceutil/trace.go:171","msg":"trace[783731834] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:817; }","duration":"232.504243ms","start":"2026-10-19T01:45:46.432018Z","end":"2026-10-19T01:45:46.664522Z","steps":["trace[783731834] 'agreement among raft nodes before linearized reading' (duration: 231.928561ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:45:46.664611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.074727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:45:46.664681Z","caller":"traceutil/trace.go:171","msg":"trace[1630128592] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:817; }","duration":"177.213458ms","start":"2026-10-19T01:45:46.487451Z","end":"2026-10-19T01:45:46.664664Z","steps":["trace[1630128592] 'agreement among raft nodes before linearized reading' (duration: 176.947827ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:45:46.664428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.51557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:45:46.664823Z","caller":"traceutil/trace.go:171","msg":"trace[306755269] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:817; }","duration":"203.961932ms","start":"2026-10-19T01:45:46.460847Z","end":"2026-10-19T01:45:46.664809Z","steps":["trace[306755269] 'agreement among raft nodes before linearized reading' (duration: 203.53591ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:45:46.666136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.620216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-10-19T01:45:46.666184Z","caller":"traceutil/trace.go:171","msg":"trace[1512114825] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:817; }","duration":"333.701496ms","start":"2026-10-19T01:45:46.332469Z","end":"2026-10-19T01:45:46.666171Z","steps":["trace[1512114825] 'agreement among raft nodes before linearized reading' (duration: 330.964175ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:45:46.666235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:45:46.33245Z","time spent":"333.776906ms","remote":"127.0.0.1:44938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-10-19T01:46:42.214218Z","caller":"traceutil/trace.go:171","msg":"trace[863676541] transaction","detail":"{read_only:false; response_revision:1489; number_of_response:1; }","duration":"127.358625ms","start":"2026-10-19T01:46:42.086834Z","end":"2026-10-19T01:46:42.214192Z","steps":["trace[863676541] 'process raft request' (duration: 127.167324ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:46:46.087384Z","caller":"traceutil/trace.go:171","msg":"trace[894446367] transaction","detail":"{read_only:false; response_revision:1551; number_of_response:1; }","duration":"109.082213ms","start":"2026-10-19T01:46:45.978255Z","end":"2026-10-19T01:46:46.087337Z","steps":["trace[894446367] 'process raft request' (duration: 71.703818ms)","trace[894446367] 'compare' (duration: 37.246135ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:46:46.101911Z","caller":"traceutil/trace.go:171","msg":"trace[1616658350] transaction","detail":"{read_only:false; response_revision:1552; number_of_response:1; }","duration":"119.952556ms","start":"2026-10-19T01:46:45.981943Z","end":"2026-10-19T01:46:46.101896Z","steps":["trace[1616658350] 'process raft request' (duration: 119.881996ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:46:46.507483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.808147ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-10-19T01:46:46.507884Z","caller":"traceutil/trace.go:171","msg":"trace[871609470] linearizableReadLoop","detail":"{readStateIndex:1611; appliedIndex:1609; }","duration":"154.48347ms","start":"2026-10-19T01:46:46.353378Z","end":"2026-10-19T01:46:46.507862Z","steps":["trace[871609470] 'read index received' (duration: 5.506272ms)","trace[871609470] 'applied index is now lower than readState.Index' (duration: 148.975938ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:46:46.508086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.687641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/superstreams.rabbitmq.com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:46:46.508188Z","caller":"traceutil/trace.go:171","msg":"trace[1068040097] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/superstreams.rabbitmq.com; range_end:; response_count:0; response_revision:1563; }","duration":"154.815181ms","start":"2026-10-19T01:46:46.353354Z","end":"2026-10-19T01:46:46.508169Z","steps":["trace[1068040097] 'agreement among raft nodes before linearized reading' (duration: 154.62866ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:46:46.508089Z","caller":"traceutil/trace.go:171","msg":"trace[908548455] transaction","detail":"{read_only:false; response_revision:1563; number_of_response:1; }","duration":"156.613348ms","start":"2026-10-19T01:46:46.351455Z","end":"2026-10-19T01:46:46.508069Z","steps":["trace[908548455] 'process raft request' (duration: 156.256556ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:46:46.664797Z","caller":"traceutil/trace.go:171","msg":"trace[562595526] transaction","detail":"{read_only:false; response_revision:1567; number_of_response:1; }","duration":"123.178718ms","start":"2026-10-19T01:46:46.541587Z","end":"2026-10-19T01:46:46.664766Z","steps":["trace[562595526] 'process raft request' (duration: 119.034972ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:47:11.319844Z","caller":"traceutil/trace.go:171","msg":"trace[88586167] linearizableReadLoop","detail":"{readStateIndex:1980; appliedIndex:1979; }","duration":"190.964842ms","start":"2026-10-19T01:47:11.128851Z","end":"2026-10-19T01:47:11.319815Z","steps":["trace[88586167] 'read index received' (duration: 190.731181ms)","trace[88586167] 'applied index is now lower than readState.Index' (duration: 232.461µs)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:47:11.319919Z","caller":"traceutil/trace.go:171","msg":"trace[1924897675] transaction","detail":"{read_only:false; response_revision:1906; number_of_response:1; }","duration":"209.143532ms","start":"2026-10-19T01:47:11.11073Z","end":"2026-10-19T01:47:11.319874Z","steps":["trace[1924897675] 'process raft request' (duration: 208.905301ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:47:11.320124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.257743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-10-19T01:47:11.320322Z","caller":"traceutil/trace.go:171","msg":"trace[1725796014] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1906; }","duration":"191.406384ms","start":"2026-10-19T01:47:11.12881Z","end":"2026-10-19T01:47:11.320217Z","steps":["trace[1725796014] 'agreement among raft nodes before linearized reading' (duration: 191.162333ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:47:11.320383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.890777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-82e0f5ea-8c81-4452-a2df-516d9cc00254\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-10-19T01:47:11.320449Z","caller":"traceutil/trace.go:171","msg":"trace[719249950] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-82e0f5ea-8c81-4452-a2df-516d9cc00254; range_end:; response_count:1; response_revision:1906; }","duration":"177.010768ms","start":"2026-10-19T01:47:11.143419Z","end":"2026-10-19T01:47:11.32043Z","steps":["trace[719249950] 'agreement among raft nodes before linearized reading' (duration: 176.782657ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:47:11.320605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.092878ms","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-19T01:47:11.320677Z","caller":"traceutil/trace.go:171","msg":"trace[1341158575] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1906; }","duration":"128.330638ms","start":"2026-10-19T01:47:11.192327Z","end":"2026-10-19T01:47:11.320658Z","steps":["trace[1341158575] 'agreement among raft nodes before linearized reading' (duration: 127.976737ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:47:11.320805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.586327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5732"} {"level":"info","ts":"2026-10-19T01:47:11.320855Z","caller":"traceutil/trace.go:171","msg":"trace[1335743448] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1906; }","duration":"138.657177ms","start":"2026-10-19T01:47:11.182182Z","end":"2026-10-19T01:47:11.320839Z","steps":["trace[1335743448] 'agreement among raft nodes before linearized reading' (duration: 138.521637ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:47:11.320858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.634193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-10-19T01:47:11.320936Z","caller":"traceutil/trace.go:171","msg":"trace[302814603] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1906; }","duration":"124.750704ms","start":"2026-10-19T01:47:11.196167Z","end":"2026-10-19T01:47:11.320918Z","steps":["trace[302814603] 'agreement among raft nodes before linearized reading' (duration: 124.480063ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:47:19.67825Z","caller":"traceutil/trace.go:171","msg":"trace[1097941092] transaction","detail":"{read_only:false; response_revision:1992; number_of_response:1; }","duration":"107.199979ms","start":"2026-10-19T01:47:19.571029Z","end":"2026-10-19T01:47:19.678229Z","steps":["trace[1097941092] 'process raft request' (duration: 107.068037ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:47:24.479163Z","caller":"traceutil/trace.go:171","msg":"trace[843661295] transaction","detail":"{read_only:false; response_revision:2030; number_of_response:1; }","duration":"116.930662ms","start":"2026-10-19T01:47:24.362194Z","end":"2026-10-19T01:47:24.479125Z","steps":["trace[843661295] 'process raft request' (duration: 116.483294ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:47:45.944861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.879389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:570"} {"level":"info","ts":"2026-10-19T01:47:45.944969Z","caller":"traceutil/trace.go:171","msg":"trace[1626796851] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2153; }","duration":"140.017119ms","start":"2026-10-19T01:47:45.804927Z","end":"2026-10-19T01:47:45.944944Z","steps":["trace[1626796851] 'range keys from in-memory index tree' (duration: 139.723327ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:47:46.509953Z","caller":"traceutil/trace.go:171","msg":"trace[97257504] transaction","detail":"{read_only:false; response_revision:2157; number_of_response:1; }","duration":"232.126427ms","start":"2026-10-19T01:47:46.277799Z","end":"2026-10-19T01:47:46.509925Z","steps":["trace[97257504] 'process raft request' (duration: 231.972076ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:47:46.515931Z","caller":"traceutil/trace.go:171","msg":"trace[894041953] transaction","detail":"{read_only:false; response_revision:2158; number_of_response:1; }","duration":"160.660242ms","start":"2026-10-19T01:47:46.355236Z","end":"2026-10-19T01:47:46.515896Z","steps":["trace[894041953] 'process raft request' (duration: 160.467447ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:47:46.856012Z","caller":"traceutil/trace.go:171","msg":"trace[2113885765] linearizableReadLoop","detail":"{readStateIndex:2242; appliedIndex:2241; }","duration":"176.312246ms","start":"2026-10-19T01:47:46.679676Z","end":"2026-10-19T01:47:46.855988Z","steps":["trace[2113885765] 'read index received' (duration: 170.107436ms)","trace[2113885765] 'applied index is now lower than readState.Index' (duration: 6.20373ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:47:46.856461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.233114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5732"} {"level":"info","ts":"2026-10-19T01:47:46.856526Z","caller":"traceutil/trace.go:171","msg":"trace[1453811155] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2159; }","duration":"166.310389ms","start":"2026-10-19T01:47:46.690198Z","end":"2026-10-19T01:47:46.856508Z","steps":["trace[1453811155] 'agreement among raft nodes before linearized reading' (duration: 166.106284ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:47:46.856796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.922807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-19T01:47:46.856815Z","caller":"traceutil/trace.go:171","msg":"trace[1595608489] transaction","detail":"{read_only:false; response_revision:2159; number_of_response:1; }","duration":"289.710483ms","start":"2026-10-19T01:47:46.567036Z","end":"2026-10-19T01:47:46.856746Z","steps":["trace[1595608489] 'process raft request' (duration: 282.824832ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:47:46.856864Z","caller":"traceutil/trace.go:171","msg":"trace[1554667656] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:2159; }","duration":"152.996643ms","start":"2026-10-19T01:47:46.703846Z","end":"2026-10-19T01:47:46.856843Z","steps":["trace[1554667656] 'agreement among raft nodes before linearized reading' (duration: 152.873153ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:47:46.857679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.857723ms","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-19T01:47:46.857751Z","caller":"traceutil/trace.go:171","msg":"trace[1381152158] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2159; }","duration":"178.094491ms","start":"2026-10-19T01:47:46.679641Z","end":"2026-10-19T01:47:46.857735Z","steps":["trace[1381152158] 'agreement among raft nodes before linearized reading' (duration: 176.837906ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:48:42.73472Z","caller":"traceutil/trace.go:171","msg":"trace[974777359] transaction","detail":"{read_only:false; response_revision:2508; number_of_response:1; }","duration":"100.667493ms","start":"2026-10-19T01:48:42.634005Z","end":"2026-10-19T01:48:42.734673Z","steps":["trace[974777359] 'process raft request' (duration: 100.416749ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:49:18.5917Z","caller":"traceutil/trace.go:171","msg":"trace[2000411620] transaction","detail":"{read_only:false; response_revision:2758; number_of_response:1; }","duration":"117.405834ms","start":"2026-10-19T01:49:18.474264Z","end":"2026-10-19T01:49:18.59167Z","steps":["trace[2000411620] 'process raft request' (duration: 83.653518ms)","trace[2000411620] 'compare' (duration: 33.635321ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:49:24.010891Z","caller":"traceutil/trace.go:171","msg":"trace[2064441169] linearizableReadLoop","detail":"{readStateIndex:2888; appliedIndex:2887; }","duration":"101.112592ms","start":"2026-10-19T01:49:23.909755Z","end":"2026-10-19T01:49:24.010867Z","steps":["trace[2064441169] 'read index received' (duration: 100.861772ms)","trace[2064441169] 'applied index is now lower than readState.Index' (duration: 249.81µs)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:49:24.01099Z","caller":"traceutil/trace.go:171","msg":"trace[1210401409] transaction","detail":"{read_only:false; response_revision:2784; number_of_response:1; }","duration":"151.813161ms","start":"2026-10-19T01:49:23.859118Z","end":"2026-10-19T01:49:24.010931Z","steps":["trace[1210401409] 'process raft request' (duration: 151.575291ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:49:24.011372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.580613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-10-19T01:49:24.01152Z","caller":"traceutil/trace.go:171","msg":"trace[1663867944] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2784; }","duration":"101.794471ms","start":"2026-10-19T01:49:23.909701Z","end":"2026-10-19T01:49:24.011495Z","steps":["trace[1663867944] 'agreement among raft nodes before linearized reading' (duration: 101.273599ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:49:29.541646Z","caller":"traceutil/trace.go:171","msg":"trace[2055502074] transaction","detail":"{read_only:false; response_revision:2814; number_of_response:1; }","duration":"143.769278ms","start":"2026-10-19T01:49:29.397847Z","end":"2026-10-19T01:49:29.541616Z","steps":["trace[2055502074] 'process raft request' (duration: 101.544097ms)","trace[2055502074] 'compare' (duration: 42.073335ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:52:32.610146Z","caller":"traceutil/trace.go:171","msg":"trace[429229087] transaction","detail":"{read_only:false; response_revision:3852; number_of_response:1; }","duration":"106.214679ms","start":"2026-10-19T01:52:32.50389Z","end":"2026-10-19T01:52:32.610105Z","steps":["trace[429229087] 'process raft request' (duration: 106.095966ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:52:47.325668Z","caller":"traceutil/trace.go:171","msg":"trace[1486524094] transaction","detail":"{read_only:false; response_revision:3931; number_of_response:1; }","duration":"136.910207ms","start":"2026-10-19T01:52:47.188722Z","end":"2026-10-19T01:52:47.325632Z","steps":["trace[1486524094] 'process raft request' (duration: 47.979611ms)","trace[1486524094] 'compare' (duration: 88.673912ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:52:47.325628Z","caller":"traceutil/trace.go:171","msg":"trace[1698455767] linearizableReadLoop","detail":"{readStateIndex:4080; appliedIndex:4079; }","duration":"113.965681ms","start":"2026-10-19T01:52:47.21162Z","end":"2026-10-19T01:52:47.325585Z","steps":["trace[1698455767] 'read index received' (duration: 25.005085ms)","trace[1698455767] 'applied index is now lower than readState.Index' (duration: 88.958566ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:52:47.326274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.605834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-10-19T01:52:47.32642Z","caller":"traceutil/trace.go:171","msg":"trace[1884052133] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3931; }","duration":"114.784348ms","start":"2026-10-19T01:52:47.211615Z","end":"2026-10-19T01:52:47.326399Z","steps":["trace[1884052133] 'agreement among raft nodes before linearized reading' (duration: 114.097924ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:52:47.452375Z","caller":"traceutil/trace.go:171","msg":"trace[1491327092] transaction","detail":"{read_only:false; response_revision:3932; number_of_response:1; }","duration":"121.392956ms","start":"2026-10-19T01:52:47.330943Z","end":"2026-10-19T01:52:47.452336Z","steps":["trace[1491327092] 'process raft request' (duration: 106.13369ms)","trace[1491327092] 'compare' (duration: 15.113903ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:52:47.457401Z","caller":"traceutil/trace.go:171","msg":"trace[2010291827] transaction","detail":"{read_only:false; response_revision:3933; number_of_response:1; }","duration":"125.700549ms","start":"2026-10-19T01:52:47.331674Z","end":"2026-10-19T01:52:47.457375Z","steps":["trace[2010291827] 'process raft request' (duration: 125.293532ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:11.637962Z","caller":"traceutil/trace.go:171","msg":"trace[501148575] linearizableReadLoop","detail":"{readStateIndex:5163; appliedIndex:5162; }","duration":"172.117185ms","start":"2026-10-19T01:54:11.46581Z","end":"2026-10-19T01:54:11.637927Z","steps":["trace[501148575] 'read index received' (duration: 95.616766ms)","trace[501148575] 'applied index is now lower than readState.Index' (duration: 76.498758ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:54:11.638061Z","caller":"traceutil/trace.go:171","msg":"trace[1924223695] transaction","detail":"{read_only:false; response_revision:4974; number_of_response:1; }","duration":"180.393011ms","start":"2026-10-19T01:54:11.457634Z","end":"2026-10-19T01:54:11.638027Z","steps":["trace[1924223695] 'process raft request' (duration: 103.812101ms)","trace[1924223695] 'compare' (duration: 76.280105ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:54:11.639206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.615475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2362732"} {"level":"info","ts":"2026-10-19T01:54:11.639276Z","caller":"traceutil/trace.go:171","msg":"trace[1993875555] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4974; }","duration":"180.721266ms","start":"2026-10-19T01:54:11.458537Z","end":"2026-10-19T01:54:11.639258Z","steps":["trace[1993875555] 'agreement among raft nodes before linearized reading' (duration: 179.565817ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:11.71776Z","caller":"traceutil/trace.go:171","msg":"trace[141256082] transaction","detail":"{read_only:false; response_revision:4975; number_of_response:1; }","duration":"244.987802ms","start":"2026-10-19T01:54:11.472643Z","end":"2026-10-19T01:54:11.717631Z","steps":["trace[141256082] 'process raft request' (duration: 244.783948ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:11.717836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.402406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-10-19T01:54:11.717913Z","caller":"traceutil/trace.go:171","msg":"trace[406453741] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4975; }","duration":"249.511937ms","start":"2026-10-19T01:54:11.468381Z","end":"2026-10-19T01:54:11.717893Z","steps":["trace[406453741] 'agreement among raft nodes before linearized reading' (duration: 249.266213ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:11.718224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.749681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-7bnfx.18dfcb6c71e414dd\" ","response":"range_response_count:1 size:832"} {"level":"info","ts":"2026-10-19T01:54:11.7183Z","caller":"traceutil/trace.go:171","msg":"trace[1822749853] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-7bnfx.18dfcb6c71e414dd; range_end:; response_count:1; response_revision:4975; }","duration":"249.912535ms","start":"2026-10-19T01:54:11.468368Z","end":"2026-10-19T01:54:11.718281Z","steps":["trace[1822749853] 'agreement among raft nodes before linearized reading' (duration: 249.544388ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:11.937165Z","caller":"traceutil/trace.go:171","msg":"trace[636396282] transaction","detail":"{read_only:false; response_revision:4976; number_of_response:1; }","duration":"284.775822ms","start":"2026-10-19T01:54:11.652365Z","end":"2026-10-19T01:54:11.937141Z","steps":["trace[636396282] 'process raft request' (duration: 284.597049ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:11.937344Z","caller":"traceutil/trace.go:171","msg":"trace[821911503] linearizableReadLoop","detail":"{readStateIndex:5166; appliedIndex:5164; }","duration":"219.723584ms","start":"2026-10-19T01:54:11.717595Z","end":"2026-10-19T01:54:11.937318Z","steps":["trace[821911503] 'read index received' (duration: 219.408769ms)","trace[821911503] 'applied index is now lower than readState.Index' (duration: 312.815µs)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:54:11.937486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.257902ms","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-19T01:54:11.937589Z","caller":"traceutil/trace.go:171","msg":"trace[2023229000] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4976; }","duration":"290.394154ms","start":"2026-10-19T01:54:11.647176Z","end":"2026-10-19T01:54:11.937571Z","steps":["trace[2023229000] 'agreement among raft nodes before linearized reading' (duration: 290.184561ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:11.937626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.45172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"warn","ts":"2026-10-19T01:54:11.937615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.012255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"} {"level":"info","ts":"2026-10-19T01:54:11.937669Z","caller":"traceutil/trace.go:171","msg":"trace[987923627] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4976; }","duration":"295.549691ms","start":"2026-10-19T01:54:11.642109Z","end":"2026-10-19T01:54:11.937658Z","steps":["trace[987923627] 'agreement among raft nodes before linearized reading' (duration: 295.326737ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:11.937695Z","caller":"traceutil/trace.go:171","msg":"trace[335490323] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4976; }","duration":"256.170838ms","start":"2026-10-19T01:54:11.681502Z","end":"2026-10-19T01:54:11.937673Z","steps":["trace[335490323] 'agreement among raft nodes before linearized reading' (duration: 255.865203ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:11.937563Z","caller":"traceutil/trace.go:171","msg":"trace[1171778805] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4976; }","duration":"280.598233ms","start":"2026-10-19T01:54:11.656887Z","end":"2026-10-19T01:54:11.937485Z","steps":["trace[1171778805] 'process raft request' (duration: 280.225556ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:11.986683Z","caller":"traceutil/trace.go:171","msg":"trace[852958484] transaction","detail":"{read_only:false; response_revision:4977; number_of_response:1; }","duration":"266.319686ms","start":"2026-10-19T01:54:11.720341Z","end":"2026-10-19T01:54:11.98666Z","steps":["trace[852958484] 'process raft request' (duration: 266.008601ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:11.987111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.774819ms","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-19T01:54:11.987132Z","caller":"traceutil/trace.go:171","msg":"trace[1845475116] transaction","detail":"{read_only:false; response_revision:4978; number_of_response:1; }","duration":"264.441345ms","start":"2026-10-19T01:54:11.722677Z","end":"2026-10-19T01:54:11.987118Z","steps":["trace[1845475116] 'process raft request' (duration: 263.903836ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:11.987164Z","caller":"traceutil/trace.go:171","msg":"trace[850344853] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4978; }","duration":"162.875641ms","start":"2026-10-19T01:54:11.824275Z","end":"2026-10-19T01:54:11.987151Z","steps":["trace[850344853] 'agreement among raft nodes before linearized reading' (duration: 162.696318ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:12.181341Z","caller":"traceutil/trace.go:171","msg":"trace[156603233] transaction","detail":"{read_only:false; response_revision:4980; number_of_response:1; }","duration":"237.370761ms","start":"2026-10-19T01:54:11.943946Z","end":"2026-10-19T01:54:12.181317Z","steps":["trace[156603233] 'process raft request' (duration: 237.27669ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:12.18135Z","caller":"traceutil/trace.go:171","msg":"trace[245907104] transaction","detail":"{read_only:false; response_revision:4979; number_of_response:1; }","duration":"239.254563ms","start":"2026-10-19T01:54:11.942065Z","end":"2026-10-19T01:54:12.18132Z","steps":["trace[245907104] 'process raft request' (duration: 239.026549ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:12.181563Z","caller":"traceutil/trace.go:171","msg":"trace[1133619234] linearizableReadLoop","detail":"{readStateIndex:5171; appliedIndex:5168; }","duration":"194.868727ms","start":"2026-10-19T01:54:11.986633Z","end":"2026-10-19T01:54:12.181502Z","steps":["trace[1133619234] 'read index received' (duration: 194.512291ms)","trace[1133619234] 'applied index is now lower than readState.Index' (duration: 354.026µs)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:54:12.181804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.923876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3465"} {"level":"warn","ts":"2026-10-19T01:54:12.181875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.90257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-prometheus-node-exporter-7bnfx-tls\" ","response":"range_response_count:1 size:4431"} {"level":"info","ts":"2026-10-19T01:54:12.181891Z","caller":"traceutil/trace.go:171","msg":"trace[2069282119] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4981; }","duration":"210.058629ms","start":"2026-10-19T01:54:11.971812Z","end":"2026-10-19T01:54:12.18187Z","steps":["trace[2069282119] 'agreement among raft nodes before linearized reading' (duration: 209.765744ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:12.181921Z","caller":"traceutil/trace.go:171","msg":"trace[606357717] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-prometheus-node-exporter-7bnfx-tls; range_end:; response_count:1; response_revision:4981; }","duration":"234.999061ms","start":"2026-10-19T01:54:11.946905Z","end":"2026-10-19T01:54:12.181904Z","steps":["trace[606357717] 'agreement among raft nodes before linearized reading' (duration: 234.774008ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:12.182091Z","caller":"traceutil/trace.go:171","msg":"trace[1512482711] transaction","detail":"{read_only:false; response_revision:4981; number_of_response:1; }","duration":"221.695861ms","start":"2026-10-19T01:54:11.960378Z","end":"2026-10-19T01:54:12.182074Z","steps":["trace[1512482711] 'process raft request' (duration: 220.892328ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:12.182277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.060011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:3958"} {"level":"warn","ts":"2026-10-19T01:54:12.182279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.784354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-prometheus-node-exporter-7bnfx-tls-9h47d\" ","response":"range_response_count:1 size:2625"} {"level":"info","ts":"2026-10-19T01:54:12.182437Z","caller":"traceutil/trace.go:171","msg":"trace[311549774] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-prometheus-node-exporter-7bnfx-tls-9h47d; range_end:; response_count:1; response_revision:4981; }","duration":"238.970367ms","start":"2026-10-19T01:54:11.94345Z","end":"2026-10-19T01:54:12.182421Z","steps":["trace[311549774] 'agreement among raft nodes before linearized reading' (duration: 238.602182ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:12.182329Z","caller":"traceutil/trace.go:171","msg":"trace[122627503] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4981; }","duration":"241.150923ms","start":"2026-10-19T01:54:11.941165Z","end":"2026-10-19T01:54:12.182316Z","steps":["trace[122627503] 'agreement among raft nodes before linearized reading' (duration: 240.932761ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:12.219028Z","caller":"traceutil/trace.go:171","msg":"trace[342823548] transaction","detail":"{read_only:false; response_revision:4982; number_of_response:1; }","duration":"227.417725ms","start":"2026-10-19T01:54:11.991591Z","end":"2026-10-19T01:54:12.219009Z","steps":["trace[342823548] 'process raft request' (duration: 227.300033ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:12.21946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.978282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-19T01:54:12.219549Z","caller":"traceutil/trace.go:171","msg":"trace[1037181910] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4982; }","duration":"159.141705ms","start":"2026-10-19T01:54:12.06039Z","end":"2026-10-19T01:54:12.219531Z","steps":["trace[1037181910] 'agreement among raft nodes before linearized reading' (duration: 158.991892ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:12.219624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.116411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-10-19T01:54:12.219644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.145262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-10-19T01:54:12.219661Z","caller":"traceutil/trace.go:171","msg":"trace[717449804] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4982; }","duration":"160.188503ms","start":"2026-10-19T01:54:12.059462Z","end":"2026-10-19T01:54:12.21965Z","steps":["trace[717449804] 'agreement among raft nodes before linearized reading' (duration: 160.074221ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:12.219689Z","caller":"traceutil/trace.go:171","msg":"trace[1501177366] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4982; }","duration":"160.236323ms","start":"2026-10-19T01:54:12.059438Z","end":"2026-10-19T01:54:12.219675Z","steps":["trace[1501177366] 'agreement among raft nodes before linearized reading' (duration: 160.108191ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:12.37926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.029636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"} {"level":"info","ts":"2026-10-19T01:54:12.379352Z","caller":"traceutil/trace.go:171","msg":"trace[1278431511] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4990; }","duration":"100.177719ms","start":"2026-10-19T01:54:12.279149Z","end":"2026-10-19T01:54:12.379326Z","steps":["trace[1278431511] 'agreement among raft nodes before linearized reading' (duration: 99.930904ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:12.379812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.620985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"} {"level":"info","ts":"2026-10-19T01:54:12.379891Z","caller":"traceutil/trace.go:171","msg":"trace[453172683] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:4990; }","duration":"100.733878ms","start":"2026-10-19T01:54:12.279138Z","end":"2026-10-19T01:54:12.379872Z","steps":["trace[453172683] 'agreement among raft nodes before linearized reading' (duration: 99.873973ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:19.82677Z","caller":"traceutil/trace.go:171","msg":"trace[1559486713] transaction","detail":"{read_only:false; response_revision:5101; number_of_response:1; }","duration":"239.05519ms","start":"2026-10-19T01:54:19.587682Z","end":"2026-10-19T01:54:19.826737Z","steps":["trace[1559486713] 'process raft request' (duration: 238.815806ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:20.460658Z","caller":"traceutil/trace.go:171","msg":"trace[1884377014] transaction","detail":"{read_only:false; response_revision:5108; number_of_response:1; }","duration":"140.273736ms","start":"2026-10-19T01:54:20.320359Z","end":"2026-10-19T01:54:20.460632Z","steps":["trace[1884377014] 'process raft request' (duration: 138.318584ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:20.474862Z","caller":"traceutil/trace.go:171","msg":"trace[329576643] linearizableReadLoop","detail":"{readStateIndex:5302; appliedIndex:5299; }","duration":"141.439906ms","start":"2026-10-19T01:54:20.333399Z","end":"2026-10-19T01:54:20.474839Z","steps":["trace[329576643] 'read index received' (duration: 125.310752ms)","trace[329576643] 'applied index is now lower than readState.Index' (duration: 16.127964ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:54:20.474941Z","caller":"traceutil/trace.go:171","msg":"trace[630448037] transaction","detail":"{read_only:false; response_revision:5110; number_of_response:1; }","duration":"142.577664ms","start":"2026-10-19T01:54:20.332336Z","end":"2026-10-19T01:54:20.474914Z","steps":["trace[630448037] 'process raft request' (duration: 142.404381ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:20.47511Z","caller":"traceutil/trace.go:171","msg":"trace[323203477] transaction","detail":"{read_only:false; response_revision:5109; number_of_response:1; }","duration":"151.886887ms","start":"2026-10-19T01:54:20.323206Z","end":"2026-10-19T01:54:20.475093Z","steps":["trace[323203477] 'process raft request' (duration: 151.397039ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:20.475224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.511637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"} {"level":"info","ts":"2026-10-19T01:54:20.475276Z","caller":"traceutil/trace.go:171","msg":"trace[1690416244] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:5110; }","duration":"138.585709ms","start":"2026-10-19T01:54:20.336674Z","end":"2026-10-19T01:54:20.47526Z","steps":["trace[1690416244] 'agreement among raft nodes before linearized reading' (duration: 138.479207ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:20.475115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.69461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-10-19T01:54:20.4754Z","caller":"traceutil/trace.go:171","msg":"trace[621865690] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5110; }","duration":"142.031145ms","start":"2026-10-19T01:54:20.333359Z","end":"2026-10-19T01:54:20.47539Z","steps":["trace[621865690] 'agreement among raft nodes before linearized reading' (duration: 141.616888ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:20.475409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.953854ms","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":"warn","ts":"2026-10-19T01:54:20.475485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.131716ms","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-19T01:54:20.475534Z","caller":"traceutil/trace.go:171","msg":"trace[1136934889] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5110; }","duration":"134.219818ms","start":"2026-10-19T01:54:20.341299Z","end":"2026-10-19T01:54:20.475519Z","steps":["trace[1136934889] 'agreement among raft nodes before linearized reading' (duration: 134.002965ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:20.475548Z","caller":"traceutil/trace.go:171","msg":"trace[1606268632] 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:5110; }","duration":"120.134507ms","start":"2026-10-19T01:54:20.355382Z","end":"2026-10-19T01:54:20.475517Z","steps":["trace[1606268632] 'agreement among raft nodes before linearized reading' (duration: 119.795662ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:20.476104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.750539ms","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":"info","ts":"2026-10-19T01:54:20.476327Z","caller":"traceutil/trace.go:171","msg":"trace[99479308] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5110; }","duration":"128.85399ms","start":"2026-10-19T01:54:20.347296Z","end":"2026-10-19T01:54:20.47615Z","steps":["trace[99479308] 'agreement among raft nodes before linearized reading' (duration: 128.567565ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:23.491465Z","caller":"traceutil/trace.go:171","msg":"trace[46403320] transaction","detail":"{read_only:false; response_revision:5155; number_of_response:1; }","duration":"159.696854ms","start":"2026-10-19T01:54:23.331742Z","end":"2026-10-19T01:54:23.491439Z","steps":["trace[46403320] 'process raft request' (duration: 159.496921ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:32.765821Z","caller":"traceutil/trace.go:171","msg":"trace[424148892] transaction","detail":"{read_only:false; response_revision:5272; number_of_response:1; }","duration":"428.957145ms","start":"2026-10-19T01:54:32.336839Z","end":"2026-10-19T01:54:32.765796Z","steps":["trace[424148892] 'process raft request' (duration: 428.803113ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:32.765969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:54:32.33681Z","time spent":"429.083878ms","remote":"127.0.0.1:44864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11654,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T01:54:32.767577Z","caller":"traceutil/trace.go:171","msg":"trace[1405810000] linearizableReadLoop","detail":"{readStateIndex:5470; appliedIndex:5470; }","duration":"331.700058ms","start":"2026-10-19T01:54:32.434681Z","end":"2026-10-19T01:54:32.766381Z","steps":["trace[1405810000] 'read index received' (duration: 331.693588ms)","trace[1405810000] 'applied index is now lower than readState.Index' (duration: 5.33µs)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:54:32.768454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.05416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-10-19T01:54:32.768534Z","caller":"traceutil/trace.go:171","msg":"trace[1825345876] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5273; }","duration":"271.192032ms","start":"2026-10-19T01:54:32.497322Z","end":"2026-10-19T01:54:32.768514Z","steps":["trace[1825345876] 'agreement among raft nodes before linearized reading' (duration: 270.938118ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:32.768602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.390544ms","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":"info","ts":"2026-10-19T01:54:32.768703Z","caller":"traceutil/trace.go:171","msg":"trace[1687481138] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5273; }","duration":"194.539437ms","start":"2026-10-19T01:54:32.574135Z","end":"2026-10-19T01:54:32.768675Z","steps":["trace[1687481138] 'agreement among raft nodes before linearized reading' (duration: 194.281102ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:32.768865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.571723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"} {"level":"info","ts":"2026-10-19T01:54:32.768909Z","caller":"traceutil/trace.go:171","msg":"trace[1493610118] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:5273; }","duration":"195.636743ms","start":"2026-10-19T01:54:32.57326Z","end":"2026-10-19T01:54:32.768897Z","steps":["trace[1493610118] 'agreement among raft nodes before linearized reading' (duration: 195.532282ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:32.769053Z","caller":"traceutil/trace.go:171","msg":"trace[1503100525] transaction","detail":"{read_only:false; response_revision:5273; number_of_response:1; }","duration":"199.586368ms","start":"2026-10-19T01:54:32.569452Z","end":"2026-10-19T01:54:32.769038Z","steps":["trace[1503100525] 'process raft request' (duration: 198.664303ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:32.769198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.988614ms","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-19T01:54:32.769229Z","caller":"traceutil/trace.go:171","msg":"trace[1325960933] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5273; }","duration":"195.063575ms","start":"2026-10-19T01:54:32.574157Z","end":"2026-10-19T01:54:32.76922Z","steps":["trace[1325960933] 'agreement among raft nodes before linearized reading' (duration: 194.978573ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:32.769427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.984345ms","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-19T01:54:32.769467Z","caller":"traceutil/trace.go:171","msg":"trace[1319123285] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5273; }","duration":"241.072727ms","start":"2026-10-19T01:54:32.52838Z","end":"2026-10-19T01:54:32.769453Z","steps":["trace[1319123285] 'agreement among raft nodes before linearized reading' (duration: 240.953875ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:32.769311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.362152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-10-19T01:54:32.770024Z","caller":"traceutil/trace.go:171","msg":"trace[2053028922] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5273; }","duration":"216.112283ms","start":"2026-10-19T01:54:32.5539Z","end":"2026-10-19T01:54:32.770012Z","steps":["trace[2053028922] 'agreement among raft nodes before linearized reading' (duration: 215.332111ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:32.770926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.2374ms","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-19T01:54:32.771028Z","caller":"traceutil/trace.go:171","msg":"trace[459090056] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5272; }","duration":"336.379563ms","start":"2026-10-19T01:54:32.434632Z","end":"2026-10-19T01:54:32.771011Z","steps":["trace[459090056] 'agreement among raft nodes before linearized reading' (duration: 331.847991ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:32.771121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:54:32.434607Z","time spent":"336.495995ms","remote":"127.0.0.1:44938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-10-19T01:54:32.911373Z","caller":"traceutil/trace.go:171","msg":"trace[569021228] transaction","detail":"{read_only:false; response_revision:5276; number_of_response:1; }","duration":"129.383687ms","start":"2026-10-19T01:54:32.781943Z","end":"2026-10-19T01:54:32.911327Z","steps":["trace[569021228] 'process raft request' (duration: 129.133492ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:32.911496Z","caller":"traceutil/trace.go:171","msg":"trace[1764353528] transaction","detail":"{read_only:false; response_revision:5281; number_of_response:1; }","duration":"125.28918ms","start":"2026-10-19T01:54:32.786182Z","end":"2026-10-19T01:54:32.911471Z","steps":["trace[1764353528] 'process raft request' (duration: 125.091987ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:32.91154Z","caller":"traceutil/trace.go:171","msg":"trace[1064914728] transaction","detail":"{read_only:false; response_revision:5275; number_of_response:1; }","duration":"133.811887ms","start":"2026-10-19T01:54:32.777706Z","end":"2026-10-19T01:54:32.911517Z","steps":["trace[1064914728] 'process raft request' (duration: 133.314259ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:32.911556Z","caller":"traceutil/trace.go:171","msg":"trace[1922711534] transaction","detail":"{read_only:false; response_revision:5278; number_of_response:1; }","duration":"129.295994ms","start":"2026-10-19T01:54:32.782203Z","end":"2026-10-19T01:54:32.911499Z","steps":["trace[1922711534] 'process raft request' (duration: 128.968599ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:32.911579Z","caller":"traceutil/trace.go:171","msg":"trace[1920789021] transaction","detail":"{read_only:false; response_revision:5279; number_of_response:1; }","duration":"126.334007ms","start":"2026-10-19T01:54:32.785224Z","end":"2026-10-19T01:54:32.911558Z","steps":["trace[1920789021] 'process raft request' (duration: 125.977882ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:32.911621Z","caller":"traceutil/trace.go:171","msg":"trace[1778191354] transaction","detail":"{read_only:false; response_revision:5280; number_of_response:1; }","duration":"126.276376ms","start":"2026-10-19T01:54:32.785334Z","end":"2026-10-19T01:54:32.91161Z","steps":["trace[1778191354] 'process raft request' (duration: 125.9003ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:32.911701Z","caller":"traceutil/trace.go:171","msg":"trace[1318049885] transaction","detail":"{read_only:false; response_revision:5274; number_of_response:1; }","duration":"135.037448ms","start":"2026-10-19T01:54:32.776652Z","end":"2026-10-19T01:54:32.911689Z","steps":["trace[1318049885] 'process raft request' (duration: 69.667763ms)","trace[1318049885] 'compare' (duration: 64.567011ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:54:32.911711Z","caller":"traceutil/trace.go:171","msg":"trace[743505758] transaction","detail":"{read_only:false; response_revision:5277; number_of_response:1; }","duration":"129.6054ms","start":"2026-10-19T01:54:32.782088Z","end":"2026-10-19T01:54:32.911694Z","steps":["trace[743505758] 'process raft request' (duration: 129.053191ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:32.911871Z","caller":"traceutil/trace.go:171","msg":"trace[1029190120] linearizableReadLoop","detail":"{readStateIndex:5473; appliedIndex:5471; }","duration":"134.455207ms","start":"2026-10-19T01:54:32.777405Z","end":"2026-10-19T01:54:32.91186Z","steps":["trace[1029190120] 'read index received' (duration: 68.86427ms)","trace[1029190120] 'applied index is now lower than readState.Index' (duration: 65.590087ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:54:32.911964Z","caller":"traceutil/trace.go:171","msg":"trace[1303167497] transaction","detail":"{read_only:false; response_revision:5283; number_of_response:1; }","duration":"121.762684ms","start":"2026-10-19T01:54:32.790191Z","end":"2026-10-19T01:54:32.911954Z","steps":["trace[1303167497] 'process raft request' (duration: 121.611212ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:54:32.912014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.5898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-7bd78af9-9125-4892-baf4-89ec1e2d2ad5\" ","response":"range_response_count:1 size:1322"} {"level":"info","ts":"2026-10-19T01:54:32.912077Z","caller":"traceutil/trace.go:171","msg":"trace[1869578416] range","detail":"{range_begin:/registry/persistentvolumes/pvc-7bd78af9-9125-4892-baf4-89ec1e2d2ad5; range_end:; response_count:1; response_revision:5283; }","duration":"134.662241ms","start":"2026-10-19T01:54:32.777375Z","end":"2026-10-19T01:54:32.912038Z","steps":["trace[1869578416] 'agreement among raft nodes before linearized reading' (duration: 134.520559ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:32.912219Z","caller":"traceutil/trace.go:171","msg":"trace[1596250217] transaction","detail":"{read_only:false; response_revision:5282; number_of_response:1; }","duration":"124.965516ms","start":"2026-10-19T01:54:32.787233Z","end":"2026-10-19T01:54:32.912198Z","steps":["trace[1596250217] 'process raft request' (duration: 124.167523ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:33.04759Z","caller":"traceutil/trace.go:171","msg":"trace[103957156] transaction","detail":"{read_only:false; response_revision:5286; number_of_response:1; }","duration":"125.298089ms","start":"2026-10-19T01:54:32.922267Z","end":"2026-10-19T01:54:33.047565Z","steps":["trace[103957156] 'process raft request' (duration: 101.096709ms)","trace[103957156] 'compare' (duration: 24.030337ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:54:33.047906Z","caller":"traceutil/trace.go:171","msg":"trace[1524867662] transaction","detail":"{read_only:false; response_revision:5287; number_of_response:1; }","duration":"125.468122ms","start":"2026-10-19T01:54:32.922416Z","end":"2026-10-19T01:54:33.047884Z","steps":["trace[1524867662] 'process raft request' (duration: 125.104476ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:33.048007Z","caller":"traceutil/trace.go:171","msg":"trace[175360094] transaction","detail":"{read_only:false; response_revision:5288; number_of_response:1; }","duration":"125.369651ms","start":"2026-10-19T01:54:32.92261Z","end":"2026-10-19T01:54:33.047979Z","steps":["trace[175360094] 'process raft request' (duration: 125.174757ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:33.048112Z","caller":"traceutil/trace.go:171","msg":"trace[1274692622] transaction","detail":"{read_only:false; response_revision:5289; number_of_response:1; }","duration":"116.833842ms","start":"2026-10-19T01:54:32.931259Z","end":"2026-10-19T01:54:33.048093Z","steps":["trace[1274692622] 'process raft request' (duration: 116.647369ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:54:36.943572Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2854} {"level":"info","ts":"2026-10-19T01:54:37.018783Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2854,"took":"73.055012ms","hash":154199828,"current-db-size-bytes":51683328,"current-db-size":"52 MB","current-db-size-in-use-bytes":27983872,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-19T01:54:37.01885Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":154199828,"revision":2854,"compact-revision":-1} {"level":"info","ts":"2026-10-19T01:59:36.950612Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5315} {"level":"info","ts":"2026-10-19T01:59:37.037872Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5315,"took":"85.631423ms","hash":616985737,"current-db-size-bytes":51683328,"current-db-size":"52 MB","current-db-size-in-use-bytes":19140608,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-10-19T01:59:37.037954Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":616985737,"revision":5315,"compact-revision":2854}