{"level":"warn","ts":"2026-07-22T22:04:05.90623Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-22T22:04:05.906351Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.20:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.20:2380","--initial-cluster=instance=https://199.19.213.20:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.20:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.20: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-07-22T22:04:05.906459Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-22T22:04:05.906477Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.20:2380"]} {"level":"info","ts":"2026-07-22T22:04:05.906505Z","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-07-22T22:04:05.907373Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.20:2379"]} {"level":"info","ts":"2026-07-22T22:04:05.907479Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.20:2380"],"listen-peer-urls":["https://199.19.213.20:2380"],"advertise-client-urls":["https://199.19.213.20:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.20:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.20: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-07-22T22:04:05.911443Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.657862ms"} {"level":"info","ts":"2026-07-22T22:04:05.91866Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"185293d8d40ffce0","cluster-id":"cc857afa6e1fa648"} {"level":"info","ts":"2026-07-22T22:04:05.918772Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 switched to configuration voters=()"} {"level":"info","ts":"2026-07-22T22:04:05.918809Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 became follower at term 0"} {"level":"info","ts":"2026-07-22T22:04:05.918828Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 185293d8d40ffce0 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-22T22:04:05.918848Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 became follower at term 1"} {"level":"info","ts":"2026-07-22T22:04:05.918907Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 switched to configuration voters=(1752625764480580832)"} {"level":"warn","ts":"2026-07-22T22:04:05.931398Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-22T22:04:05.933202Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-22T22:04:05.937017Z","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-07-22T22:04:05.940464Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"185293d8d40ffce0","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-22T22:04:05.940643Z","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-07-22T22:04:05.940717Z","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-07-22T22:04:05.940742Z","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-07-22T22:04:05.940787Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"185293d8d40ffce0","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-22T22:04:05.944231Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 switched to configuration voters=(1752625764480580832)"} {"level":"info","ts":"2026-07-22T22:04:05.944796Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"cc857afa6e1fa648","local-member-id":"185293d8d40ffce0","added-peer-id":"185293d8d40ffce0","added-peer-peer-urls":["https://199.19.213.20:2380"]} {"level":"info","ts":"2026-07-22T22:04:05.946454Z","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-07-22T22:04:05.946617Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"185293d8d40ffce0","initial-advertise-peer-urls":["https://199.19.213.20:2380"],"listen-peer-urls":["https://199.19.213.20:2380"],"advertise-client-urls":["https://199.19.213.20:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.20:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-22T22:04:05.946645Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-22T22:04:05.946709Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.20:2380"} {"level":"info","ts":"2026-07-22T22:04:05.946725Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.20:2380"} {"level":"info","ts":"2026-07-22T22:04:06.219465Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 is starting a new election at term 1"} {"level":"info","ts":"2026-07-22T22:04:06.219654Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-22T22:04:06.219763Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 received MsgPreVoteResp from 185293d8d40ffce0 at term 1"} {"level":"info","ts":"2026-07-22T22:04:06.219832Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 became candidate at term 2"} {"level":"info","ts":"2026-07-22T22:04:06.219904Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 received MsgVoteResp from 185293d8d40ffce0 at term 2"} {"level":"info","ts":"2026-07-22T22:04:06.219972Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 became leader at term 2"} {"level":"info","ts":"2026-07-22T22:04:06.220013Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 185293d8d40ffce0 elected leader 185293d8d40ffce0 at term 2"} {"level":"info","ts":"2026-07-22T22:04:06.221082Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-22T22:04:06.222599Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"185293d8d40ffce0","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.20:2379]}","request-path":"/0/members/185293d8d40ffce0/attributes","cluster-id":"cc857afa6e1fa648","publish-timeout":"7s"} {"level":"info","ts":"2026-07-22T22:04:06.222615Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-22T22:04:06.223069Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-22T22:04:06.223292Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"cc857afa6e1fa648","local-member-id":"185293d8d40ffce0","cluster-version":"3.5"} {"level":"info","ts":"2026-07-22T22:04:06.223485Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-22T22:04:06.223566Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-22T22:04:06.225067Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-22T22:04:06.225096Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-22T22:04:06.226425Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-22T22:04:06.227953Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.20:2379"} {"level":"info","ts":"2026-07-22T22:04:08.852407Z","caller":"traceutil/trace.go:171","msg":"trace[2012737450] linearizableReadLoop","detail":"{readStateIndex:76; appliedIndex:75; }","duration":"149.663888ms","start":"2026-07-22T22:04:08.702716Z","end":"2026-07-22T22:04:08.85238Z","steps":["trace[2012737450] 'read index received' (duration: 149.382516ms)","trace[2012737450] 'applied index is now lower than readState.Index' (duration: 253.562µs)"],"step_count":2} {"level":"warn","ts":"2026-07-22T22:04:08.852626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.89278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-22T22:04:08.852722Z","caller":"traceutil/trace.go:171","msg":"trace[1164639840] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:72; }","duration":"150.047722ms","start":"2026-07-22T22:04:08.702658Z","end":"2026-07-22T22:04:08.852705Z","steps":["trace[1164639840] 'agreement among raft nodes before linearized reading' (duration: 149.83456ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:04:08.852447Z","caller":"traceutil/trace.go:171","msg":"trace[2048790757] transaction","detail":"{read_only:false; response_revision:72; number_of_response:1; }","duration":"149.824349ms","start":"2026-07-22T22:04:08.702581Z","end":"2026-07-22T22:04:08.852405Z","steps":["trace[2048790757] 'process raft request' (duration: 149.583897ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:04:42.194019Z","caller":"traceutil/trace.go:171","msg":"trace[1716167149] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"105.542707ms","start":"2026-07-22T22:04:42.088454Z","end":"2026-07-22T22:04:42.193997Z","steps":["trace[1716167149] 'process raft request' (duration: 98.465751ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:04:42.388053Z","caller":"traceutil/trace.go:171","msg":"trace[508220169] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"110.707276ms","start":"2026-07-22T22:04:42.277321Z","end":"2026-07-22T22:04:42.388028Z","steps":["trace[508220169] 'process raft request' (duration: 105.650382ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:04:42.388546Z","caller":"traceutil/trace.go:171","msg":"trace[252602041] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"107.566742ms","start":"2026-07-22T22:04:42.280954Z","end":"2026-07-22T22:04:42.38852Z","steps":["trace[252602041] 'process raft request' (duration: 107.21864ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:04:42.388711Z","caller":"traceutil/trace.go:171","msg":"trace[2070080787] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"102.137534ms","start":"2026-07-22T22:04:42.286549Z","end":"2026-07-22T22:04:42.388686Z","steps":["trace[2070080787] 'process raft request' (duration: 101.810942ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:04:45.650507Z","caller":"traceutil/trace.go:171","msg":"trace[51476872] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"164.913827ms","start":"2026-07-22T22:04:45.48557Z","end":"2026-07-22T22:04:45.650484Z","steps":["trace[51476872] 'process raft request' (duration: 164.701879ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:04:48.86005Z","caller":"traceutil/trace.go:171","msg":"trace[1028318980] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"239.300044ms","start":"2026-07-22T22:04:48.620721Z","end":"2026-07-22T22:04:48.860021Z","steps":["trace[1028318980] 'process raft request' (duration: 234.940046ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:04:49.481029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.457914ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-22T22:04:49.481158Z","caller":"traceutil/trace.go:171","msg":"trace[1058938791] linearizableReadLoop","detail":"{readStateIndex:623; appliedIndex:622; }","duration":"489.903903ms","start":"2026-07-22T22:04:48.991225Z","end":"2026-07-22T22:04:49.481129Z","steps":["trace[1058938791] 'read index received' (duration: 373.720024ms)","trace[1058938791] 'applied index is now lower than readState.Index' (duration: 116.182589ms)"],"step_count":2} {"level":"info","ts":"2026-07-22T22:04:49.481195Z","caller":"traceutil/trace.go:171","msg":"trace[692342017] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"492.064336ms","start":"2026-07-22T22:04:48.989091Z","end":"2026-07-22T22:04:49.481155Z","steps":["trace[692342017] 'process raft request' (duration: 375.860366ms)","trace[692342017] 'compare' (duration: 115.113073ms)"],"step_count":2} {"level":"warn","ts":"2026-07-22T22:04:49.481267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.584911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-22T22:04:49.481297Z","caller":"traceutil/trace.go:171","msg":"trace[1554681874] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:599; }","duration":"392.658683ms","start":"2026-07-22T22:04:49.088628Z","end":"2026-07-22T22:04:49.481287Z","steps":["trace[1554681874] 'agreement among raft nodes before linearized reading' (duration: 392.605471ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:04:49.481331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:04:49.088602Z","time spent":"392.722665ms","remote":"127.0.0.1:58946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-22T22:04:49.481323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"490.060798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"warn","ts":"2026-07-22T22:04:49.481385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:04:48.989081Z","time spent":"492.20004ms","remote":"127.0.0.1:59212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-22T22:04:49.48142Z","caller":"traceutil/trace.go:171","msg":"trace[960637376] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:599; }","duration":"490.190652ms","start":"2026-07-22T22:04:48.991206Z","end":"2026-07-22T22:04:49.481397Z","steps":["trace[960637376] 'agreement among raft nodes before linearized reading' (duration: 490.015886ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:04:49.481465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:04:48.991199Z","time spent":"490.257364ms","remote":"127.0.0.1:59140","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":216,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"info","ts":"2026-07-22T22:04:50.878007Z","caller":"traceutil/trace.go:171","msg":"trace[264580844] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"130.089573ms","start":"2026-07-22T22:04:50.74789Z","end":"2026-07-22T22:04:50.877979Z","steps":["trace[264580844] 'process raft request' (duration: 129.955069ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:04:50.882651Z","caller":"traceutil/trace.go:171","msg":"trace[1215780722] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"132.946519ms","start":"2026-07-22T22:04:50.749688Z","end":"2026-07-22T22:04:50.882635Z","steps":["trace[1215780722] 'process raft request' (duration: 132.869046ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:06:18.148465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.291343ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-22T22:06:18.149157Z","caller":"traceutil/trace.go:171","msg":"trace[1330594308] transaction","detail":"{read_only:false; response_revision:1826; number_of_response:1; }","duration":"413.377221ms","start":"2026-07-22T22:06:17.735758Z","end":"2026-07-22T22:06:18.149135Z","steps":["trace[1330594308] 'process raft request' (duration: 134.288436ms)","trace[1330594308] 'compare' (duration: 277.829167ms)"],"step_count":2} {"level":"warn","ts":"2026-07-22T22:06:18.149231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:06:17.73573Z","time spent":"413.462143ms","remote":"127.0.0.1:59212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-22T22:06:18.193351Z","caller":"traceutil/trace.go:171","msg":"trace[1986808714] linearizableReadLoop","detail":"{readStateIndex:1897; appliedIndex:1896; }","duration":"275.015601ms","start":"2026-07-22T22:06:17.918311Z","end":"2026-07-22T22:06:18.193326Z","steps":["trace[1986808714] 'read index received' (duration: 274.884219ms)","trace[1986808714] 'applied index is now lower than readState.Index' (duration: 130.262µs)"],"step_count":2} {"level":"warn","ts":"2026-07-22T22:06:18.193771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.424006ms","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-07-22T22:06:18.193836Z","caller":"traceutil/trace.go:171","msg":"trace[2142532665] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1827; }","duration":"275.570148ms","start":"2026-07-22T22:06:17.918255Z","end":"2026-07-22T22:06:18.193825Z","steps":["trace[2142532665] 'agreement among raft nodes before linearized reading' (duration: 275.204393ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:06:18.19345Z","caller":"traceutil/trace.go:171","msg":"trace[283625774] transaction","detail":"{read_only:false; response_revision:1827; number_of_response:1; }","duration":"312.808032ms","start":"2026-07-22T22:06:17.880613Z","end":"2026-07-22T22:06:18.193421Z","steps":["trace[283625774] 'process raft request' (duration: 312.605709ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:06:18.194607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:06:17.88059Z","time spent":"313.874228ms","remote":"127.0.0.1:59212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-22T22:06:18.57398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.301879ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-22T22:06:18.574492Z","caller":"traceutil/trace.go:171","msg":"trace[843876054] linearizableReadLoop","detail":"{readStateIndex:1900; appliedIndex:1898; }","duration":"272.619067ms","start":"2026-07-22T22:06:18.301856Z","end":"2026-07-22T22:06:18.574475Z","steps":["trace[843876054] 'read index received' (duration: 73.757819ms)","trace[843876054] 'applied index is now lower than readState.Index' (duration: 198.860308ms)"],"step_count":2} {"level":"info","ts":"2026-07-22T22:06:18.57448Z","caller":"traceutil/trace.go:171","msg":"trace[1220710611] transaction","detail":"{read_only:false; response_revision:1829; number_of_response:1; }","duration":"375.818201ms","start":"2026-07-22T22:06:18.198629Z","end":"2026-07-22T22:06:18.574447Z","steps":["trace[1220710611] 'process raft request' (duration: 176.969434ms)","trace[1220710611] 'compare' (duration: 198.175898ms)"],"step_count":2} {"level":"warn","ts":"2026-07-22T22:06:18.575034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:06:18.198621Z","time spent":"376.367099ms","remote":"127.0.0.1:59212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-22T22:06:18.574571Z","caller":"traceutil/trace.go:171","msg":"trace[1139306270] transaction","detail":"{read_only:false; response_revision:1830; number_of_response:1; }","duration":"374.729816ms","start":"2026-07-22T22:06:18.199832Z","end":"2026-07-22T22:06:18.574562Z","steps":["trace[1139306270] 'process raft request' (duration: 374.551413ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:06:18.575617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:06:18.199813Z","time spent":"375.721741ms","remote":"127.0.0.1:59128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3731,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-22T22:06:18.574739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.87284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-22T22:06:18.575982Z","caller":"traceutil/trace.go:171","msg":"trace[299750816] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1830; }","duration":"274.1634ms","start":"2026-07-22T22:06:18.301803Z","end":"2026-07-22T22:06:18.575966Z","steps":["trace[299750816] 'agreement among raft nodes before linearized reading' (duration: 272.80339ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:06:45.538411Z","caller":"traceutil/trace.go:171","msg":"trace[2121630552] linearizableReadLoop","detail":"{readStateIndex:2110; appliedIndex:2109; }","duration":"104.607513ms","start":"2026-07-22T22:06:45.433774Z","end":"2026-07-22T22:06:45.538381Z","steps":["trace[2121630552] 'read index received' (duration: 104.35683ms)","trace[2121630552] 'applied index is now lower than readState.Index' (duration: 249.153µs)"],"step_count":2} {"level":"info","ts":"2026-07-22T22:06:45.538523Z","caller":"traceutil/trace.go:171","msg":"trace[1165523126] transaction","detail":"{read_only:false; response_revision:2034; number_of_response:1; }","duration":"240.24605ms","start":"2026-07-22T22:06:45.298232Z","end":"2026-07-22T22:06:45.538478Z","steps":["trace[1165523126] 'process raft request' (duration: 239.918815ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:06:45.538832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.966769ms","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-07-22T22:06:45.539308Z","caller":"traceutil/trace.go:171","msg":"trace[1742489824] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2034; }","duration":"105.529205ms","start":"2026-07-22T22:06:45.433712Z","end":"2026-07-22T22:06:45.539241Z","steps":["trace[1742489824] 'agreement among raft nodes before linearized reading' (duration: 104.796016ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:06:45.772595Z","caller":"traceutil/trace.go:171","msg":"trace[2070106180] transaction","detail":"{read_only:false; response_revision:2036; number_of_response:1; }","duration":"106.069663ms","start":"2026-07-22T22:06:45.666485Z","end":"2026-07-22T22:06:45.772555Z","steps":["trace[2070106180] 'process raft request' (duration: 105.85724ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:06:51.787837Z","caller":"traceutil/trace.go:171","msg":"trace[1129405605] linearizableReadLoop","detail":"{readStateIndex:2148; appliedIndex:2147; }","duration":"100.454086ms","start":"2026-07-22T22:06:51.687358Z","end":"2026-07-22T22:06:51.787812Z","steps":["trace[1129405605] 'read index received' (duration: 100.281854ms)","trace[1129405605] 'applied index is now lower than readState.Index' (duration: 170.202µs)"],"step_count":2} {"level":"info","ts":"2026-07-22T22:06:51.787886Z","caller":"traceutil/trace.go:171","msg":"trace[181993833] transaction","detail":"{read_only:false; response_revision:2071; number_of_response:1; }","duration":"147.218509ms","start":"2026-07-22T22:06:51.640625Z","end":"2026-07-22T22:06:51.787843Z","steps":["trace[181993833] 'process raft request' (duration: 147.022597ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:06:51.788063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.680948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18c4bbf2e7f49593\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-07-22T22:06:51.788125Z","caller":"traceutil/trace.go:171","msg":"trace[987032522] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18c4bbf2e7f49593; range_end:; response_count:1; response_revision:2071; }","duration":"100.800509ms","start":"2026-07-22T22:06:51.687311Z","end":"2026-07-22T22:06:51.788112Z","steps":["trace[987032522] 'agreement among raft nodes before linearized reading' (duration: 100.608807ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:06:52.896013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.04379ms","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-07-22T22:06:52.896113Z","caller":"traceutil/trace.go:171","msg":"trace[1297249943] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2076; }","duration":"147.221252ms","start":"2026-07-22T22:06:52.748872Z","end":"2026-07-22T22:06:52.896094Z","steps":["trace[1297249943] 'range keys from in-memory index tree' (duration: 146.869918ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:06:52.896021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.721887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-22T22:06:52.896419Z","caller":"traceutil/trace.go:171","msg":"trace[1060738379] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:2076; }","duration":"201.192483ms","start":"2026-07-22T22:06:52.695202Z","end":"2026-07-22T22:06:52.896395Z","steps":["trace[1060738379] 'count revisions from in-memory index tree' (duration: 200.587945ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:06:52.896739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.025098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-22T22:06:52.896808Z","caller":"traceutil/trace.go:171","msg":"trace[1399770254] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2076; }","duration":"124.140849ms","start":"2026-07-22T22:06:52.77265Z","end":"2026-07-22T22:06:52.896791Z","steps":["trace[1399770254] 'range keys from in-memory index tree' (duration: 123.761204ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:06:53.024663Z","caller":"traceutil/trace.go:171","msg":"trace[35642516] transaction","detail":"{read_only:false; response_revision:2077; number_of_response:1; }","duration":"131.833972ms","start":"2026-07-22T22:06:52.892798Z","end":"2026-07-22T22:06:53.024632Z","steps":["trace[35642516] 'process raft request' (duration: 131.64044ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:06:53.033931Z","caller":"traceutil/trace.go:171","msg":"trace[1135764193] transaction","detail":"{read_only:false; response_revision:2079; number_of_response:1; }","duration":"132.341938ms","start":"2026-07-22T22:06:52.901556Z","end":"2026-07-22T22:06:53.033898Z","steps":["trace[1135764193] 'process raft request' (duration: 132.299627ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:06:53.034246Z","caller":"traceutil/trace.go:171","msg":"trace[805699868] transaction","detail":"{read_only:false; response_revision:2078; number_of_response:1; }","duration":"133.39574ms","start":"2026-07-22T22:06:52.900814Z","end":"2026-07-22T22:06:53.03421Z","steps":["trace[805699868] 'process raft request' (duration: 132.904474ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:06:53.329392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.082784ms","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-07-22T22:06:53.329495Z","caller":"traceutil/trace.go:171","msg":"trace[203589698] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2079; }","duration":"139.251027ms","start":"2026-07-22T22:06:53.190221Z","end":"2026-07-22T22:06:53.329472Z","steps":["trace[203589698] 'range keys from in-memory index tree' (duration: 138.852841ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:08:06.306603Z","caller":"traceutil/trace.go:171","msg":"trace[1044397026] linearizableReadLoop","detail":"{readStateIndex:2665; appliedIndex:2664; }","duration":"217.625037ms","start":"2026-07-22T22:08:06.088961Z","end":"2026-07-22T22:08:06.306586Z","steps":["trace[1044397026] 'read index received' (duration: 217.445386ms)","trace[1044397026] 'applied index is now lower than readState.Index' (duration: 178.411µs)"],"step_count":2} {"level":"info","ts":"2026-07-22T22:08:06.306665Z","caller":"traceutil/trace.go:171","msg":"trace[1117656891] transaction","detail":"{read_only:false; response_revision:2571; number_of_response:1; }","duration":"248.65561ms","start":"2026-07-22T22:08:06.057986Z","end":"2026-07-22T22:08:06.306641Z","steps":["trace[1117656891] 'process raft request' (duration: 248.482778ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:08:06.306701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.732049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-22T22:08:06.306727Z","caller":"traceutil/trace.go:171","msg":"trace[204688366] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2571; }","duration":"217.839009ms","start":"2026-07-22T22:08:06.088879Z","end":"2026-07-22T22:08:06.306718Z","steps":["trace[204688366] 'agreement among raft nodes before linearized reading' (duration: 217.783469ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:08:37.735469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.09895ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-22T22:08:37.735591Z","caller":"traceutil/trace.go:171","msg":"trace[838365922] linearizableReadLoop","detail":"{readStateIndex:2845; appliedIndex:2844; }","duration":"197.730668ms","start":"2026-07-22T22:08:37.537837Z","end":"2026-07-22T22:08:37.735568Z","steps":["trace[838365922] 'read index received' (duration: 46.368028ms)","trace[838365922] 'applied index is now lower than readState.Index' (duration: 151.35825ms)"],"step_count":2} {"level":"warn","ts":"2026-07-22T22:08:37.735977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.0819ms","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-07-22T22:08:37.736057Z","caller":"traceutil/trace.go:171","msg":"trace[1354276959] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2744; }","duration":"198.213905ms","start":"2026-07-22T22:08:37.537807Z","end":"2026-07-22T22:08:37.736021Z","steps":["trace[1354276959] 'agreement among raft nodes before linearized reading' (duration: 197.829621ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:08:37.735984Z","caller":"traceutil/trace.go:171","msg":"trace[1178806823] transaction","detail":"{read_only:false; response_revision:2744; number_of_response:1; }","duration":"212.741654ms","start":"2026-07-22T22:08:37.523221Z","end":"2026-07-22T22:08:37.735963Z","steps":["trace[1178806823] 'process raft request' (duration: 61.062983ms)","trace[1178806823] 'compare' (duration: 150.963595ms)"],"step_count":2} {"level":"info","ts":"2026-07-22T22:08:43.173866Z","caller":"traceutil/trace.go:171","msg":"trace[1720807644] transaction","detail":"{read_only:false; response_revision:2773; number_of_response:1; }","duration":"117.738684ms","start":"2026-07-22T22:08:43.056095Z","end":"2026-07-22T22:08:43.173833Z","steps":["trace[1720807644] 'process raft request' (duration: 117.497045ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:08:43.402621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.118999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-07-22T22:08:43.402707Z","caller":"traceutil/trace.go:171","msg":"trace[88225844] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2773; }","duration":"107.252525ms","start":"2026-07-22T22:08:43.295441Z","end":"2026-07-22T22:08:43.402694Z","steps":["trace[88225844] 'range keys from in-memory index tree' (duration: 106.958224ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:12:28.009219Z","caller":"traceutil/trace.go:171","msg":"trace[1611591245] transaction","detail":"{read_only:false; response_revision:4651; number_of_response:1; }","duration":"132.580154ms","start":"2026-07-22T22:12:27.876619Z","end":"2026-07-22T22:12:28.009199Z","steps":["trace[1611591245] 'process raft request' (duration: 132.482023ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:12:28.043941Z","caller":"traceutil/trace.go:171","msg":"trace[325159660] transaction","detail":"{read_only:false; response_revision:4652; number_of_response:1; }","duration":"162.795088ms","start":"2026-07-22T22:12:27.881121Z","end":"2026-07-22T22:12:28.043916Z","steps":["trace[325159660] 'process raft request' (duration: 162.681716ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:12:33.103503Z","caller":"traceutil/trace.go:171","msg":"trace[1984339849] transaction","detail":"{read_only:false; response_revision:4702; number_of_response:1; }","duration":"182.977611ms","start":"2026-07-22T22:12:32.920493Z","end":"2026-07-22T22:12:33.103471Z","steps":["trace[1984339849] 'process raft request' (duration: 182.627975ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:12:33.103841Z","caller":"traceutil/trace.go:171","msg":"trace[751888367] transaction","detail":"{read_only:false; response_revision:4704; number_of_response:1; }","duration":"181.01769ms","start":"2026-07-22T22:12:32.922766Z","end":"2026-07-22T22:12:33.103784Z","steps":["trace[751888367] 'process raft request' (duration: 180.695435ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:12:33.103626Z","caller":"traceutil/trace.go:171","msg":"trace[1026437540] transaction","detail":"{read_only:false; response_revision:4703; number_of_response:1; }","duration":"183.023752ms","start":"2026-07-22T22:12:32.920574Z","end":"2026-07-22T22:12:33.103597Z","steps":["trace[1026437540] 'process raft request' (duration: 182.807798ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:12:33.104025Z","caller":"traceutil/trace.go:171","msg":"trace[651296691] linearizableReadLoop","detail":"{readStateIndex:4884; appliedIndex:4878; }","duration":"169.577348ms","start":"2026-07-22T22:12:32.934388Z","end":"2026-07-22T22:12:33.103966Z","steps":["trace[651296691] 'read index received' (duration: 412.636µs)","trace[651296691] 'applied index is now lower than readState.Index' (duration: 169.163642ms)"],"step_count":2} {"level":"info","ts":"2026-07-22T22:12:33.104223Z","caller":"traceutil/trace.go:171","msg":"trace[202069797] transaction","detail":"{read_only:false; response_revision:4706; number_of_response:1; }","duration":"179.533916ms","start":"2026-07-22T22:12:32.924659Z","end":"2026-07-22T22:12:33.104193Z","steps":["trace[202069797] 'process raft request' (duration: 179.031877ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:12:33.104568Z","caller":"traceutil/trace.go:171","msg":"trace[1915353466] transaction","detail":"{read_only:false; response_revision:4707; number_of_response:1; }","duration":"179.77566ms","start":"2026-07-22T22:12:32.924761Z","end":"2026-07-22T22:12:33.104536Z","steps":["trace[1915353466] 'process raft request' (duration: 179.028428ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:12:33.104633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.214018ms","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-07-22T22:12:33.104681Z","caller":"traceutil/trace.go:171","msg":"trace[1066890137] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4707; }","duration":"170.32483ms","start":"2026-07-22T22:12:32.934344Z","end":"2026-07-22T22:12:33.104669Z","steps":["trace[1066890137] 'agreement among raft nodes before linearized reading' (duration: 170.060886ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:12:33.10484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.418055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-07-22T22:12:33.104969Z","caller":"traceutil/trace.go:171","msg":"trace[247345388] 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:4707; }","duration":"128.597298ms","start":"2026-07-22T22:12:32.976356Z","end":"2026-07-22T22:12:33.104953Z","steps":["trace[247345388] 'agreement among raft nodes before linearized reading' (duration: 128.230582ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:12:33.105567Z","caller":"traceutil/trace.go:171","msg":"trace[99646153] transaction","detail":"{read_only:false; response_revision:4705; number_of_response:1; }","duration":"182.185329ms","start":"2026-07-22T22:12:32.923355Z","end":"2026-07-22T22:12:33.10554Z","steps":["trace[99646153] 'process raft request' (duration: 180.240468ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:12:33.328935Z","caller":"traceutil/trace.go:171","msg":"trace[550350258] linearizableReadLoop","detail":"{readStateIndex:4890; appliedIndex:4884; }","duration":"210.659737ms","start":"2026-07-22T22:12:33.118216Z","end":"2026-07-22T22:12:33.328876Z","steps":["trace[550350258] 'read index received' (duration: 146.902737ms)","trace[550350258] 'applied index is now lower than readState.Index' (duration: 63.75648ms)"],"step_count":2} {"level":"info","ts":"2026-07-22T22:12:33.329098Z","caller":"traceutil/trace.go:171","msg":"trace[1557424909] transaction","detail":"{read_only:false; response_revision:4708; number_of_response:1; }","duration":"214.696012ms","start":"2026-07-22T22:12:33.114395Z","end":"2026-07-22T22:12:33.329091Z","steps":["trace[1557424909] 'process raft request' (duration: 150.708988ms)","trace[1557424909] 'compare' (duration: 63.470306ms)"],"step_count":2} {"level":"info","ts":"2026-07-22T22:12:33.329399Z","caller":"traceutil/trace.go:171","msg":"trace[1330668069] transaction","detail":"{read_only:false; response_revision:4715; number_of_response:1; }","duration":"205.270801ms","start":"2026-07-22T22:12:33.124122Z","end":"2026-07-22T22:12:33.329393Z","steps":["trace[1330668069] 'process raft request' (duration: 204.709563ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:12:33.329385Z","caller":"traceutil/trace.go:171","msg":"trace[290951621] transaction","detail":"{read_only:false; response_revision:4714; number_of_response:1; }","duration":"209.455239ms","start":"2026-07-22T22:12:33.119891Z","end":"2026-07-22T22:12:33.329347Z","steps":["trace[290951621] 'process raft request' (duration: 208.90804ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:12:33.329593Z","caller":"traceutil/trace.go:171","msg":"trace[230604726] transaction","detail":"{read_only:false; response_revision:4716; number_of_response:1; }","duration":"137.174993ms","start":"2026-07-22T22:12:33.192407Z","end":"2026-07-22T22:12:33.329582Z","steps":["trace[230604726] 'process raft request' (duration: 136.449092ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:12:33.329594Z","caller":"traceutil/trace.go:171","msg":"trace[335922286] transaction","detail":"{read_only:false; response_revision:4709; number_of_response:1; }","duration":"214.247573ms","start":"2026-07-22T22:12:33.115335Z","end":"2026-07-22T22:12:33.329583Z","steps":["trace[335922286] 'process raft request' (duration: 213.329759ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:12:33.329805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.556759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-22T22:12:33.329832Z","caller":"traceutil/trace.go:171","msg":"trace[901738587] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:4716; }","duration":"185.627761ms","start":"2026-07-22T22:12:33.144199Z","end":"2026-07-22T22:12:33.329826Z","steps":["trace[901738587] 'agreement among raft nodes before linearized reading' (duration: 185.52978ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:12:33.330027Z","caller":"traceutil/trace.go:171","msg":"trace[2091996647] transaction","detail":"{read_only:false; response_revision:4712; number_of_response:1; }","duration":"212.090459ms","start":"2026-07-22T22:12:33.117928Z","end":"2026-07-22T22:12:33.330019Z","steps":["trace[2091996647] 'process raft request' (duration: 210.819869ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:12:33.330038Z","caller":"traceutil/trace.go:171","msg":"trace[1159235109] transaction","detail":"{read_only:false; response_revision:4710; number_of_response:1; }","duration":"214.536798ms","start":"2026-07-22T22:12:33.115484Z","end":"2026-07-22T22:12:33.33002Z","steps":["trace[1159235109] 'process raft request' (duration: 213.209088ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:12:33.33022Z","caller":"traceutil/trace.go:171","msg":"trace[1409631215] transaction","detail":"{read_only:false; response_revision:4711; number_of_response:1; }","duration":"212.452926ms","start":"2026-07-22T22:12:33.117755Z","end":"2026-07-22T22:12:33.330207Z","steps":["trace[1409631215] 'process raft request' (duration: 210.965073ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:12:33.330384Z","caller":"traceutil/trace.go:171","msg":"trace[189362586] transaction","detail":"{read_only:false; response_revision:4713; number_of_response:1; }","duration":"212.204062ms","start":"2026-07-22T22:12:33.118167Z","end":"2026-07-22T22:12:33.330372Z","steps":["trace[189362586] 'process raft request' (duration: 210.610187ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:12:33.330197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.928207ms","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":"info","ts":"2026-07-22T22:12:33.331769Z","caller":"traceutil/trace.go:171","msg":"trace[1508105571] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4716; }","duration":"213.547473ms","start":"2026-07-22T22:12:33.118202Z","end":"2026-07-22T22:12:33.331749Z","steps":["trace[1508105571] 'agreement among raft nodes before linearized reading' (duration: 211.47775ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:12:33.610678Z","caller":"traceutil/trace.go:171","msg":"trace[475520472] transaction","detail":"{read_only:false; response_revision:4724; number_of_response:1; }","duration":"148.512293ms","start":"2026-07-22T22:12:33.462135Z","end":"2026-07-22T22:12:33.610647Z","steps":["trace[475520472] 'process raft request' (duration: 97.736639ms)","trace[475520472] 'compare' (duration: 50.406988ms)"],"step_count":2} {"level":"info","ts":"2026-07-22T22:12:33.611075Z","caller":"traceutil/trace.go:171","msg":"trace[1376724356] transaction","detail":"{read_only:false; response_revision:4725; number_of_response:1; }","duration":"148.863569ms","start":"2026-07-22T22:12:33.46218Z","end":"2026-07-22T22:12:33.611044Z","steps":["trace[1376724356] 'process raft request' (duration: 148.35298ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:12:33.611184Z","caller":"traceutil/trace.go:171","msg":"trace[1262888078] linearizableReadLoop","detail":"{readStateIndex:4902; appliedIndex:4899; }","duration":"148.210548ms","start":"2026-07-22T22:12:33.462962Z","end":"2026-07-22T22:12:33.611172Z","steps":["trace[1262888078] 'read index received' (duration: 87.74188ms)","trace[1262888078] 'applied index is now lower than readState.Index' (duration: 60.467758ms)"],"step_count":2} {"level":"info","ts":"2026-07-22T22:12:33.61126Z","caller":"traceutil/trace.go:171","msg":"trace[1099828026] transaction","detail":"{read_only:false; response_revision:4726; number_of_response:1; }","duration":"110.843067ms","start":"2026-07-22T22:12:33.500409Z","end":"2026-07-22T22:12:33.611252Z","steps":["trace[1099828026] 'process raft request' (duration: 110.193746ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:12:33.611527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.549963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:650"} {"level":"info","ts":"2026-07-22T22:12:33.611559Z","caller":"traceutil/trace.go:171","msg":"trace[98049212] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:4726; }","duration":"148.627905ms","start":"2026-07-22T22:12:33.462923Z","end":"2026-07-22T22:12:33.611551Z","steps":["trace[98049212] 'agreement among raft nodes before linearized reading' (duration: 148.454573ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:12:33.61171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.856752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-07-22T22:12:33.611732Z","caller":"traceutil/trace.go:171","msg":"trace[1423734339] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4726; }","duration":"128.921073ms","start":"2026-07-22T22:12:33.482805Z","end":"2026-07-22T22:12:33.611726Z","steps":["trace[1423734339] 'agreement among raft nodes before linearized reading' (duration: 128.856472ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:12:33.831792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.36621ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-22T22:12:33.831918Z","caller":"traceutil/trace.go:171","msg":"trace[669269551] linearizableReadLoop","detail":"{readStateIndex:4908; appliedIndex:4907; }","duration":"126.471263ms","start":"2026-07-22T22:12:33.705426Z","end":"2026-07-22T22:12:33.831898Z","steps":["trace[669269551] 'read index received' (duration: 8.87874ms)","trace[669269551] 'applied index is now lower than readState.Index' (duration: 117.590733ms)"],"step_count":2} {"level":"info","ts":"2026-07-22T22:12:33.832227Z","caller":"traceutil/trace.go:171","msg":"trace[843723742] transaction","detail":"{read_only:false; response_revision:4731; number_of_response:1; }","duration":"128.531756ms","start":"2026-07-22T22:12:33.70368Z","end":"2026-07-22T22:12:33.832212Z","steps":["trace[843723742] 'process raft request' (duration: 10.618617ms)","trace[843723742] 'compare' (duration: 117.141606ms)"],"step_count":2} {"level":"warn","ts":"2026-07-22T22:12:33.832249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.80041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-22T22:12:33.83231Z","caller":"traceutil/trace.go:171","msg":"trace[62773806] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:0; response_revision:4731; }","duration":"126.885821ms","start":"2026-07-22T22:12:33.705409Z","end":"2026-07-22T22:12:33.832295Z","steps":["trace[62773806] 'agreement among raft nodes before linearized reading' (duration: 126.777459ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:12:33.833367Z","caller":"traceutil/trace.go:171","msg":"trace[1643109864] transaction","detail":"{read_only:false; response_revision:4732; number_of_response:1; }","duration":"126.541775ms","start":"2026-07-22T22:12:33.706816Z","end":"2026-07-22T22:12:33.833358Z","steps":["trace[1643109864] 'process raft request' (duration: 126.468134ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:12:33.907113Z","caller":"traceutil/trace.go:171","msg":"trace[2130099449] transaction","detail":"{read_only:false; response_revision:4733; number_of_response:1; }","duration":"141.533962ms","start":"2026-07-22T22:12:33.765539Z","end":"2026-07-22T22:12:33.907073Z","steps":["trace[2130099449] 'process raft request' (duration: 141.389189ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:12:33.90746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.649457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:6 size:61385"} {"level":"info","ts":"2026-07-22T22:12:33.907589Z","caller":"traceutil/trace.go:171","msg":"trace[1787496428] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:4733; }","duration":"198.744579ms","start":"2026-07-22T22:12:33.708775Z","end":"2026-07-22T22:12:33.90752Z","steps":["trace[1787496428] 'agreement among raft nodes before linearized reading' (duration: 198.312343ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:12:33.907758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.077116ms","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-07-22T22:12:33.907868Z","caller":"traceutil/trace.go:171","msg":"trace[307942698] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4733; }","duration":"201.221129ms","start":"2026-07-22T22:12:33.706627Z","end":"2026-07-22T22:12:33.907848Z","steps":["trace[307942698] 'agreement among raft nodes before linearized reading' (duration: 200.879642ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:12:33.907874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.176345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-07-22T22:12:33.907952Z","caller":"traceutil/trace.go:171","msg":"trace[33646101] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4733; }","duration":"199.311069ms","start":"2026-07-22T22:12:33.708627Z","end":"2026-07-22T22:12:33.907938Z","steps":["trace[33646101] 'agreement among raft nodes before linearized reading' (duration: 199.066124ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:12:48.103829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.95516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"info","ts":"2026-07-22T22:12:48.103909Z","caller":"traceutil/trace.go:171","msg":"trace[1475185080] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4934; }","duration":"346.080882ms","start":"2026-07-22T22:12:47.75781Z","end":"2026-07-22T22:12:48.103891Z","steps":["trace[1475185080] 'range keys from in-memory index tree' (duration: 345.797257ms)"],"step_count":1} {"level":"warn","ts":"2026-07-22T22:12:48.104174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:12:47.757788Z","time spent":"346.370936ms","remote":"127.0.0.1:55842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":3339,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" "} {"level":"info","ts":"2026-07-22T22:12:48.135392Z","caller":"traceutil/trace.go:171","msg":"trace[1049688339] transaction","detail":"{read_only:false; response_revision:4935; number_of_response:1; }","duration":"224.180309ms","start":"2026-07-22T22:12:47.911187Z","end":"2026-07-22T22:12:48.135368Z","steps":["trace[1049688339] 'process raft request' (duration: 224.035187ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:12:48.14523Z","caller":"traceutil/trace.go:171","msg":"trace[852759295] transaction","detail":"{read_only:false; response_revision:4936; number_of_response:1; }","duration":"189.693626ms","start":"2026-07-22T22:12:47.955521Z","end":"2026-07-22T22:12:48.145215Z","steps":["trace[852759295] 'process raft request' (duration: 189.058397ms)"],"step_count":1} {"level":"info","ts":"2026-07-22T22:14:06.433772Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2895} {"level":"info","ts":"2026-07-22T22:14:06.584765Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2895,"took":"148.496628ms","hash":3522605169,"current-db-size-bytes":53698560,"current-db-size":"54 MB","current-db-size-in-use-bytes":29302784,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-07-22T22:14:06.584829Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3522605169,"revision":2895,"compact-revision":-1} {"level":"info","ts":"2026-07-22T22:19:06.440218Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5565} {"level":"info","ts":"2026-07-22T22:19:06.558894Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5565,"took":"116.259897ms","hash":4220682057,"current-db-size-bytes":53698560,"current-db-size":"54 MB","current-db-size-in-use-bytes":18337792,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-07-22T22:19:06.558959Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4220682057,"revision":5565,"compact-revision":2895}