{"level":"warn","ts":"2026-08-13T08:01:57.561026Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-13T08:01:57.561136Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.217: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.217:2380","--initial-cluster=instance=https://199.19.213.217:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.217:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.217: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-08-13T08:01:57.561222Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-13T08:01:57.56124Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.217:2380"]} {"level":"info","ts":"2026-08-13T08:01:57.561266Z","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-08-13T08:01:57.564148Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.217:2379"]} {"level":"info","ts":"2026-08-13T08:01:57.56423Z","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.217:2380"],"listen-peer-urls":["https://199.19.213.217:2380"],"advertise-client-urls":["https://199.19.213.217:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.217:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.217: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-08-13T08:01:57.57785Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"12.871648ms"} {"level":"info","ts":"2026-08-13T08:01:57.590457Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"22141a955455b8ec","cluster-id":"30738c1f7233ae60"} {"level":"info","ts":"2026-08-13T08:01:57.590595Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"22141a955455b8ec switched to configuration voters=()"} {"level":"info","ts":"2026-08-13T08:01:57.590622Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"22141a955455b8ec became follower at term 0"} {"level":"info","ts":"2026-08-13T08:01:57.590634Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 22141a955455b8ec [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-13T08:01:57.590645Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"22141a955455b8ec became follower at term 1"} {"level":"info","ts":"2026-08-13T08:01:57.590691Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"22141a955455b8ec switched to configuration voters=(2455616925491116268)"} {"level":"warn","ts":"2026-08-13T08:01:57.605486Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-13T08:01:57.611576Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-13T08:01:57.614888Z","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-08-13T08:01:57.617975Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"22141a955455b8ec","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-13T08:01:57.620147Z","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-08-13T08:01:57.620528Z","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-08-13T08:01:57.620573Z","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-08-13T08:01:57.618679Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"22141a955455b8ec","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-13T08:01:57.621188Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"22141a955455b8ec switched to configuration voters=(2455616925491116268)"} {"level":"info","ts":"2026-08-13T08:01:57.621382Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"30738c1f7233ae60","local-member-id":"22141a955455b8ec","added-peer-id":"22141a955455b8ec","added-peer-peer-urls":["https://199.19.213.217:2380"]} {"level":"info","ts":"2026-08-13T08:01:57.624323Z","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-08-13T08:01:57.624656Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.217:2380"} {"level":"info","ts":"2026-08-13T08:01:57.624698Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.217:2380"} {"level":"info","ts":"2026-08-13T08:01:57.624757Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"22141a955455b8ec","initial-advertise-peer-urls":["https://199.19.213.217:2380"],"listen-peer-urls":["https://199.19.213.217:2380"],"advertise-client-urls":["https://199.19.213.217:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.217:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-13T08:01:57.624832Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-13T08:01:58.491214Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"22141a955455b8ec is starting a new election at term 1"} {"level":"info","ts":"2026-08-13T08:01:58.491302Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"22141a955455b8ec became pre-candidate at term 1"} {"level":"info","ts":"2026-08-13T08:01:58.491353Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"22141a955455b8ec received MsgPreVoteResp from 22141a955455b8ec at term 1"} {"level":"info","ts":"2026-08-13T08:01:58.491374Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"22141a955455b8ec became candidate at term 2"} {"level":"info","ts":"2026-08-13T08:01:58.491426Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"22141a955455b8ec received MsgVoteResp from 22141a955455b8ec at term 2"} {"level":"info","ts":"2026-08-13T08:01:58.491441Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"22141a955455b8ec became leader at term 2"} {"level":"info","ts":"2026-08-13T08:01:58.491458Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 22141a955455b8ec elected leader 22141a955455b8ec at term 2"} {"level":"info","ts":"2026-08-13T08:01:58.496261Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"22141a955455b8ec","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.217:2379]}","request-path":"/0/members/22141a955455b8ec/attributes","cluster-id":"30738c1f7233ae60","publish-timeout":"7s"} {"level":"info","ts":"2026-08-13T08:01:58.496531Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-13T08:01:58.496633Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-13T08:01:58.49663Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T08:01:58.499486Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.217:2379"} {"level":"info","ts":"2026-08-13T08:01:58.500213Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-13T08:01:58.500233Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-13T08:01:58.500307Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-13T08:01:58.506121Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"30738c1f7233ae60","local-member-id":"22141a955455b8ec","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T08:01:58.506372Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T08:01:58.506472Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T08:02:07.000811Z","caller":"traceutil/trace.go:171","msg":"trace[1826700767] linearizableReadLoop","detail":"{readStateIndex:308; appliedIndex:307; }","duration":"367.453411ms","start":"2026-08-13T08:02:06.633333Z","end":"2026-08-13T08:02:07.000786Z","steps":["trace[1826700767] 'read index received' (duration: 367.339428ms)","trace[1826700767] 'applied index is now lower than readState.Index' (duration: 113.003µs)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:02:07.000947Z","caller":"traceutil/trace.go:171","msg":"trace[467807865] transaction","detail":"{read_only:false; response_revision:298; number_of_response:1; }","duration":"408.131379ms","start":"2026-08-13T08:02:06.592802Z","end":"2026-08-13T08:02:07.000933Z","steps":["trace[467807865] 'process raft request' (duration: 407.857001ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:02:07.001185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.822133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-08-13T08:02:07.001341Z","caller":"traceutil/trace.go:171","msg":"trace[700027429] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:298; }","duration":"368.018689ms","start":"2026-08-13T08:02:06.633302Z","end":"2026-08-13T08:02:07.001321Z","steps":["trace[700027429] 'agreement among raft nodes before linearized reading' (duration: 367.715359ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:02:07.001428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:02:06.633283Z","time spent":"368.131672ms","remote":"127.0.0.1:36936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":225,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" "} {"level":"warn","ts":"2026-08-13T08:02:07.001348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:02:06.592777Z","time spent":"408.192791ms","remote":"127.0.0.1:36864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2163,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T08:02:07.001721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.609477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-08-13T08:02:07.001753Z","caller":"traceutil/trace.go:171","msg":"trace[1479663559] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:298; }","duration":"118.680499ms","start":"2026-08-13T08:02:06.883064Z","end":"2026-08-13T08:02:07.001744Z","steps":["trace[1479663559] 'agreement among raft nodes before linearized reading' (duration: 118.621228ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:02:07.001775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.801754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"warn","ts":"2026-08-13T08:02:07.001878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.257195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"warn","ts":"2026-08-13T08:02:07.001776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.131539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-08-13T08:02:07.001952Z","caller":"traceutil/trace.go:171","msg":"trace[989717913] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:298; }","duration":"218.345755ms","start":"2026-08-13T08:02:06.783594Z","end":"2026-08-13T08:02:07.001939Z","steps":["trace[989717913] 'agreement among raft nodes before linearized reading' (duration: 218.119208ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:02:07.001979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.768446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-08-13T08:02:07.001884Z","caller":"traceutil/trace.go:171","msg":"trace[1421460845] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:298; }","duration":"316.956669ms","start":"2026-08-13T08:02:06.684898Z","end":"2026-08-13T08:02:07.001855Z","steps":["trace[1421460845] 'agreement among raft nodes before linearized reading' (duration: 316.775893ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:02:07.002114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:02:06.684864Z","time spent":"317.239037ms","remote":"127.0.0.1:36936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":215,"request content":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" "} {"level":"info","ts":"2026-08-13T08:02:07.002093Z","caller":"traceutil/trace.go:171","msg":"trace[148860446] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:298; }","duration":"267.942061ms","start":"2026-08-13T08:02:06.734131Z","end":"2026-08-13T08:02:07.002073Z","steps":["trace[148860446] 'agreement among raft nodes before linearized reading' (duration: 267.710004ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:07.001955Z","caller":"traceutil/trace.go:171","msg":"trace[1035843847] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:298; }","duration":"168.355538ms","start":"2026-08-13T08:02:06.83358Z","end":"2026-08-13T08:02:07.001936Z","steps":["trace[1035843847] 'agreement among raft nodes before linearized reading' (duration: 168.253165ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:38.648213Z","caller":"traceutil/trace.go:171","msg":"trace[886338937] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"251.495698ms","start":"2026-08-13T08:02:38.396682Z","end":"2026-08-13T08:02:38.648177Z","steps":["trace[886338937] 'process raft request' (duration: 156.405729ms)","trace[886338937] 'compare' (duration: 94.831972ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:02:38.648361Z","caller":"traceutil/trace.go:171","msg":"trace[1094433987] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"239.834044ms","start":"2026-08-13T08:02:38.4085Z","end":"2026-08-13T08:02:38.648334Z","steps":["trace[1094433987] 'process raft request' (duration: 239.649379ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:38.648469Z","caller":"traceutil/trace.go:171","msg":"trace[1036877395] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"236.877713ms","start":"2026-08-13T08:02:38.411583Z","end":"2026-08-13T08:02:38.648461Z","steps":["trace[1036877395] 'process raft request' (duration: 236.76572ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:38.648526Z","caller":"traceutil/trace.go:171","msg":"trace[1623585331] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"236.926984ms","start":"2026-08-13T08:02:38.411593Z","end":"2026-08-13T08:02:38.64852Z","steps":["trace[1623585331] 'process raft request' (duration: 236.7884ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:38.648449Z","caller":"traceutil/trace.go:171","msg":"trace[1737492193] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"251.630912ms","start":"2026-08-13T08:02:38.396725Z","end":"2026-08-13T08:02:38.648356Z","steps":["trace[1737492193] 'process raft request' (duration: 251.387725ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:38.648597Z","caller":"traceutil/trace.go:171","msg":"trace[1569447385] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"233.466658ms","start":"2026-08-13T08:02:38.415118Z","end":"2026-08-13T08:02:38.648585Z","steps":["trace[1569447385] 'process raft request' (duration: 233.330534ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:38.64847Z","caller":"traceutil/trace.go:171","msg":"trace[937149493] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"239.880596ms","start":"2026-08-13T08:02:38.408553Z","end":"2026-08-13T08:02:38.648433Z","steps":["trace[937149493] 'process raft request' (duration: 239.627409ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:38.648547Z","caller":"traceutil/trace.go:171","msg":"trace[676796753] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"227.193443ms","start":"2026-08-13T08:02:38.421333Z","end":"2026-08-13T08:02:38.648526Z","steps":["trace[676796753] 'process raft request' (duration: 227.155762ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:38.648797Z","caller":"traceutil/trace.go:171","msg":"trace[1429632391] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"240.110672ms","start":"2026-08-13T08:02:38.408621Z","end":"2026-08-13T08:02:38.648732Z","steps":["trace[1429632391] 'process raft request' (duration: 239.639899ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:38.680109Z","caller":"traceutil/trace.go:171","msg":"trace[1263266984] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"249.962816ms","start":"2026-08-13T08:02:38.430122Z","end":"2026-08-13T08:02:38.680085Z","steps":["trace[1263266984] 'process raft request' (duration: 249.75572ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:38.680352Z","caller":"traceutil/trace.go:171","msg":"trace[1694296352] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"248.716231ms","start":"2026-08-13T08:02:38.431599Z","end":"2026-08-13T08:02:38.680315Z","steps":["trace[1694296352] 'process raft request' (duration: 248.420563ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:38.680412Z","caller":"traceutil/trace.go:171","msg":"trace[1191395525] linearizableReadLoop","detail":"{readStateIndex:518; appliedIndex:506; }","duration":"237.299524ms","start":"2026-08-13T08:02:38.443048Z","end":"2026-08-13T08:02:38.680347Z","steps":["trace[1191395525] 'read index received' (duration: 110.199398ms)","trace[1191395525] 'applied index is now lower than readState.Index' (duration: 127.099126ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:02:38.680461Z","caller":"traceutil/trace.go:171","msg":"trace[1413498210] transaction","detail":"{read_only:false; number_of_response:1; response_revision:500; }","duration":"248.776882ms","start":"2026-08-13T08:02:38.431676Z","end":"2026-08-13T08:02:38.680453Z","steps":["trace[1413498210] 'process raft request' (duration: 248.400382ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:38.680568Z","caller":"traceutil/trace.go:171","msg":"trace[786664709] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"235.550095ms","start":"2026-08-13T08:02:38.444983Z","end":"2026-08-13T08:02:38.680533Z","steps":["trace[786664709] 'process raft request' (duration: 235.178635ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:02:38.680684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.575652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-13T08:02:38.680738Z","caller":"traceutil/trace.go:171","msg":"trace[459070261] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:501; }","duration":"237.734076ms","start":"2026-08-13T08:02:38.442994Z","end":"2026-08-13T08:02:38.680728Z","steps":["trace[459070261] 'agreement among raft nodes before linearized reading' (duration: 237.564591ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:38.801302Z","caller":"traceutil/trace.go:171","msg":"trace[1937538146] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"142.441712ms","start":"2026-08-13T08:02:38.658824Z","end":"2026-08-13T08:02:38.801266Z","steps":["trace[1937538146] 'process raft request' (duration: 141.389463ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:38.801406Z","caller":"traceutil/trace.go:171","msg":"trace[1033729699] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"138.787571ms","start":"2026-08-13T08:02:38.662588Z","end":"2026-08-13T08:02:38.801375Z","steps":["trace[1033729699] 'process raft request' (duration: 137.750232ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:38.801436Z","caller":"traceutil/trace.go:171","msg":"trace[1063730415] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"195.383401ms","start":"2026-08-13T08:02:38.605985Z","end":"2026-08-13T08:02:38.801368Z","steps":["trace[1063730415] 'process raft request' (duration: 191.151274ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:38.801847Z","caller":"traceutil/trace.go:171","msg":"trace[507142474] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"144.943251ms","start":"2026-08-13T08:02:38.656499Z","end":"2026-08-13T08:02:38.801443Z","steps":["trace[507142474] 'process raft request' (duration: 143.489461ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:38.801869Z","caller":"traceutil/trace.go:171","msg":"trace[1695405007] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"126.49703ms","start":"2026-08-13T08:02:38.675353Z","end":"2026-08-13T08:02:38.80185Z","steps":["trace[1695405007] 'process raft request' (duration: 125.533153ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:38.801939Z","caller":"traceutil/trace.go:171","msg":"trace[940325341] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"139.048318ms","start":"2026-08-13T08:02:38.66266Z","end":"2026-08-13T08:02:38.801708Z","steps":["trace[940325341] 'process raft request' (duration: 137.811053ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:38.801415Z","caller":"traceutil/trace.go:171","msg":"trace[875811432] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"134.098341ms","start":"2026-08-13T08:02:38.667288Z","end":"2026-08-13T08:02:38.801386Z","steps":["trace[875811432] 'process raft request' (duration: 133.296509ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:38.804212Z","caller":"traceutil/trace.go:171","msg":"trace[1685745792] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"132.28431ms","start":"2026-08-13T08:02:38.669587Z","end":"2026-08-13T08:02:38.801871Z","steps":["trace[1685745792] 'process raft request' (duration: 131.19517ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:38.80444Z","caller":"traceutil/trace.go:171","msg":"trace[283058809] linearizableReadLoop","detail":"{readStateIndex:528; appliedIndex:519; }","duration":"121.357928ms","start":"2026-08-13T08:02:38.680491Z","end":"2026-08-13T08:02:38.801849Z","steps":["trace[283058809] 'read index received' (duration: 115.754592ms)","trace[283058809] 'applied index is now lower than readState.Index' (duration: 5.163003ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:02:38.804704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.743805ms","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-08-13T08:02:38.804789Z","caller":"traceutil/trace.go:171","msg":"trace[1911141634] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:510; }","duration":"242.90596ms","start":"2026-08-13T08:02:38.561865Z","end":"2026-08-13T08:02:38.804771Z","steps":["trace[1911141634] 'agreement among raft nodes before linearized reading' (duration: 240.01812ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:02:38.804861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.129255ms","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-08-13T08:02:38.804909Z","caller":"traceutil/trace.go:171","msg":"trace[880284829] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:510; }","duration":"328.226077ms","start":"2026-08-13T08:02:38.476671Z","end":"2026-08-13T08:02:38.804897Z","steps":["trace[880284829] 'agreement among raft nodes before linearized reading' (duration: 324.750431ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:02:38.804933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:02:38.476648Z","time spent":"328.278768ms","remote":"127.0.0.1:36998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-08-13T08:02:38.805012Z","caller":"traceutil/trace.go:171","msg":"trace[1517232982] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"131.986402ms","start":"2026-08-13T08:02:38.669447Z","end":"2026-08-13T08:02:38.801433Z","steps":["trace[1517232982] 'process raft request' (duration: 131.264942ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:02:38.805402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.361708ms","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-08-13T08:02:38.805437Z","caller":"traceutil/trace.go:171","msg":"trace[1348331347] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:510; }","duration":"307.43767ms","start":"2026-08-13T08:02:38.497991Z","end":"2026-08-13T08:02:38.805429Z","steps":["trace[1348331347] 'agreement among raft nodes before linearized reading' (duration: 303.895972ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:02:38.805468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:02:38.49797Z","time spent":"307.490332ms","remote":"127.0.0.1:36998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-13T08:02:38.863371Z","caller":"traceutil/trace.go:171","msg":"trace[2120829223] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"168.454574ms","start":"2026-08-13T08:02:38.694897Z","end":"2026-08-13T08:02:38.863352Z","steps":["trace[2120829223] 'process raft request' (duration: 168.404883ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:38.863514Z","caller":"traceutil/trace.go:171","msg":"trace[1818980522] transaction","detail":"{read_only:false; number_of_response:0; response_revision:510; }","duration":"176.864638ms","start":"2026-08-13T08:02:38.686638Z","end":"2026-08-13T08:02:38.863503Z","steps":["trace[1818980522] 'process raft request' (duration: 176.482377ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:38.863556Z","caller":"traceutil/trace.go:171","msg":"trace[461945594] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"176.820826ms","start":"2026-08-13T08:02:38.686728Z","end":"2026-08-13T08:02:38.863549Z","steps":["trace[461945594] 'process raft request' (duration: 176.459536ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:38.863845Z","caller":"traceutil/trace.go:171","msg":"trace[777028776] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"172.100365ms","start":"2026-08-13T08:02:38.691735Z","end":"2026-08-13T08:02:38.863835Z","steps":["trace[777028776] 'process raft request' (duration: 171.515239ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:39.100842Z","caller":"traceutil/trace.go:171","msg":"trace[1707645071] transaction","detail":"{read_only:false; number_of_response:0; response_revision:513; }","duration":"288.325679ms","start":"2026-08-13T08:02:38.812491Z","end":"2026-08-13T08:02:39.100816Z","steps":["trace[1707645071] 'process raft request' (duration: 288.164885ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:39.100931Z","caller":"traceutil/trace.go:171","msg":"trace[519087275] transaction","detail":"{read_only:false; number_of_response:0; response_revision:513; }","duration":"288.498874ms","start":"2026-08-13T08:02:38.8124Z","end":"2026-08-13T08:02:39.100899Z","steps":["trace[519087275] 'process raft request' (duration: 276.757348ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:39.101089Z","caller":"traceutil/trace.go:171","msg":"trace[1058694418] transaction","detail":"{read_only:false; number_of_response:0; response_revision:513; }","duration":"288.622387ms","start":"2026-08-13T08:02:38.812407Z","end":"2026-08-13T08:02:39.101029Z","steps":["trace[1058694418] 'process raft request' (duration: 288.222896ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:39.101234Z","caller":"traceutil/trace.go:171","msg":"trace[2006811259] transaction","detail":"{read_only:false; number_of_response:0; response_revision:513; }","duration":"288.678039ms","start":"2026-08-13T08:02:38.812548Z","end":"2026-08-13T08:02:39.101226Z","steps":["trace[2006811259] 'process raft request' (duration: 288.128993ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:39.101173Z","caller":"traceutil/trace.go:171","msg":"trace[1974333904] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"288.572996ms","start":"2026-08-13T08:02:38.812586Z","end":"2026-08-13T08:02:39.101159Z","steps":["trace[1974333904] 'process raft request' (duration: 288.130523ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:39.101335Z","caller":"traceutil/trace.go:171","msg":"trace[978192127] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"287.548237ms","start":"2026-08-13T08:02:38.813777Z","end":"2026-08-13T08:02:39.101325Z","steps":["trace[978192127] 'process raft request' (duration: 287.012653ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:39.101616Z","caller":"traceutil/trace.go:171","msg":"trace[1075265979] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"287.765654ms","start":"2026-08-13T08:02:38.813825Z","end":"2026-08-13T08:02:39.10159Z","steps":["trace[1075265979] 'process raft request' (duration: 286.998272ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:39.101666Z","caller":"traceutil/trace.go:171","msg":"trace[583463840] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"269.804625ms","start":"2026-08-13T08:02:38.831848Z","end":"2026-08-13T08:02:39.101652Z","steps":["trace[583463840] 'process raft request' (duration: 269.025254ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:39.10243Z","caller":"traceutil/trace.go:171","msg":"trace[607739188] linearizableReadLoop","detail":"{readStateIndex:541; appliedIndex:532; }","duration":"235.506493ms","start":"2026-08-13T08:02:38.866903Z","end":"2026-08-13T08:02:39.10241Z","steps":["trace[607739188] 'read index received' (duration: 222.317367ms)","trace[607739188] 'applied index is now lower than readState.Index' (duration: 13.187686ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:02:39.102783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.850553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/v1beta1.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:1010"} {"level":"info","ts":"2026-08-13T08:02:39.102854Z","caller":"traceutil/trace.go:171","msg":"trace[1643674239] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/v1beta1.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:518; }","duration":"235.954066ms","start":"2026-08-13T08:02:38.866878Z","end":"2026-08-13T08:02:39.102832Z","steps":["trace[1643674239] 'agreement among raft nodes before linearized reading' (duration: 235.607476ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:39.103091Z","caller":"traceutil/trace.go:171","msg":"trace[1283600769] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"267.81003ms","start":"2026-08-13T08:02:38.835263Z","end":"2026-08-13T08:02:39.103073Z","steps":["trace[1283600769] 'process raft request' (duration: 266.317718ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:39.190189Z","caller":"traceutil/trace.go:171","msg":"trace[1292732595] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"317.698094ms","start":"2026-08-13T08:02:38.872458Z","end":"2026-08-13T08:02:39.190156Z","steps":["trace[1292732595] 'process raft request' (duration: 317.411666ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:39.190237Z","caller":"traceutil/trace.go:171","msg":"trace[1293382231] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"314.380922ms","start":"2026-08-13T08:02:38.875835Z","end":"2026-08-13T08:02:39.190216Z","steps":["trace[1293382231] 'process raft request' (duration: 314.228858ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:39.190251Z","caller":"traceutil/trace.go:171","msg":"trace[869342581] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"316.996025ms","start":"2026-08-13T08:02:38.873229Z","end":"2026-08-13T08:02:39.190225Z","steps":["trace[869342581] 'process raft request' (duration: 316.772239ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:02:39.190362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:02:38.873221Z","time spent":"317.087367ms","remote":"127.0.0.1:36804","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10846,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T08:02:39.190361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:02:38.872443Z","time spent":"317.827967ms","remote":"127.0.0.1:36804","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T08:02:39.190446Z","caller":"traceutil/trace.go:171","msg":"trace[1545307686] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"297.73804ms","start":"2026-08-13T08:02:38.892697Z","end":"2026-08-13T08:02:39.190435Z","steps":["trace[1545307686] 'process raft request' (duration: 297.421751ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:02:39.190577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:02:38.875811Z","time spent":"314.488455ms","remote":"127.0.0.1:36804","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-13T08:02:39.364121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.035807ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-13T08:02:39.364293Z","caller":"traceutil/trace.go:171","msg":"trace[469635124] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"164.134624ms","start":"2026-08-13T08:02:39.200139Z","end":"2026-08-13T08:02:39.364274Z","steps":["trace[469635124] 'process raft request' (duration: 28.777959ms)","trace[469635124] 'compare' (duration: 134.914593ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:02:39.401167Z","caller":"traceutil/trace.go:171","msg":"trace[1989246179] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"198.378864ms","start":"2026-08-13T08:02:39.202767Z","end":"2026-08-13T08:02:39.401146Z","steps":["trace[1989246179] 'process raft request' (duration: 198.20589ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:39.401281Z","caller":"traceutil/trace.go:171","msg":"trace[336926762] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"197.173001ms","start":"2026-08-13T08:02:39.204094Z","end":"2026-08-13T08:02:39.401267Z","steps":["trace[336926762] 'process raft request' (duration: 197.002886ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:39.680586Z","caller":"traceutil/trace.go:171","msg":"trace[410410004] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"406.257982ms","start":"2026-08-13T08:02:39.274265Z","end":"2026-08-13T08:02:39.680523Z","steps":["trace[410410004] 'process raft request' (duration: 381.039863ms)","trace[410410004] 'compare' (duration: 25.024794ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:02:39.680702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:02:39.274237Z","time spent":"406.413467ms","remote":"127.0.0.1:36804","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97665,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-13T08:02:39.701608Z","caller":"traceutil/trace.go:171","msg":"trace[1127523500] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"281.83133ms","start":"2026-08-13T08:02:39.419759Z","end":"2026-08-13T08:02:39.70159Z","steps":["trace[1127523500] 'process raft request' (duration: 281.766048ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:39.702471Z","caller":"traceutil/trace.go:171","msg":"trace[1703115998] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"286.944651ms","start":"2026-08-13T08:02:39.415502Z","end":"2026-08-13T08:02:39.702447Z","steps":["trace[1703115998] 'process raft request' (duration: 285.869702ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:39.957444Z","caller":"traceutil/trace.go:171","msg":"trace[1557005352] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"100.441367ms","start":"2026-08-13T08:02:39.856974Z","end":"2026-08-13T08:02:39.957416Z","steps":["trace[1557005352] 'process raft request' (duration: 59.329297ms)","trace[1557005352] 'compare' (duration: 40.679458ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:02:40.429247Z","caller":"traceutil/trace.go:171","msg":"trace[1299146785] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"281.032477ms","start":"2026-08-13T08:02:40.148195Z","end":"2026-08-13T08:02:40.429227Z","steps":["trace[1299146785] 'process raft request' (duration: 279.362661ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:40.429596Z","caller":"traceutil/trace.go:171","msg":"trace[1656937203] linearizableReadLoop","detail":"{readStateIndex:569; appliedIndex:569; }","duration":"256.294042ms","start":"2026-08-13T08:02:40.173277Z","end":"2026-08-13T08:02:40.429571Z","steps":["trace[1656937203] 'read index received' (duration: 256.280281ms)","trace[1656937203] 'applied index is now lower than readState.Index' (duration: 10.801µs)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:02:40.429727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.430576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T08:02:40.429796Z","caller":"traceutil/trace.go:171","msg":"trace[1435149970] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:546; }","duration":"256.534759ms","start":"2026-08-13T08:02:40.173242Z","end":"2026-08-13T08:02:40.429777Z","steps":["trace[1435149970] 'agreement among raft nodes before linearized reading' (duration: 256.423265ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:40.439071Z","caller":"traceutil/trace.go:171","msg":"trace[1421998272] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"206.281974ms","start":"2026-08-13T08:02:40.232766Z","end":"2026-08-13T08:02:40.439048Z","steps":["trace[1421998272] 'process raft request' (duration: 205.830252ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:40.439552Z","caller":"traceutil/trace.go:171","msg":"trace[1212781973] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"109.969891ms","start":"2026-08-13T08:02:40.329558Z","end":"2026-08-13T08:02:40.439528Z","steps":["trace[1212781973] 'process raft request' (duration: 109.459567ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:47.097353Z","caller":"traceutil/trace.go:171","msg":"trace[5914591] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"119.165166ms","start":"2026-08-13T08:02:46.978168Z","end":"2026-08-13T08:02:47.097334Z","steps":["trace[5914591] 'process raft request' (duration: 119.048903ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:47.291329Z","caller":"traceutil/trace.go:171","msg":"trace[1426770212] linearizableReadLoop","detail":"{readStateIndex:632; appliedIndex:627; }","duration":"116.326748ms","start":"2026-08-13T08:02:47.174979Z","end":"2026-08-13T08:02:47.291306Z","steps":["trace[1426770212] 'read index received' (duration: 903.375µs)","trace[1426770212] 'applied index is now lower than readState.Index' (duration: 115.421963ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:02:47.29166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.657107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-13T08:02:47.291778Z","caller":"traceutil/trace.go:171","msg":"trace[1035526116] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:607; }","duration":"116.814862ms","start":"2026-08-13T08:02:47.174943Z","end":"2026-08-13T08:02:47.291758Z","steps":["trace[1035526116] 'agreement among raft nodes before linearized reading' (duration: 116.468642ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:47.292084Z","caller":"traceutil/trace.go:171","msg":"trace[1173900416] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"106.192036ms","start":"2026-08-13T08:02:47.185877Z","end":"2026-08-13T08:02:47.292069Z","steps":["trace[1173900416] 'process raft request' (duration: 105.429555ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:02:47.2922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.869832ms","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-08-13T08:02:47.292375Z","caller":"traceutil/trace.go:171","msg":"trace[1276802249] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:608; }","duration":"117.056278ms","start":"2026-08-13T08:02:47.175298Z","end":"2026-08-13T08:02:47.292354Z","steps":["trace[1276802249] 'agreement among raft nodes before linearized reading' (duration: 116.77814ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:47.920359Z","caller":"traceutil/trace.go:171","msg":"trace[1360807237] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"146.69915ms","start":"2026-08-13T08:02:47.773641Z","end":"2026-08-13T08:02:47.92034Z","steps":["trace[1360807237] 'process raft request' (duration: 146.573306ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:03:05.487329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.768418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-08-13T08:03:05.487408Z","caller":"traceutil/trace.go:171","msg":"trace[333784390] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:773; }","duration":"219.894011ms","start":"2026-08-13T08:03:05.267499Z","end":"2026-08-13T08:03:05.487393Z","steps":["trace[333784390] 'range keys from in-memory index tree' (duration: 219.51243ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:03:46.908217Z","caller":"traceutil/trace.go:171","msg":"trace[1642883553] linearizableReadLoop","detail":"{readStateIndex:1047; appliedIndex:1046; }","duration":"153.687994ms","start":"2026-08-13T08:03:46.754508Z","end":"2026-08-13T08:03:46.908196Z","steps":["trace[1642883553] 'read index received' (duration: 153.411627ms)","trace[1642883553] 'applied index is now lower than readState.Index' (duration: 275.497µs)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:03:46.908403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.870969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-13T08:03:46.908432Z","caller":"traceutil/trace.go:171","msg":"trace[2114303595] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1008; }","duration":"153.963362ms","start":"2026-08-13T08:03:46.754461Z","end":"2026-08-13T08:03:46.908424Z","steps":["trace[2114303595] 'agreement among raft nodes before linearized reading' (duration: 153.825008ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:03:46.908516Z","caller":"traceutil/trace.go:171","msg":"trace[729487241] transaction","detail":"{read_only:false; response_revision:1008; number_of_response:1; }","duration":"272.093386ms","start":"2026-08-13T08:03:46.6364Z","end":"2026-08-13T08:03:46.908494Z","steps":["trace[729487241] 'process raft request' (duration: 271.685964ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:03:47.368205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.722386ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-13T08:03:47.368526Z","caller":"traceutil/trace.go:171","msg":"trace[1573166435] linearizableReadLoop","detail":"{readStateIndex:1048; appliedIndex:1047; }","duration":"372.184396ms","start":"2026-08-13T08:03:46.996285Z","end":"2026-08-13T08:03:47.368469Z","steps":["trace[1573166435] 'read index received' (duration: 126.10278ms)","trace[1573166435] 'applied index is now lower than readState.Index' (duration: 246.077396ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:03:47.36866Z","caller":"traceutil/trace.go:171","msg":"trace[924664153] transaction","detail":"{read_only:false; response_revision:1009; number_of_response:1; }","duration":"456.867577ms","start":"2026-08-13T08:03:46.911557Z","end":"2026-08-13T08:03:47.368424Z","steps":["trace[924664153] 'process raft request' (duration: 210.844153ms)","trace[924664153] 'compare' (duration: 245.610143ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:03:47.368886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:03:46.91154Z","time spent":"457.231617ms","remote":"127.0.0.1:36998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T08:03:47.489538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.227439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-13T08:03:47.489574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.191507ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-08-13T08:03:47.489615Z","caller":"traceutil/trace.go:171","msg":"trace[1804143308] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1009; }","duration":"493.341572ms","start":"2026-08-13T08:03:46.996251Z","end":"2026-08-13T08:03:47.489593Z","steps":["trace[1804143308] 'agreement among raft nodes before linearized reading' (duration: 372.405092ms)","trace[1804143308] 'count revisions from in-memory index tree' (duration: 120.826378ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:03:47.489635Z","caller":"traceutil/trace.go:171","msg":"trace[932527944] linearizableReadLoop","detail":"{readStateIndex:1049; appliedIndex:1048; }","duration":"121.016853ms","start":"2026-08-13T08:03:47.368605Z","end":"2026-08-13T08:03:47.489622Z","steps":["trace[932527944] 'read index received' (duration: 71.252µs)","trace[932527944] 'applied index is now lower than readState.Index' (duration: 120.944561ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:03:47.489661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:03:46.996235Z","time spent":"493.413035ms","remote":"127.0.0.1:36912","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":27,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true "} {"level":"warn","ts":"2026-08-13T08:03:47.489687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.172572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T08:03:47.48972Z","caller":"traceutil/trace.go:171","msg":"trace[1730182031] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1009; }","duration":"315.243003ms","start":"2026-08-13T08:03:47.174459Z","end":"2026-08-13T08:03:47.489702Z","steps":["trace[1730182031] 'agreement among raft nodes before linearized reading' (duration: 315.195632ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:03:47.489751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:03:47.174434Z","time spent":"315.310655ms","remote":"127.0.0.1:36720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-13T08:03:47.489765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.030183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-13T08:03:47.489807Z","caller":"traceutil/trace.go:171","msg":"trace[660232923] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1009; }","duration":"125.135205ms","start":"2026-08-13T08:03:47.364662Z","end":"2026-08-13T08:03:47.489797Z","steps":["trace[660232923] 'agreement among raft nodes before linearized reading' (duration: 124.988881ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:03:53.055522Z","caller":"traceutil/trace.go:171","msg":"trace[907299739] transaction","detail":"{read_only:false; response_revision:1028; number_of_response:1; }","duration":"127.818458ms","start":"2026-08-13T08:03:52.927676Z","end":"2026-08-13T08:03:53.055494Z","steps":["trace[907299739] 'process raft request' (duration: 127.639533ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:04:11.927866Z","caller":"traceutil/trace.go:171","msg":"trace[338405253] transaction","detail":"{read_only:false; response_revision:1138; number_of_response:1; }","duration":"423.917769ms","start":"2026-08-13T08:04:11.503931Z","end":"2026-08-13T08:04:11.927849Z","steps":["trace[338405253] 'process raft request' (duration: 423.740165ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:04:11.92799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.587245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-08-13T08:04:11.928003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:04:11.503907Z","time spent":"424.017432ms","remote":"127.0.0.1:36998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T08:04:11.92803Z","caller":"traceutil/trace.go:171","msg":"trace[1580824225] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1138; }","duration":"281.663327ms","start":"2026-08-13T08:04:11.646358Z","end":"2026-08-13T08:04:11.928022Z","steps":["trace[1580824225] 'agreement among raft nodes before linearized reading' (duration: 281.538274ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:04:11.927849Z","caller":"traceutil/trace.go:171","msg":"trace[836126624] linearizableReadLoop","detail":"{readStateIndex:1184; appliedIndex:1183; }","duration":"281.433191ms","start":"2026-08-13T08:04:11.646393Z","end":"2026-08-13T08:04:11.927826Z","steps":["trace[836126624] 'read index received' (duration: 281.188434ms)","trace[836126624] 'applied index is now lower than readState.Index' (duration: 243.897µs)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:04:11.928184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.31397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.217\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-13T08:04:11.928228Z","caller":"traceutil/trace.go:171","msg":"trace[2108225722] range","detail":"{range_begin:/registry/masterleases/199.19.213.217; range_end:; response_count:1; response_revision:1138; }","duration":"136.387722ms","start":"2026-08-13T08:04:11.791828Z","end":"2026-08-13T08:04:11.928215Z","steps":["trace[2108225722] 'agreement among raft nodes before linearized reading' (duration: 136.28347ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:04:12.123682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.71167ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:39"} {"level":"info","ts":"2026-08-13T08:04:12.123968Z","caller":"traceutil/trace.go:171","msg":"trace[67795536] linearizableReadLoop","detail":"{readStateIndex:1186; appliedIndex:1184; }","duration":"188.914424ms","start":"2026-08-13T08:04:11.935038Z","end":"2026-08-13T08:04:12.123953Z","steps":["trace[67795536] 'read index received' (duration: 62.920547ms)","trace[67795536] 'applied index is now lower than readState.Index' (duration: 125.993227ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:04:12.124029Z","caller":"traceutil/trace.go:171","msg":"trace[2126988045] transaction","detail":"{read_only:false; response_revision:1139; number_of_response:1; }","duration":"190.778715ms","start":"2026-08-13T08:04:11.933242Z","end":"2026-08-13T08:04:12.124021Z","steps":["trace[2126988045] 'process raft request' (duration: 190.563409ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:04:12.124245Z","caller":"traceutil/trace.go:171","msg":"trace[1443136567] transaction","detail":"{read_only:false; response_revision:1140; number_of_response:1; }","duration":"129.972456ms","start":"2026-08-13T08:04:11.994264Z","end":"2026-08-13T08:04:12.124237Z","steps":["trace[1443136567] 'process raft request' (duration: 129.645177ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:04:12.124424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.378268ms","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-08-13T08:04:12.124444Z","caller":"traceutil/trace.go:171","msg":"trace[2045129767] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1140; }","duration":"189.426638ms","start":"2026-08-13T08:04:11.935011Z","end":"2026-08-13T08:04:12.124437Z","steps":["trace[2045129767] 'agreement among raft nodes before linearized reading' (duration: 189.335076ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:04:12.124641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.272329ms","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-08-13T08:04:12.124668Z","caller":"traceutil/trace.go:171","msg":"trace[507122568] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1140; }","duration":"169.343931ms","start":"2026-08-13T08:04:11.955318Z","end":"2026-08-13T08:04:12.124662Z","steps":["trace[507122568] 'agreement among raft nodes before linearized reading' (duration: 169.281559ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:04:12.124676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.43376ms","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-08-13T08:04:12.124771Z","caller":"traceutil/trace.go:171","msg":"trace[869120274] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1140; }","duration":"181.570244ms","start":"2026-08-13T08:04:11.943182Z","end":"2026-08-13T08:04:12.124752Z","steps":["trace[869120274] 'agreement among raft nodes before linearized reading' (duration: 181.337638ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:04:20.462021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.090916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T08:04:20.462098Z","caller":"traceutil/trace.go:171","msg":"trace[682908998] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:1165; }","duration":"375.21817ms","start":"2026-08-13T08:04:20.086862Z","end":"2026-08-13T08:04:20.462081Z","steps":["trace[682908998] 'count revisions from in-memory index tree' (duration: 375.003044ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:04:20.462116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.778839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-08-13T08:04:20.462116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.196414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-08-13T08:04:20.462139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:04:20.086842Z","time spent":"375.285352ms","remote":"127.0.0.1:59966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "} {"level":"info","ts":"2026-08-13T08:04:20.462168Z","caller":"traceutil/trace.go:171","msg":"trace[290982445] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1165; }","duration":"296.866162ms","start":"2026-08-13T08:04:20.165289Z","end":"2026-08-13T08:04:20.462155Z","steps":["trace[290982445] 'range keys from in-memory index tree' (duration: 296.554903ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:04:20.462176Z","caller":"traceutil/trace.go:171","msg":"trace[1499271642] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1165; }","duration":"303.293137ms","start":"2026-08-13T08:04:20.158875Z","end":"2026-08-13T08:04:20.462169Z","steps":["trace[1499271642] 'range keys from in-memory index tree' (duration: 303.098551ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:04:20.462199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:04:20.15886Z","time spent":"303.330088ms","remote":"127.0.0.1:36998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-13T08:04:20.462194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.173258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-08-13T08:04:20.462257Z","caller":"traceutil/trace.go:171","msg":"trace[143886504] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1165; }","duration":"294.26353ms","start":"2026-08-13T08:04:20.167976Z","end":"2026-08-13T08:04:20.462239Z","steps":["trace[143886504] 'range keys from in-memory index tree' (duration: 294.011354ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:04:20.46224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.925834ms","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-08-13T08:04:20.462309Z","caller":"traceutil/trace.go:171","msg":"trace[1494264877] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1165; }","duration":"297.044877ms","start":"2026-08-13T08:04:20.165249Z","end":"2026-08-13T08:04:20.462294Z","steps":["trace[1494264877] 'range keys from in-memory index tree' (duration: 296.719738ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:04:22.270435Z","caller":"traceutil/trace.go:171","msg":"trace[553028249] linearizableReadLoop","detail":"{readStateIndex:1219; appliedIndex:1218; }","duration":"277.654997ms","start":"2026-08-13T08:04:21.992765Z","end":"2026-08-13T08:04:22.27042Z","steps":["trace[553028249] 'read index received' (duration: 277.543164ms)","trace[553028249] 'applied index is now lower than readState.Index' (duration: 110.983µs)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:04:22.270511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:04:21.793277Z","time spent":"477.230304ms","remote":"127.0.0.1:36778","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-08-13T08:04:22.270585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.807701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-13T08:04:22.270613Z","caller":"traceutil/trace.go:171","msg":"trace[1749404075] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1170; }","duration":"277.874813ms","start":"2026-08-13T08:04:21.99273Z","end":"2026-08-13T08:04:22.270605Z","steps":["trace[1749404075] 'agreement among raft nodes before linearized reading' (duration: 277.76696ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:04:24.761635Z","caller":"traceutil/trace.go:171","msg":"trace[237504562] linearizableReadLoop","detail":"{readStateIndex:1230; appliedIndex:1229; }","duration":"131.15401ms","start":"2026-08-13T08:04:24.630461Z","end":"2026-08-13T08:04:24.761615Z","steps":["trace[237504562] 'read index received' (duration: 91.443436ms)","trace[237504562] 'applied index is now lower than readState.Index' (duration: 39.709864ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:04:24.761777Z","caller":"traceutil/trace.go:171","msg":"trace[2125618901] transaction","detail":"{read_only:false; response_revision:1181; number_of_response:1; }","duration":"156.193083ms","start":"2026-08-13T08:04:24.60557Z","end":"2026-08-13T08:04:24.761763Z","steps":["trace[2125618901] 'process raft request' (duration: 116.422638ms)","trace[2125618901] 'compare' (duration: 39.519188ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:04:24.761868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.400006ms","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-08-13T08:04:24.761895Z","caller":"traceutil/trace.go:171","msg":"trace[2095202853] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1181; }","duration":"131.468648ms","start":"2026-08-13T08:04:24.630419Z","end":"2026-08-13T08:04:24.761888Z","steps":["trace[2095202853] 'agreement among raft nodes before linearized reading' (duration: 131.359425ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:04:24.762067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.326797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-13T08:04:24.762083Z","caller":"traceutil/trace.go:171","msg":"trace[1430100855] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1181; }","duration":"130.344027ms","start":"2026-08-13T08:04:24.631734Z","end":"2026-08-13T08:04:24.762078Z","steps":["trace[1430100855] 'agreement among raft nodes before linearized reading' (duration: 130.296756ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:04:39.429987Z","caller":"traceutil/trace.go:171","msg":"trace[2143876745] linearizableReadLoop","detail":"{readStateIndex:1348; appliedIndex:1347; }","duration":"291.112524ms","start":"2026-08-13T08:04:39.138839Z","end":"2026-08-13T08:04:39.429952Z","steps":["trace[2143876745] 'read index received' (duration: 290.912979ms)","trace[2143876745] 'applied index is now lower than readState.Index' (duration: 197.515µs)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:04:39.43031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.388441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T08:04:39.430403Z","caller":"traceutil/trace.go:171","msg":"trace[1224723195] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:1296; }","duration":"291.592257ms","start":"2026-08-13T08:04:39.138792Z","end":"2026-08-13T08:04:39.430384Z","steps":["trace[1224723195] 'agreement among raft nodes before linearized reading' (duration: 291.32039ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:04:39.430238Z","caller":"traceutil/trace.go:171","msg":"trace[252702415] transaction","detail":"{read_only:false; response_revision:1296; number_of_response:1; }","duration":"300.622338ms","start":"2026-08-13T08:04:39.129448Z","end":"2026-08-13T08:04:39.430071Z","steps":["trace[252702415] 'process raft request' (duration: 300.28946ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:04:39.430805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:04:39.129421Z","time spent":"301.211954ms","remote":"127.0.0.1:36998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T08:04:39.625013Z","caller":"traceutil/trace.go:171","msg":"trace[905295450] linearizableReadLoop","detail":"{readStateIndex:1349; appliedIndex:1348; }","duration":"194.882725ms","start":"2026-08-13T08:04:39.430107Z","end":"2026-08-13T08:04:39.624989Z","steps":["trace[905295450] 'read index received' (duration: 183.806819ms)","trace[905295450] 'applied index is now lower than readState.Index' (duration: 11.074696ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:04:39.625127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.035351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T08:04:39.62516Z","caller":"traceutil/trace.go:171","msg":"trace[493294803] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1297; }","duration":"449.192395ms","start":"2026-08-13T08:04:39.175959Z","end":"2026-08-13T08:04:39.625151Z","steps":["trace[493294803] 'agreement among raft nodes before linearized reading' (duration: 449.116223ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:04:39.625188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:04:39.175937Z","time spent":"449.244907ms","remote":"127.0.0.1:36720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-13T08:04:39.625325Z","caller":"traceutil/trace.go:171","msg":"trace[1741791912] transaction","detail":"{read_only:false; response_revision:1297; number_of_response:1; }","duration":"203.420602ms","start":"2026-08-13T08:04:39.421875Z","end":"2026-08-13T08:04:39.625295Z","steps":["trace[1741791912] 'process raft request' (duration: 192.096019ms)","trace[1741791912] 'compare' (duration: 10.748827ms)"],"step_count":2}