{"level":"warn","ts":"2026-07-09T23:53:59.990039Z","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-09T23:53:59.990114Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.151:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.151:2380","--initial-cluster=instance=https://199.19.213.151:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.151:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.151: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-09T23:53:59.990309Z","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-09T23:53:59.990326Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.151:2380"]} {"level":"info","ts":"2026-07-09T23:53:59.990342Z","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-09T23:53:59.990958Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.151:2379"]} {"level":"info","ts":"2026-07-09T23:53:59.991034Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.151:2380"],"listen-peer-urls":["https://199.19.213.151:2380"],"advertise-client-urls":["https://199.19.213.151:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.151:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.151: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-09T23:53:59.993523Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.300302ms"} {"level":"info","ts":"2026-07-09T23:53:59.999467Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"9abf795dae4ebc2c","cluster-id":"8a186cf11cef5bce"} {"level":"info","ts":"2026-07-09T23:53:59.999562Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9abf795dae4ebc2c switched to configuration voters=()"} {"level":"info","ts":"2026-07-09T23:53:59.999587Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9abf795dae4ebc2c became follower at term 0"} {"level":"info","ts":"2026-07-09T23:53:59.999599Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9abf795dae4ebc2c [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-09T23:53:59.999618Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9abf795dae4ebc2c became follower at term 1"} {"level":"info","ts":"2026-07-09T23:53:59.999666Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9abf795dae4ebc2c switched to configuration voters=(11150764645655952428)"} {"level":"warn","ts":"2026-07-09T23:54:00.004261Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-09T23:54:00.005654Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-09T23:54:00.006588Z","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-09T23:54:00.009271Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"9abf795dae4ebc2c","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-09T23:54:00.00977Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"9abf795dae4ebc2c","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-09T23:54:00.011785Z","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-09T23:54:00.011875Z","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-09T23:54:00.0119Z","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-09T23:54:00.012078Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9abf795dae4ebc2c switched to configuration voters=(11150764645655952428)"} {"level":"info","ts":"2026-07-09T23:54:00.012246Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8a186cf11cef5bce","local-member-id":"9abf795dae4ebc2c","added-peer-id":"9abf795dae4ebc2c","added-peer-peer-urls":["https://199.19.213.151:2380"]} {"level":"info","ts":"2026-07-09T23:54:00.015272Z","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-09T23:54:00.015988Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"9abf795dae4ebc2c","initial-advertise-peer-urls":["https://199.19.213.151:2380"],"listen-peer-urls":["https://199.19.213.151:2380"],"advertise-client-urls":["https://199.19.213.151:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.151:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-09T23:54:00.016271Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-09T23:54:00.015489Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.151:2380"} {"level":"info","ts":"2026-07-09T23:54:00.01695Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.151:2380"} {"level":"info","ts":"2026-07-09T23:54:00.402594Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9abf795dae4ebc2c is starting a new election at term 1"} {"level":"info","ts":"2026-07-09T23:54:00.402654Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9abf795dae4ebc2c became pre-candidate at term 1"} {"level":"info","ts":"2026-07-09T23:54:00.402672Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9abf795dae4ebc2c received MsgPreVoteResp from 9abf795dae4ebc2c at term 1"} {"level":"info","ts":"2026-07-09T23:54:00.402723Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9abf795dae4ebc2c became candidate at term 2"} {"level":"info","ts":"2026-07-09T23:54:00.402734Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9abf795dae4ebc2c received MsgVoteResp from 9abf795dae4ebc2c at term 2"} {"level":"info","ts":"2026-07-09T23:54:00.402742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9abf795dae4ebc2c became leader at term 2"} {"level":"info","ts":"2026-07-09T23:54:00.402769Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9abf795dae4ebc2c elected leader 9abf795dae4ebc2c at term 2"} {"level":"info","ts":"2026-07-09T23:54:00.435162Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"9abf795dae4ebc2c","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.151:2379]}","request-path":"/0/members/9abf795dae4ebc2c/attributes","cluster-id":"8a186cf11cef5bce","publish-timeout":"7s"} {"level":"info","ts":"2026-07-09T23:54:00.435202Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-09T23:54:00.435405Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-09T23:54:00.436283Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-09T23:54:00.437797Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-09T23:54:00.437856Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-09T23:54:00.438213Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8a186cf11cef5bce","local-member-id":"9abf795dae4ebc2c","cluster-version":"3.5"} {"level":"info","ts":"2026-07-09T23:54:00.438402Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-09T23:54:00.438512Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-09T23:54:00.438931Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-09T23:54:00.440462Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.151:2379"} {"level":"info","ts":"2026-07-09T23:54:32.993194Z","caller":"traceutil/trace.go:171","msg":"trace[741779353] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"295.301244ms","start":"2026-07-09T23:54:32.697869Z","end":"2026-07-09T23:54:32.99317Z","steps":["trace[741779353] 'process raft request' (duration: 295.15424ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T23:54:37.191732Z","caller":"traceutil/trace.go:171","msg":"trace[280110226] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"338.778663ms","start":"2026-07-09T23:54:36.85293Z","end":"2026-07-09T23:54:37.191708Z","steps":["trace[280110226] 'process raft request' (duration: 338.672781ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:54:37.192318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T23:54:36.852911Z","time spent":"338.901086ms","remote":"127.0.0.1:55672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-09T23:54:37.198037Z","caller":"traceutil/trace.go:171","msg":"trace[1217915721] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"331.704601ms","start":"2026-07-09T23:54:36.866314Z","end":"2026-07-09T23:54:37.198019Z","steps":["trace[1217915721] 'process raft request' (duration: 331.311442ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:54:37.198138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T23:54:36.866297Z","time spent":"331.797583ms","remote":"127.0.0.1:55672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-09T23:54:37.198243Z","caller":"traceutil/trace.go:171","msg":"trace[1637377619] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"338.820275ms","start":"2026-07-09T23:54:36.859411Z","end":"2026-07-09T23:54:37.198231Z","steps":["trace[1637377619] 'process raft request' (duration: 338.17691ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T23:54:37.198237Z","caller":"traceutil/trace.go:171","msg":"trace[1951823194] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"340.698597ms","start":"2026-07-09T23:54:36.857479Z","end":"2026-07-09T23:54:37.198177Z","steps":["trace[1951823194] 'process raft request' (duration: 340.025691ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:54:37.198292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T23:54:36.859389Z","time spent":"338.882386ms","remote":"127.0.0.1:55672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-09T23:54:37.198397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T23:54:36.857459Z","time spent":"340.861571ms","remote":"127.0.0.1:55672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-09T23:54:37.198394Z","caller":"traceutil/trace.go:171","msg":"trace[733314844] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"327.183946ms","start":"2026-07-09T23:54:36.871186Z","end":"2026-07-09T23:54:37.19837Z","steps":["trace[733314844] 'process raft request' (duration: 326.544722ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:54:37.19849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T23:54:36.871177Z","time spent":"327.265749ms","remote":"127.0.0.1:55672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-09T23:54:37.198562Z","caller":"traceutil/trace.go:171","msg":"trace[1651294840] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"326.984232ms","start":"2026-07-09T23:54:36.871545Z","end":"2026-07-09T23:54:37.198529Z","steps":["trace[1651294840] 'process raft request' (duration: 326.250685ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:54:37.198658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T23:54:36.871523Z","time spent":"327.106625ms","remote":"127.0.0.1:55672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-09T23:54:37.198746Z","caller":"traceutil/trace.go:171","msg":"trace[2057599211] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"329.821437ms","start":"2026-07-09T23:54:36.868917Z","end":"2026-07-09T23:54:37.198738Z","steps":["trace[2057599211] 'process raft request' (duration: 328.778614ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:54:37.198815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T23:54:36.8689Z","time spent":"329.896239ms","remote":"127.0.0.1:55672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-09T23:54:37.198992Z","caller":"traceutil/trace.go:171","msg":"trace[742676670] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"326.824489ms","start":"2026-07-09T23:54:36.872159Z","end":"2026-07-09T23:54:37.198983Z","steps":["trace[742676670] 'process raft request' (duration: 325.671872ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:54:37.199044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T23:54:36.872149Z","time spent":"326.873761ms","remote":"127.0.0.1:55672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-09T23:54:37.199609Z","caller":"traceutil/trace.go:171","msg":"trace[535567765] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"300.615948ms","start":"2026-07-09T23:54:36.898978Z","end":"2026-07-09T23:54:37.199594Z","steps":["trace[535567765] 'process raft request' (duration: 300.300751ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:54:37.199673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T23:54:36.898963Z","time spent":"300.685699ms","remote":"127.0.0.1:55672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-09T23:54:37.199765Z","caller":"traceutil/trace.go:171","msg":"trace[1670980783] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"316.852159ms","start":"2026-07-09T23:54:36.882905Z","end":"2026-07-09T23:54:37.199758Z","steps":["trace[1670980783] 'process raft request' (duration: 315.082638ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T23:54:37.19976Z","caller":"traceutil/trace.go:171","msg":"trace[388962731] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"186.132427ms","start":"2026-07-09T23:54:37.01361Z","end":"2026-07-09T23:54:37.199742Z","steps":["trace[388962731] 'process raft request' (duration: 185.841791ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:54:37.199805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T23:54:36.882888Z","time spent":"316.900801ms","remote":"127.0.0.1:55672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-09T23:54:37.199829Z","caller":"traceutil/trace.go:171","msg":"trace[1574638005] linearizableReadLoop","detail":"{readStateIndex:553; appliedIndex:542; }","duration":"187.750694ms","start":"2026-07-09T23:54:37.012069Z","end":"2026-07-09T23:54:37.19982Z","steps":["trace[1574638005] 'read index received' (duration: 179.586816ms)","trace[1574638005] 'applied index is now lower than readState.Index' (duration: 8.163058ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T23:54:37.199861Z","caller":"traceutil/trace.go:171","msg":"trace[1508127128] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"315.433468ms","start":"2026-07-09T23:54:36.884421Z","end":"2026-07-09T23:54:37.199854Z","steps":["trace[1508127128] 'process raft request' (duration: 314.780903ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:54:37.199889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T23:54:36.884414Z","time spent":"315.462518ms","remote":"127.0.0.1:55672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-09T23:54:37.200048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.978639ms","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-09T23:54:37.200107Z","caller":"traceutil/trace.go:171","msg":"trace[1996398896] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:536; }","duration":"188.086481ms","start":"2026-07-09T23:54:37.012012Z","end":"2026-07-09T23:54:37.200099Z","steps":["trace[1996398896] 'agreement among raft nodes before linearized reading' (duration: 187.929448ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T23:54:43.511772Z","caller":"traceutil/trace.go:171","msg":"trace[836709186] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"357.069303ms","start":"2026-07-09T23:54:43.154668Z","end":"2026-07-09T23:54:43.511738Z","steps":["trace[836709186] 'process raft request' (duration: 355.810904ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:54:43.512139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.197293ms","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-09T23:54:43.512207Z","caller":"traceutil/trace.go:171","msg":"trace[1464142811] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:628; }","duration":"255.303556ms","start":"2026-07-09T23:54:43.256883Z","end":"2026-07-09T23:54:43.512187Z","steps":["trace[1464142811] 'agreement among raft nodes before linearized reading' (duration: 254.935957ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:54:43.512235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T23:54:43.15464Z","time spent":"357.200406ms","remote":"127.0.0.1:55718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036281,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T23:54:43.51176Z","caller":"traceutil/trace.go:171","msg":"trace[779444133] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:651; }","duration":"254.773494ms","start":"2026-07-09T23:54:43.256924Z","end":"2026-07-09T23:54:43.511697Z","steps":["trace[779444133] 'read index received' (duration: 253.813022ms)","trace[779444133] 'applied index is now lower than readState.Index' (duration: 959.662µs)"],"step_count":2} {"level":"info","ts":"2026-07-09T23:54:43.569161Z","caller":"traceutil/trace.go:171","msg":"trace[1411953342] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"195.934291ms","start":"2026-07-09T23:54:43.373201Z","end":"2026-07-09T23:54:43.569135Z","steps":["trace[1411953342] 'process raft request' (duration: 195.787437ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:54:43.569293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.801198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-zskdm\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-07-09T23:54:43.569355Z","caller":"traceutil/trace.go:171","msg":"trace[1740723568] range","detail":"{range_begin:/registry/pods/kube-system/cilium-zskdm; range_end:; response_count:1; response_revision:629; }","duration":"154.91033ms","start":"2026-07-09T23:54:43.414429Z","end":"2026-07-09T23:54:43.569339Z","steps":["trace[1740723568] 'agreement among raft nodes before linearized reading' (duration: 154.720575ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:54:43.569247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.98451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.151\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-09T23:54:43.569467Z","caller":"traceutil/trace.go:171","msg":"trace[1973887000] range","detail":"{range_begin:/registry/masterleases/199.19.213.151; range_end:; response_count:1; response_revision:629; }","duration":"191.226975ms","start":"2026-07-09T23:54:43.378208Z","end":"2026-07-09T23:54:43.569435Z","steps":["trace[1973887000] 'agreement among raft nodes before linearized reading' (duration: 190.914927ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T23:54:43.851558Z","caller":"traceutil/trace.go:171","msg":"trace[1876278650] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"291.171311ms","start":"2026-07-09T23:54:43.560358Z","end":"2026-07-09T23:54:43.851529Z","steps":["trace[1876278650] 'process raft request' (duration: 291.093139ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T23:54:43.851941Z","caller":"traceutil/trace.go:171","msg":"trace[1225504993] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"335.072598ms","start":"2026-07-09T23:54:43.516844Z","end":"2026-07-09T23:54:43.851917Z","steps":["trace[1225504993] 'process raft request' (duration: 277.649039ms)","trace[1225504993] 'compare' (duration: 56.722503ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T23:54:43.852055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T23:54:43.516823Z","time spent":"335.163341ms","remote":"127.0.0.1:55908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T23:54:44.470291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.211568ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"info","ts":"2026-07-09T23:54:44.470509Z","caller":"traceutil/trace.go:171","msg":"trace[1956317942] linearizableReadLoop","detail":"{readStateIndex:657; appliedIndex:655; }","duration":"607.828506ms","start":"2026-07-09T23:54:43.862664Z","end":"2026-07-09T23:54:44.470493Z","steps":["trace[1956317942] 'read index received' (duration: 424.204468ms)","trace[1956317942] 'applied index is now lower than readState.Index' (duration: 183.623158ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T23:54:44.470611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T23:54:43.571529Z","time spent":"899.079547ms","remote":"127.0.0.1:55652","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-07-09T23:54:44.470706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"608.02505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T23:54:44.470762Z","caller":"traceutil/trace.go:171","msg":"trace[1819752414] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:632; }","duration":"608.105631ms","start":"2026-07-09T23:54:43.862629Z","end":"2026-07-09T23:54:44.470734Z","steps":["trace[1819752414] 'agreement among raft nodes before linearized reading' (duration: 607.979728ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:54:44.470804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T23:54:43.862613Z","time spent":"608.182434ms","remote":"127.0.0.1:55882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"info","ts":"2026-07-09T23:54:44.470863Z","caller":"traceutil/trace.go:171","msg":"trace[1322098769] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"887.099932ms","start":"2026-07-09T23:54:43.583752Z","end":"2026-07-09T23:54:44.470852Z","steps":["trace[1322098769] 'process raft request' (duration: 886.629801ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:54:44.470856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.661485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-07-09T23:54:44.470959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T23:54:43.583735Z","time spent":"887.164203ms","remote":"127.0.0.1:55806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T23:54:44.470959Z","caller":"traceutil/trace.go:171","msg":"trace[203416727] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:632; }","duration":"454.810499ms","start":"2026-07-09T23:54:44.01612Z","end":"2026-07-09T23:54:44.47093Z","steps":["trace[203416727] 'agreement among raft nodes before linearized reading' (duration: 454.598854ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:54:44.471019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T23:54:44.016103Z","time spent":"454.9056ms","remote":"127.0.0.1:55908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-09T23:54:44.471109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.629921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-09T23:54:44.47115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.308503ms","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-09T23:54:44.471195Z","caller":"traceutil/trace.go:171","msg":"trace[1646955817] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:632; }","duration":"278.385495ms","start":"2026-07-09T23:54:44.192799Z","end":"2026-07-09T23:54:44.471184Z","steps":["trace[1646955817] 'agreement among raft nodes before linearized reading' (duration: 278.207251ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T23:54:44.471198Z","caller":"traceutil/trace.go:171","msg":"trace[322208434] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:632; }","duration":"369.726673ms","start":"2026-07-09T23:54:44.10145Z","end":"2026-07-09T23:54:44.471177Z","steps":["trace[322208434] 'agreement among raft nodes before linearized reading' (duration: 369.57171ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:54:44.471238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T23:54:44.101392Z","time spent":"369.839327ms","remote":"127.0.0.1:55636","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-09T23:54:44.471237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.933316ms","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-09T23:54:44.47134Z","caller":"traceutil/trace.go:171","msg":"trace[634700188] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:632; }","duration":"339.080041ms","start":"2026-07-09T23:54:44.132235Z","end":"2026-07-09T23:54:44.471315Z","steps":["trace[634700188] 'agreement among raft nodes before linearized reading' (duration: 338.756903ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:54:44.471395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T23:54:44.132219Z","time spent":"339.166343ms","remote":"127.0.0.1:55908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-09T23:54:45.602318Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13559387715286451337,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-09T23:54:46.103236Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13559387715286451337,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-09T23:54:46.15577Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.282004321s","expected-duration":"1s"} {"level":"info","ts":"2026-07-09T23:54:46.156995Z","caller":"traceutil/trace.go:171","msg":"trace[807296878] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"1.28500019s","start":"2026-07-09T23:54:44.871964Z","end":"2026-07-09T23:54:46.156964Z","steps":["trace[807296878] 'process raft request' (duration: 1.284380656s)"],"step_count":1} {"level":"info","ts":"2026-07-09T23:54:46.157071Z","caller":"traceutil/trace.go:171","msg":"trace[1872564968] linearizableReadLoop","detail":"{readStateIndex:662; appliedIndex:661; }","duration":"1.055143409s","start":"2026-07-09T23:54:45.101896Z","end":"2026-07-09T23:54:46.15704Z","steps":["trace[1872564968] 'read index received' (duration: 1.054226119s)","trace[1872564968] 'applied index is now lower than readState.Index' (duration: 915.02µs)"],"step_count":2} {"level":"warn","ts":"2026-07-09T23:54:46.157156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T23:54:44.871925Z","time spent":"1.285143423s","remote":"127.0.0.1:55718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T23:54:46.157205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.055305143s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T23:54:46.15726Z","caller":"traceutil/trace.go:171","msg":"trace[1583632989] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:638; }","duration":"1.055396045s","start":"2026-07-09T23:54:45.101847Z","end":"2026-07-09T23:54:46.157243Z","steps":["trace[1583632989] 'agreement among raft nodes before linearized reading' (duration: 1.055312243s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:54:46.157297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T23:54:45.101826Z","time spent":"1.055462867s","remote":"127.0.0.1:55636","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-09T23:54:46.157327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.582985ms","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-09T23:54:46.157382Z","caller":"traceutil/trace.go:171","msg":"trace[1086389795] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:638; }","duration":"300.668976ms","start":"2026-07-09T23:54:45.856697Z","end":"2026-07-09T23:54:46.157366Z","steps":["trace[1086389795] 'agreement among raft nodes before linearized reading' (duration: 300.497532ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:54:46.157424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T23:54:45.856683Z","time spent":"300.729878ms","remote":"127.0.0.1:55908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-09T23:54:47.841641Z","caller":"traceutil/trace.go:171","msg":"trace[240416030] transaction","detail":"{read_only:false; response_revision:673; number_of_response:1; }","duration":"279.723076ms","start":"2026-07-09T23:54:47.561881Z","end":"2026-07-09T23:54:47.841604Z","steps":["trace[240416030] 'process raft request' (duration: 279.103261ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T23:54:50.709908Z","caller":"traceutil/trace.go:171","msg":"trace[629924628] transaction","detail":"{read_only:false; response_revision:714; number_of_response:1; }","duration":"128.528453ms","start":"2026-07-09T23:54:50.581357Z","end":"2026-07-09T23:54:50.709885Z","steps":["trace[629924628] 'process raft request' (duration: 128.371938ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:55:00.970296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.410451ms","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-09T23:55:00.970375Z","caller":"traceutil/trace.go:171","msg":"trace[1316060883] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:792; }","duration":"386.523484ms","start":"2026-07-09T23:55:00.583838Z","end":"2026-07-09T23:55:00.970361Z","steps":["trace[1316060883] 'range keys from in-memory index tree' (duration: 386.281709ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:55:00.970409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T23:55:00.583829Z","time spent":"386.573885ms","remote":"127.0.0.1:55908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-09T23:55:00.97052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.189973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-09T23:55:00.970619Z","caller":"traceutil/trace.go:171","msg":"trace[1961763887] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:792; }","duration":"385.317496ms","start":"2026-07-09T23:55:00.585283Z","end":"2026-07-09T23:55:00.970601Z","steps":["trace[1961763887] 'range keys from in-memory index tree' (duration: 385.05956ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:55:00.97067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T23:55:00.585274Z","time spent":"385.375427ms","remote":"127.0.0.1:55908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-09T23:55:00.970689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"737.298064ms","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-09T23:55:00.970754Z","caller":"traceutil/trace.go:171","msg":"trace[348542648] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:792; }","duration":"737.394797ms","start":"2026-07-09T23:55:00.233341Z","end":"2026-07-09T23:55:00.970735Z","steps":["trace[348542648] 'range keys from in-memory index tree' (duration: 737.148511ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:55:00.970799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T23:55:00.233322Z","time spent":"737.463918ms","remote":"127.0.0.1:55908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-09T23:55:00.971261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.262954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-09T23:55:00.971358Z","caller":"traceutil/trace.go:171","msg":"trace[1015690653] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:792; }","duration":"388.410968ms","start":"2026-07-09T23:55:00.582932Z","end":"2026-07-09T23:55:00.971343Z","steps":["trace[1015690653] 'range keys from in-memory index tree' (duration: 388.076989ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:55:00.971343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.491983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-rdt6m\" ","response":"range_response_count:1 size:3965"} {"level":"warn","ts":"2026-07-09T23:55:00.971401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T23:55:00.58291Z","time spent":"388.48377ms","remote":"127.0.0.1:55908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-09T23:55:00.971413Z","caller":"traceutil/trace.go:171","msg":"trace[2051018751] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-rdt6m; range_end:; response_count:1; response_revision:792; }","duration":"458.611876ms","start":"2026-07-09T23:55:00.512785Z","end":"2026-07-09T23:55:00.971397Z","steps":["trace[2051018751] 'range keys from in-memory index tree' (duration: 458.331438ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:55:00.971447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T23:55:00.512765Z","time spent":"458.671847ms","remote":"127.0.0.1:55806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3989,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-rdt6m\" "} {"level":"info","ts":"2026-07-09T23:55:01.212347Z","caller":"traceutil/trace.go:171","msg":"trace[1810525512] transaction","detail":"{read_only:false; response_revision:793; number_of_response:1; }","duration":"236.814925ms","start":"2026-07-09T23:55:00.975458Z","end":"2026-07-09T23:55:01.212273Z","steps":["trace[1810525512] 'process raft request' (duration: 236.676471ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T23:55:01.219164Z","caller":"traceutil/trace.go:171","msg":"trace[2074030539] linearizableReadLoop","detail":"{readStateIndex:826; appliedIndex:821; }","duration":"117.357263ms","start":"2026-07-09T23:55:01.101775Z","end":"2026-07-09T23:55:01.219132Z","steps":["trace[2074030539] 'read index received' (duration: 110.354871ms)","trace[2074030539] 'applied index is now lower than readState.Index' (duration: 7.001342ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T23:55:01.219163Z","caller":"traceutil/trace.go:171","msg":"trace[1107677824] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"243.228803ms","start":"2026-07-09T23:55:00.975869Z","end":"2026-07-09T23:55:01.219098Z","steps":["trace[1107677824] 'process raft request' (duration: 242.899676ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T23:55:01.219313Z","caller":"traceutil/trace.go:171","msg":"trace[143310681] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"242.892636ms","start":"2026-07-09T23:55:00.976408Z","end":"2026-07-09T23:55:01.219301Z","steps":["trace[143310681] 'process raft request' (duration: 242.513657ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T23:55:01.219372Z","caller":"traceutil/trace.go:171","msg":"trace[28673712] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"239.312102ms","start":"2026-07-09T23:55:00.980042Z","end":"2026-07-09T23:55:01.219354Z","steps":["trace[28673712] 'process raft request' (duration: 238.966154ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:55:01.219459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.667621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T23:55:01.219492Z","caller":"traceutil/trace.go:171","msg":"trace[2122029504] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:797; }","duration":"117.755383ms","start":"2026-07-09T23:55:01.101727Z","end":"2026-07-09T23:55:01.219483Z","steps":["trace[2122029504] 'agreement among raft nodes before linearized reading' (duration: 117.688391ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T23:55:01.21955Z","caller":"traceutil/trace.go:171","msg":"trace[598527186] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"242.541526ms","start":"2026-07-09T23:55:00.976996Z","end":"2026-07-09T23:55:01.219538Z","steps":["trace[598527186] 'process raft request' (duration: 241.964023ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T23:55:35.102655Z","caller":"traceutil/trace.go:171","msg":"trace[983822660] transaction","detail":"{read_only:false; response_revision:1009; number_of_response:1; }","duration":"202.73912ms","start":"2026-07-09T23:55:34.899892Z","end":"2026-07-09T23:55:35.102631Z","steps":["trace[983822660] 'process raft request' (duration: 202.552536ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:55:35.477293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.238968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-07-09T23:55:35.477371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.507764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-09T23:55:35.477378Z","caller":"traceutil/trace.go:171","msg":"trace[54859738] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1009; }","duration":"123.362281ms","start":"2026-07-09T23:55:35.353997Z","end":"2026-07-09T23:55:35.477359Z","steps":["trace[54859738] 'range keys from in-memory index tree' (duration: 123.073035ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T23:55:35.477404Z","caller":"traceutil/trace.go:171","msg":"trace[1626609275] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1009; }","duration":"116.562035ms","start":"2026-07-09T23:55:35.360832Z","end":"2026-07-09T23:55:35.477394Z","steps":["trace[1626609275] 'range keys from in-memory index tree' (duration: 116.435503ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:55:35.477444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.739829ms","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-09T23:55:35.47752Z","caller":"traceutil/trace.go:171","msg":"trace[115742550] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1009; }","duration":"119.844751ms","start":"2026-07-09T23:55:35.357656Z","end":"2026-07-09T23:55:35.4775Z","steps":["trace[115742550] 'range keys from in-memory index tree' (duration: 119.613735ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:55:35.477566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.494997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-09T23:55:35.477644Z","caller":"traceutil/trace.go:171","msg":"trace[1265657898] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1009; }","duration":"117.740962ms","start":"2026-07-09T23:55:35.359884Z","end":"2026-07-09T23:55:35.477625Z","steps":["trace[1265657898] 'range keys from in-memory index tree' (duration: 117.267001ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:55:36.084177Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13559387715286452106,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-09T23:55:36.249646Z","caller":"traceutil/trace.go:171","msg":"trace[1827247431] transaction","detail":"{read_only:false; response_revision:1010; number_of_response:1; }","duration":"768.724548ms","start":"2026-07-09T23:55:35.480902Z","end":"2026-07-09T23:55:36.249627Z","steps":["trace[1827247431] 'process raft request' (duration: 768.615176ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:55:36.249776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T23:55:35.480887Z","time spent":"768.81741ms","remote":"127.0.0.1:55908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T23:55:36.660961Z","caller":"traceutil/trace.go:171","msg":"trace[452052707] transaction","detail":"{read_only:false; response_revision:1012; number_of_response:1; }","duration":"1.179336226s","start":"2026-07-09T23:55:35.481602Z","end":"2026-07-09T23:55:36.660938Z","steps":["trace[452052707] 'process raft request' (duration: 1.179245044s)"],"step_count":1} {"level":"info","ts":"2026-07-09T23:55:36.66109Z","caller":"traceutil/trace.go:171","msg":"trace[2030093859] transaction","detail":"{read_only:false; response_revision:1013; number_of_response:1; }","duration":"1.178556368s","start":"2026-07-09T23:55:35.482525Z","end":"2026-07-09T23:55:36.661082Z","steps":["trace[2030093859] 'process raft request' (duration: 1.178382494s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:55:36.661116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T23:55:35.481597Z","time spent":"1.179426298s","remote":"127.0.0.1:55908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T23:55:36.661152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T23:55:35.482502Z","time spent":"1.17860666s","remote":"127.0.0.1:55908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T23:55:36.660946Z","caller":"traceutil/trace.go:171","msg":"trace[418730366] transaction","detail":"{read_only:false; response_revision:1011; number_of_response:1; }","duration":"1.179383188s","start":"2026-07-09T23:55:35.481543Z","end":"2026-07-09T23:55:36.660927Z","steps":["trace[418730366] 'process raft request' (duration: 1.179038009s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:55:36.661209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T23:55:35.481528Z","time spent":"1.179663404s","remote":"127.0.0.1:55908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T23:55:36.661246Z","caller":"traceutil/trace.go:171","msg":"trace[1071049963] linearizableReadLoop","detail":"{readStateIndex:1052; appliedIndex:1047; }","duration":"1.077100011s","start":"2026-07-09T23:55:35.584126Z","end":"2026-07-09T23:55:36.661226Z","steps":["trace[1071049963] 'read index received' (duration: 665.404768ms)","trace[1071049963] 'applied index is now lower than readState.Index' (duration: 411.694373ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T23:55:36.661471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.077349287s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-09T23:55:36.66152Z","caller":"traceutil/trace.go:171","msg":"trace[1844346467] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1014; }","duration":"1.077427199s","start":"2026-07-09T23:55:35.584079Z","end":"2026-07-09T23:55:36.661506Z","steps":["trace[1844346467] 'agreement among raft nodes before linearized reading' (duration: 1.077289706s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:55:36.661557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T23:55:35.584065Z","time spent":"1.077484211s","remote":"127.0.0.1:55908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-07-09T23:55:36.661663Z","caller":"traceutil/trace.go:171","msg":"trace[1977930710] transaction","detail":"{read_only:false; response_revision:1014; number_of_response:1; }","duration":"701.083589ms","start":"2026-07-09T23:55:35.960546Z","end":"2026-07-09T23:55:36.66163Z","steps":["trace[1977930710] 'process raft request' (duration: 700.492226ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:55:36.661872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T23:55:35.960522Z","time spent":"701.224062ms","remote":"127.0.0.1:55908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T23:55:56.887559Z","caller":"traceutil/trace.go:171","msg":"trace[12666983] transaction","detail":"{read_only:false; response_revision:1081; number_of_response:1; }","duration":"131.411107ms","start":"2026-07-09T23:55:56.756131Z","end":"2026-07-09T23:55:56.887542Z","steps":["trace[12666983] 'process raft request' (duration: 131.379186ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T23:55:56.887733Z","caller":"traceutil/trace.go:171","msg":"trace[46781864] transaction","detail":"{read_only:false; response_revision:1079; number_of_response:1; }","duration":"133.629058ms","start":"2026-07-09T23:55:56.754096Z","end":"2026-07-09T23:55:56.887725Z","steps":["trace[46781864] 'process raft request' (duration: 133.2902ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T23:55:56.887833Z","caller":"traceutil/trace.go:171","msg":"trace[924917385] transaction","detail":"{read_only:false; response_revision:1080; number_of_response:1; }","duration":"132.464161ms","start":"2026-07-09T23:55:56.755361Z","end":"2026-07-09T23:55:56.887825Z","steps":["trace[924917385] 'process raft request' (duration: 132.124464ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:55:58.299274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.704817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T23:55:58.299372Z","caller":"traceutil/trace.go:171","msg":"trace[1283932560] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1082; }","duration":"198.84714ms","start":"2026-07-09T23:55:58.100506Z","end":"2026-07-09T23:55:58.299353Z","steps":["trace[1283932560] 'range keys from in-memory index tree' (duration: 198.617426ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T23:55:58.834787Z","caller":"traceutil/trace.go:171","msg":"trace[434804276] linearizableReadLoop","detail":"{readStateIndex:1126; appliedIndex:1125; }","duration":"185.379721ms","start":"2026-07-09T23:55:58.649356Z","end":"2026-07-09T23:55:58.834736Z","steps":["trace[434804276] 'read index received' (duration: 97.371993ms)","trace[434804276] 'applied index is now lower than readState.Index' (duration: 88.003728ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T23:55:58.860427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.044201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-09T23:55:58.860522Z","caller":"traceutil/trace.go:171","msg":"trace[440995811] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:1084; }","duration":"211.181324ms","start":"2026-07-09T23:55:58.649315Z","end":"2026-07-09T23:55:58.860496Z","steps":["trace[440995811] 'agreement among raft nodes before linearized reading' (duration: 185.549074ms)","trace[440995811] 'count revisions from in-memory index tree' (duration: 25.502417ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T23:55:59.587182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"603.330414ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-09T23:55:59.58738Z","caller":"traceutil/trace.go:171","msg":"trace[321728861] linearizableReadLoop","detail":"{readStateIndex:1131; appliedIndex:1129; }","duration":"486.045854ms","start":"2026-07-09T23:55:59.101317Z","end":"2026-07-09T23:55:59.587363Z","steps":["trace[321728861] 'read index received' (duration: 347.452304ms)","trace[321728861] 'applied index is now lower than readState.Index' (duration: 138.5927ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T23:55:59.587448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.133316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T23:55:59.587473Z","caller":"traceutil/trace.go:171","msg":"trace[522661753] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1088; }","duration":"486.35853ms","start":"2026-07-09T23:55:59.101106Z","end":"2026-07-09T23:55:59.587464Z","steps":["trace[522661753] 'agreement among raft nodes before linearized reading' (duration: 486.314489ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T23:55:59.587484Z","caller":"traceutil/trace.go:171","msg":"trace[1384844205] transaction","detail":"{read_only:false; response_revision:1087; number_of_response:1; }","duration":"690.487483ms","start":"2026-07-09T23:55:58.896965Z","end":"2026-07-09T23:55:59.587452Z","steps":["trace[1384844205] 'process raft request' (duration: 86.81955ms)","trace[1384844205] 'compare' (duration: 603.206081ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T23:55:59.587512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T23:55:59.101081Z","time spent":"486.424032ms","remote":"127.0.0.1:55636","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-09T23:55:59.587504Z","caller":"traceutil/trace.go:171","msg":"trace[1918926997] transaction","detail":"{read_only:false; response_revision:1088; number_of_response:1; }","duration":"688.059557ms","start":"2026-07-09T23:55:58.899414Z","end":"2026-07-09T23:55:59.587473Z","steps":["trace[1918926997] 'process raft request' (duration: 687.861673ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:55:59.587628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T23:55:58.899386Z","time spent":"688.174749ms","remote":"127.0.0.1:55908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T23:55:59.587622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T23:55:58.896955Z","time spent":"690.590916ms","remote":"127.0.0.1:55908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T23:56:20.080356Z","caller":"traceutil/trace.go:171","msg":"trace[492833616] transaction","detail":"{read_only:false; response_revision:1217; number_of_response:1; }","duration":"403.809528ms","start":"2026-07-09T23:56:19.676523Z","end":"2026-07-09T23:56:20.080332Z","steps":["trace[492833616] 'process raft request' (duration: 403.657555ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:56:20.080517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T23:56:19.676507Z","time spent":"403.92346ms","remote":"127.0.0.1:55908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T23:56:20.330049Z","caller":"traceutil/trace.go:171","msg":"trace[2094389033] linearizableReadLoop","detail":"{readStateIndex:1267; appliedIndex:1266; }","duration":"229.454156ms","start":"2026-07-09T23:56:20.100573Z","end":"2026-07-09T23:56:20.330027Z","steps":["trace[2094389033] 'read index received' (duration: 160.691295ms)","trace[2094389033] 'applied index is now lower than readState.Index' (duration: 68.761741ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T23:56:20.330146Z","caller":"traceutil/trace.go:171","msg":"trace[201866086] transaction","detail":"{read_only:false; response_revision:1218; number_of_response:1; }","duration":"653.242676ms","start":"2026-07-09T23:56:19.676865Z","end":"2026-07-09T23:56:20.330108Z","steps":["trace[201866086] 'process raft request' (duration: 584.425634ms)","trace[201866086] 'compare' (duration: 68.653928ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T23:56:20.33018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.592539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T23:56:20.330223Z","caller":"traceutil/trace.go:171","msg":"trace[1611772433] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1218; }","duration":"229.666291ms","start":"2026-07-09T23:56:20.100541Z","end":"2026-07-09T23:56:20.330208Z","steps":["trace[1611772433] 'agreement among raft nodes before linearized reading' (duration: 229.561979ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:56:20.330282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T23:56:19.676853Z","time spent":"653.357248ms","remote":"127.0.0.1:55908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T23:56:41.037717Z","caller":"traceutil/trace.go:171","msg":"trace[808087079] transaction","detail":"{read_only:false; response_revision:1340; number_of_response:1; }","duration":"208.83614ms","start":"2026-07-09T23:56:40.828856Z","end":"2026-07-09T23:56:41.037693Z","steps":["trace[808087079] 'process raft request' (duration: 208.627186ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T23:56:41.189982Z","caller":"traceutil/trace.go:171","msg":"trace[1168626816] transaction","detail":"{read_only:false; response_revision:1341; number_of_response:1; }","duration":"174.052965ms","start":"2026-07-09T23:56:41.015905Z","end":"2026-07-09T23:56:41.189958Z","steps":["trace[1168626816] 'process raft request' (duration: 165.940477ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T23:56:41.18998Z","caller":"traceutil/trace.go:171","msg":"trace[1289336373] linearizableReadLoop","detail":"{readStateIndex:1395; appliedIndex:1393; }","duration":"140.776635ms","start":"2026-07-09T23:56:41.049161Z","end":"2026-07-09T23:56:41.189937Z","steps":["trace[1289336373] 'read index received' (duration: 132.698228ms)","trace[1289336373] 'applied index is now lower than readState.Index' (duration: 8.077337ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T23:56:41.190139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.963909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:534"} {"level":"info","ts":"2026-07-09T23:56:41.190162Z","caller":"traceutil/trace.go:171","msg":"trace[891551165] transaction","detail":"{read_only:false; response_revision:1342; number_of_response:1; }","duration":"148.817311ms","start":"2026-07-09T23:56:41.041335Z","end":"2026-07-09T23:56:41.190152Z","steps":["trace[891551165] 'process raft request' (duration: 148.562545ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T23:56:41.190178Z","caller":"traceutil/trace.go:171","msg":"trace[1551498969] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1342; }","duration":"141.03629ms","start":"2026-07-09T23:56:41.04913Z","end":"2026-07-09T23:56:41.190167Z","steps":["trace[1551498969] 'agreement among raft nodes before linearized reading' (duration: 140.897567ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T23:56:41.930233Z","caller":"traceutil/trace.go:171","msg":"trace[25434045] transaction","detail":"{read_only:false; response_revision:1347; number_of_response:1; }","duration":"200.148399ms","start":"2026-07-09T23:56:41.73006Z","end":"2026-07-09T23:56:41.930208Z","steps":["trace[25434045] 'process raft request' (duration: 199.969115ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:56:42.744987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"576.073101ms","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-09T23:56:42.74507Z","caller":"traceutil/trace.go:171","msg":"trace[2017942488] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1347; }","duration":"576.210714ms","start":"2026-07-09T23:56:42.168838Z","end":"2026-07-09T23:56:42.745049Z","steps":["trace[2017942488] 'range keys from in-memory index tree' (duration: 575.879847ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:56:42.745116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T23:56:42.168817Z","time spent":"576.290096ms","remote":"127.0.0.1:55908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-09T23:56:42.745247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.617371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-09T23:56:42.745322Z","caller":"traceutil/trace.go:171","msg":"trace[463280477] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1347; }","duration":"329.747325ms","start":"2026-07-09T23:56:42.415557Z","end":"2026-07-09T23:56:42.745304Z","steps":["trace[463280477] 'range keys from in-memory index tree' (duration: 329.400736ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:56:42.745366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T23:56:42.415529Z","time spent":"329.828327ms","remote":"127.0.0.1:55908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-09T23:56:42.745427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"595.204934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:621"} {"level":"warn","ts":"2026-07-09T23:56:42.745465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"645.036037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T23:56:42.7455Z","caller":"traceutil/trace.go:171","msg":"trace[1609730224] range","detail":"{range_begin:/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1347; }","duration":"595.321467ms","start":"2026-07-09T23:56:42.15016Z","end":"2026-07-09T23:56:42.745482Z","steps":["trace[1609730224] 'range keys from in-memory index tree' (duration: 595.048061ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T23:56:42.74551Z","caller":"traceutil/trace.go:171","msg":"trace[14628363] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1347; }","duration":"645.114968ms","start":"2026-07-09T23:56:42.100381Z","end":"2026-07-09T23:56:42.745496Z","steps":["trace[14628363] 'range keys from in-memory index tree' (duration: 644.951685ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:56:42.745542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T23:56:42.100361Z","time spent":"645.17453ms","remote":"127.0.0.1:55620","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-09T23:56:42.745542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T23:56:42.150141Z","time spent":"595.392608ms","remote":"127.0.0.1:55734","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":645,"request content":"key:\"/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"info","ts":"2026-07-09T23:56:42.912325Z","caller":"traceutil/trace.go:171","msg":"trace[1404963268] transaction","detail":"{read_only:false; response_revision:1348; number_of_response:1; }","duration":"160.486851ms","start":"2026-07-09T23:56:42.75181Z","end":"2026-07-09T23:56:42.912297Z","steps":["trace[1404963268] 'process raft request' (duration: 160.337618ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T23:56:42.938158Z","caller":"traceutil/trace.go:171","msg":"trace[1790184577] transaction","detail":"{read_only:false; response_revision:1349; number_of_response:1; }","duration":"185.97025ms","start":"2026-07-09T23:56:42.752162Z","end":"2026-07-09T23:56:42.938132Z","steps":["trace[1790184577] 'process raft request' (duration: 185.789866ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T23:56:42.938337Z","caller":"traceutil/trace.go:171","msg":"trace[933196681] transaction","detail":"{read_only:false; response_revision:1350; number_of_response:1; }","duration":"183.631656ms","start":"2026-07-09T23:56:42.754664Z","end":"2026-07-09T23:56:42.938296Z","steps":["trace[933196681] 'process raft request' (duration: 183.414741ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:56:43.788898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.41509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-09T23:56:43.788983Z","caller":"traceutil/trace.go:171","msg":"trace[1419864654] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:1356; }","duration":"138.563404ms","start":"2026-07-09T23:56:43.6504Z","end":"2026-07-09T23:56:43.788964Z","steps":["trace[1419864654] 'count revisions from in-memory index tree' (duration: 138.335809ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T23:56:46.483322Z","caller":"traceutil/trace.go:171","msg":"trace[1572374059] linearizableReadLoop","detail":"{readStateIndex:1419; appliedIndex:1418; }","duration":"271.926198ms","start":"2026-07-09T23:56:46.211371Z","end":"2026-07-09T23:56:46.483297Z","steps":["trace[1572374059] 'read index received' (duration: 271.709923ms)","trace[1572374059] 'applied index is now lower than readState.Index' (duration: 215.345µs)"],"step_count":2} {"level":"warn","ts":"2026-07-09T23:56:46.483561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.999653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-07-09T23:56:46.483562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.174383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:534"} {"level":"info","ts":"2026-07-09T23:56:46.483607Z","caller":"traceutil/trace.go:171","msg":"trace[1532473478] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1365; }","duration":"126.065514ms","start":"2026-07-09T23:56:46.35753Z","end":"2026-07-09T23:56:46.483596Z","steps":["trace[1532473478] 'agreement among raft nodes before linearized reading' (duration: 125.908771ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T23:56:46.483642Z","caller":"traceutil/trace.go:171","msg":"trace[1571225876] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1365; }","duration":"272.259676ms","start":"2026-07-09T23:56:46.211347Z","end":"2026-07-09T23:56:46.483606Z","steps":["trace[1571225876] 'agreement among raft nodes before linearized reading' (duration: 272.089322ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T23:56:46.483511Z","caller":"traceutil/trace.go:171","msg":"trace[1457814973] transaction","detail":"{read_only:false; response_revision:1365; number_of_response:1; }","duration":"284.761445ms","start":"2026-07-09T23:56:46.198718Z","end":"2026-07-09T23:56:46.48348Z","steps":["trace[1457814973] 'process raft request' (duration: 284.426547ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:56:46.945086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.160416ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-09T23:56:46.945195Z","caller":"traceutil/trace.go:171","msg":"trace[1480216977] transaction","detail":"{read_only:false; response_revision:1366; number_of_response:1; }","duration":"456.992947ms","start":"2026-07-09T23:56:46.48818Z","end":"2026-07-09T23:56:46.945173Z","steps":["trace[1480216977] 'process raft request' (duration: 132.634917ms)","trace[1480216977] 'compare' (duration: 323.768827ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T23:56:46.945261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T23:56:46.488155Z","time spent":"457.07088ms","remote":"127.0.0.1:55908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T23:56:46.94622Z","caller":"traceutil/trace.go:171","msg":"trace[22132038] transaction","detail":"{read_only:false; response_revision:1367; number_of_response:1; }","duration":"457.352766ms","start":"2026-07-09T23:56:46.488844Z","end":"2026-07-09T23:56:46.946197Z","steps":["trace[22132038] 'process raft request' (duration: 457.263014ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T23:56:46.946421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T23:56:46.488822Z","time spent":"457.549761ms","remote":"127.0.0.1:55908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":519,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T23:56:46.960499Z","caller":"traceutil/trace.go:171","msg":"trace[1689310790] transaction","detail":"{read_only:false; response_revision:1368; number_of_response:1; }","duration":"118.500369ms","start":"2026-07-09T23:56:46.841946Z","end":"2026-07-09T23:56:46.960446Z","steps":["trace[1689310790] 'process raft request' (duration: 118.376516ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T00:01:02.738171Z","caller":"traceutil/trace.go:171","msg":"trace[1147734194] linearizableReadLoop","detail":"{readStateIndex:2801; appliedIndex:2800; }","duration":"294.684035ms","start":"2026-07-10T00:01:02.443451Z","end":"2026-07-10T00:01:02.738135Z","steps":["trace[1147734194] 'read index received' (duration: 294.471109ms)","trace[1147734194] 'applied index is now lower than readState.Index' (duration: 211.666µs)"],"step_count":2} {"level":"info","ts":"2026-07-10T00:01:02.738298Z","caller":"traceutil/trace.go:171","msg":"trace[1036851534] transaction","detail":"{read_only:false; response_revision:2695; number_of_response:1; }","duration":"304.171235ms","start":"2026-07-10T00:01:02.434091Z","end":"2026-07-10T00:01:02.738262Z","steps":["trace[1036851534] 'process raft request' (duration: 303.819026ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T00:01:02.738435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.616055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:529"} {"level":"warn","ts":"2026-07-10T00:01:02.738479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T00:01:02.434074Z","time spent":"304.310108ms","remote":"127.0.0.1:55908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-10T00:01:02.738491Z","caller":"traceutil/trace.go:171","msg":"trace[123115093] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2695; }","duration":"326.712847ms","start":"2026-07-10T00:01:02.411762Z","end":"2026-07-10T00:01:02.738474Z","steps":["trace[123115093] 'agreement among raft nodes before linearized reading' (duration: 326.516472ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T00:01:02.738728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T00:01:02.411746Z","time spent":"326.971653ms","remote":"127.0.0.1:55908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":553,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-07-10T00:01:02.744569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.122228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-07-10T00:01:02.744625Z","caller":"traceutil/trace.go:171","msg":"trace[2051995983] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2696; }","duration":"246.21462ms","start":"2026-07-10T00:01:02.498398Z","end":"2026-07-10T00:01:02.744613Z","steps":["trace[2051995983] 'agreement among raft nodes before linearized reading' (duration: 246.067517ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T00:01:02.744862Z","caller":"traceutil/trace.go:171","msg":"trace[113942746] transaction","detail":"{read_only:false; response_revision:2696; number_of_response:1; }","duration":"297.877048ms","start":"2026-07-10T00:01:02.446973Z","end":"2026-07-10T00:01:02.74485Z","steps":["trace[113942746] 'process raft request' (duration: 297.375336ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T00:01:02.745033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.118899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-07-10T00:01:02.745069Z","caller":"traceutil/trace.go:171","msg":"trace[345968281] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2696; }","duration":"246.190679ms","start":"2026-07-10T00:01:02.498869Z","end":"2026-07-10T00:01:02.74506Z","steps":["trace[345968281] 'agreement among raft nodes before linearized reading' (duration: 246.105677ms)"],"step_count":1}