{"level":"warn","ts":"2026-07-09T09:23:31.415632Z","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-09T09:23:31.415772Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.166:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.166:2380","--initial-cluster=instance=https://199.19.213.166:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.166:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.166: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-09T09:23:31.415873Z","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-09T09:23:31.41589Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.166:2380"]} {"level":"info","ts":"2026-07-09T09:23:31.415918Z","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-09T09:23:31.41658Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.166:2379"]} {"level":"info","ts":"2026-07-09T09:23:31.416661Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.166:2380"],"listen-peer-urls":["https://199.19.213.166:2380"],"advertise-client-urls":["https://199.19.213.166:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.166:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.166: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-09T09:23:31.419239Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.295037ms"} {"level":"info","ts":"2026-07-09T09:23:31.425088Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6a8829716614d67b","cluster-id":"95303c3f9d508ee2"} {"level":"info","ts":"2026-07-09T09:23:31.42524Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a8829716614d67b switched to configuration voters=()"} {"level":"info","ts":"2026-07-09T09:23:31.425281Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a8829716614d67b became follower at term 0"} {"level":"info","ts":"2026-07-09T09:23:31.425304Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6a8829716614d67b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-09T09:23:31.425326Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a8829716614d67b became follower at term 1"} {"level":"info","ts":"2026-07-09T09:23:31.425392Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a8829716614d67b switched to configuration voters=(7676431131873695355)"} {"level":"warn","ts":"2026-07-09T09:23:31.435989Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-09T09:23:31.437485Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-09T09:23:31.441303Z","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-09T09:23:31.443242Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6a8829716614d67b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-09T09:23:31.444053Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6a8829716614d67b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-09T09:23:31.444204Z","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-09T09:23:31.444476Z","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-09T09:23:31.444503Z","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-09T09:23:31.446662Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a8829716614d67b switched to configuration voters=(7676431131873695355)"} {"level":"info","ts":"2026-07-09T09:23:31.446853Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"95303c3f9d508ee2","local-member-id":"6a8829716614d67b","added-peer-id":"6a8829716614d67b","added-peer-peer-urls":["https://199.19.213.166:2380"]} {"level":"info","ts":"2026-07-09T09:23:31.448444Z","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-09T09:23:31.44878Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6a8829716614d67b","initial-advertise-peer-urls":["https://199.19.213.166:2380"],"listen-peer-urls":["https://199.19.213.166:2380"],"advertise-client-urls":["https://199.19.213.166:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.166:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-09T09:23:31.448823Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-09T09:23:31.448978Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.166:2380"} {"level":"info","ts":"2026-07-09T09:23:31.449051Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.166:2380"} {"level":"info","ts":"2026-07-09T09:23:32.425778Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a8829716614d67b is starting a new election at term 1"} {"level":"info","ts":"2026-07-09T09:23:32.425839Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a8829716614d67b became pre-candidate at term 1"} {"level":"info","ts":"2026-07-09T09:23:32.425874Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a8829716614d67b received MsgPreVoteResp from 6a8829716614d67b at term 1"} {"level":"info","ts":"2026-07-09T09:23:32.425893Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a8829716614d67b became candidate at term 2"} {"level":"info","ts":"2026-07-09T09:23:32.425906Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a8829716614d67b received MsgVoteResp from 6a8829716614d67b at term 2"} {"level":"info","ts":"2026-07-09T09:23:32.425922Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a8829716614d67b became leader at term 2"} {"level":"info","ts":"2026-07-09T09:23:32.425943Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6a8829716614d67b elected leader 6a8829716614d67b at term 2"} {"level":"info","ts":"2026-07-09T09:23:32.482981Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-09T09:23:32.506232Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-09T09:23:32.506285Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-09T09:23:32.506226Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6a8829716614d67b","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.166:2379]}","request-path":"/0/members/6a8829716614d67b/attributes","cluster-id":"95303c3f9d508ee2","publish-timeout":"7s"} {"level":"info","ts":"2026-07-09T09:23:32.506688Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-09T09:23:32.506768Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-09T09:23:32.507112Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"95303c3f9d508ee2","local-member-id":"6a8829716614d67b","cluster-version":"3.5"} {"level":"info","ts":"2026-07-09T09:23:32.50755Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-09T09:23:32.507637Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-09T09:23:32.509535Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.166:2379"} {"level":"info","ts":"2026-07-09T09:23:32.510631Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-07-09T09:23:35.93626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"655.308942ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"warn","ts":"2026-07-09T09:23:35.936529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:23:35.348468Z","time spent":"588.055729ms","remote":"127.0.0.1:37286","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-07-09T09:23:35.93658Z","caller":"traceutil/trace.go:171","msg":"trace[830714552] transaction","detail":"{read_only:false; response_revision:90; number_of_response:1; }","duration":"748.279104ms","start":"2026-07-09T09:23:35.188235Z","end":"2026-07-09T09:23:35.936514Z","steps":["trace[830714552] 'process raft request' (duration: 92.208093ms)","trace[830714552] 'compare' (duration: 655.104207ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T09:23:35.936806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:23:35.18821Z","time spent":"748.504229ms","remote":"127.0.0.1:37576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":638,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-09T09:23:36.82762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.654342ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-07-09T09:23:36.827779Z","caller":"traceutil/trace.go:171","msg":"trace[1265160948] linearizableReadLoop","detail":"{readStateIndex:96; appliedIndex:95; }","duration":"887.674557ms","start":"2026-07-09T09:23:35.94008Z","end":"2026-07-09T09:23:36.827754Z","steps":["trace[1265160948] 'read index received' (duration: 451.659276ms)","trace[1265160948] 'applied index is now lower than readState.Index' (duration: 436.013481ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T09:23:36.827802Z","caller":"traceutil/trace.go:171","msg":"trace[1263180047] transaction","detail":"{read_only:false; response_revision:91; number_of_response:1; }","duration":"889.822151ms","start":"2026-07-09T09:23:35.937949Z","end":"2026-07-09T09:23:36.827771Z","steps":["trace[1263180047] 'process raft request' (duration: 453.914613ms)","trace[1263180047] 'compare' (duration: 435.451127ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T09:23:36.827928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:23:35.937926Z","time spent":"889.939085ms","remote":"127.0.0.1:37286","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":592,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-09T09:23:36.828054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"887.932013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:kube-aggregator\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-09T09:23:36.828087Z","caller":"traceutil/trace.go:171","msg":"trace[1067615809] range","detail":"{range_begin:/registry/clusterroles/system:kube-aggregator; range_end:; response_count:0; response_revision:91; }","duration":"888.047686ms","start":"2026-07-09T09:23:35.940028Z","end":"2026-07-09T09:23:36.828076Z","steps":["trace[1067615809] 'agreement among raft nodes before linearized reading' (duration: 887.860172ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:23:36.828122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:23:35.940012Z","time spent":"888.102257ms","remote":"127.0.0.1:37576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/system:kube-aggregator\" "} {"level":"warn","ts":"2026-07-09T09:23:36.828154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.359638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-09T09:23:36.828278Z","caller":"traceutil/trace.go:171","msg":"trace[1491993273] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:91; }","duration":"532.570122ms","start":"2026-07-09T09:23:36.295678Z","end":"2026-07-09T09:23:36.828248Z","steps":["trace[1491993273] 'agreement among raft nodes before linearized reading' (duration: 532.389248ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:23:36.828334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:23:36.295649Z","time spent":"532.676745ms","remote":"127.0.0.1:37518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-09T09:23:36.828799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"559.345538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-09T09:23:36.828868Z","caller":"traceutil/trace.go:171","msg":"trace[1128907139] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:91; }","duration":"559.4771ms","start":"2026-07-09T09:23:36.269367Z","end":"2026-07-09T09:23:36.828844Z","steps":["trace[1128907139] 'agreement among raft nodes before linearized reading' (duration: 558.594269ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:23:36.828903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:23:36.269333Z","time spent":"559.561173ms","remote":"127.0.0.1:37216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-09T09:23:37.216691Z","caller":"traceutil/trace.go:171","msg":"trace[892396060] transaction","detail":"{read_only:false; response_revision:92; number_of_response:1; }","duration":"383.607684ms","start":"2026-07-09T09:23:36.83304Z","end":"2026-07-09T09:23:37.216647Z","steps":["trace[892396060] 'process raft request' (duration: 349.147436ms)","trace[892396060] 'compare' (duration: 34.316024ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T09:23:37.216859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:23:36.833023Z","time spent":"383.759357ms","remote":"127.0.0.1:37576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":582,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-09T09:23:37.217379Z","caller":"traceutil/trace.go:171","msg":"trace[1905934254] transaction","detail":"{read_only:false; response_revision:93; number_of_response:1; }","duration":"383.431739ms","start":"2026-07-09T09:23:36.833933Z","end":"2026-07-09T09:23:37.217365Z","steps":["trace[1905934254] 'process raft request' (duration: 382.924646ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:23:37.217466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:23:36.833892Z","time spent":"383.532002ms","remote":"127.0.0.1:37286","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":625,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-09T09:23:37.217524Z","caller":"traceutil/trace.go:171","msg":"trace[857705836] transaction","detail":"{read_only:false; response_revision:94; number_of_response:1; }","duration":"382.997899ms","start":"2026-07-09T09:23:36.834476Z","end":"2026-07-09T09:23:37.217474Z","steps":["trace[857705836] 'process raft request' (duration: 382.589888ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:23:37.217756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:23:36.834457Z","time spent":"383.197943ms","remote":"127.0.0.1:37518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-09T09:23:37.45647Z","caller":"traceutil/trace.go:171","msg":"trace[1778052130] transaction","detail":"{read_only:false; response_revision:95; number_of_response:1; }","duration":"233.981333ms","start":"2026-07-09T09:23:37.222459Z","end":"2026-07-09T09:23:37.45644Z","steps":["trace[1778052130] 'process raft request' (duration: 233.789048ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:23:37.458042Z","caller":"traceutil/trace.go:171","msg":"trace[1577909253] linearizableReadLoop","detail":"{readStateIndex:101; appliedIndex:99; }","duration":"234.524036ms","start":"2026-07-09T09:23:37.22349Z","end":"2026-07-09T09:23:37.458014Z","steps":["trace[1577909253] 'read index received' (duration: 232.784272ms)","trace[1577909253] 'applied index is now lower than readState.Index' (duration: 1.738744ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T09:23:37.458181Z","caller":"traceutil/trace.go:171","msg":"trace[396793212] transaction","detail":"{read_only:false; response_revision:97; number_of_response:1; }","duration":"234.171378ms","start":"2026-07-09T09:23:37.223991Z","end":"2026-07-09T09:23:37.458162Z","steps":["trace[396793212] 'process raft request' (duration: 233.979294ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:23:37.458351Z","caller":"traceutil/trace.go:171","msg":"trace[280899250] transaction","detail":"{read_only:false; response_revision:96; number_of_response:1; }","duration":"235.300477ms","start":"2026-07-09T09:23:37.22301Z","end":"2026-07-09T09:23:37.45831Z","steps":["trace[280899250] 'process raft request' (duration: 234.810074ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:23:37.458409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.890365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-07-09T09:23:37.4585Z","caller":"traceutil/trace.go:171","msg":"trace[1851358002] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:97; }","duration":"235.02273ms","start":"2026-07-09T09:23:37.223465Z","end":"2026-07-09T09:23:37.458488Z","steps":["trace[1851358002] 'agreement among raft nodes before linearized reading' (duration: 234.836304ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:24:15.686691Z","caller":"traceutil/trace.go:171","msg":"trace[2130372607] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"347.586264ms","start":"2026-07-09T09:24:15.338983Z","end":"2026-07-09T09:24:15.686569Z","steps":["trace[2130372607] 'process raft request' (duration: 347.404919ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:24:15.686954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:24:15.338948Z","time spent":"347.900762ms","remote":"127.0.0.1:37264","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-09T09:24:15.697236Z","caller":"traceutil/trace.go:171","msg":"trace[580895914] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"357.338349ms","start":"2026-07-09T09:24:15.339855Z","end":"2026-07-09T09:24:15.697193Z","steps":["trace[580895914] 'process raft request' (duration: 357.125344ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:24:15.69752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:24:15.339823Z","time spent":"357.513404ms","remote":"127.0.0.1:37264","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-09T09:24:15.697686Z","caller":"traceutil/trace.go:171","msg":"trace[754063780] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"333.175092ms","start":"2026-07-09T09:24:15.364497Z","end":"2026-07-09T09:24:15.697672Z","steps":["trace[754063780] 'process raft request' (duration: 332.825262ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:24:15.697761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:24:15.364453Z","time spent":"333.267834ms","remote":"127.0.0.1:37264","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-09T09:24:15.697833Z","caller":"traceutil/trace.go:171","msg":"trace[1447159741] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"355.071732ms","start":"2026-07-09T09:24:15.342754Z","end":"2026-07-09T09:24:15.697826Z","steps":["trace[1447159741] 'process raft request' (duration: 354.357024ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:24:15.697881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:24:15.342742Z","time spent":"355.118853ms","remote":"127.0.0.1:37264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-09T09:24:15.698595Z","caller":"traceutil/trace.go:171","msg":"trace[1796519740] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"312.296425ms","start":"2026-07-09T09:24:15.386243Z","end":"2026-07-09T09:24:15.69854Z","steps":["trace[1796519740] 'process raft request' (duration: 311.400023ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:24:15.698803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:24:15.386218Z","time spent":"312.48066ms","remote":"127.0.0.1:37264","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-09T09:24:15.6989Z","caller":"traceutil/trace.go:171","msg":"trace[996774107] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"329.435117ms","start":"2026-07-09T09:24:15.369414Z","end":"2026-07-09T09:24:15.698849Z","steps":["trace[996774107] 'process raft request' (duration: 327.98632ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:24:15.699127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:24:15.369387Z","time spent":"329.653922ms","remote":"127.0.0.1:37264","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-09T09:24:15.699339Z","caller":"traceutil/trace.go:171","msg":"trace[1613392068] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"348.278092ms","start":"2026-07-09T09:24:15.351048Z","end":"2026-07-09T09:24:15.699326Z","steps":["trace[1613392068] 'process raft request' (duration: 346.131388ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:24:15.699388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:24:15.351023Z","time spent":"348.339793ms","remote":"127.0.0.1:37264","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-09T09:24:15.699397Z","caller":"traceutil/trace.go:171","msg":"trace[1049901238] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"243.396219ms","start":"2026-07-09T09:24:15.455987Z","end":"2026-07-09T09:24:15.699383Z","steps":["trace[1049901238] 'process raft request' (duration: 242.010714ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:24:15.699394Z","caller":"traceutil/trace.go:171","msg":"trace[1045927824] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"329.831267ms","start":"2026-07-09T09:24:15.369542Z","end":"2026-07-09T09:24:15.699373Z","steps":["trace[1045927824] 'process raft request' (duration: 327.949699ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:24:15.699463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:24:15.369534Z","time spent":"329.901138ms","remote":"127.0.0.1:37264","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-09T09:24:15.69947Z","caller":"traceutil/trace.go:171","msg":"trace[1349142838] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"306.461259ms","start":"2026-07-09T09:24:15.392997Z","end":"2026-07-09T09:24:15.699458Z","steps":["trace[1349142838] 'process raft request' (duration: 304.798007ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:24:15.699505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:24:15.39296Z","time spent":"306.529791ms","remote":"127.0.0.1:37264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-09T09:24:15.70007Z","caller":"traceutil/trace.go:171","msg":"trace[337792993] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"334.128615ms","start":"2026-07-09T09:24:15.365138Z","end":"2026-07-09T09:24:15.699267Z","steps":["trace[337792993] 'process raft request' (duration: 332.222227ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:24:15.700122Z","caller":"traceutil/trace.go:171","msg":"trace[666181699] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"139.276538ms","start":"2026-07-09T09:24:15.560833Z","end":"2026-07-09T09:24:15.70011Z","steps":["trace[666181699] 'process raft request' (duration: 137.244466ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:24:15.700142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:24:15.365114Z","time spent":"334.995787ms","remote":"127.0.0.1:37264","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-09T09:24:15.708523Z","caller":"traceutil/trace.go:171","msg":"trace[549335233] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"130.298141ms","start":"2026-07-09T09:24:15.578201Z","end":"2026-07-09T09:24:15.7085Z","steps":["trace[549335233] 'process raft request' (duration: 128.764373ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:24:15.709123Z","caller":"traceutil/trace.go:171","msg":"trace[1930493260] linearizableReadLoop","detail":"{readStateIndex:564; appliedIndex:554; }","duration":"161.65157ms","start":"2026-07-09T09:24:15.547457Z","end":"2026-07-09T09:24:15.709108Z","steps":["trace[1930493260] 'read index received' (duration: 139.122053ms)","trace[1930493260] 'applied index is now lower than readState.Index' (duration: 22.527387ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T09:24:15.710188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.734188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-09T09:24:15.710234Z","caller":"traceutil/trace.go:171","msg":"trace[2092727782] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:546; }","duration":"162.843681ms","start":"2026-07-09T09:24:15.547378Z","end":"2026-07-09T09:24:15.710222Z","steps":["trace[2092727782] 'agreement among raft nodes before linearized reading' (duration: 162.626475ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:24:15.738013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.2065ms","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-09T09:24:15.7381Z","caller":"traceutil/trace.go:171","msg":"trace[60708129] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:547; }","duration":"140.350664ms","start":"2026-07-09T09:24:15.597728Z","end":"2026-07-09T09:24:15.738079Z","steps":["trace[60708129] 'agreement among raft nodes before linearized reading' (duration: 121.024138ms)","trace[60708129] 'range keys from in-memory index tree' (duration: 19.09316ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T09:24:23.193694Z","caller":"traceutil/trace.go:171","msg":"trace[1570722331] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"222.863493ms","start":"2026-07-09T09:24:22.970282Z","end":"2026-07-09T09:24:23.193145Z","steps":["trace[1570722331] 'process raft request' (duration: 221.90405ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:24:24.649961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.207036363s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-09T09:24:24.650215Z","caller":"traceutil/trace.go:171","msg":"trace[725824141] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"1.398385121s","start":"2026-07-09T09:24:23.251765Z","end":"2026-07-09T09:24:24.650151Z","steps":["trace[725824141] 'process raft request' (duration: 191.051903ms)","trace[725824141] 'compare' (duration: 1.206667891s)"],"step_count":2} {"level":"info","ts":"2026-07-09T09:24:24.650265Z","caller":"traceutil/trace.go:171","msg":"trace[1453112452] linearizableReadLoop","detail":"{readStateIndex:671; appliedIndex:670; }","duration":"1.319449803s","start":"2026-07-09T09:24:23.330751Z","end":"2026-07-09T09:24:24.650201Z","steps":["trace[1453112452] 'read index received' (duration: 111.97715ms)","trace[1453112452] 'applied index is now lower than readState.Index' (duration: 1.207465713s)"],"step_count":2} {"level":"warn","ts":"2026-07-09T09:24:24.650561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:24:23.25173Z","time spent":"1.398681838s","remote":"127.0.0.1:37484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-09T09:24:24.967474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.351532ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"warn","ts":"2026-07-09T09:24:24.967512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.636721952s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T09:24:24.967612Z","caller":"traceutil/trace.go:171","msg":"trace[779042085] linearizableReadLoop","detail":"{readStateIndex:672; appliedIndex:671; }","duration":"317.199568ms","start":"2026-07-09T09:24:24.650386Z","end":"2026-07-09T09:24:24.967585Z","steps":["trace[779042085] 'read index received' (duration: 96.064µs)","trace[779042085] 'applied index is now lower than readState.Index' (duration: 317.101624ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T09:24:24.967617Z","caller":"traceutil/trace.go:171","msg":"trace[35416246] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:646; }","duration":"1.636893256s","start":"2026-07-09T09:24:23.330696Z","end":"2026-07-09T09:24:24.96759Z","steps":["trace[35416246] 'agreement among raft nodes before linearized reading' (duration: 1.319758611s)","trace[35416246] 'range keys from in-memory index tree' (duration: 316.969802ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T09:24:24.967686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:24:23.33067Z","time spent":"1.637005789s","remote":"127.0.0.1:37216","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-09T09:24:24.967895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.111550345s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-09T09:24:24.967951Z","caller":"traceutil/trace.go:171","msg":"trace[545072672] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:646; }","duration":"1.111685257s","start":"2026-07-09T09:24:23.856248Z","end":"2026-07-09T09:24:24.967933Z","steps":["trace[545072672] 'agreement among raft nodes before linearized reading' (duration: 1.111467491s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:24:24.968007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:24:23.856194Z","time spent":"1.111798961s","remote":"127.0.0.1:37518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-09T09:24:24.96792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.034414ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-09T09:24:24.968071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.604897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"warn","ts":"2026-07-09T09:24:24.967919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.105860401s","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-09T09:24:24.968128Z","caller":"traceutil/trace.go:171","msg":"trace[2052603288] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:646; }","duration":"1.106167399s","start":"2026-07-09T09:24:23.86195Z","end":"2026-07-09T09:24:24.968117Z","steps":["trace[2052603288] 'agreement among raft nodes before linearized reading' (duration: 1.105712987s)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:24:24.968138Z","caller":"traceutil/trace.go:171","msg":"trace[1040668151] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:646; }","duration":"311.71213ms","start":"2026-07-09T09:24:24.656403Z","end":"2026-07-09T09:24:24.968115Z","steps":["trace[1040668151] 'agreement among raft nodes before linearized reading' (duration: 311.616167ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:24:24.968165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:24:23.861914Z","time spent":"1.10623547s","remote":"127.0.0.1:37518","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-09T09:24:24.96819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:24:24.656377Z","time spent":"311.804261ms","remote":"127.0.0.1:37436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":216,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"info","ts":"2026-07-09T09:24:24.968076Z","caller":"traceutil/trace.go:171","msg":"trace[260144363] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:646; }","duration":"234.211888ms","start":"2026-07-09T09:24:24.73384Z","end":"2026-07-09T09:24:24.968052Z","steps":["trace[260144363] 'range keys from in-memory index tree' (duration: 234.011282ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:24:24.968262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.168751465s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-07-09T09:24:24.968246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.16259902s","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-09T09:24:24.968307Z","caller":"traceutil/trace.go:171","msg":"trace[171960194] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:646; }","duration":"1.168851047s","start":"2026-07-09T09:24:23.799443Z","end":"2026-07-09T09:24:24.968294Z","steps":["trace[171960194] 'agreement among raft nodes before linearized reading' (duration: 1.168672663s)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:24:24.968336Z","caller":"traceutil/trace.go:171","msg":"trace[1084380461] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:646; }","duration":"1.162750503s","start":"2026-07-09T09:24:23.805567Z","end":"2026-07-09T09:24:24.968318Z","steps":["trace[1084380461] 'agreement among raft nodes before linearized reading' (duration: 1.162476617s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:24:24.968352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:24:23.799413Z","time spent":"1.168931679s","remote":"127.0.0.1:37518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-09T09:24:24.968397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:24:23.805536Z","time spent":"1.162848076s","remote":"127.0.0.1:37518","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-09T09:24:24.96882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.637069141s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-kkjdt\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-07-09T09:24:24.969889Z","caller":"traceutil/trace.go:171","msg":"trace[590831906] range","detail":"{range_begin:/registry/pods/kube-system/cilium-kkjdt; range_end:; response_count:1; response_revision:646; }","duration":"1.637326667s","start":"2026-07-09T09:24:23.331583Z","end":"2026-07-09T09:24:24.96891Z","steps":["trace[590831906] 'agreement among raft nodes before linearized reading' (duration: 1.636407415s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:24:24.969963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:24:23.331553Z","time spent":"1.638393155s","remote":"127.0.0.1:37420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-kkjdt\" "} {"level":"info","ts":"2026-07-09T09:24:25.468818Z","caller":"traceutil/trace.go:171","msg":"trace[152186914] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"124.534607ms","start":"2026-07-09T09:24:25.344249Z","end":"2026-07-09T09:24:25.468784Z","steps":["trace[152186914] 'process raft request' (duration: 124.352813ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:24:25.490274Z","caller":"traceutil/trace.go:171","msg":"trace[989374386] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"134.179249ms","start":"2026-07-09T09:24:25.355375Z","end":"2026-07-09T09:24:25.489554Z","steps":["trace[989374386] 'process raft request' (duration: 133.378279ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:24:26.872813Z","caller":"traceutil/trace.go:171","msg":"trace[124400074] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"338.865416ms","start":"2026-07-09T09:24:26.533915Z","end":"2026-07-09T09:24:26.872781Z","steps":["trace[124400074] 'process raft request' (duration: 338.694352ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:24:26.873038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:24:26.533866Z","time spent":"339.04079ms","remote":"127.0.0.1:37518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-09T09:24:41.136188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.415223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-09T09:24:41.136257Z","caller":"traceutil/trace.go:171","msg":"trace[1394633728] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:810; }","duration":"175.495805ms","start":"2026-07-09T09:24:40.960747Z","end":"2026-07-09T09:24:41.136243Z","steps":["trace[1394633728] 'range keys from in-memory index tree' (duration: 175.113705ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:24:41.45503Z","caller":"traceutil/trace.go:171","msg":"trace[1369437948] transaction","detail":"{read_only:false; response_revision:811; number_of_response:1; }","duration":"313.869908ms","start":"2026-07-09T09:24:41.141131Z","end":"2026-07-09T09:24:41.455001Z","steps":["trace[1369437948] 'process raft request' (duration: 313.688284ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:24:41.455618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:24:41.141112Z","time spent":"314.029372ms","remote":"127.0.0.1:37518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T09:24:41.456659Z","caller":"traceutil/trace.go:171","msg":"trace[1689716014] transaction","detail":"{read_only:false; response_revision:812; number_of_response:1; }","duration":"314.796143ms","start":"2026-07-09T09:24:41.141838Z","end":"2026-07-09T09:24:41.456634Z","steps":["trace[1689716014] 'process raft request' (duration: 314.562527ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:24:41.456749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:24:41.14183Z","time spent":"314.873334ms","remote":"127.0.0.1:37518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T09:24:41.456796Z","caller":"traceutil/trace.go:171","msg":"trace[226130453] transaction","detail":"{read_only:false; response_revision:814; number_of_response:1; }","duration":"314.547116ms","start":"2026-07-09T09:24:41.142225Z","end":"2026-07-09T09:24:41.456773Z","steps":["trace[226130453] 'process raft request' (duration: 314.390411ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:24:41.456797Z","caller":"traceutil/trace.go:171","msg":"trace[1790003436] transaction","detail":"{read_only:false; response_revision:813; number_of_response:1; }","duration":"314.839363ms","start":"2026-07-09T09:24:41.1419Z","end":"2026-07-09T09:24:41.456739Z","steps":["trace[1790003436] 'process raft request' (duration: 314.594837ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:24:41.456953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:24:41.14222Z","time spent":"314.640428ms","remote":"127.0.0.1:37518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T09:24:41.456989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:24:41.141885Z","time spent":"315.007888ms","remote":"127.0.0.1:37518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T09:24:41.457069Z","caller":"traceutil/trace.go:171","msg":"trace[1741745605] transaction","detail":"{read_only:false; response_revision:815; number_of_response:1; }","duration":"314.002023ms","start":"2026-07-09T09:24:41.143052Z","end":"2026-07-09T09:24:41.457054Z","steps":["trace[1741745605] 'process raft request' (duration: 313.590422ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:24:41.457153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:24:41.143043Z","time spent":"314.068174ms","remote":"127.0.0.1:37518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T09:24:51.709681Z","caller":"traceutil/trace.go:171","msg":"trace[1980452497] linearizableReadLoop","detail":"{readStateIndex:963; appliedIndex:961; }","duration":"188.64747ms","start":"2026-07-09T09:24:51.520972Z","end":"2026-07-09T09:24:51.709619Z","steps":["trace[1980452497] 'read index received' (duration: 37.213285ms)","trace[1980452497] 'applied index is now lower than readState.Index' (duration: 151.432375ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T09:24:51.70988Z","caller":"traceutil/trace.go:171","msg":"trace[680574045] transaction","detail":"{read_only:false; response_revision:930; number_of_response:1; }","duration":"195.35393ms","start":"2026-07-09T09:24:51.514509Z","end":"2026-07-09T09:24:51.709863Z","steps":["trace[680574045] 'process raft request' (duration: 193.735779ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:24:51.710037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.788634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-09T09:24:51.71014Z","caller":"traceutil/trace.go:171","msg":"trace[1114937290] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:930; }","duration":"179.968439ms","start":"2026-07-09T09:24:51.530154Z","end":"2026-07-09T09:24:51.710122Z","steps":["trace[1114937290] 'agreement among raft nodes before linearized reading' (duration: 179.718322ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:24:51.71041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.410529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-09T09:24:51.710526Z","caller":"traceutil/trace.go:171","msg":"trace[226098125] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:930; }","duration":"189.558892ms","start":"2026-07-09T09:24:51.520941Z","end":"2026-07-09T09:24:51.7105Z","steps":["trace[226098125] 'agreement among raft nodes before linearized reading' (duration: 189.270975ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:24:51.710532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.947117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-09T09:24:51.710692Z","caller":"traceutil/trace.go:171","msg":"trace[1702057818] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:930; }","duration":"176.142262ms","start":"2026-07-09T09:24:51.534509Z","end":"2026-07-09T09:24:51.710652Z","steps":["trace[1702057818] 'agreement among raft nodes before linearized reading' (duration: 175.766643ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:24:51.710669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.594914ms","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-09T09:24:51.71077Z","caller":"traceutil/trace.go:171","msg":"trace[515782085] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:930; }","duration":"174.736117ms","start":"2026-07-09T09:24:51.536009Z","end":"2026-07-09T09:24:51.710745Z","steps":["trace[515782085] 'agreement among raft nodes before linearized reading' (duration: 174.200123ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:25:14.381793Z","caller":"traceutil/trace.go:171","msg":"trace[657370205] transaction","detail":"{read_only:false; response_revision:1018; number_of_response:1; }","duration":"317.683566ms","start":"2026-07-09T09:25:14.064061Z","end":"2026-07-09T09:25:14.381744Z","steps":["trace[657370205] 'process raft request' (duration: 317.372887ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:25:14.38204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:25:14.064042Z","time spent":"317.865029ms","remote":"127.0.0.1:37484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2914,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T09:25:17.364259Z","caller":"traceutil/trace.go:171","msg":"trace[1071904443] linearizableReadLoop","detail":"{readStateIndex:1069; appliedIndex:1068; }","duration":"167.490033ms","start":"2026-07-09T09:25:17.19672Z","end":"2026-07-09T09:25:17.36421Z","steps":["trace[1071904443] 'read index received' (duration: 167.212535ms)","trace[1071904443] 'applied index is now lower than readState.Index' (duration: 275.888µs)"],"step_count":2} {"level":"info","ts":"2026-07-09T09:25:17.364462Z","caller":"traceutil/trace.go:171","msg":"trace[662655572] transaction","detail":"{read_only:false; response_revision:1029; number_of_response:1; }","duration":"249.214688ms","start":"2026-07-09T09:25:17.115201Z","end":"2026-07-09T09:25:17.364416Z","steps":["trace[662655572] 'process raft request' (duration: 248.799658ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:25:17.364558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.78199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T09:25:17.364658Z","caller":"traceutil/trace.go:171","msg":"trace[1093922429] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:1029; }","duration":"167.990016ms","start":"2026-07-09T09:25:17.196646Z","end":"2026-07-09T09:25:17.364636Z","steps":["trace[1093922429] 'agreement among raft nodes before linearized reading' (duration: 167.755699ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:25:48.229362Z","caller":"traceutil/trace.go:171","msg":"trace[3451480] linearizableReadLoop","detail":"{readStateIndex:1174; appliedIndex:1173; }","duration":"179.765393ms","start":"2026-07-09T09:25:48.049573Z","end":"2026-07-09T09:25:48.229338Z","steps":["trace[3451480] 'read index received' (duration: 179.518277ms)","trace[3451480] 'applied index is now lower than readState.Index' (duration: 245.866µs)"],"step_count":2} {"level":"warn","ts":"2026-07-09T09:25:48.229841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.252355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-07-09T09:25:48.229826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.042386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-07-09T09:25:48.229899Z","caller":"traceutil/trace.go:171","msg":"trace[856050837] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1128; }","duration":"180.371128ms","start":"2026-07-09T09:25:48.049514Z","end":"2026-07-09T09:25:48.229885Z","steps":["trace[856050837] 'agreement among raft nodes before linearized reading' (duration: 180.195733ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:25:48.229868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.013095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-09T09:25:48.229943Z","caller":"traceutil/trace.go:171","msg":"trace[1754293345] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1128; }","duration":"172.22938ms","start":"2026-07-09T09:25:48.057682Z","end":"2026-07-09T09:25:48.229911Z","steps":["trace[1754293345] 'agreement among raft nodes before linearized reading' (duration: 171.965304ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:25:48.229953Z","caller":"traceutil/trace.go:171","msg":"trace[1434584168] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1128; }","duration":"142.124357ms","start":"2026-07-09T09:25:48.087814Z","end":"2026-07-09T09:25:48.229938Z","steps":["trace[1434584168] 'agreement among raft nodes before linearized reading' (duration: 141.867051ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:25:48.230043Z","caller":"traceutil/trace.go:171","msg":"trace[834090191] transaction","detail":"{read_only:false; response_revision:1128; number_of_response:1; }","duration":"460.215388ms","start":"2026-07-09T09:25:47.769284Z","end":"2026-07-09T09:25:48.229499Z","steps":["trace[834090191] 'process raft request' (duration: 459.87424ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:25:48.230138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:25:47.769239Z","time spent":"460.828364ms","remote":"127.0.0.1:37518","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-09T09:25:48.230176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.615004ms","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-09T09:25:48.230309Z","caller":"traceutil/trace.go:171","msg":"trace[826941551] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1128; }","duration":"167.797829ms","start":"2026-07-09T09:25:48.062483Z","end":"2026-07-09T09:25:48.230281Z","steps":["trace[826941551] 'agreement among raft nodes before linearized reading' (duration: 167.350517ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:25:48.230331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.494352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-07-09T09:25:48.230456Z","caller":"traceutil/trace.go:171","msg":"trace[1069553496] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1128; }","duration":"171.761288ms","start":"2026-07-09T09:25:48.058665Z","end":"2026-07-09T09:25:48.230426Z","steps":["trace[1069553496] 'agreement among raft nodes before linearized reading' (duration: 171.313377ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:25:48.384744Z","caller":"traceutil/trace.go:171","msg":"trace[1352312810] transaction","detail":"{read_only:false; response_revision:1130; number_of_response:1; }","duration":"148.396947ms","start":"2026-07-09T09:25:48.236314Z","end":"2026-07-09T09:25:48.384711Z","steps":["trace[1352312810] 'process raft request' (duration: 148.245322ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:25:48.38507Z","caller":"traceutil/trace.go:171","msg":"trace[1300237302] transaction","detail":"{read_only:false; response_revision:1131; number_of_response:1; }","duration":"148.481648ms","start":"2026-07-09T09:25:48.236527Z","end":"2026-07-09T09:25:48.385009Z","steps":["trace[1300237302] 'process raft request' (duration: 148.13691ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:25:48.385264Z","caller":"traceutil/trace.go:171","msg":"trace[1123964839] transaction","detail":"{read_only:false; response_revision:1129; number_of_response:1; }","duration":"149.026102ms","start":"2026-07-09T09:25:48.236212Z","end":"2026-07-09T09:25:48.385238Z","steps":["trace[1123964839] 'process raft request' (duration: 148.1562ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:25:48.385248Z","caller":"traceutil/trace.go:171","msg":"trace[706324524] transaction","detail":"{read_only:false; response_revision:1133; number_of_response:1; }","duration":"148.514949ms","start":"2026-07-09T09:25:48.236664Z","end":"2026-07-09T09:25:48.385179Z","steps":["trace[706324524] 'process raft request' (duration: 148.222152ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:25:48.385274Z","caller":"traceutil/trace.go:171","msg":"trace[1997334067] transaction","detail":"{read_only:false; response_revision:1132; number_of_response:1; }","duration":"148.553231ms","start":"2026-07-09T09:25:48.236656Z","end":"2026-07-09T09:25:48.385209Z","steps":["trace[1997334067] 'process raft request' (duration: 148.13962ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:25:49.44738Z","caller":"traceutil/trace.go:171","msg":"trace[236959653] linearizableReadLoop","detail":"{readStateIndex:1182; appliedIndex:1181; }","duration":"117.408378ms","start":"2026-07-09T09:25:49.329936Z","end":"2026-07-09T09:25:49.447344Z","steps":["trace[236959653] 'read index received' (duration: 117.153332ms)","trace[236959653] 'applied index is now lower than readState.Index' (duration: 253.966µs)"],"step_count":2} {"level":"warn","ts":"2026-07-09T09:25:49.447616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.638353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T09:25:49.447747Z","caller":"traceutil/trace.go:171","msg":"trace[366132065] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1135; }","duration":"117.83681ms","start":"2026-07-09T09:25:49.329881Z","end":"2026-07-09T09:25:49.447718Z","steps":["trace[366132065] 'agreement among raft nodes before linearized reading' (duration: 117.600914ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:25:49.44811Z","caller":"traceutil/trace.go:171","msg":"trace[1902202233] transaction","detail":"{read_only:false; response_revision:1135; number_of_response:1; }","duration":"303.410429ms","start":"2026-07-09T09:25:49.144679Z","end":"2026-07-09T09:25:49.44809Z","steps":["trace[1902202233] 'process raft request' (duration: 302.455735ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:25:49.448381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:25:49.144648Z","time spent":"303.538811ms","remote":"127.0.0.1:37518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T09:25:50.64921Z","caller":"traceutil/trace.go:171","msg":"trace[1725350578] transaction","detail":"{read_only:false; response_revision:1138; number_of_response:1; }","duration":"250.448347ms","start":"2026-07-09T09:25:50.398678Z","end":"2026-07-09T09:25:50.649126Z","steps":["trace[1725350578] 'process raft request' (duration: 250.151779ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:25:50.649643Z","caller":"traceutil/trace.go:171","msg":"trace[1051370317] transaction","detail":"{read_only:false; response_revision:1140; number_of_response:1; }","duration":"247.862451ms","start":"2026-07-09T09:25:50.401764Z","end":"2026-07-09T09:25:50.649626Z","steps":["trace[1051370317] 'process raft request' (duration: 247.787499ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:25:50.64967Z","caller":"traceutil/trace.go:171","msg":"trace[1015044926] transaction","detail":"{read_only:false; response_revision:1139; number_of_response:1; }","duration":"250.850927ms","start":"2026-07-09T09:25:50.398787Z","end":"2026-07-09T09:25:50.649638Z","steps":["trace[1015044926] 'process raft request' (duration: 250.286953ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:25:50.649697Z","caller":"traceutil/trace.go:171","msg":"trace[370056568] transaction","detail":"{read_only:false; response_revision:1137; number_of_response:1; }","duration":"250.383484ms","start":"2026-07-09T09:25:50.39852Z","end":"2026-07-09T09:25:50.648903Z","steps":["trace[370056568] 'process raft request' (duration: 234.963932ms)","trace[370056568] 'compare' (duration: 14.880558ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T09:26:05.037697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.500571ms","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-09T09:26:05.03791Z","caller":"traceutil/trace.go:171","msg":"trace[777592495] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1233; }","duration":"316.766089ms","start":"2026-07-09T09:26:04.721095Z","end":"2026-07-09T09:26:05.037861Z","steps":["trace[777592495] 'range keys from in-memory index tree' (duration: 316.131453ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:26:05.038059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.352993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-07-09T09:26:05.038121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.781193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-09T09:26:05.038183Z","caller":"traceutil/trace.go:171","msg":"trace[1378114399] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1233; }","duration":"315.559717ms","start":"2026-07-09T09:26:04.722594Z","end":"2026-07-09T09:26:05.038154Z","steps":["trace[1378114399] 'range keys from in-memory index tree' (duration: 315.028753ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:26:05.038195Z","caller":"traceutil/trace.go:171","msg":"trace[1189182385] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1233; }","duration":"311.896115ms","start":"2026-07-09T09:26:04.726266Z","end":"2026-07-09T09:26:05.038162Z","steps":["trace[1189182385] 'range keys from in-memory index tree' (duration: 311.622028ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:26:05.038173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.47982ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-09T09:26:05.038249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:26:04.722564Z","time spent":"315.67474ms","remote":"127.0.0.1:37518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-09T09:26:05.038253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:26:04.726236Z","time spent":"312.006608ms","remote":"127.0.0.1:37518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-09T09:26:05.038274Z","caller":"traceutil/trace.go:171","msg":"trace[1579539768] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1233; }","duration":"303.591553ms","start":"2026-07-09T09:26:04.73467Z","end":"2026-07-09T09:26:05.038262Z","steps":["trace[1579539768] 'range keys from in-memory index tree' (duration: 303.47122ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:26:05.038098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:26:04.721071Z","time spent":"317.010435ms","remote":"127.0.0.1:37518","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-09T09:26:05.037986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.873511ms","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-09T09:26:05.038499Z","caller":"traceutil/trace.go:171","msg":"trace[1334941038] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1233; }","duration":"315.447105ms","start":"2026-07-09T09:26:04.72304Z","end":"2026-07-09T09:26:05.038487Z","steps":["trace[1334941038] 'range keys from in-memory index tree' (duration: 314.664845ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:26:05.038541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:26:04.723012Z","time spent":"315.519057ms","remote":"127.0.0.1:37518","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-09T09:26:07.386794Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15455121670062205876,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-09T09:26:07.424125Z","caller":"traceutil/trace.go:171","msg":"trace[244468174] linearizableReadLoop","detail":"{readStateIndex:1291; appliedIndex:1290; }","duration":"537.909349ms","start":"2026-07-09T09:26:06.886187Z","end":"2026-07-09T09:26:07.424097Z","steps":["trace[244468174] 'read index received' (duration: 537.616162ms)","trace[244468174] 'applied index is now lower than readState.Index' (duration: 292.237µs)"],"step_count":2} {"level":"info","ts":"2026-07-09T09:26:07.424222Z","caller":"traceutil/trace.go:171","msg":"trace[1075265130] transaction","detail":"{read_only:false; response_revision:1239; number_of_response:1; }","duration":"921.32673ms","start":"2026-07-09T09:26:06.502866Z","end":"2026-07-09T09:26:07.424193Z","steps":["trace[1075265130] 'process raft request' (duration: 921.066663ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:26:07.424311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.090365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-09T09:26:07.424339Z","caller":"traceutil/trace.go:171","msg":"trace[1583047100] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:1239; }","duration":"538.231867ms","start":"2026-07-09T09:26:06.886099Z","end":"2026-07-09T09:26:07.424331Z","steps":["trace[1583047100] 'agreement among raft nodes before linearized reading' (duration: 538.135585ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:26:07.424361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:26:06.886074Z","time spent":"538.281609ms","remote":"127.0.0.1:37518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":8,"response size":30,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"warn","ts":"2026-07-09T09:26:07.42437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:26:06.502849Z","time spent":"921.428362ms","remote":"127.0.0.1:37518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T09:26:07.42458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.271366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-07-09T09:26:07.424584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.635895ms","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-09T09:26:07.424594Z","caller":"traceutil/trace.go:171","msg":"trace[807808757] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1239; }","duration":"370.296626ms","start":"2026-07-09T09:26:07.054292Z","end":"2026-07-09T09:26:07.424589Z","steps":["trace[807808757] 'agreement among raft nodes before linearized reading' (duration: 370.199714ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:26:07.424611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:26:07.054287Z","time spent":"370.320337ms","remote":"127.0.0.1:37518","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-09T09:26:07.42457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.244771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-09T09:26:07.424685Z","caller":"traceutil/trace.go:171","msg":"trace[1911965785] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1239; }","duration":"373.406735ms","start":"2026-07-09T09:26:07.05125Z","end":"2026-07-09T09:26:07.424657Z","steps":["trace[1911965785] 'agreement among raft nodes before linearized reading' (duration: 373.047187ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:26:07.42474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:26:07.051238Z","time spent":"373.492168ms","remote":"127.0.0.1:37518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-09T09:26:07.424615Z","caller":"traceutil/trace.go:171","msg":"trace[41737553] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1239; }","duration":"370.675476ms","start":"2026-07-09T09:26:07.053929Z","end":"2026-07-09T09:26:07.424605Z","steps":["trace[41737553] 'agreement among raft nodes before linearized reading' (duration: 370.552993ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:26:07.424824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:26:07.053923Z","time spent":"370.890873ms","remote":"127.0.0.1:37518","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-09T09:26:07.42488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.434716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-09T09:26:07.424969Z","caller":"traceutil/trace.go:171","msg":"trace[175825669] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1239; }","duration":"371.551259ms","start":"2026-07-09T09:26:07.053397Z","end":"2026-07-09T09:26:07.424948Z","steps":["trace[175825669] 'agreement among raft nodes before linearized reading' (duration: 371.310003ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:26:07.425008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:26:07.05339Z","time spent":"371.611ms","remote":"127.0.0.1:37518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-09T09:26:23.702861Z","caller":"traceutil/trace.go:171","msg":"trace[1709831360] linearizableReadLoop","detail":"{readStateIndex:1351; appliedIndex:1349; }","duration":"168.246109ms","start":"2026-07-09T09:26:23.534581Z","end":"2026-07-09T09:26:23.702827Z","steps":["trace[1709831360] 'read index received' (duration: 26.240296ms)","trace[1709831360] 'applied index is now lower than readState.Index' (duration: 142.004653ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T09:26:23.702924Z","caller":"traceutil/trace.go:171","msg":"trace[246672891] transaction","detail":"{read_only:false; response_revision:1296; number_of_response:1; }","duration":"169.209765ms","start":"2026-07-09T09:26:23.533661Z","end":"2026-07-09T09:26:23.702871Z","steps":["trace[246672891] 'process raft request' (duration: 168.930007ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:26:23.703279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.651419ms","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-09T09:26:23.703395Z","caller":"traceutil/trace.go:171","msg":"trace[2051194968] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1297; }","duration":"168.811213ms","start":"2026-07-09T09:26:23.53456Z","end":"2026-07-09T09:26:23.703371Z","steps":["trace[2051194968] 'agreement among raft nodes before linearized reading' (duration: 168.434444ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:26:23.703665Z","caller":"traceutil/trace.go:171","msg":"trace[2003430291] transaction","detail":"{read_only:false; response_revision:1297; number_of_response:1; }","duration":"160.924714ms","start":"2026-07-09T09:26:23.542712Z","end":"2026-07-09T09:26:23.703637Z","steps":["trace[2003430291] 'process raft request' (duration: 160.051171ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:26:23.782779Z","caller":"traceutil/trace.go:171","msg":"trace[1518621790] transaction","detail":"{read_only:false; response_revision:1298; number_of_response:1; }","duration":"172.038796ms","start":"2026-07-09T09:26:23.610697Z","end":"2026-07-09T09:26:23.782736Z","steps":["trace[1518621790] 'process raft request' (duration: 115.755028ms)","trace[1518621790] 'compare' (duration: 56.136074ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T09:26:23.823085Z","caller":"traceutil/trace.go:171","msg":"trace[575371514] linearizableReadLoop","detail":"{readStateIndex:1354; appliedIndex:1352; }","duration":"120.118147ms","start":"2026-07-09T09:26:23.702951Z","end":"2026-07-09T09:26:23.823069Z","steps":["trace[575371514] 'read index received' (duration: 23.448784ms)","trace[575371514] 'applied index is now lower than readState.Index' (duration: 96.668253ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T09:26:23.823283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.366651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-09T09:26:23.823329Z","caller":"traceutil/trace.go:171","msg":"trace[667781488] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1298; }","duration":"283.478764ms","start":"2026-07-09T09:26:23.539837Z","end":"2026-07-09T09:26:23.823316Z","steps":["trace[667781488] 'agreement among raft nodes before linearized reading' (duration: 283.305819ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:26:23.823387Z","caller":"traceutil/trace.go:171","msg":"trace[1111356132] transaction","detail":"{read_only:false; response_revision:1300; number_of_response:1; }","duration":"112.70321ms","start":"2026-07-09T09:26:23.710666Z","end":"2026-07-09T09:26:23.823369Z","steps":["trace[1111356132] 'process raft request' (duration: 112.628318ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:26:23.82355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.802309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T09:26:23.823588Z","caller":"traceutil/trace.go:171","msg":"trace[1059706386] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1300; }","duration":"184.894271ms","start":"2026-07-09T09:26:23.638686Z","end":"2026-07-09T09:26:23.82358Z","steps":["trace[1059706386] 'agreement among raft nodes before linearized reading' (duration: 184.804289ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:26:23.823651Z","caller":"traceutil/trace.go:171","msg":"trace[1448416735] transaction","detail":"{read_only:false; response_revision:1299; number_of_response:1; }","duration":"114.360501ms","start":"2026-07-09T09:26:23.709276Z","end":"2026-07-09T09:26:23.823636Z","steps":["trace[1448416735] 'process raft request' (duration: 113.725415ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:26:24.103677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.039184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-09T09:26:24.103793Z","caller":"traceutil/trace.go:171","msg":"trace[698984729] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1301; }","duration":"207.243819ms","start":"2026-07-09T09:26:23.896518Z","end":"2026-07-09T09:26:24.103762Z","steps":["trace[698984729] 'count revisions from in-memory index tree' (duration: 206.930811ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:26:24.40752Z","caller":"traceutil/trace.go:171","msg":"trace[978499895] transaction","detail":"{read_only:false; response_revision:1302; number_of_response:1; }","duration":"220.875804ms","start":"2026-07-09T09:26:24.18661Z","end":"2026-07-09T09:26:24.407486Z","steps":["trace[978499895] 'process raft request' (duration: 220.197737ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:26:24.861957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.725961ms","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-09T09:26:24.86212Z","caller":"traceutil/trace.go:171","msg":"trace[215252408] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1302; }","duration":"127.906995ms","start":"2026-07-09T09:26:24.73419Z","end":"2026-07-09T09:26:24.862097Z","steps":["trace[215252408] 'range keys from in-memory index tree' (duration: 127.708951ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:26:25.173302Z","caller":"traceutil/trace.go:171","msg":"trace[328643203] linearizableReadLoop","detail":"{readStateIndex:1359; appliedIndex:1358; }","duration":"116.394614ms","start":"2026-07-09T09:26:25.056872Z","end":"2026-07-09T09:26:25.173267Z","steps":["trace[328643203] 'read index received' (duration: 116.023324ms)","trace[328643203] 'applied index is now lower than readState.Index' (duration: 370.33µs)"],"step_count":2} {"level":"info","ts":"2026-07-09T09:26:25.173377Z","caller":"traceutil/trace.go:171","msg":"trace[134353807] transaction","detail":"{read_only:false; response_revision:1303; number_of_response:1; }","duration":"213.363544ms","start":"2026-07-09T09:26:24.959949Z","end":"2026-07-09T09:26:25.173312Z","steps":["trace[134353807] 'process raft request' (duration: 213.094458ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:26:25.173537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.630069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-09T09:26:25.173818Z","caller":"traceutil/trace.go:171","msg":"trace[1909868862] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1303; }","duration":"116.812114ms","start":"2026-07-09T09:26:25.056801Z","end":"2026-07-09T09:26:25.173613Z","steps":["trace[1909868862] 'agreement among raft nodes before linearized reading' (duration: 116.561397ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:26:26.210344Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15455121670062206046,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-09T09:26:26.359172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.432495ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-09T09:26:26.359382Z","caller":"traceutil/trace.go:171","msg":"trace[1044676730] linearizableReadLoop","detail":"{readStateIndex:1362; appliedIndex:1360; }","duration":"650.083826ms","start":"2026-07-09T09:26:25.709276Z","end":"2026-07-09T09:26:26.35936Z","steps":["trace[1044676730] 'read index received' (duration: 516.359793ms)","trace[1044676730] 'applied index is now lower than readState.Index' (duration: 133.722683ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T09:26:26.359495Z","caller":"traceutil/trace.go:171","msg":"trace[235535601] transaction","detail":"{read_only:false; response_revision:1306; number_of_response:1; }","duration":"569.199944ms","start":"2026-07-09T09:26:25.790278Z","end":"2026-07-09T09:26:26.359478Z","steps":["trace[235535601] 'process raft request' (duration: 569.02353ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:26:26.359481Z","caller":"traceutil/trace.go:171","msg":"trace[172086061] transaction","detail":"{read_only:false; response_revision:1305; number_of_response:1; }","duration":"746.018911ms","start":"2026-07-09T09:26:25.613414Z","end":"2026-07-09T09:26:26.359432Z","steps":["trace[172086061] 'process raft request' (duration: 612.212406ms)","trace[172086061] 'compare' (duration: 133.299522ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T09:26:26.359561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:26:25.790243Z","time spent":"569.281925ms","remote":"127.0.0.1:37518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T09:26:26.359701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:26:25.613397Z","time spent":"746.179765ms","remote":"127.0.0.1:37518","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-09T09:26:26.359896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.263099ms","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-09T09:26:26.359981Z","caller":"traceutil/trace.go:171","msg":"trace[641948873] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1306; }","duration":"523.421043ms","start":"2026-07-09T09:26:25.836541Z","end":"2026-07-09T09:26:26.359962Z","steps":["trace[641948873] 'agreement among raft nodes before linearized reading' (duration: 523.148455ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:26:26.360027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:26:25.836511Z","time spent":"523.503005ms","remote":"127.0.0.1:37518","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-09T09:26:26.359905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"650.61823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-07-09T09:26:26.360094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.975183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-09T09:26:26.360208Z","caller":"traceutil/trace.go:171","msg":"trace[451643040] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1306; }","duration":"516.138887ms","start":"2026-07-09T09:26:25.844042Z","end":"2026-07-09T09:26:26.360181Z","steps":["trace[451643040] 'agreement among raft nodes before linearized reading' (duration: 515.763357ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:26:26.360134Z","caller":"traceutil/trace.go:171","msg":"trace[49022133] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1306; }","duration":"650.927678ms","start":"2026-07-09T09:26:25.70919Z","end":"2026-07-09T09:26:26.360118Z","steps":["trace[49022133] 'agreement among raft nodes before linearized reading' (duration: 650.583609ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:26:26.360273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:26:25.709129Z","time spent":"651.134873ms","remote":"127.0.0.1:37518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-09T09:26:26.360277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:26:25.844032Z","time spent":"516.23551ms","remote":"127.0.0.1:37518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-09T09:26:26.54784Z","caller":"traceutil/trace.go:171","msg":"trace[886796915] transaction","detail":"{read_only:false; response_revision:1308; number_of_response:1; }","duration":"182.558602ms","start":"2026-07-09T09:26:26.365246Z","end":"2026-07-09T09:26:26.547805Z","steps":["trace[886796915] 'process raft request' (duration: 122.025316ms)","trace[886796915] 'compare' (duration: 60.328581ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T09:26:26.548051Z","caller":"traceutil/trace.go:171","msg":"trace[188616695] transaction","detail":"{read_only:false; response_revision:1309; number_of_response:1; }","duration":"181.061294ms","start":"2026-07-09T09:26:26.366946Z","end":"2026-07-09T09:26:26.548008Z","steps":["trace[188616695] 'process raft request' (duration: 180.808928ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:26:35.616998Z","caller":"traceutil/trace.go:171","msg":"trace[1765319838] linearizableReadLoop","detail":"{readStateIndex:1437; appliedIndex:1436; }","duration":"104.42451ms","start":"2026-07-09T09:26:35.512537Z","end":"2026-07-09T09:26:35.616961Z","steps":["trace[1765319838] 'read index received' (duration: 104.274166ms)","trace[1765319838] 'applied index is now lower than readState.Index' (duration: 148.694µs)"],"step_count":2} {"level":"info","ts":"2026-07-09T09:26:35.617026Z","caller":"traceutil/trace.go:171","msg":"trace[1198462903] transaction","detail":"{read_only:false; response_revision:1379; number_of_response:1; }","duration":"145.490952ms","start":"2026-07-09T09:26:35.471494Z","end":"2026-07-09T09:26:35.616985Z","steps":["trace[1198462903] 'process raft request' (duration: 145.225195ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:26:35.617264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.700947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T09:26:35.617377Z","caller":"traceutil/trace.go:171","msg":"trace[250474385] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:1379; }","duration":"104.857931ms","start":"2026-07-09T09:26:35.512456Z","end":"2026-07-09T09:26:35.617314Z","steps":["trace[250474385] 'agreement among raft nodes before linearized reading' (duration: 104.616115ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:26:36.184442Z","caller":"traceutil/trace.go:171","msg":"trace[1236601295] transaction","detail":"{read_only:false; response_revision:1393; number_of_response:1; }","duration":"109.600132ms","start":"2026-07-09T09:26:36.074807Z","end":"2026-07-09T09:26:36.184407Z","steps":["trace[1236601295] 'process raft request' (duration: 109.50744ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:26:36.184503Z","caller":"traceutil/trace.go:171","msg":"trace[1329918463] transaction","detail":"{read_only:false; response_revision:1392; number_of_response:1; }","duration":"117.369109ms","start":"2026-07-09T09:26:36.067075Z","end":"2026-07-09T09:26:36.184444Z","steps":["trace[1329918463] 'process raft request' (duration: 117.034771ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:26:36.359618Z","caller":"traceutil/trace.go:171","msg":"trace[156980610] transaction","detail":"{read_only:false; response_revision:1394; number_of_response:1; }","duration":"134.481403ms","start":"2026-07-09T09:26:36.225095Z","end":"2026-07-09T09:26:36.359577Z","steps":["trace[156980610] 'process raft request' (duration: 116.587559ms)","trace[156980610] 'compare' (duration: 17.171946ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T09:26:36.565716Z","caller":"traceutil/trace.go:171","msg":"trace[1552624320] transaction","detail":"{read_only:false; response_revision:1397; number_of_response:1; }","duration":"105.296502ms","start":"2026-07-09T09:26:36.460382Z","end":"2026-07-09T09:26:36.565678Z","steps":["trace[1552624320] 'process raft request' (duration: 100.513931ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:26:37.127303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.617963ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-09T09:26:37.127445Z","caller":"traceutil/trace.go:171","msg":"trace[230454496] transaction","detail":"{read_only:false; response_revision:1399; number_of_response:1; }","duration":"520.749316ms","start":"2026-07-09T09:26:36.606671Z","end":"2026-07-09T09:26:37.12742Z","steps":["trace[230454496] 'process raft request' (duration: 64.888537ms)","trace[230454496] 'compare' (duration: 455.13328ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T09:26:37.127515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:26:36.606656Z","time spent":"520.828017ms","remote":"127.0.0.1:37518","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-09T09:26:41.989005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.873038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T09:26:41.989083Z","caller":"traceutil/trace.go:171","msg":"trace[871749687] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:1419; }","duration":"346.035831ms","start":"2026-07-09T09:26:41.643032Z","end":"2026-07-09T09:26:41.989068Z","steps":["trace[871749687] 'count revisions from in-memory index tree' (duration: 345.756845ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:26:41.989112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:26:41.643Z","time spent":"346.104803ms","remote":"127.0.0.1:37534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":28,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "} {"level":"warn","ts":"2026-07-09T09:26:41.989639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.848768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-09T09:26:41.99009Z","caller":"traceutil/trace.go:171","msg":"trace[1037442939] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1419; }","duration":"179.301729ms","start":"2026-07-09T09:26:41.8107Z","end":"2026-07-09T09:26:41.990002Z","steps":["trace[1037442939] 'range keys from in-memory index tree' (duration: 178.382317ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:26:42.548763Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15455121670062206272,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-09T09:26:42.735325Z","caller":"traceutil/trace.go:171","msg":"trace[1066648736] transaction","detail":"{read_only:false; response_revision:1420; number_of_response:1; }","duration":"740.271875ms","start":"2026-07-09T09:26:41.995014Z","end":"2026-07-09T09:26:42.735286Z","steps":["trace[1066648736] 'process raft request' (duration: 740.052469ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:26:42.735632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:26:41.99499Z","time spent":"740.442629ms","remote":"127.0.0.1:37518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":517,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T09:26:42.739149Z","caller":"traceutil/trace.go:171","msg":"trace[1634153854] linearizableReadLoop","detail":"{readStateIndex:1481; appliedIndex:1478; }","duration":"690.909493ms","start":"2026-07-09T09:26:42.048204Z","end":"2026-07-09T09:26:42.739114Z","steps":["trace[1634153854] 'read index received' (duration: 686.765757ms)","trace[1634153854] 'applied index is now lower than readState.Index' (duration: 4.141826ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T09:26:42.739252Z","caller":"traceutil/trace.go:171","msg":"trace[1526077536] transaction","detail":"{read_only:false; response_revision:1422; number_of_response:1; }","duration":"302.220099ms","start":"2026-07-09T09:26:42.436975Z","end":"2026-07-09T09:26:42.739195Z","steps":["trace[1526077536] 'process raft request' (duration: 302.060454ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:26:42.739399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"691.191829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T09:26:42.739483Z","caller":"traceutil/trace.go:171","msg":"trace[845959748] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:1422; }","duration":"691.315382ms","start":"2026-07-09T09:26:42.048152Z","end":"2026-07-09T09:26:42.739468Z","steps":["trace[845959748] 'agreement among raft nodes before linearized reading' (duration: 691.201919ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:26:42.739551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:26:42.04813Z","time spent":"691.406025ms","remote":"127.0.0.1:37532","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":0,"response size":28,"request content":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-09T09:26:42.739566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.345223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T09:26:42.739698Z","caller":"traceutil/trace.go:171","msg":"trace[1262254033] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1422; }","duration":"410.578698ms","start":"2026-07-09T09:26:42.329067Z","end":"2026-07-09T09:26:42.739645Z","steps":["trace[1262254033] 'agreement among raft nodes before linearized reading' (duration: 410.355163ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:26:42.739787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:26:42.329042Z","time spent":"410.733862ms","remote":"127.0.0.1:37216","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-09T09:26:42.740075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.596389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T09:26:42.740157Z","caller":"traceutil/trace.go:171","msg":"trace[289671299] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1422; }","duration":"157.703651ms","start":"2026-07-09T09:26:42.58241Z","end":"2026-07-09T09:26:42.740113Z","steps":["trace[289671299] 'agreement among raft nodes before linearized reading' (duration: 157.612399ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:26:42.74001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.171654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-07-09T09:26:42.740193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:26:42.436947Z","time spent":"302.461595ms","remote":"127.0.0.1:37518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T09:26:42.740344Z","caller":"traceutil/trace.go:171","msg":"trace[660187094] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1422; }","duration":"147.535694ms","start":"2026-07-09T09:26:42.592783Z","end":"2026-07-09T09:26:42.740319Z","steps":["trace[660187094] 'agreement among raft nodes before linearized reading' (duration: 146.726073ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:26:42.740544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.87036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-09T09:26:42.739252Z","caller":"traceutil/trace.go:171","msg":"trace[163204003] transaction","detail":"{read_only:false; response_revision:1421; number_of_response:1; }","duration":"743.701332ms","start":"2026-07-09T09:26:41.995473Z","end":"2026-07-09T09:26:42.739174Z","steps":["trace[163204003] 'process raft request' (duration: 743.339453ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:26:42.740641Z","caller":"traceutil/trace.go:171","msg":"trace[192893782] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1422; }","duration":"100.999723ms","start":"2026-07-09T09:26:42.63962Z","end":"2026-07-09T09:26:42.74062Z","steps":["trace[192893782] 'agreement among raft nodes before linearized reading' (duration: 100.698466ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:26:42.740716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:26:41.995447Z","time spent":"745.193339ms","remote":"127.0.0.1:37518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T09:26:42.741005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.352523ms","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-09T09:26:42.74108Z","caller":"traceutil/trace.go:171","msg":"trace[1658090029] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1422; }","duration":"263.498906ms","start":"2026-07-09T09:26:42.477571Z","end":"2026-07-09T09:26:42.74107Z","steps":["trace[1658090029] 'agreement among raft nodes before linearized reading' (duration: 262.687096ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:26:44.380123Z","caller":"traceutil/trace.go:171","msg":"trace[2112257779] transaction","detail":"{read_only:false; response_revision:1428; number_of_response:1; }","duration":"117.857294ms","start":"2026-07-09T09:26:44.262233Z","end":"2026-07-09T09:26:44.38009Z","steps":["trace[2112257779] 'process raft request' (duration: 117.540917ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:26:44.85827Z","caller":"traceutil/trace.go:171","msg":"trace[2143115930] transaction","detail":"{read_only:false; response_revision:1430; number_of_response:1; }","duration":"107.247835ms","start":"2026-07-09T09:26:44.750987Z","end":"2026-07-09T09:26:44.858235Z","steps":["trace[2143115930] 'process raft request' (duration: 72.44344ms)","trace[2143115930] 'compare' (duration: 34.616429ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T09:26:44.858734Z","caller":"traceutil/trace.go:171","msg":"trace[867636234] transaction","detail":"{read_only:false; response_revision:1431; number_of_response:1; }","duration":"102.703749ms","start":"2026-07-09T09:26:44.756009Z","end":"2026-07-09T09:26:44.858712Z","steps":["trace[867636234] 'process raft request' (duration: 102.174006ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:26:44.858916Z","caller":"traceutil/trace.go:171","msg":"trace[2115015821] linearizableReadLoop","detail":"{readStateIndex:1490; appliedIndex:1488; }","duration":"106.398714ms","start":"2026-07-09T09:26:44.752502Z","end":"2026-07-09T09:26:44.858901Z","steps":["trace[2115015821] 'read index received' (duration: 8.184078ms)","trace[2115015821] 'applied index is now lower than readState.Index' (duration: 98.213186ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T09:26:44.859201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.660291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-09T09:26:44.858969Z","caller":"traceutil/trace.go:171","msg":"trace[1655773406] transaction","detail":"{read_only:false; response_revision:1432; number_of_response:1; }","duration":"101.335994ms","start":"2026-07-09T09:26:44.757596Z","end":"2026-07-09T09:26:44.858932Z","steps":["trace[1655773406] 'process raft request' (duration: 101.017976ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:26:44.859255Z","caller":"traceutil/trace.go:171","msg":"trace[871957728] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1432; }","duration":"106.754602ms","start":"2026-07-09T09:26:44.752487Z","end":"2026-07-09T09:26:44.859242Z","steps":["trace[871957728] 'agreement among raft nodes before linearized reading' (duration: 106.514147ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:26:44.859892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.059825ms","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-09T09:26:44.860002Z","caller":"traceutil/trace.go:171","msg":"trace[167336920] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1433; }","duration":"106.224679ms","start":"2026-07-09T09:26:44.753751Z","end":"2026-07-09T09:26:44.859976Z","steps":["trace[167336920] 'agreement among raft nodes before linearized reading' (duration: 106.000272ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:26:44.860471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.282496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-09T09:26:44.860525Z","caller":"traceutil/trace.go:171","msg":"trace[282306126] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1433; }","duration":"105.360717ms","start":"2026-07-09T09:26:44.755154Z","end":"2026-07-09T09:26:44.860515Z","steps":["trace[282306126] 'agreement among raft nodes before linearized reading' (duration: 105.164062ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:26:46.975361Z","caller":"traceutil/trace.go:171","msg":"trace[1796913858] linearizableReadLoop","detail":"{readStateIndex:1502; appliedIndex:1501; }","duration":"104.644159ms","start":"2026-07-09T09:26:46.870677Z","end":"2026-07-09T09:26:46.975322Z","steps":["trace[1796913858] 'read index received' (duration: 2.564976ms)","trace[1796913858] 'applied index is now lower than readState.Index' (duration: 102.077503ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T09:26:46.975433Z","caller":"traceutil/trace.go:171","msg":"trace[359372468] transaction","detail":"{read_only:false; response_revision:1442; number_of_response:1; }","duration":"105.372126ms","start":"2026-07-09T09:26:46.870018Z","end":"2026-07-09T09:26:46.97539Z","steps":["trace[359372468] 'process raft request' (duration: 101.413866ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:26:46.975987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.261368ms","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-09T09:26:46.97605Z","caller":"traceutil/trace.go:171","msg":"trace[1619638261] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1442; }","duration":"102.393621ms","start":"2026-07-09T09:26:46.873641Z","end":"2026-07-09T09:26:46.976034Z","steps":["trace[1619638261] 'agreement among raft nodes before linearized reading' (duration: 102.028602ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:26:46.975987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.280325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-07-09T09:26:46.976146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.679403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-09T09:26:46.976255Z","caller":"traceutil/trace.go:171","msg":"trace[1724370446] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1442; }","duration":"105.575612ms","start":"2026-07-09T09:26:46.87065Z","end":"2026-07-09T09:26:46.976226Z","steps":["trace[1724370446] 'agreement among raft nodes before linearized reading' (duration: 104.880335ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:26:46.976367Z","caller":"traceutil/trace.go:171","msg":"trace[1241787622] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1442; }","duration":"101.999221ms","start":"2026-07-09T09:26:46.874309Z","end":"2026-07-09T09:26:46.976309Z","steps":["trace[1241787622] 'agreement among raft nodes before linearized reading' (duration: 101.434757ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:26:48.673598Z","caller":"traceutil/trace.go:171","msg":"trace[1573955077] transaction","detail":"{read_only:false; response_revision:1448; number_of_response:1; }","duration":"127.417238ms","start":"2026-07-09T09:26:48.546148Z","end":"2026-07-09T09:26:48.673565Z","steps":["trace[1573955077] 'process raft request' (duration: 127.180513ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:27:05.242537Z","caller":"traceutil/trace.go:171","msg":"trace[319130285] transaction","detail":"{read_only:false; response_revision:1527; number_of_response:1; }","duration":"126.705699ms","start":"2026-07-09T09:27:05.115796Z","end":"2026-07-09T09:27:05.242502Z","steps":["trace[319130285] 'process raft request' (duration: 107.82459ms)","trace[319130285] 'compare' (duration: 18.709015ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T09:27:08.343312Z","caller":"traceutil/trace.go:171","msg":"trace[569487280] transaction","detail":"{read_only:false; response_revision:1539; number_of_response:1; }","duration":"147.341944ms","start":"2026-07-09T09:27:08.195921Z","end":"2026-07-09T09:27:08.343263Z","steps":["trace[569487280] 'process raft request' (duration: 56.412284ms)","trace[569487280] 'compare' (duration: 90.695604ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T09:27:49.315116Z","caller":"traceutil/trace.go:171","msg":"trace[1336717464] linearizableReadLoop","detail":"{readStateIndex:1798; appliedIndex:1797; }","duration":"105.726747ms","start":"2026-07-09T09:27:49.209363Z","end":"2026-07-09T09:27:49.31509Z","steps":["trace[1336717464] 'read index received' (duration: 105.461429ms)","trace[1336717464] 'applied index is now lower than readState.Index' (duration: 264.338µs)"],"step_count":2} {"level":"info","ts":"2026-07-09T09:27:49.315203Z","caller":"traceutil/trace.go:171","msg":"trace[1450056729] transaction","detail":"{read_only:false; response_revision:1725; number_of_response:1; }","duration":"130.801383ms","start":"2026-07-09T09:27:49.184342Z","end":"2026-07-09T09:27:49.315143Z","steps":["trace[1450056729] 'process raft request' (duration: 130.573147ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:27:49.315337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.956932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-07-09T09:27:49.315387Z","caller":"traceutil/trace.go:171","msg":"trace[1320610533] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1725; }","duration":"106.078385ms","start":"2026-07-09T09:27:49.209295Z","end":"2026-07-09T09:27:49.315373Z","steps":["trace[1320610533] 'agreement among raft nodes before linearized reading' (duration: 105.90541ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:29:10.135956Z","caller":"traceutil/trace.go:171","msg":"trace[526195789] transaction","detail":"{read_only:false; response_revision:2100; number_of_response:1; }","duration":"120.105313ms","start":"2026-07-09T09:29:10.015817Z","end":"2026-07-09T09:29:10.135922Z","steps":["trace[526195789] 'process raft request' (duration: 119.939679ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:29:10.167805Z","caller":"traceutil/trace.go:171","msg":"trace[1614129348] transaction","detail":"{read_only:false; response_revision:2101; number_of_response:1; }","duration":"150.355912ms","start":"2026-07-09T09:29:10.017421Z","end":"2026-07-09T09:29:10.167777Z","steps":["trace[1614129348] 'process raft request' (duration: 150.119356ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:29:52.537816Z","caller":"traceutil/trace.go:171","msg":"trace[954881358] transaction","detail":"{read_only:false; response_revision:2293; number_of_response:1; }","duration":"102.447073ms","start":"2026-07-09T09:29:52.435334Z","end":"2026-07-09T09:29:52.537781Z","steps":["trace[954881358] 'process raft request' (duration: 102.215808ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:29:52.600698Z","caller":"traceutil/trace.go:171","msg":"trace[992365009] transaction","detail":"{read_only:false; response_revision:2294; number_of_response:1; }","duration":"163.235089ms","start":"2026-07-09T09:29:52.437433Z","end":"2026-07-09T09:29:52.600668Z","steps":["trace[992365009] 'process raft request' (duration: 163.078235ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:30:28.601638Z","caller":"traceutil/trace.go:171","msg":"trace[1438044130] transaction","detail":"{read_only:false; response_revision:2455; number_of_response:1; }","duration":"100.718828ms","start":"2026-07-09T09:30:28.50088Z","end":"2026-07-09T09:30:28.601599Z","steps":["trace[1438044130] 'process raft request' (duration: 36.334126ms)","trace[1438044130] 'compare' (duration: 63.815088ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T09:30:28.601735Z","caller":"traceutil/trace.go:171","msg":"trace[939548831] transaction","detail":"{read_only:false; response_revision:2456; number_of_response:1; }","duration":"100.232326ms","start":"2026-07-09T09:30:28.501453Z","end":"2026-07-09T09:30:28.601686Z","steps":["trace[939548831] 'process raft request' (duration: 99.875676ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T09:30:43.418344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.246197ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-09T09:30:43.418446Z","caller":"traceutil/trace.go:171","msg":"trace[1133099452] linearizableReadLoop","detail":"{readStateIndex:2653; appliedIndex:2652; }","duration":"112.651458ms","start":"2026-07-09T09:30:43.305778Z","end":"2026-07-09T09:30:43.41843Z","steps":["trace[1133099452] 'read index received' (duration: 75.121µs)","trace[1133099452] 'applied index is now lower than readState.Index' (duration: 112.575167ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T09:30:43.418535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.759641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-09T09:30:43.418564Z","caller":"traceutil/trace.go:171","msg":"trace[1894337408] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:2545; }","duration":"112.791192ms","start":"2026-07-09T09:30:43.305765Z","end":"2026-07-09T09:30:43.418556Z","steps":["trace[1894337408] 'agreement among raft nodes before linearized reading' (duration: 112.70583ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:30:43.418552Z","caller":"traceutil/trace.go:171","msg":"trace[228567310] transaction","detail":"{read_only:false; response_revision:2545; number_of_response:1; }","duration":"431.101233ms","start":"2026-07-09T09:30:42.987371Z","end":"2026-07-09T09:30:43.418472Z","steps":["trace[228567310] 'process raft request' (duration: 147.652751ms)","trace[228567310] 'compare' (duration: 283.140655ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T09:30:43.418996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T09:30:42.987348Z","time spent":"431.517193ms","remote":"127.0.0.1:37518","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-09T09:30:49.638067Z","caller":"traceutil/trace.go:171","msg":"trace[1411357500] transaction","detail":"{read_only:false; response_revision:2579; number_of_response:1; }","duration":"125.523143ms","start":"2026-07-09T09:30:49.512506Z","end":"2026-07-09T09:30:49.638029Z","steps":["trace[1411357500] 'process raft request' (duration: 125.269157ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T09:30:50.399262Z","caller":"traceutil/trace.go:171","msg":"trace[1775606871] transaction","detail":"{read_only:false; response_revision:2581; number_of_response:1; }","duration":"110.012371ms","start":"2026-07-09T09:30:50.289217Z","end":"2026-07-09T09:30:50.399229Z","steps":["trace[1775606871] 'process raft request' (duration: 13.468149ms)","trace[1775606871] 'compare' (duration: 96.126352ms)"],"step_count":2}