{"level":"warn","ts":"2026-05-19T13:29:44.950875Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-19T13:29:44.95107Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.147: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.147:2380","--initial-cluster=instance=https://199.19.213.147:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.147:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.147: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-05-19T13:29:44.951258Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-19T13:29:44.951314Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.147:2380"]} {"level":"info","ts":"2026-05-19T13:29:44.951406Z","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-05-19T13:29:44.952097Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.147:2379"]} {"level":"info","ts":"2026-05-19T13:29:44.953296Z","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.147:2380"],"listen-peer-urls":["https://199.19.213.147:2380"],"advertise-client-urls":["https://199.19.213.147:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.147:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.147: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-05-19T13:29:44.957064Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.497891ms"} {"level":"info","ts":"2026-05-19T13:29:44.962506Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6244e483e416226f","cluster-id":"68a374eab3e2de92"} {"level":"info","ts":"2026-05-19T13:29:44.962616Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f switched to configuration voters=()"} {"level":"info","ts":"2026-05-19T13:29:44.962671Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f became follower at term 0"} {"level":"info","ts":"2026-05-19T13:29:44.962716Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6244e483e416226f [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-19T13:29:44.962746Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f became follower at term 1"} {"level":"info","ts":"2026-05-19T13:29:44.962822Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f switched to configuration voters=(7081035769251766895)"} {"level":"warn","ts":"2026-05-19T13:29:44.96806Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-19T13:29:44.96969Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-19T13:29:44.971235Z","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-05-19T13:29:44.973935Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6244e483e416226f","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-19T13:29:44.974841Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6244e483e416226f","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-19T13:29:44.974941Z","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-05-19T13:29:44.974998Z","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-05-19T13:29:44.975022Z","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-05-19T13:29:44.976027Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f switched to configuration voters=(7081035769251766895)"} {"level":"info","ts":"2026-05-19T13:29:44.976234Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"68a374eab3e2de92","local-member-id":"6244e483e416226f","added-peer-id":"6244e483e416226f","added-peer-peer-urls":["https://199.19.213.147:2380"]} {"level":"info","ts":"2026-05-19T13:29:44.978433Z","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-05-19T13:29:44.978641Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6244e483e416226f","initial-advertise-peer-urls":["https://199.19.213.147:2380"],"listen-peer-urls":["https://199.19.213.147:2380"],"advertise-client-urls":["https://199.19.213.147:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.147:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-19T13:29:44.978671Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-19T13:29:44.978707Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.147:2380"} {"level":"info","ts":"2026-05-19T13:29:44.978724Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.147:2380"} {"level":"info","ts":"2026-05-19T13:29:45.263887Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f is starting a new election at term 1"} {"level":"info","ts":"2026-05-19T13:29:45.263931Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f became pre-candidate at term 1"} {"level":"info","ts":"2026-05-19T13:29:45.263955Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f received MsgPreVoteResp from 6244e483e416226f at term 1"} {"level":"info","ts":"2026-05-19T13:29:45.263968Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f became candidate at term 2"} {"level":"info","ts":"2026-05-19T13:29:45.263975Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f received MsgVoteResp from 6244e483e416226f at term 2"} {"level":"info","ts":"2026-05-19T13:29:45.263985Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f became leader at term 2"} {"level":"info","ts":"2026-05-19T13:29:45.263999Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6244e483e416226f elected leader 6244e483e416226f at term 2"} {"level":"info","ts":"2026-05-19T13:29:45.265016Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6244e483e416226f","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.147:2379]}","request-path":"/0/members/6244e483e416226f/attributes","cluster-id":"68a374eab3e2de92","publish-timeout":"7s"} {"level":"info","ts":"2026-05-19T13:29:45.265048Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T13:29:45.265172Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-19T13:29:45.265134Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-19T13:29:45.266417Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"68a374eab3e2de92","local-member-id":"6244e483e416226f","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T13:29:45.266662Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T13:29:45.266791Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T13:29:45.26732Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-19T13:29:45.268994Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-19T13:29:45.269238Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-19T13:29:45.272014Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.147:2379"} {"level":"warn","ts":"2026-05-19T13:29:47.159588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.442136ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"info","ts":"2026-05-19T13:29:47.159908Z","caller":"traceutil/trace.go:171","msg":"trace[1951486166] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:4; }","duration":"342.575992ms","start":"2026-05-19T13:29:46.817314Z","end":"2026-05-19T13:29:47.15989Z","steps":["trace[1951486166] 'read index received' (duration: 40.616101ms)","trace[1951486166] 'applied index is now lower than readState.Index' (duration: 301.956991ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T13:29:47.160076Z","caller":"traceutil/trace.go:171","msg":"trace[221416128] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"343.804346ms","start":"2026-05-19T13:29:46.816175Z","end":"2026-05-19T13:29:47.15998Z","steps":["trace[221416128] 'process raft request' (duration: 121.280968ms)","trace[221416128] 'compare' (duration: 221.264804ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T13:29:47.160133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.808215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T13:29:47.160327Z","caller":"traceutil/trace.go:171","msg":"trace[1119413341] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:0; response_revision:3; }","duration":"343.017357ms","start":"2026-05-19T13:29:46.817297Z","end":"2026-05-19T13:29:47.160314Z","steps":["trace[1119413341] 'agreement among raft nodes before linearized reading' (duration: 342.733384ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:29:47.160411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:29:46.817289Z","time spent":"343.108768ms","remote":"127.0.0.1:33518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":0,"response size":26,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-05-19T13:29:47.160531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:29:46.816169Z","time spent":"344.033959ms","remote":"127.0.0.1:33416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T13:29:47.165838Z","caller":"traceutil/trace.go:171","msg":"trace[2142973885] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"266.194694ms","start":"2026-05-19T13:29:46.899624Z","end":"2026-05-19T13:29:47.165818Z","steps":["trace[2142973885] 'process raft request' (duration: 266.037402ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:29:47.166056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.784091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T13:29:47.167528Z","caller":"traceutil/trace.go:171","msg":"trace[1841364400] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"298.274668ms","start":"2026-05-19T13:29:46.869216Z","end":"2026-05-19T13:29:47.167491Z","steps":["trace[1841364400] 'agreement among raft nodes before linearized reading' (duration: 296.742361ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:29:47.166117Z","caller":"traceutil/trace.go:171","msg":"trace[1272821530] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"260.988395ms","start":"2026-05-19T13:29:46.905106Z","end":"2026-05-19T13:29:47.166094Z","steps":["trace[1272821530] 'process raft request' (duration: 260.707771ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:29:47.165961Z","caller":"traceutil/trace.go:171","msg":"trace[1968961577] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"260.906993ms","start":"2026-05-19T13:29:46.905036Z","end":"2026-05-19T13:29:47.165943Z","steps":["trace[1968961577] 'process raft request' (duration: 260.746641ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:29:47.166165Z","caller":"traceutil/trace.go:171","msg":"trace[915174739] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"261.043445ms","start":"2026-05-19T13:29:46.905103Z","end":"2026-05-19T13:29:47.166147Z","steps":["trace[915174739] 'process raft request' (duration: 260.736492ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:29:47.166194Z","caller":"traceutil/trace.go:171","msg":"trace[512394461] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"261.015715ms","start":"2026-05-19T13:29:46.905171Z","end":"2026-05-19T13:29:47.166187Z","steps":["trace[512394461] 'process raft request' (duration: 260.696791ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:29:47.166218Z","caller":"traceutil/trace.go:171","msg":"trace[1067537354] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"260.727161ms","start":"2026-05-19T13:29:46.905485Z","end":"2026-05-19T13:29:47.166212Z","steps":["trace[1067537354] 'process raft request' (duration: 260.408577ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:29:47.166319Z","caller":"traceutil/trace.go:171","msg":"trace[1854081186] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"263.949418ms","start":"2026-05-19T13:29:46.902344Z","end":"2026-05-19T13:29:47.166293Z","steps":["trace[1854081186] 'process raft request' (duration: 263.408962ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:29:47.166365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.703711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.147\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T13:29:47.168472Z","caller":"traceutil/trace.go:171","msg":"trace[1443568325] range","detail":"{range_begin:/registry/masterleases/199.19.213.147; range_end:; response_count:0; response_revision:11; }","duration":"276.823864ms","start":"2026-05-19T13:29:46.891621Z","end":"2026-05-19T13:29:47.168445Z","steps":["trace[1443568325] 'agreement among raft nodes before linearized reading' (duration: 274.7161ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:29:47.166379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.357295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T13:29:47.168672Z","caller":"traceutil/trace.go:171","msg":"trace[285005378] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"268.689541ms","start":"2026-05-19T13:29:46.899958Z","end":"2026-05-19T13:29:47.168648Z","steps":["trace[285005378] 'agreement among raft nodes before linearized reading' (duration: 266.326645ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:29:47.166396Z","caller":"traceutil/trace.go:171","msg":"trace[1690156990] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"258.199483ms","start":"2026-05-19T13:29:46.908188Z","end":"2026-05-19T13:29:47.166388Z","steps":["trace[1690156990] 'process raft request' (duration: 257.735888ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:29:47.16641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.306456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T13:29:47.168989Z","caller":"traceutil/trace.go:171","msg":"trace[1899521892] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"218.841375ms","start":"2026-05-19T13:29:46.950067Z","end":"2026-05-19T13:29:47.168909Z","steps":["trace[1899521892] 'agreement among raft nodes before linearized reading' (duration: 216.328597ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:29:47.166323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.381719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T13:29:47.169186Z","caller":"traceutil/trace.go:171","msg":"trace[212511143] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"264.245151ms","start":"2026-05-19T13:29:46.904896Z","end":"2026-05-19T13:29:47.169141Z","steps":["trace[212511143] 'agreement among raft nodes before linearized reading' (duration: 261.361718ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:29:47.377672Z","caller":"traceutil/trace.go:171","msg":"trace[1274906407] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"161.483912ms","start":"2026-05-19T13:29:47.216167Z","end":"2026-05-19T13:29:47.377651Z","steps":["trace[1274906407] 'process raft request' (duration: 143.810604ms)","trace[1274906407] 'compare' (duration: 17.483256ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T13:29:47.377826Z","caller":"traceutil/trace.go:171","msg":"trace[1639969475] transaction","detail":"{read_only:false; response_revision:27; number_of_response:1; }","duration":"155.264583ms","start":"2026-05-19T13:29:47.22254Z","end":"2026-05-19T13:29:47.377805Z","steps":["trace[1639969475] 'process raft request' (duration: 155.230763ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:29:47.378054Z","caller":"traceutil/trace.go:171","msg":"trace[1441057421] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"160.774325ms","start":"2026-05-19T13:29:47.217273Z","end":"2026-05-19T13:29:47.378047Z","steps":["trace[1441057421] 'process raft request' (duration: 160.438481ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:29:47.378128Z","caller":"traceutil/trace.go:171","msg":"trace[2070088748] transaction","detail":"{read_only:false; response_revision:26; number_of_response:1; }","duration":"160.3117ms","start":"2026-05-19T13:29:47.217804Z","end":"2026-05-19T13:29:47.378115Z","steps":["trace[2070088748] 'process raft request' (duration: 159.931525ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:29:47.378188Z","caller":"traceutil/trace.go:171","msg":"trace[232661520] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"160.998287ms","start":"2026-05-19T13:29:47.217185Z","end":"2026-05-19T13:29:47.378183Z","steps":["trace[232661520] 'process raft request' (duration: 160.481642ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:29:47.378249Z","caller":"traceutil/trace.go:171","msg":"trace[1023289251] linearizableReadLoop","detail":"{readStateIndex:30; appliedIndex:24; }","duration":"159.226137ms","start":"2026-05-19T13:29:47.219012Z","end":"2026-05-19T13:29:47.378238Z","steps":["trace[1023289251] 'read index received' (duration: 140.977332ms)","trace[1023289251] 'applied index is now lower than readState.Index' (duration: 18.247735ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T13:29:47.37815Z","caller":"traceutil/trace.go:171","msg":"trace[473552386] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"161.520473ms","start":"2026-05-19T13:29:47.216622Z","end":"2026-05-19T13:29:47.378143Z","steps":["trace[473552386] 'process raft request' (duration: 160.971707ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:29:47.37817Z","caller":"traceutil/trace.go:171","msg":"trace[1883110072] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"161.012207ms","start":"2026-05-19T13:29:47.217153Z","end":"2026-05-19T13:29:47.378165Z","steps":["trace[1883110072] 'process raft request' (duration: 160.490341ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:29:47.37845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.392034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"warn","ts":"2026-05-19T13:29:47.378506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.726966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3491"} {"level":"info","ts":"2026-05-19T13:29:47.378597Z","caller":"traceutil/trace.go:171","msg":"trace[1247141092] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:27; }","duration":"161.842817ms","start":"2026-05-19T13:29:47.216721Z","end":"2026-05-19T13:29:47.378564Z","steps":["trace[1247141092] 'agreement among raft nodes before linearized reading' (duration: 161.692985ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:29:47.378514Z","caller":"traceutil/trace.go:171","msg":"trace[78214460] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:27; }","duration":"163.526856ms","start":"2026-05-19T13:29:47.21497Z","end":"2026-05-19T13:29:47.378496Z","steps":["trace[78214460] 'agreement among raft nodes before linearized reading' (duration: 163.363594ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:29:52.705868Z","caller":"traceutil/trace.go:171","msg":"trace[137521494] linearizableReadLoop","detail":"{readStateIndex:338; appliedIndex:337; }","duration":"237.505544ms","start":"2026-05-19T13:29:52.468338Z","end":"2026-05-19T13:29:52.705844Z","steps":["trace[137521494] 'read index received' (duration: 237.271471ms)","trace[137521494] 'applied index is now lower than readState.Index' (duration: 233.072µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T13:29:52.705904Z","caller":"traceutil/trace.go:171","msg":"trace[1922443477] transaction","detail":"{read_only:false; response_revision:328; number_of_response:1; }","duration":"250.615702ms","start":"2026-05-19T13:29:52.455256Z","end":"2026-05-19T13:29:52.705871Z","steps":["trace[1922443477] 'process raft request' (duration: 250.44563ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:29:52.706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.645095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/resourcequota-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-05-19T13:29:52.706037Z","caller":"traceutil/trace.go:171","msg":"trace[1014249279] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/resourcequota-controller; range_end:; response_count:1; response_revision:328; }","duration":"237.740055ms","start":"2026-05-19T13:29:52.468283Z","end":"2026-05-19T13:29:52.706023Z","steps":["trace[1014249279] 'agreement among raft nodes before linearized reading' (duration: 237.662345ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:29:52.878296Z","caller":"traceutil/trace.go:171","msg":"trace[1454903698] transaction","detail":"{read_only:false; response_revision:329; number_of_response:1; }","duration":"152.744073ms","start":"2026-05-19T13:29:52.725526Z","end":"2026-05-19T13:29:52.87827Z","steps":["trace[1454903698] 'process raft request' (duration: 101.270646ms)","trace[1454903698] 'compare' (duration: 51.347746ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T13:30:22.270545Z","caller":"traceutil/trace.go:171","msg":"trace[1722256676] linearizableReadLoop","detail":"{readStateIndex:637; appliedIndex:636; }","duration":"147.649962ms","start":"2026-05-19T13:30:22.122862Z","end":"2026-05-19T13:30:22.270512Z","steps":["trace[1722256676] 'read index received' (duration: 102.517749ms)","trace[1722256676] 'applied index is now lower than readState.Index' (duration: 45.131203ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T13:30:22.270574Z","caller":"traceutil/trace.go:171","msg":"trace[1379575946] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"172.595864ms","start":"2026-05-19T13:30:22.097942Z","end":"2026-05-19T13:30:22.270538Z","steps":["trace[1379575946] 'process raft request' (duration: 127.43603ms)","trace[1379575946] 'compare' (duration: 44.812971ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T13:30:22.270768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.889464ms","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-05-19T13:30:22.270809Z","caller":"traceutil/trace.go:171","msg":"trace[1604013621] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:616; }","duration":"147.947895ms","start":"2026-05-19T13:30:22.122849Z","end":"2026-05-19T13:30:22.270797Z","steps":["trace[1604013621] 'agreement among raft nodes before linearized reading' (duration: 147.766763ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:30:22.780858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.385773ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T13:30:22.780939Z","caller":"traceutil/trace.go:171","msg":"trace[358635008] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:637; }","duration":"498.668408ms","start":"2026-05-19T13:30:22.282256Z","end":"2026-05-19T13:30:22.780925Z","steps":["trace[358635008] 'read index received' (duration: 281.089474ms)","trace[358635008] 'applied index is now lower than readState.Index' (duration: 217.577934ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T13:30:22.78121Z","caller":"traceutil/trace.go:171","msg":"trace[151206023] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"502.083717ms","start":"2026-05-19T13:30:22.279105Z","end":"2026-05-19T13:30:22.781189Z","steps":["trace[151206023] 'process raft request' (duration: 284.294521ms)","trace[151206023] 'compare' (duration: 217.283712ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T13:30:22.781276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:30:22.279082Z","time spent":"502.165318ms","remote":"127.0.0.1:33598","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T13:30:22.781267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.95912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T13:30:22.781328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.703049ms","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-05-19T13:30:22.781355Z","caller":"traceutil/trace.go:171","msg":"trace[1200081846] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:617; }","duration":"307.74569ms","start":"2026-05-19T13:30:22.473598Z","end":"2026-05-19T13:30:22.781344Z","steps":["trace[1200081846] 'agreement among raft nodes before linearized reading' (duration: 307.694539ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:30:22.781356Z","caller":"traceutil/trace.go:171","msg":"trace[1379818063] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system; range_end:; response_count:0; response_revision:617; }","duration":"499.084722ms","start":"2026-05-19T13:30:22.28225Z","end":"2026-05-19T13:30:22.781335Z","steps":["trace[1379818063] 'agreement among raft nodes before linearized reading' (duration: 498.89598ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:30:22.781377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:30:22.473585Z","time spent":"307.78635ms","remote":"127.0.0.1:33598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-19T13:30:22.781275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.557713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-19T13:30:22.781424Z","caller":"traceutil/trace.go:171","msg":"trace[671281029] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:617; }","duration":"323.743715ms","start":"2026-05-19T13:30:22.45767Z","end":"2026-05-19T13:30:22.781414Z","steps":["trace[671281029] 'agreement among raft nodes before linearized reading' (duration: 323.518293ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:30:22.781413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:30:22.282212Z","time spent":"499.183923ms","remote":"127.0.0.1:33826","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":27,"request content":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" "} {"level":"warn","ts":"2026-05-19T13:30:22.781448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:30:22.457648Z","time spent":"323.793675ms","remote":"127.0.0.1:33598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-19T13:30:22.781444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.124775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-mpl8g\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-19T13:30:22.781516Z","caller":"traceutil/trace.go:171","msg":"trace[1145698547] range","detail":"{range_begin:/registry/pods/kube-system/cilium-mpl8g; range_end:; response_count:1; response_revision:617; }","duration":"267.238406ms","start":"2026-05-19T13:30:22.514258Z","end":"2026-05-19T13:30:22.781496Z","steps":["trace[1145698547] 'agreement among raft nodes before linearized reading' (duration: 266.985064ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:30:23.212626Z","caller":"traceutil/trace.go:171","msg":"trace[767309200] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"416.052199ms","start":"2026-05-19T13:30:22.796548Z","end":"2026-05-19T13:30:23.2126Z","steps":["trace[767309200] 'process raft request' (duration: 415.870247ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:30:23.212816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:30:22.796531Z","time spent":"416.18494ms","remote":"127.0.0.1:33526","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T13:30:23.29316Z","caller":"traceutil/trace.go:171","msg":"trace[220380972] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:641; }","duration":"102.196123ms","start":"2026-05-19T13:30:23.190935Z","end":"2026-05-19T13:30:23.293131Z","steps":["trace[220380972] 'read index received' (duration: 22.793692ms)","trace[220380972] 'applied index is now lower than readState.Index' (duration: 79.401391ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T13:30:23.293208Z","caller":"traceutil/trace.go:171","msg":"trace[1884436725] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"106.408428ms","start":"2026-05-19T13:30:23.186781Z","end":"2026-05-19T13:30:23.29319Z","steps":["trace[1884436725] 'process raft request' (duration: 105.814503ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:30:23.293341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.397464ms","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-05-19T13:30:23.293378Z","caller":"traceutil/trace.go:171","msg":"trace[48808041] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:621; }","duration":"102.491895ms","start":"2026-05-19T13:30:23.190876Z","end":"2026-05-19T13:30:23.293368Z","steps":["trace[48808041] 'agreement among raft nodes before linearized reading' (duration: 102.350953ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:30:24.746464Z","caller":"traceutil/trace.go:171","msg":"trace[420158510] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"101.20826ms","start":"2026-05-19T13:30:24.645227Z","end":"2026-05-19T13:30:24.746435Z","steps":["trace[420158510] 'process raft request' (duration: 101.055979ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:32:34.532516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.270431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-05-19T13:32:34.532628Z","caller":"traceutil/trace.go:171","msg":"trace[609958620] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:2173; }","duration":"175.459215ms","start":"2026-05-19T13:32:34.357148Z","end":"2026-05-19T13:32:34.532608Z","steps":["trace[609958620] 'count revisions from in-memory index tree' (duration: 175.118138ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:33:16.386126Z","caller":"traceutil/trace.go:171","msg":"trace[1169324433] transaction","detail":"{read_only:false; response_revision:2562; number_of_response:1; }","duration":"147.108697ms","start":"2026-05-19T13:33:16.238974Z","end":"2026-05-19T13:33:16.386083Z","steps":["trace[1169324433] 'process raft request' (duration: 146.254253ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:33:45.543364Z","caller":"traceutil/trace.go:171","msg":"trace[507112113] transaction","detail":"{read_only:false; response_revision:2762; number_of_response:1; }","duration":"118.611839ms","start":"2026-05-19T13:33:45.424713Z","end":"2026-05-19T13:33:45.543325Z","steps":["trace[507112113] 'process raft request' (duration: 118.361335ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:36:18.282157Z","caller":"traceutil/trace.go:171","msg":"trace[1022626688] transaction","detail":"{read_only:false; response_revision:4425; number_of_response:1; }","duration":"121.054917ms","start":"2026-05-19T13:36:18.161074Z","end":"2026-05-19T13:36:18.282128Z","steps":["trace[1022626688] 'process raft request' (duration: 119.678937ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:36:18.286456Z","caller":"traceutil/trace.go:171","msg":"trace[339888594] transaction","detail":"{read_only:false; response_revision:4424; number_of_response:1; }","duration":"123.802397ms","start":"2026-05-19T13:36:18.15818Z","end":"2026-05-19T13:36:18.281983Z","steps":["trace[339888594] 'process raft request' (duration: 34.619649ms)","trace[339888594] 'compare' (duration: 87.822168ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T13:36:20.532298Z","caller":"traceutil/trace.go:171","msg":"trace[169906871] linearizableReadLoop","detail":"{readStateIndex:4648; appliedIndex:4647; }","duration":"103.439332ms","start":"2026-05-19T13:36:20.428837Z","end":"2026-05-19T13:36:20.532276Z","steps":["trace[169906871] 'read index received' (duration: 103.38424ms)","trace[169906871] 'applied index is now lower than readState.Index' (duration: 54.002µs)"],"step_count":2} {"level":"warn","ts":"2026-05-19T13:36:20.532516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.56086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-w857p-tls\" ","response":"range_response_count:1 size:2464"} {"level":"info","ts":"2026-05-19T13:36:20.53255Z","caller":"traceutil/trace.go:171","msg":"trace[814320725] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-w857p-tls; range_end:; response_count:1; response_revision:4458; }","duration":"117.633983ms","start":"2026-05-19T13:36:20.414906Z","end":"2026-05-19T13:36:20.53254Z","steps":["trace[814320725] 'agreement among raft nodes before linearized reading' (duration: 117.484908ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:36:20.532612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.534133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1131"} {"level":"info","ts":"2026-05-19T13:36:20.532703Z","caller":"traceutil/trace.go:171","msg":"trace[824956943] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4458; }","duration":"114.670707ms","start":"2026-05-19T13:36:20.418014Z","end":"2026-05-19T13:36:20.532684Z","steps":["trace[824956943] 'agreement among raft nodes before linearized reading' (duration: 114.346307ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:36:20.533441Z","caller":"traceutil/trace.go:171","msg":"trace[2115688465] transaction","detail":"{read_only:false; response_revision:4458; number_of_response:1; }","duration":"115.398118ms","start":"2026-05-19T13:36:20.418018Z","end":"2026-05-19T13:36:20.533417Z","steps":["trace[2115688465] 'process raft request' (duration: 114.111511ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:36:20.539378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.131008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5c510a21-5b6f-4d65-82f5-5a4977b6a06d\" ","response":"range_response_count:1 size:4050"} {"level":"info","ts":"2026-05-19T13:36:20.539452Z","caller":"traceutil/trace.go:171","msg":"trace[931048058] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5c510a21-5b6f-4d65-82f5-5a4977b6a06d; range_end:; response_count:1; response_revision:4459; }","duration":"108.250781ms","start":"2026-05-19T13:36:20.431183Z","end":"2026-05-19T13:36:20.539434Z","steps":["trace[931048058] 'agreement among raft nodes before linearized reading' (duration: 108.022004ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:36:20.539733Z","caller":"traceutil/trace.go:171","msg":"trace[700804073] transaction","detail":"{read_only:false; response_revision:4459; number_of_response:1; }","duration":"105.266914ms","start":"2026-05-19T13:36:20.434455Z","end":"2026-05-19T13:36:20.539721Z","steps":["trace[700804073] 'process raft request' (duration: 99.252821ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:36:20.540563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.223162ms","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-05-19T13:36:20.540585Z","caller":"traceutil/trace.go:171","msg":"trace[1070098654] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4459; }","duration":"106.264053ms","start":"2026-05-19T13:36:20.434314Z","end":"2026-05-19T13:36:20.540578Z","steps":["trace[1070098654] 'agreement among raft nodes before linearized reading' (duration: 106.186751ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:36:20.540698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.393587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:552"} {"level":"info","ts":"2026-05-19T13:36:20.540717Z","caller":"traceutil/trace.go:171","msg":"trace[1874587884] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4459; }","duration":"106.424338ms","start":"2026-05-19T13:36:20.434286Z","end":"2026-05-19T13:36:20.54071Z","steps":["trace[1874587884] 'agreement among raft nodes before linearized reading' (duration: 106.373166ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:36:20.540824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.609851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:567"} {"level":"info","ts":"2026-05-19T13:36:20.540841Z","caller":"traceutil/trace.go:171","msg":"trace[784145568] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:4459; }","duration":"108.637303ms","start":"2026-05-19T13:36:20.432199Z","end":"2026-05-19T13:36:20.540836Z","steps":["trace[784145568] 'agreement among raft nodes before linearized reading' (duration: 108.584851ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:36:20.541491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.060473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-19T13:36:20.541516Z","caller":"traceutil/trace.go:171","msg":"trace[1853534824] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:4459; }","duration":"110.100084ms","start":"2026-05-19T13:36:20.431409Z","end":"2026-05-19T13:36:20.541509Z","steps":["trace[1853534824] 'agreement among raft nodes before linearized reading' (duration: 109.499857ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:36:27.338393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.803844ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-19T13:36:27.338625Z","caller":"traceutil/trace.go:171","msg":"trace[1121043333] transaction","detail":"{read_only:false; response_revision:4627; number_of_response:1; }","duration":"181.155636ms","start":"2026-05-19T13:36:27.157439Z","end":"2026-05-19T13:36:27.338595Z","steps":["trace[1121043333] 'compare' (duration: 170.652849ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:36:27.338967Z","caller":"traceutil/trace.go:171","msg":"trace[1743279706] transaction","detail":"{read_only:false; response_revision:4628; number_of_response:1; }","duration":"178.371506ms","start":"2026-05-19T13:36:27.160578Z","end":"2026-05-19T13:36:27.338949Z","steps":["trace[1743279706] 'process raft request' (duration: 177.942194ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:36:27.68044Z","caller":"traceutil/trace.go:171","msg":"trace[650315744] transaction","detail":"{read_only:false; response_revision:4639; number_of_response:1; }","duration":"164.551417ms","start":"2026-05-19T13:36:27.51586Z","end":"2026-05-19T13:36:27.680411Z","steps":["trace[650315744] 'process raft request' (duration: 72.393574ms)","trace[650315744] 'compare' (duration: 91.617738ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T13:36:27.680795Z","caller":"traceutil/trace.go:171","msg":"trace[3902251] transaction","detail":"{read_only:false; response_revision:4642; number_of_response:1; }","duration":"148.323838ms","start":"2026-05-19T13:36:27.532427Z","end":"2026-05-19T13:36:27.680751Z","steps":["trace[3902251] 'process raft request' (duration: 148.276527ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:36:27.680894Z","caller":"traceutil/trace.go:171","msg":"trace[1735852807] transaction","detail":"{read_only:false; response_revision:4640; number_of_response:1; }","duration":"164.872266ms","start":"2026-05-19T13:36:27.515994Z","end":"2026-05-19T13:36:27.680866Z","steps":["trace[1735852807] 'process raft request' (duration: 164.333571ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:36:27.681078Z","caller":"traceutil/trace.go:171","msg":"trace[620027664] transaction","detail":"{read_only:false; response_revision:4641; number_of_response:1; }","duration":"163.859717ms","start":"2026-05-19T13:36:27.517207Z","end":"2026-05-19T13:36:27.681067Z","steps":["trace[620027664] 'process raft request' (duration: 163.395944ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:36:39.709416Z","caller":"traceutil/trace.go:171","msg":"trace[1571589570] linearizableReadLoop","detail":"{readStateIndex:5025; appliedIndex:5024; }","duration":"239.044459ms","start":"2026-05-19T13:36:39.470347Z","end":"2026-05-19T13:36:39.709392Z","steps":["trace[1571589570] 'read index received' (duration: 238.902385ms)","trace[1571589570] 'applied index is now lower than readState.Index' (duration: 141.104µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T13:36:39.709473Z","caller":"traceutil/trace.go:171","msg":"trace[1676708516] transaction","detail":"{read_only:false; response_revision:4820; number_of_response:1; }","duration":"240.509188ms","start":"2026-05-19T13:36:39.468931Z","end":"2026-05-19T13:36:39.70944Z","steps":["trace[1676708516] 'process raft request' (duration: 240.303663ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:36:39.709874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.497141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-bbbb6a41-3c02-4541-88f0-28d645c3b59e\" ","response":"range_response_count:1 size:1322"} {"level":"info","ts":"2026-05-19T13:36:39.709946Z","caller":"traceutil/trace.go:171","msg":"trace[592167272] range","detail":"{range_begin:/registry/persistentvolumes/pvc-bbbb6a41-3c02-4541-88f0-28d645c3b59e; range_end:; response_count:1; response_revision:4820; }","duration":"239.589073ms","start":"2026-05-19T13:36:39.470335Z","end":"2026-05-19T13:36:39.709924Z","steps":["trace[592167272] 'agreement among raft nodes before linearized reading' (duration: 239.182922ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T13:36:39.792479Z","caller":"traceutil/trace.go:171","msg":"trace[886812702] transaction","detail":"{read_only:false; response_revision:4821; number_of_response:1; }","duration":"317.128139ms","start":"2026-05-19T13:36:39.475324Z","end":"2026-05-19T13:36:39.792452Z","steps":["trace[886812702] 'process raft request' (duration: 316.943014ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T13:36:39.792637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T13:36:39.475318Z","time spent":"317.225851ms","remote":"127.0.0.1:33526","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10791,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T13:39:45.607073Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3255} {"level":"info","ts":"2026-05-19T13:39:45.714378Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3255,"took":"105.619977ms","hash":3253711069,"current-db-size-bytes":56975360,"current-db-size":"57 MB","current-db-size-in-use-bytes":31424512,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-05-19T13:39:45.714447Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3253711069,"revision":3255,"compact-revision":-1} {"level":"info","ts":"2026-05-19T13:41:03.375613Z","caller":"traceutil/trace.go:171","msg":"trace[525144478] transaction","detail":"{read_only:false; response_revision:7060; number_of_response:1; }","duration":"118.165392ms","start":"2026-05-19T13:41:03.257423Z","end":"2026-05-19T13:41:03.375588Z","steps":["trace[525144478] 'process raft request' (duration: 117.984389ms)"],"step_count":1}