{"level":"warn","ts":"2026-07-16T00:17:15.444413Z","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-16T00:17:15.444507Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.3: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.204.45.3:2380","--initial-cluster=instance=https://199.204.45.3:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.3:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.3: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-16T00:17:15.444598Z","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-16T00:17:15.444617Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.3:2380"]} {"level":"info","ts":"2026-07-16T00:17:15.444647Z","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-16T00:17:15.445456Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"]} {"level":"info","ts":"2026-07-16T00:17:15.445553Z","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.204.45.3:2380"],"listen-peer-urls":["https://199.204.45.3:2380"],"advertise-client-urls":["https://199.204.45.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.3: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-16T00:17:15.449706Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.90962ms"} {"level":"info","ts":"2026-07-16T00:17:15.466373Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"597401b06ce1cf3d","cluster-id":"dfc54657ad8a2432"} {"level":"info","ts":"2026-07-16T00:17:15.466455Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=()"} {"level":"info","ts":"2026-07-16T00:17:15.466474Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became follower at term 0"} {"level":"info","ts":"2026-07-16T00:17:15.4665Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 597401b06ce1cf3d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-16T00:17:15.466547Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became follower at term 1"} {"level":"info","ts":"2026-07-16T00:17:15.46662Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=(6445778823926632253)"} {"level":"warn","ts":"2026-07-16T00:17:15.475191Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-16T00:17:15.47684Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-16T00:17:15.479851Z","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-16T00:17:15.483428Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"597401b06ce1cf3d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-16T00:17:15.484834Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"597401b06ce1cf3d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-16T00:17:15.485081Z","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-16T00:17:15.48512Z","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-16T00:17:15.485132Z","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-16T00:17:15.485411Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=(6445778823926632253)"} {"level":"info","ts":"2026-07-16T00:17:15.485734Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"dfc54657ad8a2432","local-member-id":"597401b06ce1cf3d","added-peer-id":"597401b06ce1cf3d","added-peer-peer-urls":["https://199.204.45.3:2380"]} {"level":"info","ts":"2026-07-16T00:17:15.488434Z","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-16T00:17:15.488623Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"597401b06ce1cf3d","initial-advertise-peer-urls":["https://199.204.45.3:2380"],"listen-peer-urls":["https://199.204.45.3:2380"],"advertise-client-urls":["https://199.204.45.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-16T00:17:15.488658Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-16T00:17:15.488717Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.3:2380"} {"level":"info","ts":"2026-07-16T00:17:15.488732Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.3:2380"} {"level":"info","ts":"2026-07-16T00:17:16.067332Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d is starting a new election at term 1"} {"level":"info","ts":"2026-07-16T00:17:16.067418Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became pre-candidate at term 1"} {"level":"info","ts":"2026-07-16T00:17:16.067437Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d received MsgPreVoteResp from 597401b06ce1cf3d at term 1"} {"level":"info","ts":"2026-07-16T00:17:16.067448Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became candidate at term 2"} {"level":"info","ts":"2026-07-16T00:17:16.067453Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d received MsgVoteResp from 597401b06ce1cf3d at term 2"} {"level":"info","ts":"2026-07-16T00:17:16.067462Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became leader at term 2"} {"level":"info","ts":"2026-07-16T00:17:16.067469Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 597401b06ce1cf3d elected leader 597401b06ce1cf3d at term 2"} {"level":"info","ts":"2026-07-16T00:17:16.068389Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"597401b06ce1cf3d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.3:2379]}","request-path":"/0/members/597401b06ce1cf3d/attributes","cluster-id":"dfc54657ad8a2432","publish-timeout":"7s"} {"level":"info","ts":"2026-07-16T00:17:16.068396Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-16T00:17:16.068744Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-16T00:17:16.068497Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-16T00:17:16.070105Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"dfc54657ad8a2432","local-member-id":"597401b06ce1cf3d","cluster-version":"3.5"} {"level":"info","ts":"2026-07-16T00:17:16.070223Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-16T00:17:16.07027Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-16T00:17:16.070378Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-16T00:17:16.069706Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-16T00:17:16.070637Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-16T00:17:16.07464Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.3:2379"} {"level":"info","ts":"2026-07-16T00:17:18.671379Z","caller":"traceutil/trace.go:171","msg":"trace[566961601] transaction","detail":"{read_only:false; response_revision:72; number_of_response:1; }","duration":"100.607583ms","start":"2026-07-16T00:17:18.570742Z","end":"2026-07-16T00:17:18.67135Z","steps":["trace[566961601] 'process raft request' (duration: 89.376055ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:17:19.178167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.643088ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-07-16T00:17:19.178366Z","caller":"traceutil/trace.go:171","msg":"trace[989684758] transaction","detail":"{read_only:false; response_revision:84; number_of_response:1; }","duration":"260.844713ms","start":"2026-07-16T00:17:18.917501Z","end":"2026-07-16T00:17:19.178346Z","steps":["trace[989684758] 'process raft request' (duration: 58.318064ms)","trace[989684758] 'compare' (duration: 201.47449ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T00:17:19.417628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.650213ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-07-16T00:17:19.417756Z","caller":"traceutil/trace.go:171","msg":"trace[1739081938] transaction","detail":"{read_only:false; response_revision:87; number_of_response:1; }","duration":"179.897143ms","start":"2026-07-16T00:17:19.237834Z","end":"2026-07-16T00:17:19.417731Z","steps":["trace[1739081938] 'process raft request' (duration: 41.070582ms)","trace[1739081938] 'compare' (duration: 138.501006ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T00:17:28.211003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.080762ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-16T00:17:28.21129Z","caller":"traceutil/trace.go:171","msg":"trace[1523768405] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"363.540295ms","start":"2026-07-16T00:17:27.847706Z","end":"2026-07-16T00:17:28.211247Z","steps":["trace[1523768405] 'process raft request' (duration: 239.952672ms)","trace[1523768405] 'compare' (duration: 122.927355ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T00:17:28.211523Z","caller":"traceutil/trace.go:171","msg":"trace[515233807] linearizableReadLoop","detail":"{readStateIndex:367; appliedIndex:366; }","duration":"360.493035ms","start":"2026-07-16T00:17:27.850992Z","end":"2026-07-16T00:17:28.211485Z","steps":["trace[515233807] 'read index received' (duration: 236.662652ms)","trace[515233807] 'applied index is now lower than readState.Index' (duration: 123.824143ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T00:17:28.211521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:17:27.847689Z","time spent":"363.727753ms","remote":"127.0.0.1:38682","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7078,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-16T00:17:28.211744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.694963ms","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-16T00:17:28.211832Z","caller":"traceutil/trace.go:171","msg":"trace[2129442561] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:353; }","duration":"360.85811ms","start":"2026-07-16T00:17:27.850951Z","end":"2026-07-16T00:17:28.211809Z","steps":["trace[2129442561] 'agreement among raft nodes before linearized reading' (duration: 360.637371ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:17:28.211964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:17:27.850934Z","time spent":"360.980345ms","remote":"127.0.0.1:38732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-16T00:17:28.212242Z","caller":"traceutil/trace.go:171","msg":"trace[41482473] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"185.984031ms","start":"2026-07-16T00:17:28.026232Z","end":"2026-07-16T00:17:28.212216Z","steps":["trace[41482473] 'process raft request' (duration: 184.922816ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:17:28.465626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.018908ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-16T00:17:28.465734Z","caller":"traceutil/trace.go:171","msg":"trace[1689101694] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"243.353386ms","start":"2026-07-16T00:17:28.222362Z","end":"2026-07-16T00:17:28.465715Z","steps":["trace[1689101694] 'process raft request' (duration: 134.162221ms)","trace[1689101694] 'compare' (duration: 108.895263ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T00:17:28.876941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.271763ms","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-16T00:17:28.877147Z","caller":"traceutil/trace.go:171","msg":"trace[288966940] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:356; }","duration":"243.460002ms","start":"2026-07-16T00:17:28.633605Z","end":"2026-07-16T00:17:28.877065Z","steps":["trace[288966940] 'range keys from in-memory index tree' (duration: 243.144288ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:17:43.394862Z","caller":"traceutil/trace.go:171","msg":"trace[429067639] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"366.726869ms","start":"2026-07-16T00:17:43.028107Z","end":"2026-07-16T00:17:43.394834Z","steps":["trace[429067639] 'process raft request' (duration: 366.496521ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:17:43.395046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:17:43.02809Z","time spent":"366.862914ms","remote":"127.0.0.1:38732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T00:17:43.734453Z","caller":"traceutil/trace.go:171","msg":"trace[435005591] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"318.445092ms","start":"2026-07-16T00:17:43.415989Z","end":"2026-07-16T00:17:43.734435Z","steps":["trace[435005591] 'process raft request' (duration: 318.411991ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:17:43.734451Z","caller":"traceutil/trace.go:171","msg":"trace[149076767] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"335.837535ms","start":"2026-07-16T00:17:43.398589Z","end":"2026-07-16T00:17:43.734426Z","steps":["trace[149076767] 'process raft request' (duration: 325.588903ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:17:43.734568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:17:43.415977Z","time spent":"318.534026ms","remote":"127.0.0.1:38732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-16T00:17:43.734592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:17:43.398564Z","time spent":"335.95578ms","remote":"127.0.0.1:38732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T00:17:43.734706Z","caller":"traceutil/trace.go:171","msg":"trace[2086322061] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"324.132579ms","start":"2026-07-16T00:17:43.410564Z","end":"2026-07-16T00:17:43.734696Z","steps":["trace[2086322061] 'process raft request' (duration: 323.756095ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:17:43.734768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:17:43.41055Z","time spent":"324.190342ms","remote":"127.0.0.1:38922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4180,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T00:17:49.88808Z","caller":"traceutil/trace.go:171","msg":"trace[324381738] transaction","detail":"{read_only:false; response_revision:445; number_of_response:1; }","duration":"126.932573ms","start":"2026-07-16T00:17:49.761123Z","end":"2026-07-16T00:17:49.888055Z","steps":["trace[324381738] 'process raft request' (duration: 126.797639ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:17:50.402251Z","caller":"traceutil/trace.go:171","msg":"trace[1051803429] transaction","detail":"{read_only:false; response_revision:446; number_of_response:1; }","duration":"387.046044ms","start":"2026-07-16T00:17:50.015178Z","end":"2026-07-16T00:17:50.402224Z","steps":["trace[1051803429] 'process raft request' (duration: 386.903249ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:17:50.402436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:17:50.015158Z","time spent":"387.19595ms","remote":"127.0.0.1:38732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T00:17:56.631212Z","caller":"traceutil/trace.go:171","msg":"trace[1112649274] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"129.542281ms","start":"2026-07-16T00:17:56.501647Z","end":"2026-07-16T00:17:56.63119Z","steps":["trace[1112649274] 'process raft request' (duration: 69.245665ms)","trace[1112649274] 'compare' (duration: 60.193273ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T00:17:57.660181Z","caller":"traceutil/trace.go:171","msg":"trace[1094455414] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"733.348704ms","start":"2026-07-16T00:17:56.926801Z","end":"2026-07-16T00:17:57.66015Z","steps":["trace[1094455414] 'process raft request' (duration: 733.115747ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:17:57.660313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:17:56.926783Z","time spent":"733.467197ms","remote":"127.0.0.1:38520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-16T00:17:57.669116Z","caller":"traceutil/trace.go:171","msg":"trace[1133827503] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"722.107878ms","start":"2026-07-16T00:17:56.946991Z","end":"2026-07-16T00:17:57.669099Z","steps":["trace[1133827503] 'process raft request' (duration: 721.975324ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:17:57.669217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:17:56.946972Z","time spent":"722.199191ms","remote":"127.0.0.1:38520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-16T00:17:57.669369Z","caller":"traceutil/trace.go:171","msg":"trace[542778555] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"731.246863ms","start":"2026-07-16T00:17:56.938112Z","end":"2026-07-16T00:17:57.669359Z","steps":["trace[542778555] 'process raft request' (duration: 730.776188ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:17:57.669421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:17:56.938088Z","time spent":"731.312236ms","remote":"127.0.0.1:38520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-16T00:17:57.669697Z","caller":"traceutil/trace.go:171","msg":"trace[270344392] linearizableReadLoop","detail":"{readStateIndex:528; appliedIndex:516; }","duration":"206.963181ms","start":"2026-07-16T00:17:57.462723Z","end":"2026-07-16T00:17:57.669686Z","steps":["trace[270344392] 'read index received' (duration: 197.302992ms)","trace[270344392] 'applied index is now lower than readState.Index' (duration: 9.659669ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T00:17:57.669806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.074974ms","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-16T00:17:57.669852Z","caller":"traceutil/trace.go:171","msg":"trace[813652414] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:507; }","duration":"207.173078ms","start":"2026-07-16T00:17:57.46267Z","end":"2026-07-16T00:17:57.669843Z","steps":["trace[813652414] 'agreement among raft nodes before linearized reading' (duration: 207.059394ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:17:57.669963Z","caller":"traceutil/trace.go:171","msg":"trace[1966653859] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"711.309789ms","start":"2026-07-16T00:17:56.958642Z","end":"2026-07-16T00:17:57.669952Z","steps":["trace[1966653859] 'process raft request' (duration: 710.473753ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:17:57.670019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:17:56.958628Z","time spent":"711.366971ms","remote":"127.0.0.1:38520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-16T00:17:57.670045Z","caller":"traceutil/trace.go:171","msg":"trace[247441724] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"699.530209ms","start":"2026-07-16T00:17:56.970509Z","end":"2026-07-16T00:17:57.670039Z","steps":["trace[247441724] 'process raft request' (duration: 698.802276ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:17:57.670104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:17:56.970502Z","time spent":"699.56272ms","remote":"127.0.0.1:38520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-16T00:17:57.670121Z","caller":"traceutil/trace.go:171","msg":"trace[803153722] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"723.104561ms","start":"2026-07-16T00:17:56.947009Z","end":"2026-07-16T00:17:57.670114Z","steps":["trace[803153722] 'process raft request' (duration: 722.003725ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:17:57.670157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:17:56.946991Z","time spent":"723.149271ms","remote":"127.0.0.1:38520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-16T00:17:57.670215Z","caller":"traceutil/trace.go:171","msg":"trace[2003774820] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"668.88044ms","start":"2026-07-16T00:17:57.001328Z","end":"2026-07-16T00:17:57.670208Z","steps":["trace[2003774820] 'process raft request' (duration: 668.025052ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:17:57.670269Z","caller":"traceutil/trace.go:171","msg":"trace[741674422] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"723.175732ms","start":"2026-07-16T00:17:56.947087Z","end":"2026-07-16T00:17:57.670263Z","steps":["trace[741674422] 'process raft request' (duration: 721.977024ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:17:57.67033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:17:56.947072Z","time spent":"723.239625ms","remote":"127.0.0.1:38520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-16T00:17:57.670353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:17:57.001291Z","time spent":"668.978374ms","remote":"127.0.0.1:38520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-16T00:17:57.670399Z","caller":"traceutil/trace.go:171","msg":"trace[1002181272] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"714.09974ms","start":"2026-07-16T00:17:56.956271Z","end":"2026-07-16T00:17:57.670371Z","steps":["trace[1002181272] 'process raft request' (duration: 712.817669ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:17:57.670022Z","caller":"traceutil/trace.go:171","msg":"trace[1614675825] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"704.468869ms","start":"2026-07-16T00:17:56.965527Z","end":"2026-07-16T00:17:57.669996Z","steps":["trace[1614675825] 'process raft request' (duration: 703.635722ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:17:57.670517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:17:56.956227Z","time spent":"714.234614ms","remote":"127.0.0.1:38520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-16T00:17:57.671286Z","caller":"traceutil/trace.go:171","msg":"trace[1227884697] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"559.822131ms","start":"2026-07-16T00:17:57.110699Z","end":"2026-07-16T00:17:57.670521Z","steps":["trace[1227884697] 'process raft request' (duration: 558.820619ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:17:57.671432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:17:57.110679Z","time spent":"560.659767ms","remote":"127.0.0.1:38520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-16T00:17:57.670247Z","caller":"traceutil/trace.go:171","msg":"trace[536170470] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"723.172323ms","start":"2026-07-16T00:17:56.947067Z","end":"2026-07-16T00:17:57.67024Z","steps":["trace[536170470] 'process raft request' (duration: 721.973544ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:17:57.671737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:17:56.947063Z","time spent":"724.534916ms","remote":"127.0.0.1:38520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-16T00:17:57.670519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:17:56.965518Z","time spent":"704.972015ms","remote":"127.0.0.1:38520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-16T00:18:04.669564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.435701ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-16T00:18:04.669719Z","caller":"traceutil/trace.go:171","msg":"trace[276453952] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:605; }","duration":"125.611536ms","start":"2026-07-16T00:18:04.544083Z","end":"2026-07-16T00:18:04.669694Z","steps":["trace[276453952] 'range keys from in-memory index tree' (duration: 125.41271ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:18:04.669738Z","caller":"traceutil/trace.go:171","msg":"trace[525548808] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"486.102891ms","start":"2026-07-16T00:18:04.183594Z","end":"2026-07-16T00:18:04.669697Z","steps":["trace[525548808] 'process raft request' (duration: 416.781322ms)","trace[525548808] 'compare' (duration: 68.932028ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T00:18:04.669932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:18:04.183573Z","time spent":"486.254695ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-16T00:18:05.534701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"576.693189ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-16T00:18:05.534809Z","caller":"traceutil/trace.go:171","msg":"trace[1320358010] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"860.205625ms","start":"2026-07-16T00:18:04.674585Z","end":"2026-07-16T00:18:05.534791Z","steps":["trace[1320358010] 'process raft request' (duration: 283.348251ms)","trace[1320358010] 'compare' (duration: 576.258137ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T00:18:05.534871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:18:04.674567Z","time spent":"860.277767ms","remote":"127.0.0.1:38732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-16T00:18:05.97811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.102759ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-16T00:18:05.978205Z","caller":"traceutil/trace.go:171","msg":"trace[513213430] linearizableReadLoop","detail":"{readStateIndex:633; appliedIndex:631; }","duration":"1.298972719s","start":"2026-07-16T00:18:04.679217Z","end":"2026-07-16T00:18:05.978189Z","steps":["trace[513213430] 'read index received' (duration: 278.802403ms)","trace[513213430] 'applied index is now lower than readState.Index' (duration: 1.020169156s)"],"step_count":2} {"level":"info","ts":"2026-07-16T00:18:05.978225Z","caller":"traceutil/trace.go:171","msg":"trace[1778314836] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"1.301544666s","start":"2026-07-16T00:18:04.676661Z","end":"2026-07-16T00:18:05.978206Z","steps":["trace[1778314836] 'process raft request' (duration: 1.080241771s)","trace[1778314836] 'compare' (duration: 220.992946ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T00:18:05.9783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:18:04.676644Z","time spent":"1.301622699s","remote":"127.0.0.1:38732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-16T00:18:05.97832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.299104722s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-16T00:18:05.978346Z","caller":"traceutil/trace.go:171","msg":"trace[22963759] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:608; }","duration":"1.299158814s","start":"2026-07-16T00:18:04.679179Z","end":"2026-07-16T00:18:05.978337Z","steps":["trace[22963759] 'agreement among raft nodes before linearized reading' (duration: 1.299108603s)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:18:05.978396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:18:04.679163Z","time spent":"1.299225127s","remote":"127.0.0.1:38712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-07-16T00:18:05.978448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"981.242272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-16T00:18:05.978486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.833266ms","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-16T00:18:05.978523Z","caller":"traceutil/trace.go:171","msg":"trace[1197806152] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:608; }","duration":"981.379766ms","start":"2026-07-16T00:18:04.997125Z","end":"2026-07-16T00:18:05.978504Z","steps":["trace[1197806152] 'agreement among raft nodes before linearized reading' (duration: 981.251172ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:18:05.978552Z","caller":"traceutil/trace.go:171","msg":"trace[1392404956] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:608; }","duration":"257.968991ms","start":"2026-07-16T00:18:05.720567Z","end":"2026-07-16T00:18:05.978536Z","steps":["trace[1392404956] 'agreement among raft nodes before linearized reading' (duration: 257.811186ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:18:05.978562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:18:04.997104Z","time spent":"981.449488ms","remote":"127.0.0.1:38476","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-16T00:18:05.978488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.060218972s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-6vmwl\" ","response":"range_response_count:1 size:16957"} {"level":"info","ts":"2026-07-16T00:18:05.978681Z","caller":"traceutil/trace.go:171","msg":"trace[1224069713] range","detail":"{range_begin:/registry/pods/kube-system/cilium-6vmwl; range_end:; response_count:1; response_revision:608; }","duration":"1.060409628s","start":"2026-07-16T00:18:04.91822Z","end":"2026-07-16T00:18:05.97863Z","steps":["trace[1224069713] 'agreement among raft nodes before linearized reading' (duration: 1.060125509s)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:18:05.97879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:18:04.918196Z","time spent":"1.060559693s","remote":"127.0.0.1:38682","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16980,"request content":"key:\"/registry/pods/kube-system/cilium-6vmwl\" "} {"level":"warn","ts":"2026-07-16T00:18:07.46995Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933267209678802741,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-16T00:18:07.779525Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.376471471s","expected-duration":"1s"} {"level":"info","ts":"2026-07-16T00:18:07.781001Z","caller":"traceutil/trace.go:171","msg":"trace[923571801] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"1.379580813s","start":"2026-07-16T00:18:06.401402Z","end":"2026-07-16T00:18:07.780983Z","steps":["trace[923571801] 'process raft request' (duration: 1.378817631s)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:18:07.78115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:18:06.401373Z","time spent":"1.379692476s","remote":"127.0.0.1:38580","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036301,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T00:18:07.817898Z","caller":"traceutil/trace.go:171","msg":"trace[833810193] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:636; }","duration":"848.320973ms","start":"2026-07-16T00:18:06.969235Z","end":"2026-07-16T00:18:07.817556Z","steps":["trace[833810193] 'read index received' (duration: 810.515821ms)","trace[833810193] 'applied index is now lower than readState.Index' (duration: 37.803092ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T00:18:07.818127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"848.87574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-16T00:18:07.818168Z","caller":"traceutil/trace.go:171","msg":"trace[1616505141] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:612; }","duration":"848.970032ms","start":"2026-07-16T00:18:06.969186Z","end":"2026-07-16T00:18:07.818156Z","steps":["trace[1616505141] 'agreement among raft nodes before linearized reading' (duration: 848.87653ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:18:07.818205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:18:06.969165Z","time spent":"849.031884ms","remote":"127.0.0.1:38476","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-16T00:18:07.818492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.710575ms","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-07-16T00:18:07.818592Z","caller":"traceutil/trace.go:171","msg":"trace[1989981913] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:612; }","duration":"279.853939ms","start":"2026-07-16T00:18:07.538714Z","end":"2026-07-16T00:18:07.818567Z","steps":["trace[1989981913] 'agreement among raft nodes before linearized reading' (duration: 279.653334ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:18:08.229506Z","caller":"traceutil/trace.go:171","msg":"trace[2028221583] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"145.536915ms","start":"2026-07-16T00:18:08.083942Z","end":"2026-07-16T00:18:08.229479Z","steps":["trace[2028221583] 'process raft request' (duration: 132.291128ms)","trace[2028221583] 'compare' (duration: 13.109443ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T00:18:09.185586Z","caller":"traceutil/trace.go:171","msg":"trace[1555747818] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"130.972389ms","start":"2026-07-16T00:18:09.054587Z","end":"2026-07-16T00:18:09.185559Z","steps":["trace[1555747818] 'process raft request' (duration: 130.529657ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:18:09.414609Z","caller":"traceutil/trace.go:171","msg":"trace[2008615189] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"357.69205ms","start":"2026-07-16T00:18:09.056899Z","end":"2026-07-16T00:18:09.414591Z","steps":["trace[2008615189] 'process raft request' (duration: 357.598057ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:18:09.414601Z","caller":"traceutil/trace.go:171","msg":"trace[1150757533] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"358.064901ms","start":"2026-07-16T00:18:09.056509Z","end":"2026-07-16T00:18:09.414574Z","steps":["trace[1150757533] 'process raft request' (duration: 353.321134ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:18:09.41469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.016599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-16T00:18:09.414709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:18:09.05689Z","time spent":"357.769763ms","remote":"127.0.0.1:38520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4234,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-16T00:18:09.414722Z","caller":"traceutil/trace.go:171","msg":"trace[1544452911] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:639; }","duration":"358.078031ms","start":"2026-07-16T00:18:09.056635Z","end":"2026-07-16T00:18:09.414713Z","steps":["trace[1544452911] 'agreement among raft nodes before linearized reading' (duration: 358.005879ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:18:09.414758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:18:09.056569Z","time spent":"358.168194ms","remote":"127.0.0.1:38520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" "} {"level":"info","ts":"2026-07-16T00:18:09.414817Z","caller":"traceutil/trace.go:171","msg":"trace[1888397176] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"355.021393ms","start":"2026-07-16T00:18:09.059789Z","end":"2026-07-16T00:18:09.414811Z","steps":["trace[1888397176] 'process raft request' (duration: 354.776366ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:18:09.414607Z","caller":"traceutil/trace.go:171","msg":"trace[1962419511] linearizableReadLoop","detail":"{readStateIndex:662; appliedIndex:660; }","duration":"357.931897ms","start":"2026-07-16T00:18:09.056661Z","end":"2026-07-16T00:18:09.414593Z","steps":["trace[1962419511] 'read index received' (duration: 128.543339ms)","trace[1962419511] 'applied index is now lower than readState.Index' (duration: 229.387978ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T00:18:09.414855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:18:09.059767Z","time spent":"355.069875ms","remote":"127.0.0.1:38520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3353,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-16T00:18:09.414846Z","caller":"traceutil/trace.go:171","msg":"trace[1785459543] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"357.719881ms","start":"2026-07-16T00:18:09.057091Z","end":"2026-07-16T00:18:09.414811Z","steps":["trace[1785459543] 'process raft request' (duration: 357.444423ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:18:09.414742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:18:09.056491Z","time spent":"358.185534ms","remote":"127.0.0.1:38520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4580,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-16T00:18:09.41522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:18:09.05708Z","time spent":"358.04428ms","remote":"127.0.0.1:38520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3202,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-16T00:18:09.416318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.86976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-16T00:18:09.416309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.574598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-16T00:18:09.416352Z","caller":"traceutil/trace.go:171","msg":"trace[1493766995] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:0; response_revision:640; }","duration":"164.906861ms","start":"2026-07-16T00:18:09.251436Z","end":"2026-07-16T00:18:09.416343Z","steps":["trace[1493766995] 'agreement among raft nodes before linearized reading' (duration: 164.84821ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:18:09.416388Z","caller":"traceutil/trace.go:171","msg":"trace[84647396] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:0; response_revision:640; }","duration":"356.673221ms","start":"2026-07-16T00:18:09.059685Z","end":"2026-07-16T00:18:09.416359Z","steps":["trace[84647396] 'agreement among raft nodes before linearized reading' (duration: 356.503676ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:18:09.416437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:18:09.05968Z","time spent":"356.746583ms","remote":"127.0.0.1:38520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" "} {"level":"warn","ts":"2026-07-16T00:18:20.107292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"604.401315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-16T00:18:20.107371Z","caller":"traceutil/trace.go:171","msg":"trace[828268819] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:754; }","duration":"604.526798ms","start":"2026-07-16T00:18:19.502825Z","end":"2026-07-16T00:18:20.107352Z","steps":["trace[828268819] 'count revisions from in-memory index tree' (duration: 604.323413ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:18:20.107407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:18:19.502806Z","time spent":"604.59186ms","remote":"127.0.0.1:38676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":30,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true "} {"level":"warn","ts":"2026-07-16T00:18:20.107653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.464106ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-16T00:18:20.107705Z","caller":"traceutil/trace.go:171","msg":"trace[232639386] linearizableReadLoop","detail":"{readStateIndex:784; appliedIndex:783; }","duration":"234.489474ms","start":"2026-07-16T00:18:19.873207Z","end":"2026-07-16T00:18:20.107696Z","steps":["trace[232639386] 'read index received' (duration: 34.341µs)","trace[232639386] 'applied index is now lower than readState.Index' (duration: 234.454323ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T00:18:20.107677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"875.282632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"warn","ts":"2026-07-16T00:18:20.107849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.637197ms","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-07-16T00:18:20.107906Z","caller":"traceutil/trace.go:171","msg":"trace[418711747] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:754; }","duration":"875.56295ms","start":"2026-07-16T00:18:19.23233Z","end":"2026-07-16T00:18:20.107893Z","steps":["trace[418711747] 'range keys from in-memory index tree' (duration: 875.123958ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:18:20.107991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:18:19.232307Z","time spent":"875.674693ms","remote":"127.0.0.1:38732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-16T00:18:20.107793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.049256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-16T00:18:20.1078Z","caller":"traceutil/trace.go:171","msg":"trace[1334161281] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"478.020769ms","start":"2026-07-16T00:18:19.629719Z","end":"2026-07-16T00:18:20.10774Z","steps":["trace[1334161281] 'process raft request' (duration: 60.421319ms)","trace[1334161281] 'compare' (duration: 416.948972ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T00:18:20.108076Z","caller":"traceutil/trace.go:171","msg":"trace[1899574491] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:755; }","duration":"136.376744ms","start":"2026-07-16T00:18:19.971691Z","end":"2026-07-16T00:18:20.108068Z","steps":["trace[1899574491] 'agreement among raft nodes before linearized reading' (duration: 136.069426ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:18:20.107924Z","caller":"traceutil/trace.go:171","msg":"trace[685027657] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:755; }","duration":"234.75378ms","start":"2026-07-16T00:18:19.873161Z","end":"2026-07-16T00:18:20.107915Z","steps":["trace[685027657] 'agreement among raft nodes before linearized reading' (duration: 234.581426ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:18:20.108258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:18:19.629693Z","time spent":"478.4164ms","remote":"127.0.0.1:38732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-16T00:18:23.884678Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933267209678803063,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-16T00:18:24.026921Z","caller":"traceutil/trace.go:171","msg":"trace[63404913] linearizableReadLoop","detail":"{readStateIndex:806; appliedIndex:805; }","duration":"642.955704ms","start":"2026-07-16T00:18:23.383946Z","end":"2026-07-16T00:18:24.026901Z","steps":["trace[63404913] 'read index received' (duration: 642.749508ms)","trace[63404913] 'applied index is now lower than readState.Index' (duration: 205.306µs)"],"step_count":2} {"level":"warn","ts":"2026-07-16T00:18:24.027082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"643.123108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-16T00:18:24.027064Z","caller":"traceutil/trace.go:171","msg":"trace[1523968776] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"997.76511ms","start":"2026-07-16T00:18:23.029249Z","end":"2026-07-16T00:18:24.027014Z","steps":["trace[1523968776] 'process raft request' (duration: 997.507183ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:18:24.027122Z","caller":"traceutil/trace.go:171","msg":"trace[1568552697] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:775; }","duration":"643.190469ms","start":"2026-07-16T00:18:23.383923Z","end":"2026-07-16T00:18:24.027113Z","steps":["trace[1568552697] 'agreement among raft nodes before linearized reading' (duration: 643.094907ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:18:24.027159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:18:23.383813Z","time spent":"643.336093ms","remote":"127.0.0.1:38682","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":12,"response size":30,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "} {"level":"warn","ts":"2026-07-16T00:18:24.027237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:18:23.029229Z","time spent":"997.919194ms","remote":"127.0.0.1:38682","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4026,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T00:18:56.669662Z","caller":"traceutil/trace.go:171","msg":"trace[916669750] transaction","detail":"{read_only:false; response_revision:1011; number_of_response:1; }","duration":"324.097347ms","start":"2026-07-16T00:18:56.345539Z","end":"2026-07-16T00:18:56.669636Z","steps":["trace[916669750] 'process raft request' (duration: 323.923983ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:18:56.669846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:18:56.345493Z","time spent":"324.281691ms","remote":"127.0.0.1:38732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-16T00:18:56.669898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.610154ms","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-07-16T00:18:56.670011Z","caller":"traceutil/trace.go:171","msg":"trace[31497006] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1011; }","duration":"265.769848ms","start":"2026-07-16T00:18:56.404218Z","end":"2026-07-16T00:18:56.669988Z","steps":["trace[31497006] 'agreement among raft nodes before linearized reading' (duration: 265.516082ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:18:56.670995Z","caller":"traceutil/trace.go:171","msg":"trace[519447498] linearizableReadLoop","detail":"{readStateIndex:1049; appliedIndex:1048; }","duration":"265.339819ms","start":"2026-07-16T00:18:56.404276Z","end":"2026-07-16T00:18:56.669616Z","steps":["trace[519447498] 'read index received' (duration: 265.220986ms)","trace[519447498] 'applied index is now lower than readState.Index' (duration: 117.453µs)"],"step_count":2} {"level":"warn","ts":"2026-07-16T00:18:56.785852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.047687ms","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-16T00:18:56.785967Z","caller":"traceutil/trace.go:171","msg":"trace[1920983168] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1012; }","duration":"349.18374ms","start":"2026-07-16T00:18:56.436738Z","end":"2026-07-16T00:18:56.785922Z","steps":["trace[1920983168] 'agreement among raft nodes before linearized reading' (duration: 295.952629ms)","trace[1920983168] 'range keys from in-memory index tree' (duration: 52.953716ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T00:18:56.786039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:18:56.436716Z","time spent":"349.305563ms","remote":"127.0.0.1:38732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-16T00:18:56.786061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.636716ms","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-16T00:18:56.786662Z","caller":"traceutil/trace.go:171","msg":"trace[1745460164] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1012; }","duration":"211.249829ms","start":"2026-07-16T00:18:56.575382Z","end":"2026-07-16T00:18:56.786631Z","steps":["trace[1745460164] 'agreement among raft nodes before linearized reading' (duration: 157.393665ms)","trace[1745460164] 'range keys from in-memory index tree' (duration: 53.134279ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T00:18:56.78624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.47966ms","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-07-16T00:18:56.786942Z","caller":"traceutil/trace.go:171","msg":"trace[740166740] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1012; }","duration":"193.200926ms","start":"2026-07-16T00:18:56.593717Z","end":"2026-07-16T00:18:56.786918Z","steps":["trace[740166740] 'agreement among raft nodes before linearized reading' (duration: 139.049345ms)","trace[740166740] 'range keys from in-memory index tree' (duration: 53.404225ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T00:18:56.786255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.667607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-07-16T00:18:56.787083Z","caller":"traceutil/trace.go:171","msg":"trace[1760923280] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1012; }","duration":"187.498684ms","start":"2026-07-16T00:18:56.599545Z","end":"2026-07-16T00:18:56.787043Z","steps":["trace[1760923280] 'agreement among raft nodes before linearized reading' (duration: 133.21224ms)","trace[1760923280] 'range keys from in-memory index tree' (duration: 53.388724ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T00:18:57.000228Z","caller":"traceutil/trace.go:171","msg":"trace[451604878] transaction","detail":"{read_only:false; response_revision:1015; number_of_response:1; }","duration":"207.362687ms","start":"2026-07-16T00:18:56.792845Z","end":"2026-07-16T00:18:57.000208Z","steps":["trace[451604878] 'process raft request' (duration: 206.997529ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:18:57.000376Z","caller":"traceutil/trace.go:171","msg":"trace[1969847603] transaction","detail":"{read_only:false; response_revision:1014; number_of_response:1; }","duration":"207.564031ms","start":"2026-07-16T00:18:56.792805Z","end":"2026-07-16T00:18:57.000369Z","steps":["trace[1969847603] 'process raft request' (duration: 190.850126ms)","trace[1969847603] 'compare' (duration: 16.050841ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T00:18:57.00036Z","caller":"traceutil/trace.go:171","msg":"trace[1494832537] transaction","detail":"{read_only:false; response_revision:1016; number_of_response:1; }","duration":"206.849425ms","start":"2026-07-16T00:18:56.793431Z","end":"2026-07-16T00:18:57.000281Z","steps":["trace[1494832537] 'process raft request' (duration: 206.543059ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:18:57.328878Z","caller":"traceutil/trace.go:171","msg":"trace[1359081391] transaction","detail":"{read_only:false; response_revision:1018; number_of_response:1; }","duration":"247.539263ms","start":"2026-07-16T00:18:57.081309Z","end":"2026-07-16T00:18:57.328848Z","steps":["trace[1359081391] 'process raft request' (duration: 225.979817ms)","trace[1359081391] 'compare' (duration: 21.406713ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T00:18:57.665153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.175773ms","expected-duration":"100ms","prefix":"","request":"header: txn: success: > failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-16T00:18:57.665257Z","caller":"traceutil/trace.go:171","msg":"trace[1653902150] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1019; }","duration":"333.391586ms","start":"2026-07-16T00:18:57.331848Z","end":"2026-07-16T00:18:57.66524Z","steps":["trace[1653902150] 'process raft request' (duration: 183.994699ms)","trace[1653902150] 'compare' (duration: 149.079121ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T00:18:57.665319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:18:57.331822Z","time spent":"333.465678ms","remote":"127.0.0.1:38682","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":80,"response count":0,"response size":41,"request content":"compare: success: > failure: >"} {"level":"info","ts":"2026-07-16T00:18:57.807456Z","caller":"traceutil/trace.go:171","msg":"trace[1252432981] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1020; }","duration":"132.600633ms","start":"2026-07-16T00:18:57.674826Z","end":"2026-07-16T00:18:57.807426Z","steps":["trace[1252432981] 'process raft request' (duration: 103.976458ms)","trace[1252432981] 'compare' (duration: 28.531213ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T00:19:57.542388Z","caller":"traceutil/trace.go:171","msg":"trace[1969201363] linearizableReadLoop","detail":"{readStateIndex:1267; appliedIndex:1266; }","duration":"170.140129ms","start":"2026-07-16T00:19:57.372224Z","end":"2026-07-16T00:19:57.542364Z","steps":["trace[1969201363] 'read index received' (duration: 169.986456ms)","trace[1969201363] 'applied index is now lower than readState.Index' (duration: 152.563µs)"],"step_count":2} {"level":"info","ts":"2026-07-16T00:19:57.542435Z","caller":"traceutil/trace.go:171","msg":"trace[1097813618] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"190.819159ms","start":"2026-07-16T00:19:57.351585Z","end":"2026-07-16T00:19:57.542404Z","steps":["trace[1097813618] 'process raft request' (duration: 190.615016ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:19:57.54264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.690319ms","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-07-16T00:19:57.542671Z","caller":"traceutil/trace.go:171","msg":"trace[1535447102] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1216; }","duration":"121.763981ms","start":"2026-07-16T00:19:57.4209Z","end":"2026-07-16T00:19:57.542664Z","steps":["trace[1535447102] 'agreement among raft nodes before linearized reading' (duration: 121.636479ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:19:57.542802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.554127ms","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-16T00:19:57.543051Z","caller":"traceutil/trace.go:171","msg":"trace[1280707014] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1216; }","duration":"170.848451ms","start":"2026-07-16T00:19:57.372181Z","end":"2026-07-16T00:19:57.543029Z","steps":["trace[1280707014] 'agreement among raft nodes before linearized reading' (duration: 170.338932ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:20:09.930418Z","caller":"traceutil/trace.go:171","msg":"trace[324103718] linearizableReadLoop","detail":"{readStateIndex:1341; appliedIndex:1340; }","duration":"247.624146ms","start":"2026-07-16T00:20:09.682763Z","end":"2026-07-16T00:20:09.930387Z","steps":["trace[324103718] 'read index received' (duration: 247.433173ms)","trace[324103718] 'applied index is now lower than readState.Index' (duration: 186.553µs)"],"step_count":2} {"level":"info","ts":"2026-07-16T00:20:09.930484Z","caller":"traceutil/trace.go:171","msg":"trace[847704439] transaction","detail":"{read_only:false; response_revision:1287; number_of_response:1; }","duration":"248.572422ms","start":"2026-07-16T00:20:09.681875Z","end":"2026-07-16T00:20:09.930447Z","steps":["trace[847704439] 'process raft request' (duration: 248.309137ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:20:09.930663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.87009ms","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-16T00:20:09.930718Z","caller":"traceutil/trace.go:171","msg":"trace[1984172151] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1287; }","duration":"247.958981ms","start":"2026-07-16T00:20:09.682747Z","end":"2026-07-16T00:20:09.930706Z","steps":["trace[1984172151] 'agreement among raft nodes before linearized reading' (duration: 247.766688ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:20:10.220254Z","caller":"traceutil/trace.go:171","msg":"trace[94396827] transaction","detail":"{read_only:false; response_revision:1288; number_of_response:1; }","duration":"536.823779ms","start":"2026-07-16T00:20:09.683399Z","end":"2026-07-16T00:20:10.220223Z","steps":["trace[94396827] 'process raft request' (duration: 536.367691ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:20:10.220706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:20:09.683392Z","time spent":"537.024412ms","remote":"127.0.0.1:38732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T00:20:10.222148Z","caller":"traceutil/trace.go:171","msg":"trace[1394258626] linearizableReadLoop","detail":"{readStateIndex:1343; appliedIndex:1341; }","duration":"251.897318ms","start":"2026-07-16T00:20:09.970222Z","end":"2026-07-16T00:20:10.22212Z","steps":["trace[1394258626] 'read index received' (duration: 249.531399ms)","trace[1394258626] 'applied index is now lower than readState.Index' (duration: 2.364999ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T00:20:10.222355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.108612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-16T00:20:10.222385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.362152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-16T00:20:10.222453Z","caller":"traceutil/trace.go:171","msg":"trace[666488260] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:1289; }","duration":"211.446593ms","start":"2026-07-16T00:20:10.010992Z","end":"2026-07-16T00:20:10.222438Z","steps":["trace[666488260] 'agreement among raft nodes before linearized reading' (duration: 211.324261ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:20:10.222413Z","caller":"traceutil/trace.go:171","msg":"trace[1075633678] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1289; }","duration":"252.219023ms","start":"2026-07-16T00:20:09.970177Z","end":"2026-07-16T00:20:10.222396Z","steps":["trace[1075633678] 'agreement among raft nodes before linearized reading' (duration: 252.084361ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:20:10.22273Z","caller":"traceutil/trace.go:171","msg":"trace[2075421496] transaction","detail":"{read_only:false; response_revision:1289; number_of_response:1; }","duration":"287.22823ms","start":"2026-07-16T00:20:09.934981Z","end":"2026-07-16T00:20:10.222209Z","steps":["trace[2075421496] 'process raft request' (duration: 287.013477ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:20:17.543547Z","caller":"traceutil/trace.go:171","msg":"trace[360288161] transaction","detail":"{read_only:false; response_revision:1316; number_of_response:1; }","duration":"252.584081ms","start":"2026-07-16T00:20:17.290941Z","end":"2026-07-16T00:20:17.543525Z","steps":["trace[360288161] 'process raft request' (duration: 252.448589ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:20:17.593227Z","caller":"traceutil/trace.go:171","msg":"trace[24285430] transaction","detail":"{read_only:false; response_revision:1317; number_of_response:1; }","duration":"300.512618ms","start":"2026-07-16T00:20:17.292695Z","end":"2026-07-16T00:20:17.593208Z","steps":["trace[24285430] 'process raft request' (duration: 300.399796ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:20:17.593335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:20:17.292671Z","time spent":"300.606299ms","remote":"127.0.0.1:38732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T00:20:18.357643Z","caller":"traceutil/trace.go:171","msg":"trace[1708498593] transaction","detail":"{read_only:false; response_revision:1319; number_of_response:1; }","duration":"104.677542ms","start":"2026-07-16T00:20:18.252937Z","end":"2026-07-16T00:20:18.357615Z","steps":["trace[1708498593] 'process raft request' (duration: 104.499119ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:20:18.368557Z","caller":"traceutil/trace.go:171","msg":"trace[1908006749] transaction","detail":"{read_only:false; response_revision:1320; number_of_response:1; }","duration":"115.416526ms","start":"2026-07-16T00:20:18.253122Z","end":"2026-07-16T00:20:18.368539Z","steps":["trace[1908006749] 'process raft request' (duration: 115.019879ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:20:18.698434Z","caller":"traceutil/trace.go:171","msg":"trace[1230318551] transaction","detail":"{read_only:false; response_revision:1322; number_of_response:1; }","duration":"277.857462ms","start":"2026-07-16T00:20:18.420512Z","end":"2026-07-16T00:20:18.69837Z","steps":["trace[1230318551] 'process raft request' (duration: 187.523521ms)","trace[1230318551] 'compare' (duration: 90.159438ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T00:20:20.099889Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933267209678804427,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-16T00:20:20.11763Z","caller":"traceutil/trace.go:171","msg":"trace[1218673622] linearizableReadLoop","detail":"{readStateIndex:1380; appliedIndex:1379; }","duration":"518.064386ms","start":"2026-07-16T00:20:19.599536Z","end":"2026-07-16T00:20:20.1176Z","steps":["trace[1218673622] 'read index received' (duration: 517.805901ms)","trace[1218673622] 'applied index is now lower than readState.Index' (duration: 257.104µs)"],"step_count":2} {"level":"info","ts":"2026-07-16T00:20:20.117722Z","caller":"traceutil/trace.go:171","msg":"trace[943456422] transaction","detail":"{read_only:false; response_revision:1324; number_of_response:1; }","duration":"567.082406ms","start":"2026-07-16T00:20:19.550611Z","end":"2026-07-16T00:20:20.117693Z","steps":["trace[943456422] 'process raft request' (duration: 566.72585ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:20:20.117943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.404971ms","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-07-16T00:20:20.118039Z","caller":"traceutil/trace.go:171","msg":"trace[1210310645] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1324; }","duration":"518.525363ms","start":"2026-07-16T00:20:19.599493Z","end":"2026-07-16T00:20:20.118018Z","steps":["trace[1210310645] 'agreement among raft nodes before linearized reading' (duration: 518.250149ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:20:20.118086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:20:19.550599Z","time spent":"567.396351ms","remote":"127.0.0.1:38732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-16T00:20:20.118104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:20:19.599477Z","time spent":"518.608414ms","remote":"127.0.0.1:38732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-16T00:20:20.117842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.30056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-16T00:20:20.118186Z","caller":"traceutil/trace.go:171","msg":"trace[1193361634] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1324; }","duration":"148.703507ms","start":"2026-07-16T00:20:19.969467Z","end":"2026-07-16T00:20:20.118171Z","steps":["trace[1193361634] 'agreement among raft nodes before linearized reading' (duration: 148.31545ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:20:20.117967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.307555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-07-16T00:20:20.118231Z","caller":"traceutil/trace.go:171","msg":"trace[294785874] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1324; }","duration":"131.61657ms","start":"2026-07-16T00:20:19.9866Z","end":"2026-07-16T00:20:20.118217Z","steps":["trace[294785874] 'agreement among raft nodes before linearized reading' (duration: 131.194914ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:20:42.836443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.990633ms","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-07-16T00:20:42.836522Z","caller":"traceutil/trace.go:171","msg":"trace[15381866] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1404; }","duration":"355.107706ms","start":"2026-07-16T00:20:42.481396Z","end":"2026-07-16T00:20:42.836504Z","steps":["trace[15381866] 'range keys from in-memory index tree' (duration: 354.817541ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:20:42.836561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:20:42.481378Z","time spent":"355.173856ms","remote":"127.0.0.1:38732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-16T00:20:42.836577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.417297ms","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-16T00:20:42.836603Z","caller":"traceutil/trace.go:171","msg":"trace[34213006] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1404; }","duration":"358.476718ms","start":"2026-07-16T00:20:42.478118Z","end":"2026-07-16T00:20:42.836595Z","steps":["trace[34213006] 'range keys from in-memory index tree' (duration: 358.327325ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:20:42.836617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:20:42.478103Z","time spent":"358.511308ms","remote":"127.0.0.1:38732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-16T00:20:42.836609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.945824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/kube-system/\" range_end:\"/registry/statefulsets/kube-system0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-16T00:20:42.836667Z","caller":"traceutil/trace.go:171","msg":"trace[83922723] range","detail":"{range_begin:/registry/statefulsets/kube-system/; range_end:/registry/statefulsets/kube-system0; response_count:0; response_revision:1404; }","duration":"411.053886ms","start":"2026-07-16T00:20:42.425597Z","end":"2026-07-16T00:20:42.836651Z","steps":["trace[83922723] 'range keys from in-memory index tree' (duration: 410.866202ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:20:42.83669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:20:42.425547Z","time spent":"411.137107ms","remote":"127.0.0.1:38934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":77,"response count":0,"response size":28,"request content":"key:\"/registry/statefulsets/kube-system/\" range_end:\"/registry/statefulsets/kube-system0\" limit:500 "} {"level":"warn","ts":"2026-07-16T00:20:42.837057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.319677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/kube-proxy\" ","response":"range_response_count:1 size:2918"} {"level":"warn","ts":"2026-07-16T00:20:42.837072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.583935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/cilium-operator\" ","response":"range_response_count:1 size:4709"} {"level":"info","ts":"2026-07-16T00:20:42.837145Z","caller":"traceutil/trace.go:171","msg":"trace[580961852] range","detail":"{range_begin:/registry/daemonsets/kube-system/kube-proxy; range_end:; response_count:1; response_revision:1404; }","duration":"414.440518ms","start":"2026-07-16T00:20:42.422684Z","end":"2026-07-16T00:20:42.837124Z","steps":["trace[580961852] 'range keys from in-memory index tree' (duration: 413.687657ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:20:42.83719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:20:42.422668Z","time spent":"414.513ms","remote":"127.0.0.1:38950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":2941,"request content":"key:\"/registry/daemonsets/kube-system/kube-proxy\" "} {"level":"info","ts":"2026-07-16T00:20:42.837206Z","caller":"traceutil/trace.go:171","msg":"trace[672588773] range","detail":"{range_begin:/registry/deployments/kube-system/cilium-operator; range_end:; response_count:1; response_revision:1404; }","duration":"458.699617ms","start":"2026-07-16T00:20:42.378433Z","end":"2026-07-16T00:20:42.837132Z","steps":["trace[672588773] 'range keys from in-memory index tree' (duration: 457.919824ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:20:42.83725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:20:42.378415Z","time spent":"458.823519ms","remote":"127.0.0.1:38922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":1,"response size":4732,"request content":"key:\"/registry/deployments/kube-system/cilium-operator\" "} {"level":"info","ts":"2026-07-16T00:20:43.374734Z","caller":"traceutil/trace.go:171","msg":"trace[1018577103] transaction","detail":"{read_only:false; response_revision:1407; number_of_response:1; }","duration":"316.161663ms","start":"2026-07-16T00:20:43.058559Z","end":"2026-07-16T00:20:43.374721Z","steps":["trace[1018577103] 'process raft request' (duration: 315.935489ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:20:43.374864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:20:43.058539Z","time spent":"316.248794ms","remote":"127.0.0.1:38732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-16T00:20:43.375059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.141445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-16T00:20:43.375121Z","caller":"traceutil/trace.go:171","msg":"trace[1570623851] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1407; }","duration":"313.218728ms","start":"2026-07-16T00:20:43.061886Z","end":"2026-07-16T00:20:43.375105Z","steps":["trace[1570623851] 'agreement among raft nodes before linearized reading' (duration: 313.126606ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:20:43.375148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:20:43.061874Z","time spent":"313.268768ms","remote":"127.0.0.1:38484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-16T00:20:43.374655Z","caller":"traceutil/trace.go:171","msg":"trace[1149880114] linearizableReadLoop","detail":"{readStateIndex:1469; appliedIndex:1468; }","duration":"312.732559ms","start":"2026-07-16T00:20:43.061901Z","end":"2026-07-16T00:20:43.374634Z","steps":["trace[1149880114] 'read index received' (duration: 312.556426ms)","trace[1149880114] 'applied index is now lower than readState.Index' (duration: 175.293µs)"],"step_count":2} {"level":"info","ts":"2026-07-16T00:20:43.393235Z","caller":"traceutil/trace.go:171","msg":"trace[216565794] transaction","detail":"{read_only:false; response_revision:1408; number_of_response:1; }","duration":"223.357461ms","start":"2026-07-16T00:20:43.169861Z","end":"2026-07-16T00:20:43.393219Z","steps":["trace[216565794] 'process raft request' (duration: 223.213929ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:20:43.393293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.75948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:3760"} {"level":"info","ts":"2026-07-16T00:20:43.393341Z","caller":"traceutil/trace.go:171","msg":"trace[1397205926] range","detail":"{range_begin:/registry/deployments/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:1408; }","duration":"256.845692ms","start":"2026-07-16T00:20:43.13648Z","end":"2026-07-16T00:20:43.393326Z","steps":["trace[1397205926] 'agreement among raft nodes before linearized reading' (duration: 256.695189ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:20:43.393429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.194701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4219"} {"level":"info","ts":"2026-07-16T00:20:43.393454Z","caller":"traceutil/trace.go:171","msg":"trace[1923957137] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:1408; }","duration":"256.252132ms","start":"2026-07-16T00:20:43.137194Z","end":"2026-07-16T00:20:43.393447Z","steps":["trace[1923957137] 'agreement among raft nodes before linearized reading' (duration: 256.14661ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:20:50.524584Z","caller":"traceutil/trace.go:171","msg":"trace[2091695983] transaction","detail":"{read_only:false; response_revision:1430; number_of_response:1; }","duration":"109.297083ms","start":"2026-07-16T00:20:50.415232Z","end":"2026-07-16T00:20:50.524529Z","steps":["trace[2091695983] 'process raft request' (duration: 109.117191ms)"],"step_count":1}