{"level":"warn","ts":"2026-06-10T08:26:22.488359Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-10T08:26:22.488465Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.202: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.202:2380","--initial-cluster=instance=https://199.19.213.202:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.202:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.202: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-06-10T08:26:22.488826Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-10T08:26:22.488845Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.202:2380"]} {"level":"info","ts":"2026-06-10T08:26:22.488866Z","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-06-10T08:26:22.489623Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.202:2379"]} {"level":"info","ts":"2026-06-10T08:26:22.489697Z","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.202:2380"],"listen-peer-urls":["https://199.19.213.202:2380"],"advertise-client-urls":["https://199.19.213.202:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.202:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.202: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-06-10T08:26:22.493838Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.870007ms"} {"level":"info","ts":"2026-06-10T08:26:22.505765Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c9b4049ccf4190cf","cluster-id":"2bc66bd50b26302c"} {"level":"info","ts":"2026-06-10T08:26:22.505879Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9b4049ccf4190cf switched to configuration voters=()"} {"level":"info","ts":"2026-06-10T08:26:22.505952Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9b4049ccf4190cf became follower at term 0"} {"level":"info","ts":"2026-06-10T08:26:22.506027Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c9b4049ccf4190cf [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-10T08:26:22.506069Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9b4049ccf4190cf became follower at term 1"} {"level":"info","ts":"2026-06-10T08:26:22.506294Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9b4049ccf4190cf switched to configuration voters=(14534246968970023119)"} {"level":"warn","ts":"2026-06-10T08:26:22.51546Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-10T08:26:22.51725Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-10T08:26:22.520857Z","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-06-10T08:26:22.523174Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c9b4049ccf4190cf","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-10T08:26:22.523815Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c9b4049ccf4190cf","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-10T08:26:22.52399Z","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-06-10T08:26:22.524211Z","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-06-10T08:26:22.524262Z","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-06-10T08:26:22.525008Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9b4049ccf4190cf switched to configuration voters=(14534246968970023119)"} {"level":"info","ts":"2026-06-10T08:26:22.527534Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2bc66bd50b26302c","local-member-id":"c9b4049ccf4190cf","added-peer-id":"c9b4049ccf4190cf","added-peer-peer-urls":["https://199.19.213.202:2380"]} {"level":"info","ts":"2026-06-10T08:26:22.530582Z","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-06-10T08:26:22.530763Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.202:2380"} {"level":"info","ts":"2026-06-10T08:26:22.530842Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.202:2380"} {"level":"info","ts":"2026-06-10T08:26:22.531152Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c9b4049ccf4190cf","initial-advertise-peer-urls":["https://199.19.213.202:2380"],"listen-peer-urls":["https://199.19.213.202:2380"],"advertise-client-urls":["https://199.19.213.202:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.202:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-10T08:26:22.531217Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-10T08:26:23.00764Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9b4049ccf4190cf is starting a new election at term 1"} {"level":"info","ts":"2026-06-10T08:26:23.007708Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9b4049ccf4190cf became pre-candidate at term 1"} {"level":"info","ts":"2026-06-10T08:26:23.007731Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9b4049ccf4190cf received MsgPreVoteResp from c9b4049ccf4190cf at term 1"} {"level":"info","ts":"2026-06-10T08:26:23.007749Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9b4049ccf4190cf became candidate at term 2"} {"level":"info","ts":"2026-06-10T08:26:23.00776Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9b4049ccf4190cf received MsgVoteResp from c9b4049ccf4190cf at term 2"} {"level":"info","ts":"2026-06-10T08:26:23.007782Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9b4049ccf4190cf became leader at term 2"} {"level":"info","ts":"2026-06-10T08:26:23.007799Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c9b4049ccf4190cf elected leader c9b4049ccf4190cf at term 2"} {"level":"info","ts":"2026-06-10T08:26:23.00893Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-10T08:26:23.008933Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T08:26:23.00898Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-10T08:26:23.008994Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c9b4049ccf4190cf","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.202:2379]}","request-path":"/0/members/c9b4049ccf4190cf/attributes","cluster-id":"2bc66bd50b26302c","publish-timeout":"7s"} {"level":"info","ts":"2026-06-10T08:26:23.009346Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-10T08:26:23.009386Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-10T08:26:23.010018Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2bc66bd50b26302c","local-member-id":"c9b4049ccf4190cf","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T08:26:23.010201Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T08:26:23.010237Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T08:26:23.011274Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-10T08:26:23.013109Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.202:2379"} {"level":"info","ts":"2026-06-10T08:26:25.998008Z","caller":"traceutil/trace.go:171","msg":"trace[964012108] transaction","detail":"{read_only:false; response_revision:182; number_of_response:1; }","duration":"238.333658ms","start":"2026-06-10T08:26:25.759633Z","end":"2026-06-10T08:26:25.997967Z","steps":["trace[964012108] 'process raft request' (duration: 139.416339ms)","trace[964012108] 'compare' (duration: 98.455628ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:26:26.33955Z","caller":"traceutil/trace.go:171","msg":"trace[177536493] transaction","detail":"{read_only:false; response_revision:193; number_of_response:1; }","duration":"140.609525ms","start":"2026-06-10T08:26:26.198914Z","end":"2026-06-10T08:26:26.339524Z","steps":["trace[177536493] 'process raft request' (duration: 63.861573ms)","trace[177536493] 'compare' (duration: 76.599768ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:26:26.522971Z","caller":"traceutil/trace.go:171","msg":"trace[2072593127] transaction","detail":"{read_only:false; response_revision:197; number_of_response:1; }","duration":"119.273032ms","start":"2026-06-10T08:26:26.403664Z","end":"2026-06-10T08:26:26.522937Z","steps":["trace[2072593127] 'process raft request' (duration: 53.038668ms)","trace[2072593127] 'compare' (duration: 66.02491ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:26:29.376311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.780852ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-10T08:26:29.376598Z","caller":"traceutil/trace.go:171","msg":"trace[1965237157] linearizableReadLoop","detail":"{readStateIndex:316; appliedIndex:314; }","duration":"424.388933ms","start":"2026-06-10T08:26:28.952189Z","end":"2026-06-10T08:26:29.376578Z","steps":["trace[1965237157] 'read index received' (duration: 75.557779ms)","trace[1965237157] 'applied index is now lower than readState.Index' (duration: 348.830004ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:26:29.376746Z","caller":"traceutil/trace.go:171","msg":"trace[834021850] transaction","detail":"{read_only:false; response_revision:306; number_of_response:1; }","duration":"448.15665ms","start":"2026-06-10T08:26:28.928469Z","end":"2026-06-10T08:26:29.376626Z","steps":["trace[834021850] 'process raft request' (duration: 447.973297ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:26:29.37681Z","caller":"traceutil/trace.go:171","msg":"trace[1723016251] transaction","detail":"{read_only:false; response_revision:305; number_of_response:1; }","duration":"455.405626ms","start":"2026-06-10T08:26:28.921369Z","end":"2026-06-10T08:26:29.376774Z","steps":["trace[1723016251] 'process raft request' (duration: 106.434658ms)","trace[1723016251] 'compare' (duration: 347.598228ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:26:29.3769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.321078ms","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-06-10T08:26:29.376961Z","caller":"traceutil/trace.go:171","msg":"trace[308756746] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:307; }","duration":"168.40477ms","start":"2026-06-10T08:26:29.208533Z","end":"2026-06-10T08:26:29.376938Z","steps":["trace[308756746] 'agreement among raft nodes before linearized reading' (duration: 168.328208ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:26:29.376954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:26:28.921356Z","time spent":"455.537008ms","remote":"127.0.0.1:35252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":705,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T08:26:29.376958Z","caller":"traceutil/trace.go:171","msg":"trace[1356450129] transaction","detail":"{read_only:false; response_revision:307; number_of_response:1; }","duration":"417.128888ms","start":"2026-06-10T08:26:28.959729Z","end":"2026-06-10T08:26:29.376858Z","steps":["trace[1356450129] 'process raft request' (duration: 416.805452ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:26:29.37735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:26:28.959702Z","time spent":"417.502235ms","remote":"127.0.0.1:35280","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1934,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T08:26:29.376797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.601348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-06-10T08:26:29.377528Z","caller":"traceutil/trace.go:171","msg":"trace[2094181477] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:307; }","duration":"425.343483ms","start":"2026-06-10T08:26:28.952173Z","end":"2026-06-10T08:26:29.377516Z","steps":["trace[2094181477] 'agreement among raft nodes before linearized reading' (duration: 424.523436ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:26:29.377574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:26:28.952154Z","time spent":"425.401795ms","remote":"127.0.0.1:35286","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-06-10T08:26:29.378048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:26:28.928455Z","time spent":"448.412385ms","remote":"127.0.0.1:35446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T08:26:29.617777Z","caller":"traceutil/trace.go:171","msg":"trace[2138879433] transaction","detail":"{read_only:false; response_revision:310; number_of_response:1; }","duration":"232.172211ms","start":"2026-06-10T08:26:29.385589Z","end":"2026-06-10T08:26:29.617761Z","steps":["trace[2138879433] 'process raft request' (duration: 232.139701ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:26:29.617851Z","caller":"traceutil/trace.go:171","msg":"trace[2100803989] transaction","detail":"{read_only:false; response_revision:309; number_of_response:1; }","duration":"233.378867ms","start":"2026-06-10T08:26:29.384425Z","end":"2026-06-10T08:26:29.617804Z","steps":["trace[2100803989] 'process raft request' (duration: 136.400651ms)","trace[2100803989] 'compare' (duration: 96.793972ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:26:29.810138Z","caller":"traceutil/trace.go:171","msg":"trace[1422503184] transaction","detail":"{read_only:false; response_revision:312; number_of_response:1; }","duration":"171.834432ms","start":"2026-06-10T08:26:29.638274Z","end":"2026-06-10T08:26:29.810109Z","steps":["trace[1422503184] 'process raft request' (duration: 126.596333ms)","trace[1422503184] 'compare' (duration: 45.087186ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:26:29.814496Z","caller":"traceutil/trace.go:171","msg":"trace[2133091587] transaction","detail":"{read_only:false; response_revision:313; number_of_response:1; }","duration":"176.146564ms","start":"2026-06-10T08:26:29.638323Z","end":"2026-06-10T08:26:29.81447Z","steps":["trace[2133091587] 'process raft request' (duration: 175.97444ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:26:30.03197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.775613ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:5"} {"level":"info","ts":"2026-06-10T08:26:30.032151Z","caller":"traceutil/trace.go:171","msg":"trace[2125581797] transaction","detail":"{read_only:false; number_of_response:0; response_revision:313; }","duration":"264.740538ms","start":"2026-06-10T08:26:29.767358Z","end":"2026-06-10T08:26:30.032099Z","steps":["trace[2125581797] 'process raft request' (duration: 146.763822ms)","trace[2125581797] 'compare' (duration: 117.71207ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:26:30.032254Z","caller":"traceutil/trace.go:171","msg":"trace[855621921] linearizableReadLoop","detail":"{readStateIndex:324; appliedIndex:323; }","duration":"217.788053ms","start":"2026-06-10T08:26:29.814435Z","end":"2026-06-10T08:26:30.032223Z","steps":["trace[855621921] 'read index received' (duration: 99.701814ms)","trace[855621921] 'applied index is now lower than readState.Index' (duration: 118.082628ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:26:30.032458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.232476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:3980"} {"level":"info","ts":"2026-06-10T08:26:30.032899Z","caller":"traceutil/trace.go:171","msg":"trace[1571236706] transaction","detail":"{read_only:false; response_revision:315; number_of_response:1; }","duration":"214.306219ms","start":"2026-06-10T08:26:29.818538Z","end":"2026-06-10T08:26:30.032844Z","steps":["trace[1571236706] 'process raft request' (duration: 213.803569ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:26:30.032573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.317019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/resourcequota-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-06-10T08:26:30.033092Z","caller":"traceutil/trace.go:171","msg":"trace[1596700967] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/resourcequota-controller; range_end:; response_count:1; response_revision:315; }","duration":"214.830199ms","start":"2026-06-10T08:26:29.818211Z","end":"2026-06-10T08:26:30.033042Z","steps":["trace[1596700967] 'agreement among raft nodes before linearized reading' (duration: 214.201846ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:26:30.032655Z","caller":"traceutil/trace.go:171","msg":"trace[397110255] transaction","detail":"{read_only:false; response_revision:314; number_of_response:1; }","duration":"217.958266ms","start":"2026-06-10T08:26:29.814672Z","end":"2026-06-10T08:26:30.03263Z","steps":["trace[397110255] 'process raft request' (duration: 217.411645ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:26:30.033438Z","caller":"traceutil/trace.go:171","msg":"trace[347420358] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:314; }","duration":"263.734187ms","start":"2026-06-10T08:26:29.769169Z","end":"2026-06-10T08:26:30.032903Z","steps":["trace[347420358] 'agreement among raft nodes before linearized reading' (duration: 263.144874ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:26:36.204924Z","caller":"traceutil/trace.go:171","msg":"trace[1839655021] transaction","detail":"{read_only:false; response_revision:400; number_of_response:1; }","duration":"142.651213ms","start":"2026-06-10T08:26:36.062251Z","end":"2026-06-10T08:26:36.204902Z","steps":["trace[1839655021] 'process raft request' (duration: 142.532391ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:26:37.633786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.04262ms","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-06-10T08:26:37.633847Z","caller":"traceutil/trace.go:171","msg":"trace[168133210] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:405; }","duration":"120.146153ms","start":"2026-06-10T08:26:37.513688Z","end":"2026-06-10T08:26:37.633834Z","steps":["trace[168133210] 'range keys from in-memory index tree' (duration: 119.667403ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:26:37.891458Z","caller":"traceutil/trace.go:171","msg":"trace[1726941566] linearizableReadLoop","detail":"{readStateIndex:420; appliedIndex:419; }","duration":"104.495768ms","start":"2026-06-10T08:26:37.786941Z","end":"2026-06-10T08:26:37.891437Z","steps":["trace[1726941566] 'read index received' (duration: 77.785992ms)","trace[1726941566] 'applied index is now lower than readState.Index' (duration: 26.708816ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:26:37.891559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.59955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:26:37.891584Z","caller":"traceutil/trace.go:171","msg":"trace[1982400744] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:407; }","duration":"104.675502ms","start":"2026-06-10T08:26:37.7869Z","end":"2026-06-10T08:26:37.891576Z","steps":["trace[1982400744] 'agreement among raft nodes before linearized reading' (duration: 104.61428ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:26:37.891566Z","caller":"traceutil/trace.go:171","msg":"trace[809478233] transaction","detail":"{read_only:false; response_revision:407; number_of_response:1; }","duration":"245.625691ms","start":"2026-06-10T08:26:37.645918Z","end":"2026-06-10T08:26:37.891544Z","steps":["trace[809478233] 'process raft request' (duration: 218.784743ms)","trace[809478233] 'compare' (duration: 26.612503ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:26:38.331307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.432162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-10T08:26:38.331386Z","caller":"traceutil/trace.go:171","msg":"trace[1410624241] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:408; }","duration":"121.553174ms","start":"2026-06-10T08:26:38.209811Z","end":"2026-06-10T08:26:38.331364Z","steps":["trace[1410624241] 'range keys from in-memory index tree' (duration: 121.330391ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:26:38.91719Z","caller":"traceutil/trace.go:171","msg":"trace[1006768359] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"141.515832ms","start":"2026-06-10T08:26:38.775631Z","end":"2026-06-10T08:26:38.917147Z","steps":["trace[1006768359] 'process raft request' (duration: 141.37342ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:26:39.460995Z","caller":"traceutil/trace.go:171","msg":"trace[1163607849] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"102.257956ms","start":"2026-06-10T08:26:39.358715Z","end":"2026-06-10T08:26:39.460973Z","steps":["trace[1163607849] 'process raft request' (duration: 101.95407ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:26:39.771866Z","caller":"traceutil/trace.go:171","msg":"trace[302284004] linearizableReadLoop","detail":"{readStateIndex:427; appliedIndex:426; }","duration":"306.547636ms","start":"2026-06-10T08:26:39.465296Z","end":"2026-06-10T08:26:39.771843Z","steps":["trace[302284004] 'read index received' (duration: 224.094182ms)","trace[302284004] 'applied index is now lower than readState.Index' (duration: 82.452384ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:26:39.771942Z","caller":"traceutil/trace.go:171","msg":"trace[953812568] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"307.010935ms","start":"2026-06-10T08:26:39.464896Z","end":"2026-06-10T08:26:39.771907Z","steps":["trace[953812568] 'process raft request' (duration: 224.563771ms)","trace[953812568] 'compare' (duration: 82.025586ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:26:39.772102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:26:39.464876Z","time spent":"307.148547ms","remote":"127.0.0.1:35446","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-06-10T08:26:39.772226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.903883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5336"} {"level":"info","ts":"2026-06-10T08:26:39.772315Z","caller":"traceutil/trace.go:171","msg":"trace[1745623303] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:414; }","duration":"307.019615ms","start":"2026-06-10T08:26:39.46527Z","end":"2026-06-10T08:26:39.77229Z","steps":["trace[1745623303] 'agreement among raft nodes before linearized reading' (duration: 306.859402ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:26:39.772382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:26:39.465263Z","time spent":"307.105767ms","remote":"127.0.0.1:35358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":5359,"request content":"key:\"/registry/pods/kube-system/etcd-instance\" "} {"level":"warn","ts":"2026-06-10T08:26:39.772576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.769617ms","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-06-10T08:26:39.772663Z","caller":"traceutil/trace.go:171","msg":"trace[768238551] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:414; }","duration":"100.90523ms","start":"2026-06-10T08:26:39.671743Z","end":"2026-06-10T08:26:39.772648Z","steps":["trace[768238551] 'agreement among raft nodes before linearized reading' (duration: 100.767498ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:26:40.453682Z","caller":"traceutil/trace.go:171","msg":"trace[943649395] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"103.476869ms","start":"2026-06-10T08:26:40.350148Z","end":"2026-06-10T08:26:40.453625Z","steps":["trace[943649395] 'process raft request' (duration: 103.250074ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:26:40.79283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.80066ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T08:26:40.792942Z","caller":"traceutil/trace.go:171","msg":"trace[130016702] transaction","detail":"{read_only:false; response_revision:418; number_of_response:1; }","duration":"334.692272ms","start":"2026-06-10T08:26:40.458231Z","end":"2026-06-10T08:26:40.792924Z","steps":["trace[130016702] 'process raft request' (duration: 117.721998ms)","trace[130016702] 'compare' (duration: 216.691128ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:26:40.793008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:26:40.458208Z","time spent":"334.773214ms","remote":"127.0.0.1:35446","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-06-10T08:26:42.316411Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10434733343139540401,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-10T08:26:42.554867Z","caller":"traceutil/trace.go:171","msg":"trace[1430343201] transaction","detail":"{read_only:false; response_revision:419; number_of_response:1; }","duration":"775.279306ms","start":"2026-06-10T08:26:41.779566Z","end":"2026-06-10T08:26:42.554845Z","steps":["trace[1430343201] 'process raft request' (duration: 775.082872ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:26:42.555026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:26:41.779542Z","time spent":"775.393437ms","remote":"127.0.0.1:35446","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-06-10T08:26:44.822565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.767989854s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-10T08:26:44.822667Z","caller":"traceutil/trace.go:171","msg":"trace[26404960] linearizableReadLoop","detail":"{readStateIndex:433; appliedIndex:431; }","duration":"3.006799503s","start":"2026-06-10T08:26:41.81585Z","end":"2026-06-10T08:26:44.822649Z","steps":["trace[26404960] 'read index received' (duration: 738.883543ms)","trace[26404960] 'applied index is now lower than readState.Index' (duration: 2.26791463s)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:26:44.822932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.007080288s","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-06-10T08:26:44.822979Z","caller":"traceutil/trace.go:171","msg":"trace[923522377] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:419; }","duration":"3.007173221s","start":"2026-06-10T08:26:41.815791Z","end":"2026-06-10T08:26:44.822965Z","steps":["trace[923522377] 'agreement among raft nodes before linearized reading' (duration: 3.007073278s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:26:44.823013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:26:41.81577Z","time spent":"3.007234922s","remote":"127.0.0.1:35446","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-06-10T08:26:44.823068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.867088145s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-10T08:26:44.823111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.9187ms","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-06-10T08:26:44.823227Z","caller":"traceutil/trace.go:171","msg":"trace[2139020529] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:419; }","duration":"264.043582ms","start":"2026-06-10T08:26:44.559144Z","end":"2026-06-10T08:26:44.823188Z","steps":["trace[2139020529] 'agreement among raft nodes before linearized reading' (duration: 263.868769ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:26:44.823157Z","caller":"traceutil/trace.go:171","msg":"trace[763633653] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:419; }","duration":"1.867230098s","start":"2026-06-10T08:26:42.955906Z","end":"2026-06-10T08:26:44.823136Z","steps":["trace[763633653] 'agreement among raft nodes before linearized reading' (duration: 1.867088895s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:26:44.823385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:26:42.955884Z","time spent":"1.867490453s","remote":"127.0.0.1:34894","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-06-10T08:26:44.823074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.026663098s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-10T08:26:44.823534Z","caller":"traceutil/trace.go:171","msg":"trace[1056152361] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:419; }","duration":"2.027167838s","start":"2026-06-10T08:26:42.796354Z","end":"2026-06-10T08:26:44.823522Z","steps":["trace[1056152361] 'agreement among raft nodes before linearized reading' (duration: 2.026647419s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:26:44.823641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:26:42.796334Z","time spent":"2.027228349s","remote":"127.0.0.1:35446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-10T08:26:44.823074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.36557401s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-10T08:26:44.823703Z","caller":"traceutil/trace.go:171","msg":"trace[692122093] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:419; }","duration":"2.366252092s","start":"2026-06-10T08:26:42.457437Z","end":"2026-06-10T08:26:44.823689Z","steps":["trace[692122093] 'agreement among raft nodes before linearized reading' (duration: 2.365560829s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:26:44.823748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:26:42.457415Z","time spent":"2.366319854s","remote":"127.0.0.1:35446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-10T08:26:45.142832Z","caller":"traceutil/trace.go:171","msg":"trace[324174932] transaction","detail":"{read_only:false; response_revision:420; number_of_response:1; }","duration":"315.484875ms","start":"2026-06-10T08:26:44.82733Z","end":"2026-06-10T08:26:45.142814Z","steps":["trace[324174932] 'process raft request' (duration: 315.378603ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:26:45.142952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:26:44.82731Z","time spent":"315.585396ms","remote":"127.0.0.1:35446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T08:26:46.157313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"779.948164ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T08:26:46.157498Z","caller":"traceutil/trace.go:171","msg":"trace[1103877427] linearizableReadLoop","detail":"{readStateIndex:437; appliedIndex:433; }","duration":"1.324351947s","start":"2026-06-10T08:26:44.833133Z","end":"2026-06-10T08:26:46.157485Z","steps":["trace[1103877427] 'read index received' (duration: 309.502899ms)","trace[1103877427] 'applied index is now lower than readState.Index' (duration: 1.014848318s)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:26:46.157522Z","caller":"traceutil/trace.go:171","msg":"trace[524962944] transaction","detail":"{read_only:false; response_revision:422; number_of_response:1; }","duration":"1.329603679s","start":"2026-06-10T08:26:44.827901Z","end":"2026-06-10T08:26:46.157505Z","steps":["trace[524962944] 'process raft request' (duration: 1.329489097s)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:26:46.157572Z","caller":"traceutil/trace.go:171","msg":"trace[1427244125] transaction","detail":"{read_only:false; response_revision:424; number_of_response:1; }","duration":"1.11914713s","start":"2026-06-10T08:26:45.038418Z","end":"2026-06-10T08:26:46.157565Z","steps":["trace[1427244125] 'process raft request' (duration: 1.119037908s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:26:46.157616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:26:45.038393Z","time spent":"1.119198671s","remote":"127.0.0.1:35446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T08:26:46.157641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:26:44.827876Z","time spent":"1.32969901s","remote":"127.0.0.1:35446","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-06-10T08:26:46.157522Z","caller":"traceutil/trace.go:171","msg":"trace[641219594] transaction","detail":"{read_only:false; response_revision:421; number_of_response:1; }","duration":"1.329977826s","start":"2026-06-10T08:26:44.827515Z","end":"2026-06-10T08:26:46.157493Z","steps":["trace[641219594] 'process raft request' (duration: 549.777327ms)","trace[641219594] 'compare' (duration: 779.819721ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:26:46.157746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:26:44.827498Z","time spent":"1.33022967s","remote":"127.0.0.1:35446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T08:26:46.157763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.324630832s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:26:46.157797Z","caller":"traceutil/trace.go:171","msg":"trace[2095267156] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:424; }","duration":"1.324685644s","start":"2026-06-10T08:26:44.833101Z","end":"2026-06-10T08:26:46.157786Z","steps":["trace[2095267156] 'agreement among raft nodes before linearized reading' (duration: 1.324631763s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:26:46.157961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.797796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:26:46.157995Z","caller":"traceutil/trace.go:171","msg":"trace[352194345] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:424; }","duration":"310.861878ms","start":"2026-06-10T08:26:45.847124Z","end":"2026-06-10T08:26:46.157986Z","steps":["trace[352194345] 'agreement among raft nodes before linearized reading' (duration: 310.804507ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:26:46.158018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:26:45.847109Z","time spent":"310.902438ms","remote":"127.0.0.1:34894","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-06-10T08:26:46.158156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:26:44.833091Z","time spent":"1.324738455s","remote":"127.0.0.1:34894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-10T08:26:46.158191Z","caller":"traceutil/trace.go:171","msg":"trace[2045915240] transaction","detail":"{read_only:false; response_revision:423; number_of_response:1; }","duration":"1.329237972s","start":"2026-06-10T08:26:44.828265Z","end":"2026-06-10T08:26:46.157503Z","steps":["trace[2045915240] 'process raft request' (duration: 1.3291678s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:26:46.158282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:26:44.828257Z","time spent":"1.329965895s","remote":"127.0.0.1:35446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T08:26:55.293825Z","caller":"traceutil/trace.go:171","msg":"trace[949596786] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"100.871158ms","start":"2026-06-10T08:26:55.192928Z","end":"2026-06-10T08:26:55.293799Z","steps":["trace[949596786] 'process raft request' (duration: 100.721565ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:27:06.500851Z","caller":"traceutil/trace.go:171","msg":"trace[103347094] linearizableReadLoop","detail":"{readStateIndex:550; appliedIndex:549; }","duration":"109.607376ms","start":"2026-06-10T08:27:06.391222Z","end":"2026-06-10T08:27:06.50083Z","steps":["trace[103347094] 'read index received' (duration: 109.512005ms)","trace[103347094] 'applied index is now lower than readState.Index' (duration: 94.551µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:27:06.500945Z","caller":"traceutil/trace.go:171","msg":"trace[1343034002] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"145.460927ms","start":"2026-06-10T08:27:06.355458Z","end":"2026-06-10T08:27:06.500919Z","steps":["trace[1343034002] 'process raft request' (duration: 145.234723ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:27:06.501018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.773669ms","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-06-10T08:27:06.501058Z","caller":"traceutil/trace.go:171","msg":"trace[1382449925] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:532; }","duration":"109.870561ms","start":"2026-06-10T08:27:06.391178Z","end":"2026-06-10T08:27:06.501048Z","steps":["trace[1382449925] 'agreement among raft nodes before linearized reading' (duration: 109.7798ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:27:07.316061Z","caller":"traceutil/trace.go:171","msg":"trace[1476893716] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"606.890718ms","start":"2026-06-10T08:27:06.709147Z","end":"2026-06-10T08:27:07.316038Z","steps":["trace[1476893716] 'process raft request' (duration: 606.631763ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:27:07.316389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:27:06.709121Z","time spent":"607.042561ms","remote":"127.0.0.1:35446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T08:27:07.940274Z","caller":"traceutil/trace.go:171","msg":"trace[407957892] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"1.086149406s","start":"2026-06-10T08:27:06.854112Z","end":"2026-06-10T08:27:07.940261Z","steps":["trace[407957892] 'process raft request' (duration: 1.085980454s)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:27:07.940354Z","caller":"traceutil/trace.go:171","msg":"trace[1565997418] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"1.076799197s","start":"2026-06-10T08:27:06.863515Z","end":"2026-06-10T08:27:07.940314Z","steps":["trace[1565997418] 'process raft request' (duration: 1.076647655s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:27:07.940423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:27:06.854084Z","time spent":"1.086265108s","remote":"127.0.0.1:35228","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-06-10T08:27:07.940412Z","caller":"traceutil/trace.go:171","msg":"trace[483116154] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"1.074580189s","start":"2026-06-10T08:27:06.865788Z","end":"2026-06-10T08:27:07.940368Z","steps":["trace[483116154] 'process raft request' (duration: 1.074456567s)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:27:07.940458Z","caller":"traceutil/trace.go:171","msg":"trace[635854740] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"1.074543539s","start":"2026-06-10T08:27:06.865843Z","end":"2026-06-10T08:27:07.940386Z","steps":["trace[635854740] 'process raft request' (duration: 1.074439717s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:27:07.94054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:27:06.865754Z","time spent":"1.074731902s","remote":"127.0.0.1:35228","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-06-10T08:27:07.94058Z","caller":"traceutil/trace.go:171","msg":"trace[1446519088] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"1.074724972s","start":"2026-06-10T08:27:06.865843Z","end":"2026-06-10T08:27:07.940568Z","steps":["trace[1446519088] 'process raft request' (duration: 1.074474387s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:27:07.940627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:27:06.865822Z","time spent":"1.074782463s","remote":"127.0.0.1:35228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T08:27:07.940521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:27:06.863499Z","time spent":"1.07694397s","remote":"127.0.0.1:35228","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-06-10T08:27:07.940621Z","caller":"traceutil/trace.go:171","msg":"trace[1795825581] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"1.077011011s","start":"2026-06-10T08:27:06.86357Z","end":"2026-06-10T08:27:07.940581Z","steps":["trace[1795825581] 'process raft request' (duration: 1.076639495s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:27:07.940727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:27:06.865819Z","time spent":"1.074783153s","remote":"127.0.0.1:35228","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-06-10T08:27:07.940734Z","caller":"traceutil/trace.go:171","msg":"trace[1146522100] linearizableReadLoop","detail":"{readStateIndex:562; appliedIndex:553; }","duration":"1.060814435s","start":"2026-06-10T08:27:06.879899Z","end":"2026-06-10T08:27:07.940713Z","steps":["trace[1146522100] 'read index received' (duration: 436.575358ms)","trace[1146522100] 'applied index is now lower than readState.Index' (duration: 624.237957ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:27:07.940786Z","caller":"traceutil/trace.go:171","msg":"trace[1218036268] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"1.067804614s","start":"2026-06-10T08:27:06.872969Z","end":"2026-06-10T08:27:07.940774Z","steps":["trace[1218036268] 'process raft request' (duration: 1.067390677s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:27:07.940786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:27:06.863566Z","time spent":"1.077136333s","remote":"127.0.0.1:35228","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-06-10T08:27:07.940829Z","caller":"traceutil/trace.go:171","msg":"trace[1117143287] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"926.650331ms","start":"2026-06-10T08:27:07.014163Z","end":"2026-06-10T08:27:07.940814Z","steps":["trace[1117143287] 'process raft request' (duration: 926.460597ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:27:07.940846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:27:06.872955Z","time spent":"1.067860985s","remote":"127.0.0.1:35228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T08:27:07.940882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:27:07.014133Z","time spent":"926.723832ms","remote":"127.0.0.1:35228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T08:27:07.940917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.061002778s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.202\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-10T08:27:07.940954Z","caller":"traceutil/trace.go:171","msg":"trace[1710539996] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"1.025639836s","start":"2026-06-10T08:27:06.915305Z","end":"2026-06-10T08:27:07.940945Z","steps":["trace[1710539996] 'process raft request' (duration: 1.025254069s)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:27:07.940955Z","caller":"traceutil/trace.go:171","msg":"trace[547661421] range","detail":"{range_begin:/registry/masterleases/199.19.213.202; range_end:; response_count:1; response_revision:547; }","duration":"1.061067859s","start":"2026-06-10T08:27:06.879875Z","end":"2026-06-10T08:27:07.940943Z","steps":["trace[547661421] 'agreement among raft nodes before linearized reading' (duration: 1.060960297s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:27:07.941003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:27:06.915282Z","time spent":"1.025695176s","remote":"127.0.0.1:35228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T08:27:07.941049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:27:06.879868Z","time spent":"1.061117979s","remote":"127.0.0.1:35214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.202\" "} {"level":"info","ts":"2026-06-10T08:27:07.940754Z","caller":"traceutil/trace.go:171","msg":"trace[1726405330] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"1.044198642s","start":"2026-06-10T08:27:06.896547Z","end":"2026-06-10T08:27:07.940746Z","steps":["trace[1726405330] 'process raft request' (duration: 1.043952298s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:27:07.941059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.290112ms","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-06-10T08:27:07.941124Z","caller":"traceutil/trace.go:171","msg":"trace[2004683108] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:547; }","duration":"544.420085ms","start":"2026-06-10T08:27:07.396689Z","end":"2026-06-10T08:27:07.941109Z","steps":["trace[2004683108] 'agreement among raft nodes before linearized reading' (duration: 544.273302ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:27:07.941189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:27:07.396612Z","time spent":"544.565147ms","remote":"127.0.0.1:35446","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-06-10T08:27:07.941138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:27:06.896532Z","time spent":"1.044569598s","remote":"127.0.0.1:35228","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-06-10T08:27:07.940205Z","caller":"traceutil/trace.go:171","msg":"trace[995437934] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"1.086276889s","start":"2026-06-10T08:27:06.853887Z","end":"2026-06-10T08:27:07.940163Z","steps":["trace[995437934] 'process raft request' (duration: 1.086046425s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:27:07.941391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:27:06.85387Z","time spent":"1.087480749s","remote":"127.0.0.1:35228","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-06-10T08:27:07.94145Z","caller":"traceutil/trace.go:171","msg":"trace[1952881076] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"1.086262978s","start":"2026-06-10T08:27:06.854014Z","end":"2026-06-10T08:27:07.940277Z","steps":["trace[1952881076] 'process raft request' (duration: 1.086041304s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:27:07.941563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:27:06.854009Z","time spent":"1.087516568s","remote":"127.0.0.1:35228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T08:27:15.054763Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10434733343139540831,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-10T08:27:15.230117Z","caller":"traceutil/trace.go:171","msg":"trace[310017586] linearizableReadLoop","detail":"{readStateIndex:669; appliedIndex:668; }","duration":"675.614384ms","start":"2026-06-10T08:27:14.554471Z","end":"2026-06-10T08:27:15.230086Z","steps":["trace[310017586] 'read index received' (duration: 675.460902ms)","trace[310017586] 'applied index is now lower than readState.Index' (duration: 152.142µs)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:27:15.230461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"675.98012ms","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-06-10T08:27:15.23055Z","caller":"traceutil/trace.go:171","msg":"trace[1412152] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:646; }","duration":"676.117553ms","start":"2026-06-10T08:27:14.554411Z","end":"2026-06-10T08:27:15.230529Z","steps":["trace[1412152] 'agreement among raft nodes before linearized reading' (duration: 675.793197ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:27:15.23058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.71692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-ft79z\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-06-10T08:27:15.230596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:27:14.554356Z","time spent":"676.228754ms","remote":"127.0.0.1:35446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-10T08:27:15.230639Z","caller":"traceutil/trace.go:171","msg":"trace[966082635] range","detail":"{range_begin:/registry/pods/kube-system/cilium-ft79z; range_end:; response_count:1; response_revision:646; }","duration":"346.810822ms","start":"2026-06-10T08:27:14.883811Z","end":"2026-06-10T08:27:15.230622Z","steps":["trace[966082635] 'agreement among raft nodes before linearized reading' (duration: 346.66431ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:27:15.230708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:27:14.883792Z","time spent":"346.900693ms","remote":"127.0.0.1:35358","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-ft79z\" "} {"level":"warn","ts":"2026-06-10T08:27:15.230764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"660.301174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-10T08:27:15.230832Z","caller":"traceutil/trace.go:171","msg":"trace[1599397284] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:646; }","duration":"660.428695ms","start":"2026-06-10T08:27:14.570388Z","end":"2026-06-10T08:27:15.230817Z","steps":["trace[1599397284] 'agreement among raft nodes before linearized reading' (duration: 660.07793ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:27:15.230891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:27:14.570367Z","time spent":"660.502487ms","remote":"127.0.0.1:35446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-10T08:27:15.23098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"660.387385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-10T08:27:15.231061Z","caller":"traceutil/trace.go:171","msg":"trace[1863366923] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:646; }","duration":"660.551168ms","start":"2026-06-10T08:27:14.570496Z","end":"2026-06-10T08:27:15.231048Z","steps":["trace[1863366923] 'agreement among raft nodes before linearized reading' (duration: 660.004309ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:27:15.230209Z","caller":"traceutil/trace.go:171","msg":"trace[1560840286] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"803.96882ms","start":"2026-06-10T08:27:14.426187Z","end":"2026-06-10T08:27:15.230156Z","steps":["trace[1560840286] 'process raft request' (duration: 803.683785ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:27:15.231162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:27:14.570423Z","time spent":"660.72799ms","remote":"127.0.0.1:35446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-10T08:27:15.231188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:27:14.426161Z","time spent":"804.972586ms","remote":"127.0.0.1:35414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T08:27:15.482394Z","caller":"traceutil/trace.go:171","msg":"trace[1329374110] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"154.640195ms","start":"2026-06-10T08:27:15.327726Z","end":"2026-06-10T08:27:15.482367Z","steps":["trace[1329374110] 'process raft request' (duration: 82.10141ms)","trace[1329374110] 'compare' (duration: 72.349872ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:27:17.119951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.165345521s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:27:17.120023Z","caller":"traceutil/trace.go:171","msg":"trace[1855121334] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:655; }","duration":"1.165468763s","start":"2026-06-10T08:27:15.954536Z","end":"2026-06-10T08:27:17.120005Z","steps":["trace[1855121334] 'range keys from in-memory index tree' (duration: 1.165289651s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:27:17.120063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:27:15.954519Z","time spent":"1.165534474s","remote":"127.0.0.1:34910","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-06-10T08:27:17.120123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.129537057s","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-06-10T08:27:17.120198Z","caller":"traceutil/trace.go:171","msg":"trace[1684395372] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:655; }","duration":"1.129677369s","start":"2026-06-10T08:27:15.990503Z","end":"2026-06-10T08:27:17.12018Z","steps":["trace[1684395372] 'range keys from in-memory index tree' (duration: 1.129392655s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:27:17.12024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:27:15.990488Z","time spent":"1.129741291s","remote":"127.0.0.1:35446","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-06-10T08:27:17.120309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.272154685s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:27:17.120336Z","caller":"traceutil/trace.go:171","msg":"trace[169999147] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:655; }","duration":"1.272235576s","start":"2026-06-10T08:27:15.848094Z","end":"2026-06-10T08:27:17.120329Z","steps":["trace[169999147] 'range keys from in-memory index tree' (duration: 1.272093484s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:27:17.120353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:27:15.848077Z","time spent":"1.272272137s","remote":"127.0.0.1:34894","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-06-10T08:27:17.120843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.598817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.202\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-10T08:27:17.120923Z","caller":"traceutil/trace.go:171","msg":"trace[1090445288] range","detail":"{range_begin:/registry/masterleases/199.19.213.202; range_end:; response_count:1; response_revision:655; }","duration":"239.720809ms","start":"2026-06-10T08:27:16.881182Z","end":"2026-06-10T08:27:17.120903Z","steps":["trace[1090445288] 'range keys from in-memory index tree' (duration: 238.758825ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:27:17.627564Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10434733343139540852,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-10T08:27:18.127931Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10434733343139540852,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-10T08:27:18.629048Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10434733343139540852,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-10T08:27:19.127229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000283613s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-06-10T08:27:19.12732Z","caller":"traceutil/trace.go:171","msg":"trace[1274823543] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000424995s","start":"2026-06-10T08:27:17.126876Z","end":"2026-06-10T08:27:19.127301Z","steps":["trace[1274823543] 'agreement among raft nodes before linearized reading' (duration: 2.000315033s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:27:19.127388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:27:17.126563Z","time spent":"2.000815471s","remote":"127.0.0.1:34894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/06/10 08:27:19 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-10T08:27:19.129436Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10434733343139540852,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-10T08:27:19.40923Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.93768203s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-10T08:27:19.409569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:27:17.121543Z","time spent":"2.288021391s","remote":"127.0.0.1:35214","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-10T08:27:19.518824Z","caller":"traceutil/trace.go:171","msg":"trace[114597936] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"2.39449828s","start":"2026-06-10T08:27:17.1243Z","end":"2026-06-10T08:27:19.518798Z","steps":["trace[114597936] 'process raft request' (duration: 2.394276866s)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:27:19.518941Z","caller":"traceutil/trace.go:171","msg":"trace[1467864193] linearizableReadLoop","detail":"{readStateIndex:681; appliedIndex:678; }","duration":"2.391986069s","start":"2026-06-10T08:27:17.126934Z","end":"2026-06-10T08:27:19.51892Z","steps":["trace[1467864193] 'read index received' (duration: 2.282506432s)","trace[1467864193] 'applied index is now lower than readState.Index' (duration: 109.477747ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:27:19.519003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:27:17.124273Z","time spent":"2.394627321s","remote":"127.0.0.1:35446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T08:27:19.519024Z","caller":"traceutil/trace.go:171","msg":"trace[235886625] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"1.852951574s","start":"2026-06-10T08:27:17.666036Z","end":"2026-06-10T08:27:19.518988Z","steps":["trace[235886625] 'process raft request' (duration: 1.85270988s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:27:19.519204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:27:17.665999Z","time spent":"1.853108927s","remote":"127.0.0.1:35446","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-06-10T08:27:19.52045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.272345922s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-10T08:27:19.520533Z","caller":"traceutil/trace.go:171","msg":"trace[970236817] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:658; }","duration":"2.272467764s","start":"2026-06-10T08:27:17.24805Z","end":"2026-06-10T08:27:19.520517Z","steps":["trace[970236817] 'agreement among raft nodes before linearized reading' (duration: 2.27223731s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:27:19.520574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:27:17.248035Z","time spent":"2.272530805s","remote":"127.0.0.1:35446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-10T08:27:19.520702Z","caller":"traceutil/trace.go:171","msg":"trace[590232586] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"109.981155ms","start":"2026-06-10T08:27:19.410699Z","end":"2026-06-10T08:27:19.52068Z","steps":["trace[590232586] 'process raft request' (duration: 109.497497ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:27:19.520714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.17867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:27:19.520809Z","caller":"traceutil/trace.go:171","msg":"trace[1303402648] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:658; }","duration":"393.344023ms","start":"2026-06-10T08:27:19.127447Z","end":"2026-06-10T08:27:19.520791Z","steps":["trace[1303402648] 'agreement among raft nodes before linearized reading' (duration: 393.19076ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:27:19.520819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.26481056s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-10T08:27:19.520827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.263247534s","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-06-10T08:27:19.520858Z","caller":"traceutil/trace.go:171","msg":"trace[1819914475] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:658; }","duration":"2.264865581s","start":"2026-06-10T08:27:17.255982Z","end":"2026-06-10T08:27:19.520848Z","steps":["trace[1819914475] 'agreement among raft nodes before linearized reading' (duration: 2.264772159s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:27:19.520862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:27:19.127428Z","time spent":"393.420694ms","remote":"127.0.0.1:34910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-10T08:27:19.520876Z","caller":"traceutil/trace.go:171","msg":"trace[870180297] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:658; }","duration":"2.263297655s","start":"2026-06-10T08:27:17.257564Z","end":"2026-06-10T08:27:19.520861Z","steps":["trace[870180297] 'agreement among raft nodes before linearized reading' (duration: 2.263132752s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:27:19.520892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:27:17.255974Z","time spent":"2.264911861s","remote":"127.0.0.1:35446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-10T08:27:19.520911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:27:17.257544Z","time spent":"2.263359356s","remote":"127.0.0.1:35446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-10T08:27:21.413481Z","caller":"traceutil/trace.go:171","msg":"trace[1573472843] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"342.40728ms","start":"2026-06-10T08:27:21.071039Z","end":"2026-06-10T08:27:21.413447Z","steps":["trace[1573472843] 'process raft request' (duration: 342.221977ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:27:21.413687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:27:21.071013Z","time spent":"342.572762ms","remote":"127.0.0.1:35228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4580,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T08:27:21.416618Z","caller":"traceutil/trace.go:171","msg":"trace[739551581] transaction","detail":"{read_only:false; response_revision:688; number_of_response:1; }","duration":"145.79152ms","start":"2026-06-10T08:27:21.270816Z","end":"2026-06-10T08:27:21.416607Z","steps":["trace[739551581] 'process raft request' (duration: 145.742959ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:27:24.276088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.9826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:1 size:4083"} {"level":"info","ts":"2026-06-10T08:27:24.276202Z","caller":"traceutil/trace.go:171","msg":"trace[224421834] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:729; }","duration":"208.139623ms","start":"2026-06-10T08:27:24.068042Z","end":"2026-06-10T08:27:24.276182Z","steps":["trace[224421834] 'range keys from in-memory index tree' (duration: 207.786757ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:27:31.708237Z","caller":"traceutil/trace.go:171","msg":"trace[1014630048] linearizableReadLoop","detail":"{readStateIndex:821; appliedIndex:820; }","duration":"133.933331ms","start":"2026-06-10T08:27:31.574282Z","end":"2026-06-10T08:27:31.708215Z","steps":["trace[1014630048] 'read index received' (duration: 133.747608ms)","trace[1014630048] 'applied index is now lower than readState.Index' (duration: 185.013µs)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:27:31.708477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.186035ms","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-06-10T08:27:31.708534Z","caller":"traceutil/trace.go:171","msg":"trace[505701778] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:792; }","duration":"134.288266ms","start":"2026-06-10T08:27:31.574237Z","end":"2026-06-10T08:27:31.708525Z","steps":["trace[505701778] 'agreement among raft nodes before linearized reading' (duration: 134.133323ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:27:31.708594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.539991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-10T08:27:31.708623Z","caller":"traceutil/trace.go:171","msg":"trace[660475671] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:792; }","duration":"108.609962ms","start":"2026-06-10T08:27:31.600006Z","end":"2026-06-10T08:27:31.708616Z","steps":["trace[660475671] 'agreement among raft nodes before linearized reading' (duration: 108.532951ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:27:31.708749Z","caller":"traceutil/trace.go:171","msg":"trace[1631812037] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"135.622556ms","start":"2026-06-10T08:27:31.573118Z","end":"2026-06-10T08:27:31.70874Z","steps":["trace[1631812037] 'process raft request' (duration: 134.971946ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:27:31.708994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.376198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:27:31.709029Z","caller":"traceutil/trace.go:171","msg":"trace[1981975543] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:792; }","duration":"104.431318ms","start":"2026-06-10T08:27:31.604589Z","end":"2026-06-10T08:27:31.709021Z","steps":["trace[1981975543] 'agreement among raft nodes before linearized reading' (duration: 104.385848ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:27:31.709053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.318947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:27:31.709115Z","caller":"traceutil/trace.go:171","msg":"trace[263686055] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:792; }","duration":"104.441708ms","start":"2026-06-10T08:27:31.604661Z","end":"2026-06-10T08:27:31.709103Z","steps":["trace[263686055] 'agreement among raft nodes before linearized reading' (duration: 104.299566ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:27:31.709151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.055139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-10T08:27:31.709185Z","caller":"traceutil/trace.go:171","msg":"trace[335406905] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:792; }","duration":"109.10376ms","start":"2026-06-10T08:27:31.600075Z","end":"2026-06-10T08:27:31.709179Z","steps":["trace[335406905] 'agreement among raft nodes before linearized reading' (duration: 109.033739ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:27:35.482162Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10434733343139541224,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-10T08:27:35.982951Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10434733343139541224,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-10T08:27:36.179407Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.23744548s","expected-duration":"1s"} {"level":"info","ts":"2026-06-10T08:27:36.179891Z","caller":"traceutil/trace.go:171","msg":"trace[142694816] linearizableReadLoop","detail":"{readStateIndex:839; appliedIndex:838; }","duration":"1.198409048s","start":"2026-06-10T08:27:34.981454Z","end":"2026-06-10T08:27:36.179863Z","steps":["trace[142694816] 'read index received' (duration: 1.198299967s)","trace[142694816] 'applied index is now lower than readState.Index' (duration: 105.721µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:27:36.17998Z","caller":"traceutil/trace.go:171","msg":"trace[673675195] transaction","detail":"{read_only:false; response_revision:809; number_of_response:1; }","duration":"1.238091989s","start":"2026-06-10T08:27:34.941864Z","end":"2026-06-10T08:27:36.179956Z","steps":["trace[673675195] 'process raft request' (duration: 1.237809785s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:27:36.180382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.105039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-10T08:27:36.180392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.093478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-10T08:27:36.180444Z","caller":"traceutil/trace.go:171","msg":"trace[1125961664] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:809; }","duration":"382.187829ms","start":"2026-06-10T08:27:35.798239Z","end":"2026-06-10T08:27:36.180426Z","steps":["trace[1125961664] 'agreement among raft nodes before linearized reading' (duration: 382.008127ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:27:36.180488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:27:35.798223Z","time spent":"382.255881ms","remote":"127.0.0.1:35446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-10T08:27:36.180518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"623.779635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-10T08:27:36.180521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.587858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-10T08:27:36.180572Z","caller":"traceutil/trace.go:171","msg":"trace[242477225] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:809; }","duration":"623.862426ms","start":"2026-06-10T08:27:35.556692Z","end":"2026-06-10T08:27:36.180555Z","steps":["trace[242477225] 'agreement among raft nodes before linearized reading' (duration: 623.773665ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:27:36.180585Z","caller":"traceutil/trace.go:171","msg":"trace[1958989856] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:809; }","duration":"243.689398ms","start":"2026-06-10T08:27:35.936878Z","end":"2026-06-10T08:27:36.180568Z","steps":["trace[1958989856] 'agreement among raft nodes before linearized reading' (duration: 243.602187ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:27:36.180587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.50737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-10T08:27:36.18063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:27:35.55668Z","time spent":"623.930627ms","remote":"127.0.0.1:35280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":13,"response size":30,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "} {"level":"info","ts":"2026-06-10T08:27:36.180639Z","caller":"traceutil/trace.go:171","msg":"trace[1030823036] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:809; }","duration":"332.601321ms","start":"2026-06-10T08:27:35.848023Z","end":"2026-06-10T08:27:36.180624Z","steps":["trace[1030823036] 'agreement among raft nodes before linearized reading' (duration: 332.52415ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:27:36.18072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:27:35.848Z","time spent":"332.690922ms","remote":"127.0.0.1:34894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-10T08:27:36.180505Z","caller":"traceutil/trace.go:171","msg":"trace[795356726] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:809; }","duration":"382.23196ms","start":"2026-06-10T08:27:35.798239Z","end":"2026-06-10T08:27:36.180471Z","steps":["trace[795356726] 'agreement among raft nodes before linearized reading' (duration: 381.984036ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:27:36.180796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:27:35.798223Z","time spent":"382.561376ms","remote":"127.0.0.1:35446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-10T08:27:36.180401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.670974ms","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-06-10T08:27:36.180939Z","caller":"traceutil/trace.go:171","msg":"trace[577157637] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:809; }","duration":"453.255022ms","start":"2026-06-10T08:27:35.727667Z","end":"2026-06-10T08:27:36.180922Z","steps":["trace[577157637] 'agreement among raft nodes before linearized reading' (duration: 452.586462ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:27:36.180973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:27:35.727642Z","time spent":"453.321343ms","remote":"127.0.0.1:35446","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-06-10T08:27:36.180391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.636556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T08:27:36.181055Z","caller":"traceutil/trace.go:171","msg":"trace[1323845209] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:809; }","duration":"226.363737ms","start":"2026-06-10T08:27:35.954679Z","end":"2026-06-10T08:27:36.181043Z","steps":["trace[1323845209] 'agreement among raft nodes before linearized reading' (duration: 225.617246ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:27:36.181321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.19985766s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-g6zfq\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-06-10T08:27:36.181392Z","caller":"traceutil/trace.go:171","msg":"trace[188252763] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-g6zfq; range_end:; response_count:1; response_revision:809; }","duration":"1.199933421s","start":"2026-06-10T08:27:34.981441Z","end":"2026-06-10T08:27:36.181374Z","steps":["trace[188252763] 'agreement among raft nodes before linearized reading' (duration: 1.198587091s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:27:36.181436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:27:34.981376Z","time spent":"1.200047653s","remote":"127.0.0.1:35358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3988,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-g6zfq\" "} {"level":"warn","ts":"2026-06-10T08:27:36.184872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.500984ms","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-06-10T08:27:36.184945Z","caller":"traceutil/trace.go:171","msg":"trace[708380736] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:809; }","duration":"386.621375ms","start":"2026-06-10T08:27:35.798306Z","end":"2026-06-10T08:27:36.184927Z","steps":["trace[708380736] 'agreement among raft nodes before linearized reading' (duration: 381.901805ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:27:36.185013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:27:35.798286Z","time spent":"386.716177ms","remote":"127.0.0.1:35446","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-06-10T08:27:36.18009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"741.487371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-10T08:27:36.185809Z","caller":"traceutil/trace.go:171","msg":"trace[850708159] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:809; }","duration":"747.249988ms","start":"2026-06-10T08:27:35.438532Z","end":"2026-06-10T08:27:36.185782Z","steps":["trace[850708159] 'agreement among raft nodes before linearized reading' (duration: 741.486621ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:27:36.185845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:27:35.438511Z","time spent":"747.32106ms","remote":"127.0.0.1:35644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":3,"response size":30,"request content":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true "} {"level":"warn","ts":"2026-06-10T08:27:36.187446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:27:34.941834Z","time spent":"1.238230122s","remote":"127.0.0.1:35446","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-06-10T08:27:36.386534Z","caller":"traceutil/trace.go:171","msg":"trace[1172704238] transaction","detail":"{read_only:false; response_revision:810; number_of_response:1; }","duration":"197.875065ms","start":"2026-06-10T08:27:36.188633Z","end":"2026-06-10T08:27:36.386508Z","steps":["trace[1172704238] 'process raft request' (duration: 195.317557ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:27:36.393531Z","caller":"traceutil/trace.go:171","msg":"trace[1327079244] transaction","detail":"{read_only:false; response_revision:811; number_of_response:1; }","duration":"204.320953ms","start":"2026-06-10T08:27:36.189195Z","end":"2026-06-10T08:27:36.393516Z","steps":["trace[1327079244] 'process raft request' (duration: 204.143131ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:27:36.393543Z","caller":"traceutil/trace.go:171","msg":"trace[773500114] transaction","detail":"{read_only:false; response_revision:813; number_of_response:1; }","duration":"204.321333ms","start":"2026-06-10T08:27:36.18921Z","end":"2026-06-10T08:27:36.393531Z","steps":["trace[773500114] 'process raft request' (duration: 204.208282ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:27:36.393675Z","caller":"traceutil/trace.go:171","msg":"trace[287803995] transaction","detail":"{read_only:false; response_revision:814; number_of_response:1; }","duration":"202.804431ms","start":"2026-06-10T08:27:36.190861Z","end":"2026-06-10T08:27:36.393665Z","steps":["trace[287803995] 'process raft request' (duration: 202.622469ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:27:36.393542Z","caller":"traceutil/trace.go:171","msg":"trace[1178739283] transaction","detail":"{read_only:false; response_revision:812; number_of_response:1; }","duration":"204.332303ms","start":"2026-06-10T08:27:36.189195Z","end":"2026-06-10T08:27:36.393528Z","steps":["trace[1178739283] 'process raft request' (duration: 204.198921ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:27:56.723756Z","caller":"traceutil/trace.go:171","msg":"trace[966422989] transaction","detail":"{read_only:false; response_revision:1016; number_of_response:1; }","duration":"134.298761ms","start":"2026-06-10T08:27:56.589428Z","end":"2026-06-10T08:27:56.723727Z","steps":["trace[966422989] 'process raft request' (duration: 106.459487ms)","trace[966422989] 'compare' (duration: 27.703352ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:28:26.655381Z","caller":"traceutil/trace.go:171","msg":"trace[1287900843] transaction","detail":"{read_only:false; response_revision:1116; number_of_response:1; }","duration":"105.308676ms","start":"2026-06-10T08:28:26.550044Z","end":"2026-06-10T08:28:26.655353Z","steps":["trace[1287900843] 'process raft request' (duration: 104.87264ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:28:45.17215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.074851ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T08:28:45.172299Z","caller":"traceutil/trace.go:171","msg":"trace[1817338112] transaction","detail":"{read_only:false; response_revision:1177; number_of_response:1; }","duration":"321.360076ms","start":"2026-06-10T08:28:44.850914Z","end":"2026-06-10T08:28:45.172274Z","steps":["trace[1817338112] 'process raft request' (duration: 42.039412ms)","trace[1817338112] 'compare' (duration: 278.962319ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:28:45.172385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:28:44.850897Z","time spent":"321.444107ms","remote":"127.0.0.1:35446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T08:28:45.235041Z","caller":"traceutil/trace.go:171","msg":"trace[1102547109] transaction","detail":"{read_only:false; response_revision:1178; number_of_response:1; }","duration":"383.896497ms","start":"2026-06-10T08:28:44.851126Z","end":"2026-06-10T08:28:45.235022Z","steps":["trace[1102547109] 'process raft request' (duration: 383.729095ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:28:45.235256Z","caller":"traceutil/trace.go:171","msg":"trace[393386042] transaction","detail":"{read_only:false; response_revision:1179; number_of_response:1; }","duration":"382.850414ms","start":"2026-06-10T08:28:44.852335Z","end":"2026-06-10T08:28:45.235186Z","steps":["trace[393386042] 'process raft request' (duration: 382.653412ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:28:45.235289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:28:44.851115Z","time spent":"384.03995ms","remote":"127.0.0.1:35446","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-06-10T08:28:45.23541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:28:44.852328Z","time spent":"382.985496ms","remote":"127.0.0.1:35446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T08:28:45.235443Z","caller":"traceutil/trace.go:171","msg":"trace[400166235] linearizableReadLoop","detail":"{readStateIndex:1225; appliedIndex:1225; }","duration":"250.761433ms","start":"2026-06-10T08:28:44.984607Z","end":"2026-06-10T08:28:45.235368Z","steps":["trace[400166235] 'read index received' (duration: 250.752483ms)","trace[400166235] 'applied index is now lower than readState.Index' (duration: 7.67µs)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:28:45.235612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.081194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-10T08:28:45.235624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.025156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-10T08:28:45.235664Z","caller":"traceutil/trace.go:171","msg":"trace[947737646] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1179; }","duration":"251.097336ms","start":"2026-06-10T08:28:44.984556Z","end":"2026-06-10T08:28:45.235654Z","steps":["trace[947737646] 'agreement among raft nodes before linearized reading' (duration: 250.968225ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:28:45.235662Z","caller":"traceutil/trace.go:171","msg":"trace[1675430150] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:1179; }","duration":"222.173735ms","start":"2026-06-10T08:28:45.013473Z","end":"2026-06-10T08:28:45.235647Z","steps":["trace[1675430150] 'agreement among raft nodes before linearized reading' (duration: 222.088354ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:28:45.393451Z","caller":"traceutil/trace.go:171","msg":"trace[1950850965] transaction","detail":"{read_only:false; response_revision:1180; number_of_response:1; }","duration":"153.407535ms","start":"2026-06-10T08:28:45.240009Z","end":"2026-06-10T08:28:45.393416Z","steps":["trace[1950850965] 'process raft request' (duration: 59.518146ms)","trace[1950850965] 'compare' (duration: 93.764947ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:29:07.623513Z","caller":"traceutil/trace.go:171","msg":"trace[717660889] transaction","detail":"{read_only:false; response_revision:1253; number_of_response:1; }","duration":"117.25291ms","start":"2026-06-10T08:29:07.50621Z","end":"2026-06-10T08:29:07.623463Z","steps":["trace[717660889] 'process raft request' (duration: 20.311255ms)","trace[717660889] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/kube-system/plndr-svcs-lock; req_size:420; } (duration: 96.702082ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:29:11.205289Z","caller":"traceutil/trace.go:171","msg":"trace[466886511] linearizableReadLoop","detail":"{readStateIndex:1312; appliedIndex:1311; }","duration":"190.732612ms","start":"2026-06-10T08:29:11.014531Z","end":"2026-06-10T08:29:11.205264Z","steps":["trace[466886511] 'read index received' (duration: 96.040849ms)","trace[466886511] 'applied index is now lower than readState.Index' (duration: 94.690893ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:29:11.20544Z","caller":"traceutil/trace.go:171","msg":"trace[291633964] transaction","detail":"{read_only:false; response_revision:1261; number_of_response:1; }","duration":"282.969766ms","start":"2026-06-10T08:29:10.922403Z","end":"2026-06-10T08:29:11.205373Z","steps":["trace[291633964] 'process raft request' (duration: 188.271713ms)","trace[291633964] 'compare' (duration: 94.46197ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:29:11.205831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.038686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:1 size:12755"} {"level":"info","ts":"2026-06-10T08:29:11.205894Z","caller":"traceutil/trace.go:171","msg":"trace[301690150] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:1; response_revision:1261; }","duration":"191.403661ms","start":"2026-06-10T08:29:11.014471Z","end":"2026-06-10T08:29:11.205875Z","steps":["trace[301690150] 'agreement among raft nodes before linearized reading' (duration: 190.879964ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:29:13.543758Z","caller":"traceutil/trace.go:171","msg":"trace[1164433074] transaction","detail":"{read_only:false; response_revision:1270; number_of_response:1; }","duration":"115.012273ms","start":"2026-06-10T08:29:13.428714Z","end":"2026-06-10T08:29:13.543726Z","steps":["trace[1164433074] 'process raft request' (duration: 114.806591ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:29:25.383334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.524229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-10T08:29:25.383431Z","caller":"traceutil/trace.go:171","msg":"trace[698633275] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1340; }","duration":"127.700406ms","start":"2026-06-10T08:29:25.255712Z","end":"2026-06-10T08:29:25.383412Z","steps":["trace[698633275] 'count revisions from in-memory index tree' (duration: 127.394124ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:29:33.723149Z","caller":"traceutil/trace.go:171","msg":"trace[960743901] transaction","detail":"{read_only:false; response_revision:1374; number_of_response:1; }","duration":"477.675412ms","start":"2026-06-10T08:29:33.245457Z","end":"2026-06-10T08:29:33.723133Z","steps":["trace[960743901] 'process raft request' (duration: 477.557377ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:29:33.723263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:29:33.245438Z","time spent":"477.767075ms","remote":"127.0.0.1:35354","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5898,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T08:29:33.844762Z","caller":"traceutil/trace.go:171","msg":"trace[646735857] linearizableReadLoop","detail":"{readStateIndex:1432; appliedIndex:1430; }","duration":"209.224015ms","start":"2026-06-10T08:29:33.635511Z","end":"2026-06-10T08:29:33.844735Z","steps":["trace[646735857] 'read index received' (duration: 87.582228ms)","trace[646735857] 'applied index is now lower than readState.Index' (duration: 121.640567ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T08:29:33.844885Z","caller":"traceutil/trace.go:171","msg":"trace[1583829699] transaction","detail":"{read_only:false; response_revision:1375; number_of_response:1; }","duration":"432.866044ms","start":"2026-06-10T08:29:33.412004Z","end":"2026-06-10T08:29:33.84487Z","steps":["trace[1583829699] 'process raft request' (duration: 392.45239ms)","trace[1583829699] 'compare' (duration: 39.916356ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T08:29:33.845049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:29:33.411974Z","time spent":"432.956667ms","remote":"127.0.0.1:35446","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-06-10T08:29:33.845584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.878205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-10T08:29:33.84565Z","caller":"traceutil/trace.go:171","msg":"trace[1026836164] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1375; }","duration":"148.968949ms","start":"2026-06-10T08:29:33.696659Z","end":"2026-06-10T08:29:33.845628Z","steps":["trace[1026836164] 'agreement among raft nodes before linearized reading' (duration: 148.868775ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:29:33.845152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.392727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-10T08:29:33.845954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.136083ms","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-06-10T08:29:33.845986Z","caller":"traceutil/trace.go:171","msg":"trace[648092174] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1375; }","duration":"156.199165ms","start":"2026-06-10T08:29:33.689778Z","end":"2026-06-10T08:29:33.845977Z","steps":["trace[648092174] 'agreement among raft nodes before linearized reading' (duration: 156.104892ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T08:29:33.84536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.858199ms","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-06-10T08:29:33.846105Z","caller":"traceutil/trace.go:171","msg":"trace[1791258253] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1375; }","duration":"210.610427ms","start":"2026-06-10T08:29:33.635453Z","end":"2026-06-10T08:29:33.846063Z","steps":["trace[1791258253] 'agreement among raft nodes before linearized reading' (duration: 209.762205ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T08:29:33.846165Z","caller":"traceutil/trace.go:171","msg":"trace[1860245225] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1375; }","duration":"175.25308ms","start":"2026-06-10T08:29:33.670706Z","end":"2026-06-10T08:29:33.845959Z","steps":["trace[1860245225] 'agreement among raft nodes before linearized reading' (duration: 174.365826ms)"],"step_count":1}