{"level":"warn","ts":"2026-07-08T15:30:18.773295Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-08T15:30:18.773374Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.216:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.216:2380","--initial-cluster=instance=https://199.204.45.216:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.216:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.216:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-07-08T15:30:18.773511Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-08T15:30:18.773536Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.216:2380"]} {"level":"info","ts":"2026-07-08T15:30:18.773577Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-08T15:30:18.77424Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.216:2379"]} {"level":"info","ts":"2026-07-08T15:30:18.774347Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.216:2380"],"listen-peer-urls":["https://199.204.45.216:2380"],"advertise-client-urls":["https://199.204.45.216:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.216:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.216:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-07-08T15:30:19.025544Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"250.908895ms"} {"level":"info","ts":"2026-07-08T15:30:19.055455Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4e98569549cc430c","cluster-id":"65d70b4d1d4a8bf9"} {"level":"info","ts":"2026-07-08T15:30:19.055737Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c switched to configuration voters=()"} {"level":"info","ts":"2026-07-08T15:30:19.055839Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became follower at term 0"} {"level":"info","ts":"2026-07-08T15:30:19.055993Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4e98569549cc430c [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-08T15:30:19.056077Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became follower at term 1"} {"level":"info","ts":"2026-07-08T15:30:19.056238Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c switched to configuration voters=(5663371730606637836)"} {"level":"warn","ts":"2026-07-08T15:30:19.063637Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-08T15:30:19.065282Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-08T15:30:19.066329Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-07-08T15:30:19.068529Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4e98569549cc430c","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-08T15:30:19.068715Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4e98569549cc430c","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-08T15:30:19.068794Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-08T15:30:19.068872Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-08T15:30:19.068916Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-08T15:30:19.069561Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c switched to configuration voters=(5663371730606637836)"} {"level":"info","ts":"2026-07-08T15:30:19.06967Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"65d70b4d1d4a8bf9","local-member-id":"4e98569549cc430c","added-peer-id":"4e98569549cc430c","added-peer-peer-urls":["https://199.204.45.216:2380"]} {"level":"info","ts":"2026-07-08T15:30:19.085978Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-08T15:30:19.08609Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.216:2380"} {"level":"info","ts":"2026-07-08T15:30:19.086216Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.216:2380"} {"level":"info","ts":"2026-07-08T15:30:19.086423Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4e98569549cc430c","initial-advertise-peer-urls":["https://199.204.45.216:2380"],"listen-peer-urls":["https://199.204.45.216:2380"],"advertise-client-urls":["https://199.204.45.216:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.216:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-08T15:30:19.086472Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-08T15:30:19.657676Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c is starting a new election at term 1"} {"level":"info","ts":"2026-07-08T15:30:19.657766Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became pre-candidate at term 1"} {"level":"info","ts":"2026-07-08T15:30:19.657834Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c received MsgPreVoteResp from 4e98569549cc430c at term 1"} {"level":"info","ts":"2026-07-08T15:30:19.657864Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became candidate at term 2"} {"level":"info","ts":"2026-07-08T15:30:19.657882Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c received MsgVoteResp from 4e98569549cc430c at term 2"} {"level":"info","ts":"2026-07-08T15:30:19.657918Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became leader at term 2"} {"level":"info","ts":"2026-07-08T15:30:19.657932Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4e98569549cc430c elected leader 4e98569549cc430c at term 2"} {"level":"info","ts":"2026-07-08T15:30:19.659092Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-08T15:30:19.660117Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4e98569549cc430c","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.216:2379]}","request-path":"/0/members/4e98569549cc430c/attributes","cluster-id":"65d70b4d1d4a8bf9","publish-timeout":"7s"} {"level":"info","ts":"2026-07-08T15:30:19.660148Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-08T15:30:19.660198Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-08T15:30:19.660547Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"65d70b4d1d4a8bf9","local-member-id":"4e98569549cc430c","cluster-version":"3.5"} {"level":"info","ts":"2026-07-08T15:30:19.660645Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-08T15:30:19.660689Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-08T15:30:19.660668Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-08T15:30:19.660857Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-08T15:30:19.662553Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-08T15:30:19.662853Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.216:2379"} {"level":"warn","ts":"2026-07-08T15:30:24.914142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.03403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T15:30:24.914309Z","caller":"traceutil/trace.go:171","msg":"trace[1259349262] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:0; response_revision:262; }","duration":"239.295041ms","start":"2026-07-08T15:30:24.674987Z","end":"2026-07-08T15:30:24.914282Z","steps":["trace[1259349262] 'range keys from in-memory index tree' (duration: 238.932939ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:30:27.287943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.313421191s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replication-controller\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-08T15:30:27.288013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.834758ms","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-07-08T15:30:27.288164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.000829195s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-08T15:30:27.288283Z","caller":"traceutil/trace.go:171","msg":"trace[201334770] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:282; }","duration":"1.000997086s","start":"2026-07-08T15:30:26.287263Z","end":"2026-07-08T15:30:27.288261Z","steps":["trace[201334770] 'range keys from in-memory index tree' (duration: 1.000698014s)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:30:27.288268Z","caller":"traceutil/trace.go:171","msg":"trace[1824874893] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replication-controller; range_end:; response_count:0; response_revision:282; }","duration":"1.313781854s","start":"2026-07-08T15:30:25.974432Z","end":"2026-07-08T15:30:27.288214Z","steps":["trace[1824874893] 'range keys from in-memory index tree' (duration: 1.31328149s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:30:27.288042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.176525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-07-08T15:30:27.28834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:30:26.287246Z","time spent":"1.001083977s","remote":"127.0.0.1:33302","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":"warn","ts":"2026-07-08T15:30:27.288398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:30:25.974391Z","time spent":"1.313962975s","remote":"127.0.0.1:33244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":27,"request content":"key:\"/registry/serviceaccounts/kube-system/replication-controller\" "} {"level":"info","ts":"2026-07-08T15:30:27.288289Z","caller":"traceutil/trace.go:171","msg":"trace[1256960603] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:282; }","duration":"146.12937ms","start":"2026-07-08T15:30:27.142103Z","end":"2026-07-08T15:30:27.288233Z","steps":["trace[1256960603] 'range keys from in-memory index tree' (duration: 145.669927ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:30:27.288429Z","caller":"traceutil/trace.go:171","msg":"trace[306740720] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:282; }","duration":"152.61863ms","start":"2026-07-08T15:30:27.135781Z","end":"2026-07-08T15:30:27.288399Z","steps":["trace[306740720] 'range keys from in-memory index tree' (duration: 152.049015ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:30:27.288114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.974199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-08T15:30:27.288701Z","caller":"traceutil/trace.go:171","msg":"trace[781943316] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:282; }","duration":"146.550165ms","start":"2026-07-08T15:30:27.14213Z","end":"2026-07-08T15:30:27.28868Z","steps":["trace[781943316] 'range keys from in-memory index tree' (duration: 145.858388ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:30:27.849909Z","caller":"traceutil/trace.go:171","msg":"trace[866079040] transaction","detail":"{read_only:false; response_revision:283; number_of_response:1; }","duration":"556.835821ms","start":"2026-07-08T15:30:27.293053Z","end":"2026-07-08T15:30:27.849889Z","steps":["trace[866079040] 'process raft request' (duration: 556.71418ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:30:27.850511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:30:27.293033Z","time spent":"556.943581ms","remote":"127.0.0.1:33302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T15:30:28.077162Z","caller":"traceutil/trace.go:171","msg":"trace[932361988] transaction","detail":"{read_only:false; response_revision:287; number_of_response:1; }","duration":"782.497733ms","start":"2026-07-08T15:30:27.294647Z","end":"2026-07-08T15:30:28.077144Z","steps":["trace[932361988] 'process raft request' (duration: 782.465163ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:30:28.077291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:30:27.294639Z","time spent":"782.596214ms","remote":"127.0.0.1:33244","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":194,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-08T15:30:28.07739Z","caller":"traceutil/trace.go:171","msg":"trace[959009200] transaction","detail":"{read_only:false; response_revision:284; number_of_response:1; }","duration":"784.31327ms","start":"2026-07-08T15:30:27.293062Z","end":"2026-07-08T15:30:28.077375Z","steps":["trace[959009200] 'process raft request' (duration: 783.881656ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:30:28.077487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:30:27.293044Z","time spent":"784.391571ms","remote":"127.0.0.1:33302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T15:30:28.077283Z","caller":"traceutil/trace.go:171","msg":"trace[1096506236] transaction","detail":"{read_only:false; response_revision:285; number_of_response:1; }","duration":"784.130728ms","start":"2026-07-08T15:30:27.293127Z","end":"2026-07-08T15:30:28.077258Z","steps":["trace[1096506236] 'process raft request' (duration: 783.911756ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:30:28.077645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:30:27.293097Z","time spent":"784.468721ms","remote":"127.0.0.1:33302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T15:30:28.078202Z","caller":"traceutil/trace.go:171","msg":"trace[1092606502] transaction","detail":"{read_only:false; response_revision:286; number_of_response:1; }","duration":"784.015467ms","start":"2026-07-08T15:30:27.293272Z","end":"2026-07-08T15:30:28.077288Z","steps":["trace[1092606502] 'process raft request' (duration: 783.796525ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:30:28.078398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:30:27.293264Z","time spent":"785.006147ms","remote":"127.0.0.1:33302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T15:30:34.226038Z","caller":"traceutil/trace.go:171","msg":"trace[1256040683] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"100.654048ms","start":"2026-07-08T15:30:34.125363Z","end":"2026-07-08T15:30:34.226017Z","steps":["trace[1256040683] 'process raft request' (duration: 100.557877ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:30:56.157566Z","caller":"traceutil/trace.go:171","msg":"trace[2101062811] transaction","detail":"{read_only:false; response_revision:450; number_of_response:1; }","duration":"272.612142ms","start":"2026-07-08T15:30:55.884924Z","end":"2026-07-08T15:30:56.157536Z","steps":["trace[2101062811] 'process raft request' (duration: 272.206191ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:30:56.569467Z","caller":"traceutil/trace.go:171","msg":"trace[1187430084] transaction","detail":"{read_only:false; response_revision:460; number_of_response:1; }","duration":"171.910704ms","start":"2026-07-08T15:30:56.39753Z","end":"2026-07-08T15:30:56.56944Z","steps":["trace[1187430084] 'process raft request' (duration: 106.362888ms)","trace[1187430084] 'compare' (duration: 65.32647ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T15:30:56.569639Z","caller":"traceutil/trace.go:171","msg":"trace[669248382] transaction","detail":"{read_only:false; response_revision:461; number_of_response:1; }","duration":"172.010977ms","start":"2026-07-08T15:30:56.397606Z","end":"2026-07-08T15:30:56.569617Z","steps":["trace[669248382] 'process raft request' (duration: 171.752119ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:30:56.569902Z","caller":"traceutil/trace.go:171","msg":"trace[624728824] transaction","detail":"{read_only:false; response_revision:462; number_of_response:1; }","duration":"170.992879ms","start":"2026-07-08T15:30:56.398494Z","end":"2026-07-08T15:30:56.569487Z","steps":["trace[624728824] 'process raft request' (duration: 170.912957ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:30:57.128628Z","caller":"traceutil/trace.go:171","msg":"trace[172615403] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"183.472602ms","start":"2026-07-08T15:30:56.945134Z","end":"2026-07-08T15:30:57.128606Z","steps":["trace[172615403] 'process raft request' (duration: 115.822132ms)","trace[172615403] 'compare' (duration: 67.507625ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T15:30:57.128952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.353799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-fc2kl\" ","response":"range_response_count:1 size:3637"} {"level":"info","ts":"2026-07-08T15:30:57.128961Z","caller":"traceutil/trace.go:171","msg":"trace[1370040752] linearizableReadLoop","detail":"{readStateIndex:501; appliedIndex:500; }","duration":"183.015819ms","start":"2026-07-08T15:30:56.945545Z","end":"2026-07-08T15:30:57.128561Z","steps":["trace[1370040752] 'read index received' (duration: 115.314768ms)","trace[1370040752] 'applied index is now lower than readState.Index' (duration: 67.700131ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T15:30:57.129001Z","caller":"traceutil/trace.go:171","msg":"trace[984174557] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-fc2kl; range_end:; response_count:1; response_revision:484; }","duration":"183.484083ms","start":"2026-07-08T15:30:56.945504Z","end":"2026-07-08T15:30:57.128988Z","steps":["trace[984174557] 'agreement among raft nodes before linearized reading' (duration: 183.350439ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:30:57.1324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.490706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329952"} {"level":"info","ts":"2026-07-08T15:30:57.133004Z","caller":"traceutil/trace.go:171","msg":"trace[528152379] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:484; }","duration":"183.079592ms","start":"2026-07-08T15:30:56.949848Z","end":"2026-07-08T15:30:57.132927Z","steps":["trace[528152379] 'agreement among raft nodes before linearized reading' (duration: 179.319156ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:30:59.076681Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831411607587468358,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-08T15:30:59.540743Z","caller":"traceutil/trace.go:171","msg":"trace[575427619] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"970.323511ms","start":"2026-07-08T15:30:58.570388Z","end":"2026-07-08T15:30:59.540711Z","steps":["trace[575427619] 'process raft request' (duration: 970.093693ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:30:59.540911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:30:58.570369Z","time spent":"970.482686ms","remote":"127.0.0.1:33068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-08T15:30:59.631458Z","caller":"traceutil/trace.go:171","msg":"trace[100569712] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"1.049609677s","start":"2026-07-08T15:30:58.581826Z","end":"2026-07-08T15:30:59.631436Z","steps":["trace[100569712] 'process raft request' (duration: 1.049463643s)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:30:59.631529Z","caller":"traceutil/trace.go:171","msg":"trace[1647283410] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"1.047363492s","start":"2026-07-08T15:30:58.584153Z","end":"2026-07-08T15:30:59.631517Z","steps":["trace[1647283410] 'process raft request' (duration: 1.047232078s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:30:59.631655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:30:58.584148Z","time spent":"1.047428613s","remote":"127.0.0.1:33068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-08T15:30:59.631673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:30:58.581775Z","time spent":"1.049759001s","remote":"127.0.0.1:33068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-08T15:30:59.631454Z","caller":"traceutil/trace.go:171","msg":"trace[2017799924] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"1.054703315s","start":"2026-07-08T15:30:58.576717Z","end":"2026-07-08T15:30:59.63142Z","steps":["trace[2017799924] 'process raft request' (duration: 1.054511659s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:30:59.631932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:30:58.576712Z","time spent":"1.055179128s","remote":"127.0.0.1:33068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-08T15:30:59.631842Z","caller":"traceutil/trace.go:171","msg":"trace[1675314674] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"1.046840146s","start":"2026-07-08T15:30:58.584983Z","end":"2026-07-08T15:30:59.631823Z","steps":["trace[1675314674] 'process raft request' (duration: 1.046436755s)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:30:59.632144Z","caller":"traceutil/trace.go:171","msg":"trace[2077307920] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"1.045993511s","start":"2026-07-08T15:30:58.586138Z","end":"2026-07-08T15:30:59.632131Z","steps":["trace[2077307920] 'process raft request' (duration: 1.045359423s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:30:59.632115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:30:58.584966Z","time spent":"1.047049013s","remote":"127.0.0.1:33068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-08T15:30:59.632216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:30:58.586131Z","time spent":"1.046049873s","remote":"127.0.0.1:33068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-08T15:30:59.632356Z","caller":"traceutil/trace.go:171","msg":"trace[348820215] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"1.038492053s","start":"2026-07-08T15:30:58.593846Z","end":"2026-07-08T15:30:59.632315Z","steps":["trace[348820215] 'process raft request' (duration: 1.038001659s)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:30:59.63138Z","caller":"traceutil/trace.go:171","msg":"trace[414576977] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"1.054684724s","start":"2026-07-08T15:30:58.576663Z","end":"2026-07-08T15:30:59.631348Z","steps":["trace[414576977] 'process raft request' (duration: 1.054409256s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:30:59.632465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:30:58.593828Z","time spent":"1.038564326s","remote":"127.0.0.1:33068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-08T15:30:59.632599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:30:58.576653Z","time spent":"1.05590414s","remote":"127.0.0.1:33068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-08T15:30:59.631508Z","caller":"traceutil/trace.go:171","msg":"trace[1754574642] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"1.049597586s","start":"2026-07-08T15:30:58.581878Z","end":"2026-07-08T15:30:59.631475Z","steps":["trace[1754574642] 'process raft request' (duration: 1.049469793s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:30:59.632798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:30:58.581873Z","time spent":"1.050841902s","remote":"127.0.0.1:33068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-08T15:30:59.633042Z","caller":"traceutil/trace.go:171","msg":"trace[2064149885] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"1.033439218s","start":"2026-07-08T15:30:58.599592Z","end":"2026-07-08T15:30:59.633031Z","steps":["trace[2064149885] 'process raft request' (duration: 1.032550411s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:30:59.633128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:30:58.599581Z","time spent":"1.03349182s","remote":"127.0.0.1:33068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-08T15:30:59.63378Z","caller":"traceutil/trace.go:171","msg":"trace[1684070226] linearizableReadLoop","detail":"{readStateIndex:519; appliedIndex:507; }","duration":"1.057396644s","start":"2026-07-08T15:30:58.576364Z","end":"2026-07-08T15:30:59.63376Z","steps":["trace[1684070226] 'read index received' (duration: 964.195824ms)","trace[1684070226] 'applied index is now lower than readState.Index' (duration: 93.19958ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T15:30:59.633967Z","caller":"traceutil/trace.go:171","msg":"trace[296393077] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"994.426946ms","start":"2026-07-08T15:30:58.63952Z","end":"2026-07-08T15:30:59.633947Z","steps":["trace[296393077] 'process raft request' (duration: 992.85982ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:30:59.634109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:30:58.639502Z","time spent":"994.552571ms","remote":"127.0.0.1:33068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-08T15:30:59.634285Z","caller":"traceutil/trace.go:171","msg":"trace[1782155828] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"883.148198ms","start":"2026-07-08T15:30:58.751118Z","end":"2026-07-08T15:30:59.634266Z","steps":["trace[1782155828] 'process raft request' (duration: 882.54717ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:30:59.634552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:30:58.751092Z","time spent":"883.428416ms","remote":"127.0.0.1:33068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-08T15:30:59.634756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.058375622s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-08T15:30:59.63486Z","caller":"traceutil/trace.go:171","msg":"trace[1398195336] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:501; }","duration":"1.058484606s","start":"2026-07-08T15:30:58.576359Z","end":"2026-07-08T15:30:59.634844Z","steps":["trace[1398195336] 'agreement among raft nodes before linearized reading' (duration: 1.05795273s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:30:59.634948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:30:58.576321Z","time spent":"1.058612559s","remote":"127.0.0.1:33302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-08T15:30:59.638162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.057112988s","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-07-08T15:30:59.638237Z","caller":"traceutil/trace.go:171","msg":"trace[1959392153] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:503; }","duration":"1.05721437s","start":"2026-07-08T15:30:58.581006Z","end":"2026-07-08T15:30:59.63822Z","steps":["trace[1959392153] 'agreement among raft nodes before linearized reading' (duration: 1.057086176s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:30:59.638273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:30:58.580998Z","time spent":"1.057266661s","remote":"127.0.0.1:33302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-08T15:30:59.638824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.117912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T15:30:59.638861Z","caller":"traceutil/trace.go:171","msg":"trace[1390888335] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:503; }","duration":"127.179824ms","start":"2026-07-08T15:30:59.511673Z","end":"2026-07-08T15:30:59.638853Z","steps":["trace[1390888335] 'agreement among raft nodes before linearized reading' (duration: 127.125083ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:31:00.834877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.083152ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T15:31:00.835019Z","caller":"traceutil/trace.go:171","msg":"trace[908303355] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"303.66488ms","start":"2026-07-08T15:31:00.531329Z","end":"2026-07-08T15:31:00.834994Z","steps":["trace[908303355] 'process raft request' (duration: 165.194396ms)","trace[908303355] 'compare' (duration: 137.375891ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T15:31:00.8352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:31:00.531306Z","time spent":"303.849005ms","remote":"127.0.0.1:33068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570081,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T15:31:00.850646Z","caller":"traceutil/trace.go:171","msg":"trace[663359813] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"249.161735ms","start":"2026-07-08T15:31:00.601465Z","end":"2026-07-08T15:31:00.850626Z","steps":["trace[663359813] 'process raft request' (duration: 249.035651ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:31:01.397261Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831411607587468444,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-08T15:31:01.994175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.490613ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T15:31:01.99428Z","caller":"traceutil/trace.go:171","msg":"trace[86684584] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"1.104183497s","start":"2026-07-08T15:31:00.890075Z","end":"2026-07-08T15:31:01.994259Z","steps":["trace[86684584] 'process raft request' (duration: 645.53577ms)","trace[86684584] 'compare' (duration: 458.235255ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T15:31:01.994351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:31:00.890057Z","time spent":"1.10425386s","remote":"127.0.0.1:33068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":15664,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T15:31:01.995853Z","caller":"traceutil/trace.go:171","msg":"trace[1686145735] linearizableReadLoop","detail":"{readStateIndex:587; appliedIndex:585; }","duration":"1.09894942s","start":"2026-07-08T15:31:00.896875Z","end":"2026-07-08T15:31:01.995825Z","steps":["trace[1686145735] 'read index received' (duration: 638.690703ms)","trace[1686145735] 'applied index is now lower than readState.Index' (duration: 460.257397ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T15:31:01.996499Z","caller":"traceutil/trace.go:171","msg":"trace[579168215] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"953.84169ms","start":"2026-07-08T15:31:01.042642Z","end":"2026-07-08T15:31:01.996484Z","steps":["trace[579168215] 'process raft request' (duration: 952.791449ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:31:01.99662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:31:01.04262Z","time spent":"953.920062ms","remote":"127.0.0.1:33068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570090,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T15:31:01.996903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.781863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-08T15:31:01.996921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.100044084s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gatewayclasses.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:10870"} {"level":"info","ts":"2026-07-08T15:31:01.996953Z","caller":"traceutil/trace.go:171","msg":"trace[1300762358] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:565; }","duration":"483.866466ms","start":"2026-07-08T15:31:01.513073Z","end":"2026-07-08T15:31:01.996939Z","steps":["trace[1300762358] 'agreement among raft nodes before linearized reading' (duration: 483.789354ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:31:01.99696Z","caller":"traceutil/trace.go:171","msg":"trace[1532860250] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/gatewayclasses.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:565; }","duration":"1.100110975s","start":"2026-07-08T15:31:00.896837Z","end":"2026-07-08T15:31:01.996948Z","steps":["trace[1532860250] 'agreement among raft nodes before linearized reading' (duration: 1.099985551s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:31:01.996981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:31:01.513056Z","time spent":"483.919008ms","remote":"127.0.0.1:32992","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-07-08T15:31:01.996992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:31:00.896823Z","time spent":"1.100161417s","remote":"127.0.0.1:33068","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":1,"response size":10892,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gatewayclasses.gateway.networking.k8s.io\" "} {"level":"warn","ts":"2026-07-08T15:31:01.997109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.078436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-07-08T15:31:01.99711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.200855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-08T15:31:01.997144Z","caller":"traceutil/trace.go:171","msg":"trace[1471528641] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:565; }","duration":"343.130197ms","start":"2026-07-08T15:31:01.654005Z","end":"2026-07-08T15:31:01.997135Z","steps":["trace[1471528641] 'agreement among raft nodes before linearized reading' (duration: 343.075595ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:31:01.997161Z","caller":"traceutil/trace.go:171","msg":"trace[19116877] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:565; }","duration":"335.295658ms","start":"2026-07-08T15:31:01.661851Z","end":"2026-07-08T15:31:01.997146Z","steps":["trace[19116877] 'agreement among raft nodes before linearized reading' (duration: 335.146014ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:31:01.997192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:31:01.653993Z","time spent":"343.191979ms","remote":"127.0.0.1:33302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-08T15:31:01.997197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:31:01.661832Z","time spent":"335.3583ms","remote":"127.0.0.1:33302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-08T15:31:04.999887Z","caller":"traceutil/trace.go:171","msg":"trace[791109287] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"159.348078ms","start":"2026-07-08T15:31:04.840497Z","end":"2026-07-08T15:31:04.999845Z","steps":["trace[791109287] 'process raft request' (duration: 156.636642ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:31:05.035164Z","caller":"traceutil/trace.go:171","msg":"trace[311778955] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"102.716987ms","start":"2026-07-08T15:31:04.932425Z","end":"2026-07-08T15:31:05.035142Z","steps":["trace[311778955] 'process raft request' (duration: 102.619714ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:31:05.268385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.371712ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-08T15:31:05.268479Z","caller":"traceutil/trace.go:171","msg":"trace[2124070603] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"220.443855ms","start":"2026-07-08T15:31:05.048018Z","end":"2026-07-08T15:31:05.268462Z","steps":["trace[2124070603] 'process raft request' (duration: 42.936048ms)","trace[2124070603] 'compare' (duration: 177.235898ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T15:31:06.517854Z","caller":"traceutil/trace.go:171","msg":"trace[324935116] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:617; }","duration":"257.964651ms","start":"2026-07-08T15:31:06.259865Z","end":"2026-07-08T15:31:06.51783Z","steps":["trace[324935116] 'read index received' (duration: 257.31027ms)","trace[324935116] 'applied index is now lower than readState.Index' (duration: 653.631µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T15:31:06.517978Z","caller":"traceutil/trace.go:171","msg":"trace[816119274] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"318.37663ms","start":"2026-07-08T15:31:06.199592Z","end":"2026-07-08T15:31:06.517969Z","steps":["trace[816119274] 'process raft request' (duration: 317.789921ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:31:06.518075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:31:06.199342Z","time spent":"318.66219ms","remote":"127.0.0.1:33100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036225,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T15:31:06.518474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.622673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-08T15:31:06.518508Z","caller":"traceutil/trace.go:171","msg":"trace[279549434] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:595; }","duration":"258.702815ms","start":"2026-07-08T15:31:06.259798Z","end":"2026-07-08T15:31:06.518501Z","steps":["trace[279549434] 'agreement among raft nodes before linearized reading' (duration: 258.639863ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:31:06.518496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.54188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-08T15:31:06.518603Z","caller":"traceutil/trace.go:171","msg":"trace[1871671893] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:595; }","duration":"211.703606ms","start":"2026-07-08T15:31:06.306875Z","end":"2026-07-08T15:31:06.518579Z","steps":["trace[1871671893] 'agreement among raft nodes before linearized reading' (duration: 211.403406ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:31:06.518832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.279446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-k6l42\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-07-08T15:31:06.518932Z","caller":"traceutil/trace.go:171","msg":"trace[1678598058] range","detail":"{range_begin:/registry/pods/kube-system/cilium-k6l42; range_end:; response_count:1; response_revision:595; }","duration":"198.455252ms","start":"2026-07-08T15:31:06.320454Z","end":"2026-07-08T15:31:06.518909Z","steps":["trace[1678598058] 'agreement among raft nodes before linearized reading' (duration: 198.179382ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:31:06.983664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.336173ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T15:31:06.983821Z","caller":"traceutil/trace.go:171","msg":"trace[1156016703] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"460.956482ms","start":"2026-07-08T15:31:06.522801Z","end":"2026-07-08T15:31:06.983757Z","steps":["trace[1156016703] 'process raft request' (duration: 300.441133ms)","trace[1156016703] 'compare' (duration: 160.24153ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T15:31:06.984082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:31:06.522785Z","time spent":"461.130988ms","remote":"127.0.0.1:33302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T15:31:06.992589Z","caller":"traceutil/trace.go:171","msg":"trace[1165423693] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"468.434247ms","start":"2026-07-08T15:31:06.524129Z","end":"2026-07-08T15:31:06.992563Z","steps":["trace[1165423693] 'process raft request' (duration: 468.172639ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:31:06.992725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:31:06.524111Z","time spent":"468.540071ms","remote":"127.0.0.1:33302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T15:31:06.992728Z","caller":"traceutil/trace.go:171","msg":"trace[1271569401] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"452.104523ms","start":"2026-07-08T15:31:06.540574Z","end":"2026-07-08T15:31:06.992678Z","steps":["trace[1271569401] 'process raft request' (duration: 451.886096ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:31:06.992787Z","caller":"traceutil/trace.go:171","msg":"trace[1101960834] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"431.257919ms","start":"2026-07-08T15:31:06.56148Z","end":"2026-07-08T15:31:06.992738Z","steps":["trace[1101960834] 'process raft request' (duration: 431.070033ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:31:06.992936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:31:06.540556Z","time spent":"452.299769ms","remote":"127.0.0.1:33216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T15:31:06.992978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:31:06.561462Z","time spent":"431.494417ms","remote":"127.0.0.1:33400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1092,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-08T15:31:08.526523Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4831411607587468541,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-08T15:31:08.704575Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.300860337s","expected-duration":"1s"} {"level":"warn","ts":"2026-07-08T15:31:08.709672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.589042447s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T15:31:08.709826Z","caller":"traceutil/trace.go:171","msg":"trace[45398933] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:599; }","duration":"1.589258514s","start":"2026-07-08T15:31:07.120534Z","end":"2026-07-08T15:31:08.709793Z","steps":["trace[45398933] 'range keys from in-memory index tree' (duration: 1.588884991s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:31:08.709861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:31:07.120509Z","time spent":"1.589341687s","remote":"127.0.0.1:32992","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-07-08T15:31:08.71199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.394680774s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T15:31:08.712115Z","caller":"traceutil/trace.go:171","msg":"trace[1410578622] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:599; }","duration":"1.394828398s","start":"2026-07-08T15:31:07.317267Z","end":"2026-07-08T15:31:08.712095Z","steps":["trace[1410578622] 'range keys from in-memory index tree' (duration: 1.394663013s)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:31:08.713684Z","caller":"traceutil/trace.go:171","msg":"trace[524135997] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"1.311348689s","start":"2026-07-08T15:31:07.402313Z","end":"2026-07-08T15:31:08.713662Z","steps":["trace[524135997] 'process raft request' (duration: 1.303052889s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:31:08.714269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:31:07.402284Z","time spent":"1.31167959s","remote":"127.0.0.1:33100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036261,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T15:31:08.738367Z","caller":"traceutil/trace.go:171","msg":"trace[317379892] linearizableReadLoop","detail":"{readStateIndex:624; appliedIndex:622; }","duration":"712.875952ms","start":"2026-07-08T15:31:08.025423Z","end":"2026-07-08T15:31:08.738299Z","steps":["trace[317379892] 'read index received' (duration: 679.617583ms)","trace[317379892] 'applied index is now lower than readState.Index' (duration: 33.256619ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T15:31:08.739187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.687108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T15:31:08.739273Z","caller":"traceutil/trace.go:171","msg":"trace[603378167] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:600; }","duration":"225.819194ms","start":"2026-07-08T15:31:08.513431Z","end":"2026-07-08T15:31:08.739251Z","steps":["trace[603378167] 'agreement among raft nodes before linearized reading' (duration: 225.631687ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:31:08.73942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"711.907119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-07-08T15:31:08.739433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"713.966939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-08T15:31:08.739616Z","caller":"traceutil/trace.go:171","msg":"trace[1245146950] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:600; }","duration":"714.218087ms","start":"2026-07-08T15:31:08.025366Z","end":"2026-07-08T15:31:08.739584Z","steps":["trace[1245146950] 'agreement among raft nodes before linearized reading' (duration: 713.557325ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:31:08.739682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:31:08.025349Z","time spent":"714.322671ms","remote":"127.0.0.1:33302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-08T15:31:08.739545Z","caller":"traceutil/trace.go:171","msg":"trace[1632806582] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:600; }","duration":"712.071585ms","start":"2026-07-08T15:31:08.027452Z","end":"2026-07-08T15:31:08.739523Z","steps":["trace[1632806582] 'agreement among raft nodes before linearized reading' (duration: 711.597879ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:31:08.739858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:31:08.027436Z","time spent":"712.408355ms","remote":"127.0.0.1:33302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-08T15:31:10.921175Z","caller":"traceutil/trace.go:171","msg":"trace[261966484] linearizableReadLoop","detail":"{readStateIndex:670; appliedIndex:669; }","duration":"165.729291ms","start":"2026-07-08T15:31:10.755418Z","end":"2026-07-08T15:31:10.921147Z","steps":["trace[261966484] 'read index received' (duration: 165.597677ms)","trace[261966484] 'applied index is now lower than readState.Index' (duration: 130.414µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T15:31:10.921271Z","caller":"traceutil/trace.go:171","msg":"trace[951544016] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"335.190233ms","start":"2026-07-08T15:31:10.586064Z","end":"2026-07-08T15:31:10.921254Z","steps":["trace[951544016] 'process raft request' (duration: 334.943985ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:31:10.92137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:31:10.586042Z","time spent":"335.269086ms","remote":"127.0.0.1:33068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3353,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-08T15:31:10.921472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.038272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-08T15:31:10.921522Z","caller":"traceutil/trace.go:171","msg":"trace[49424650] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:646; }","duration":"166.127735ms","start":"2026-07-08T15:31:10.755377Z","end":"2026-07-08T15:31:10.921505Z","steps":["trace[49424650] 'agreement among raft nodes before linearized reading' (duration: 165.909918ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:31:10.927745Z","caller":"traceutil/trace.go:171","msg":"trace[2105087066] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"141.702783ms","start":"2026-07-08T15:31:10.786019Z","end":"2026-07-08T15:31:10.927721Z","steps":["trace[2105087066] 'process raft request' (duration: 141.373542ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:31:10.927788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.660436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-07-08T15:31:10.9282Z","caller":"traceutil/trace.go:171","msg":"trace[916586040] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:647; }","duration":"172.09529ms","start":"2026-07-08T15:31:10.756087Z","end":"2026-07-08T15:31:10.928182Z","steps":["trace[916586040] 'agreement among raft nodes before linearized reading' (duration: 171.553432ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:31:13.568196Z","caller":"traceutil/trace.go:171","msg":"trace[53366766] linearizableReadLoop","detail":"{readStateIndex:706; appliedIndex:704; }","duration":"183.789047ms","start":"2026-07-08T15:31:13.384382Z","end":"2026-07-08T15:31:13.568171Z","steps":["trace[53366766] 'read index received' (duration: 61.278177ms)","trace[53366766] 'applied index is now lower than readState.Index' (duration: 122.50974ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T15:31:13.568429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.022045ms","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-07-08T15:31:13.568494Z","caller":"traceutil/trace.go:171","msg":"trace[964866174] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:681; }","duration":"184.117278ms","start":"2026-07-08T15:31:13.384362Z","end":"2026-07-08T15:31:13.568479Z","steps":["trace[964866174] 'agreement among raft nodes before linearized reading' (duration: 183.908151ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:31:13.568921Z","caller":"traceutil/trace.go:171","msg":"trace[307458551] transaction","detail":"{read_only:false; response_revision:681; number_of_response:1; }","duration":"186.116729ms","start":"2026-07-08T15:31:13.382748Z","end":"2026-07-08T15:31:13.568864Z","steps":["trace[307458551] 'process raft request' (duration: 180.053103ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:31:13.935312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.252776ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-08T15:31:13.935584Z","caller":"traceutil/trace.go:171","msg":"trace[1390085521] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"273.682153ms","start":"2026-07-08T15:31:13.661884Z","end":"2026-07-08T15:31:13.935566Z","steps":["trace[1390085521] 'process raft request' (duration: 273.609471ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:31:13.935638Z","caller":"traceutil/trace.go:171","msg":"trace[294654882] transaction","detail":"{read_only:false; response_revision:682; number_of_response:1; }","duration":"321.156867ms","start":"2026-07-08T15:31:13.614447Z","end":"2026-07-08T15:31:13.935604Z","steps":["trace[294654882] 'process raft request' (duration: 81.540148ms)","trace[294654882] 'compare' (duration: 238.995127ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T15:31:13.935944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:31:13.614419Z","time spent":"321.396475ms","remote":"127.0.0.1:33068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187246,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-08T15:31:14.409338Z","caller":"traceutil/trace.go:171","msg":"trace[1924486713] linearizableReadLoop","detail":"{readStateIndex:709; appliedIndex:708; }","duration":"424.643038ms","start":"2026-07-08T15:31:13.984664Z","end":"2026-07-08T15:31:14.409307Z","steps":["trace[1924486713] 'read index received' (duration: 423.385973ms)","trace[1924486713] 'applied index is now lower than readState.Index' (duration: 1.255954ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T15:31:14.409438Z","caller":"traceutil/trace.go:171","msg":"trace[777165215] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"598.571983ms","start":"2026-07-08T15:31:13.810826Z","end":"2026-07-08T15:31:14.409398Z","steps":["trace[777165215] 'process raft request' (duration: 597.162852ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:31:14.409637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:31:13.810791Z","time spent":"598.752639ms","remote":"127.0.0.1:33068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187455,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-08T15:31:14.409652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.966029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:1 size:13229"} {"level":"info","ts":"2026-07-08T15:31:14.409719Z","caller":"traceutil/trace.go:171","msg":"trace[1958089357] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:1; response_revision:684; }","duration":"425.097834ms","start":"2026-07-08T15:31:13.984606Z","end":"2026-07-08T15:31:14.409704Z","steps":["trace[1958089357] 'agreement among raft nodes before linearized reading' (duration: 424.856195ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:31:14.409765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:31:13.984569Z","time spent":"425.185678ms","remote":"127.0.0.1:33068","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":1,"response size":13251,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" "} {"level":"info","ts":"2026-07-08T15:31:14.497011Z","caller":"traceutil/trace.go:171","msg":"trace[448084515] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"493.557089ms","start":"2026-07-08T15:31:14.003431Z","end":"2026-07-08T15:31:14.496988Z","steps":["trace[448084515] 'process raft request' (duration: 493.193046ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:31:14.498232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:31:14.0034Z","time spent":"493.726435ms","remote":"127.0.0.1:33068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188228,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T15:31:14.498251Z","caller":"traceutil/trace.go:171","msg":"trace[482320738] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"464.764741ms","start":"2026-07-08T15:31:14.033455Z","end":"2026-07-08T15:31:14.49822Z","steps":["trace[482320738] 'process raft request' (duration: 463.477294ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:31:14.498375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:31:14.033423Z","time spent":"464.897436ms","remote":"127.0.0.1:33086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":716,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-08T15:31:14.49838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.527827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-07-08T15:31:14.498466Z","caller":"traceutil/trace.go:171","msg":"trace[502912392] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:686; }","duration":"300.678813ms","start":"2026-07-08T15:31:14.197751Z","end":"2026-07-08T15:31:14.49843Z","steps":["trace[502912392] 'agreement among raft nodes before linearized reading' (duration: 299.895695ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:31:14.498522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:31:14.197736Z","time spent":"300.763106ms","remote":"127.0.0.1:33302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":512,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-08T15:31:14.499007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.598403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:1 size:10377"} {"level":"info","ts":"2026-07-08T15:31:14.499178Z","caller":"traceutil/trace.go:171","msg":"trace[650933305] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:686; }","duration":"115.048679ms","start":"2026-07-08T15:31:14.384103Z","end":"2026-07-08T15:31:14.499152Z","steps":["trace[650933305] 'agreement among raft nodes before linearized reading' (duration: 112.980474ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:31:14.498463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.30903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-k6l42\" ","response":"range_response_count:1 size:18337"} {"level":"info","ts":"2026-07-08T15:31:14.499455Z","caller":"traceutil/trace.go:171","msg":"trace[1810279634] range","detail":"{range_begin:/registry/pods/kube-system/cilium-k6l42; range_end:; response_count:1; response_revision:686; }","duration":"118.348568ms","start":"2026-07-08T15:31:14.381078Z","end":"2026-07-08T15:31:14.499426Z","steps":["trace[1810279634] 'agreement among raft nodes before linearized reading' (duration: 116.18291ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:31:14.499025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.518723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:1 size:24244"} {"level":"info","ts":"2026-07-08T15:31:14.499585Z","caller":"traceutil/trace.go:171","msg":"trace[1578983202] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:1; response_revision:686; }","duration":"315.105374ms","start":"2026-07-08T15:31:14.184465Z","end":"2026-07-08T15:31:14.49957Z","steps":["trace[1578983202] 'agreement among raft nodes before linearized reading' (duration: 312.50681ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:31:14.499695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:31:14.18445Z","time spent":"315.235028ms","remote":"127.0.0.1:33068","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":24266,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" "} {"level":"warn","ts":"2026-07-08T15:31:25.572314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.362942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-07-08T15:31:25.572383Z","caller":"traceutil/trace.go:171","msg":"trace[1488810726] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:769; }","duration":"488.464546ms","start":"2026-07-08T15:31:25.0839Z","end":"2026-07-08T15:31:25.572364Z","steps":["trace[1488810726] 'range keys from in-memory index tree' (duration: 488.232587ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:31:25.572427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"572.111621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-07-08T15:31:25.572448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"571.174384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-08T15:31:25.572479Z","caller":"traceutil/trace.go:171","msg":"trace[1861649210] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:769; }","duration":"572.199164ms","start":"2026-07-08T15:31:25.000265Z","end":"2026-07-08T15:31:25.572464Z","steps":["trace[1861649210] 'range keys from in-memory index tree' (duration: 571.990745ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:31:25.572485Z","caller":"traceutil/trace.go:171","msg":"trace[4474095] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:769; }","duration":"571.230325ms","start":"2026-07-08T15:31:25.001245Z","end":"2026-07-08T15:31:25.572475Z","steps":["trace[4474095] 'range keys from in-memory index tree' (duration: 571.034718ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:31:25.572513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:31:25.001235Z","time spent":"571.273547ms","remote":"127.0.0.1:33302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-08T15:31:25.572515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:31:25.000246Z","time spent":"572.260156ms","remote":"127.0.0.1:33302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-08T15:31:25.572532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.329761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-08T15:31:25.572593Z","caller":"traceutil/trace.go:171","msg":"trace[2059419365] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:769; }","duration":"510.420604ms","start":"2026-07-08T15:31:25.062159Z","end":"2026-07-08T15:31:25.57258Z","steps":["trace[2059419365] 'range keys from in-memory index tree' (duration: 510.229407ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:31:25.572666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:31:25.062145Z","time spent":"510.504737ms","remote":"127.0.0.1:33302","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-07-08T15:31:25.572425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:31:25.083883Z","time spent":"488.532359ms","remote":"127.0.0.1:33302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-08T15:31:25.572872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.078939ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T15:31:25.572917Z","caller":"traceutil/trace.go:171","msg":"trace[2071060605] transaction","detail":"{read_only:false; response_revision:770; number_of_response:1; }","duration":"334.120936ms","start":"2026-07-08T15:31:25.238788Z","end":"2026-07-08T15:31:25.572909Z","steps":["trace[2071060605] 'process raft request' (duration: 173.962314ms)","trace[2071060605] 'compare' (duration: 159.546868ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T15:31:25.572954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:31:25.238759Z","time spent":"334.179219ms","remote":"127.0.0.1:33302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T15:31:25.595789Z","caller":"traceutil/trace.go:171","msg":"trace[924595816] transaction","detail":"{read_only:false; response_revision:771; number_of_response:1; }","duration":"144.179323ms","start":"2026-07-08T15:31:25.45158Z","end":"2026-07-08T15:31:25.595759Z","steps":["trace[924595816] 'process raft request' (duration: 143.980765ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:31:34.657304Z","caller":"traceutil/trace.go:171","msg":"trace[1879493776] transaction","detail":"{read_only:false; response_revision:865; number_of_response:1; }","duration":"122.182188ms","start":"2026-07-08T15:31:34.535087Z","end":"2026-07-08T15:31:34.65727Z","steps":["trace[1879493776] 'process raft request' (duration: 92.242039ms)","trace[1879493776] 'compare' (duration: 29.747761ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T15:31:34.657968Z","caller":"traceutil/trace.go:171","msg":"trace[783099813] transaction","detail":"{read_only:false; response_revision:866; number_of_response:1; }","duration":"117.775649ms","start":"2026-07-08T15:31:34.54018Z","end":"2026-07-08T15:31:34.657955Z","steps":["trace[783099813] 'process raft request' (duration: 117.025708ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:31:34.837669Z","caller":"traceutil/trace.go:171","msg":"trace[248010232] transaction","detail":"{read_only:false; response_revision:869; number_of_response:1; }","duration":"172.787439ms","start":"2026-07-08T15:31:34.664821Z","end":"2026-07-08T15:31:34.837609Z","steps":["trace[248010232] 'process raft request' (duration: 127.318417ms)","trace[248010232] 'compare' (duration: 45.238242ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T15:31:34.837712Z","caller":"traceutil/trace.go:171","msg":"trace[471393710] transaction","detail":"{read_only:false; response_revision:870; number_of_response:1; }","duration":"172.147342ms","start":"2026-07-08T15:31:34.665534Z","end":"2026-07-08T15:31:34.837681Z","steps":["trace[471393710] 'process raft request' (duration: 172.000166ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:31:34.838078Z","caller":"traceutil/trace.go:171","msg":"trace[19870015] transaction","detail":"{read_only:false; response_revision:871; number_of_response:1; }","duration":"171.770696ms","start":"2026-07-08T15:31:34.666289Z","end":"2026-07-08T15:31:34.83806Z","steps":["trace[19870015] 'process raft request' (duration: 171.316947ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:31:34.838795Z","caller":"traceutil/trace.go:171","msg":"trace[653930056] transaction","detail":"{read_only:false; response_revision:872; number_of_response:1; }","duration":"171.085786ms","start":"2026-07-08T15:31:34.667693Z","end":"2026-07-08T15:31:34.838779Z","steps":["trace[653930056] 'process raft request' (duration: 169.974198ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:31:35.002792Z","caller":"traceutil/trace.go:171","msg":"trace[353377212] transaction","detail":"{read_only:false; response_revision:873; number_of_response:1; }","duration":"157.977726ms","start":"2026-07-08T15:31:34.84479Z","end":"2026-07-08T15:31:35.002767Z","steps":["trace[353377212] 'process raft request' (duration: 97.001402ms)","trace[353377212] 'compare' (duration: 60.847429ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T15:31:35.009821Z","caller":"traceutil/trace.go:171","msg":"trace[1692967213] transaction","detail":"{read_only:false; response_revision:875; number_of_response:1; }","duration":"159.949102ms","start":"2026-07-08T15:31:34.849857Z","end":"2026-07-08T15:31:35.009806Z","steps":["trace[1692967213] 'process raft request' (duration: 159.895469ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:31:35.009983Z","caller":"traceutil/trace.go:171","msg":"trace[707979448] transaction","detail":"{read_only:false; number_of_response:1; response_revision:874; }","duration":"163.455273ms","start":"2026-07-08T15:31:34.846503Z","end":"2026-07-08T15:31:35.009958Z","steps":["trace[707979448] 'process raft request' (duration: 163.184062ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:31:35.010185Z","caller":"traceutil/trace.go:171","msg":"trace[1602742659] transaction","detail":"{read_only:false; response_revision:874; number_of_response:1; }","duration":"165.015188ms","start":"2026-07-08T15:31:34.845159Z","end":"2026-07-08T15:31:35.010175Z","steps":["trace[1602742659] 'process raft request' (duration: 164.455364ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:31:35.142751Z","caller":"traceutil/trace.go:171","msg":"trace[513925988] transaction","detail":"{read_only:false; response_revision:878; number_of_response:1; }","duration":"122.536118ms","start":"2026-07-08T15:31:35.02018Z","end":"2026-07-08T15:31:35.142716Z","steps":["trace[513925988] 'process raft request' (duration: 96.756961ms)","trace[513925988] 'compare' (duration: 25.582469ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T15:32:19.143001Z","caller":"traceutil/trace.go:171","msg":"trace[585528779] transaction","detail":"{read_only:false; response_revision:1081; number_of_response:1; }","duration":"147.423718ms","start":"2026-07-08T15:32:18.99555Z","end":"2026-07-08T15:32:19.142974Z","steps":["trace[585528779] 'process raft request' (duration: 145.762162ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:32:35.172714Z","caller":"traceutil/trace.go:171","msg":"trace[700118581] transaction","detail":"{read_only:false; response_revision:1133; number_of_response:1; }","duration":"116.616582ms","start":"2026-07-08T15:32:35.056064Z","end":"2026-07-08T15:32:35.172681Z","steps":["trace[700118581] 'process raft request' (duration: 116.416451ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:32:47.598624Z","caller":"traceutil/trace.go:171","msg":"trace[944219467] transaction","detail":"{read_only:false; response_revision:1174; number_of_response:1; }","duration":"174.836251ms","start":"2026-07-08T15:32:47.423604Z","end":"2026-07-08T15:32:47.598441Z","steps":["trace[944219467] 'process raft request' (duration: 151.394562ms)","trace[944219467] 'compare' (duration: 23.301452ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T15:32:51.416419Z","caller":"traceutil/trace.go:171","msg":"trace[397438042] transaction","detail":"{read_only:false; response_revision:1185; number_of_response:1; }","duration":"103.906327ms","start":"2026-07-08T15:32:51.312481Z","end":"2026-07-08T15:32:51.416388Z","steps":["trace[397438042] 'process raft request' (duration: 103.752269ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:33:08.520988Z","caller":"traceutil/trace.go:171","msg":"trace[1813192622] linearizableReadLoop","detail":"{readStateIndex:1307; appliedIndex:1306; }","duration":"100.236651ms","start":"2026-07-08T15:33:08.420722Z","end":"2026-07-08T15:33:08.520959Z","steps":["trace[1813192622] 'read index received' (duration: 99.919503ms)","trace[1813192622] 'applied index is now lower than readState.Index' (duration: 315.768µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T15:33:08.521068Z","caller":"traceutil/trace.go:171","msg":"trace[2096210017] transaction","detail":"{read_only:false; response_revision:1253; number_of_response:1; }","duration":"102.107216ms","start":"2026-07-08T15:33:08.418917Z","end":"2026-07-08T15:33:08.521024Z","steps":["trace[2096210017] 'process raft request' (duration: 101.866972ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:33:08.521346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.595661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-08T15:33:08.521483Z","caller":"traceutil/trace.go:171","msg":"trace[764322721] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1253; }","duration":"100.787602ms","start":"2026-07-08T15:33:08.42066Z","end":"2026-07-08T15:33:08.521448Z","steps":["trace[764322721] 'agreement among raft nodes before linearized reading' (duration: 100.518196ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:33:08.521662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.800862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-08T15:33:08.521756Z","caller":"traceutil/trace.go:171","msg":"trace[1035553576] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1253; }","duration":"101.066278ms","start":"2026-07-08T15:33:08.420669Z","end":"2026-07-08T15:33:08.521736Z","steps":["trace[1035553576] 'agreement among raft nodes before linearized reading' (duration: 100.426792ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:33:08.673058Z","caller":"traceutil/trace.go:171","msg":"trace[935736845] transaction","detail":"{read_only:false; response_revision:1255; number_of_response:1; }","duration":"145.721475ms","start":"2026-07-08T15:33:08.527307Z","end":"2026-07-08T15:33:08.673029Z","steps":["trace[935736845] 'process raft request' (duration: 126.743101ms)","trace[935736845] 'compare' (duration: 18.808053ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T15:33:08.673651Z","caller":"traceutil/trace.go:171","msg":"trace[26982049] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"145.83731ms","start":"2026-07-08T15:33:08.527576Z","end":"2026-07-08T15:33:08.673413Z","steps":["trace[26982049] 'process raft request' (duration: 145.414735ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:33:10.07165Z","caller":"traceutil/trace.go:171","msg":"trace[1410046538] linearizableReadLoop","detail":"{readStateIndex:1315; appliedIndex:1314; }","duration":"287.347588ms","start":"2026-07-08T15:33:09.784272Z","end":"2026-07-08T15:33:10.071619Z","steps":["trace[1410046538] 'read index received' (duration: 287.281484ms)","trace[1410046538] 'applied index is now lower than readState.Index' (duration: 64.564µs)"],"step_count":2} {"level":"warn","ts":"2026-07-08T15:33:10.071902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.598562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2bccf074-3163-44e4-9790-3110adeddc0f\" ","response":"range_response_count:1 size:3579"} {"level":"info","ts":"2026-07-08T15:33:10.071982Z","caller":"traceutil/trace.go:171","msg":"trace[882091561] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2bccf074-3163-44e4-9790-3110adeddc0f; range_end:; response_count:1; response_revision:1261; }","duration":"287.728539ms","start":"2026-07-08T15:33:09.784233Z","end":"2026-07-08T15:33:10.071962Z","steps":["trace[882091561] 'agreement among raft nodes before linearized reading' (duration: 287.485556ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:33:10.072147Z","caller":"traceutil/trace.go:171","msg":"trace[180010277] transaction","detail":"{read_only:false; response_revision:1261; number_of_response:1; }","duration":"313.214633ms","start":"2026-07-08T15:33:09.758918Z","end":"2026-07-08T15:33:10.072133Z","steps":["trace[180010277] 'process raft request' (duration: 312.536445ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T15:33:10.072242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T15:33:09.758815Z","time spent":"313.365092ms","remote":"127.0.0.1:33302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T15:33:10.320611Z","caller":"traceutil/trace.go:171","msg":"trace[1515240442] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"242.219444ms","start":"2026-07-08T15:33:10.07836Z","end":"2026-07-08T15:33:10.320579Z","steps":["trace[1515240442] 'process raft request' (duration: 242.058085ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:33:10.90337Z","caller":"traceutil/trace.go:171","msg":"trace[67266570] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"173.934072ms","start":"2026-07-08T15:33:10.729362Z","end":"2026-07-08T15:33:10.903296Z","steps":["trace[67266570] 'process raft request' (duration: 113.323105ms)","trace[67266570] 'compare' (duration: 60.386764ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T15:33:10.903596Z","caller":"traceutil/trace.go:171","msg":"trace[2078172165] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"172.857151ms","start":"2026-07-08T15:33:10.730676Z","end":"2026-07-08T15:33:10.903533Z","steps":["trace[2078172165] 'process raft request' (duration: 172.570365ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T15:33:25.233864Z","caller":"traceutil/trace.go:171","msg":"trace[65603242] transaction","detail":"{read_only:false; response_revision:1338; number_of_response:1; }","duration":"151.75309ms","start":"2026-07-08T15:33:25.082084Z","end":"2026-07-08T15:33:25.233838Z","steps":["trace[65603242] 'process raft request' (duration: 151.115864ms)"],"step_count":1}