{"level":"warn","ts":"2026-05-29T11:28:00.924001Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-29T11:28:00.924099Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.9: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.9:2380","--initial-cluster=instance=https://199.19.213.9:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.9:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.9: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-05-29T11:28:00.924173Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-29T11:28:00.924186Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.9:2380"]} {"level":"info","ts":"2026-05-29T11:28:00.924207Z","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-05-29T11:28:00.925287Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.9:2379"]} {"level":"info","ts":"2026-05-29T11:28:00.925387Z","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.9:2380"],"listen-peer-urls":["https://199.19.213.9:2380"],"advertise-client-urls":["https://199.19.213.9:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.9:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.9: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-05-29T11:28:00.964606Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"38.864663ms"} {"level":"info","ts":"2026-05-29T11:28:01.10606Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3a0c9d65f167b31b","cluster-id":"86e523b598166645"} {"level":"info","ts":"2026-05-29T11:28:01.106158Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3a0c9d65f167b31b switched to configuration voters=()"} {"level":"info","ts":"2026-05-29T11:28:01.106179Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3a0c9d65f167b31b became follower at term 0"} {"level":"info","ts":"2026-05-29T11:28:01.10619Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3a0c9d65f167b31b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-29T11:28:01.106198Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3a0c9d65f167b31b became follower at term 1"} {"level":"info","ts":"2026-05-29T11:28:01.106236Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3a0c9d65f167b31b switched to configuration voters=(4182891215087711003)"} {"level":"warn","ts":"2026-05-29T11:28:01.110508Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-29T11:28:01.112183Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-29T11:28:01.113862Z","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-05-29T11:28:01.121466Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3a0c9d65f167b31b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-29T11:28:01.122015Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3a0c9d65f167b31b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-29T11:28:01.122184Z","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-05-29T11:28:01.122246Z","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-05-29T11:28:01.122259Z","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-05-29T11:28:01.130417Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3a0c9d65f167b31b switched to configuration voters=(4182891215087711003)"} {"level":"info","ts":"2026-05-29T11:28:01.130543Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"86e523b598166645","local-member-id":"3a0c9d65f167b31b","added-peer-id":"3a0c9d65f167b31b","added-peer-peer-urls":["https://199.19.213.9:2380"]} {"level":"info","ts":"2026-05-29T11:28:01.130899Z","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-05-29T11:28:01.131649Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3a0c9d65f167b31b","initial-advertise-peer-urls":["https://199.19.213.9:2380"],"listen-peer-urls":["https://199.19.213.9:2380"],"advertise-client-urls":["https://199.19.213.9:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.9:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-29T11:28:01.131623Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.9:2380"} {"level":"info","ts":"2026-05-29T11:28:01.131843Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-29T11:28:01.131916Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.9:2380"} {"level":"info","ts":"2026-05-29T11:28:01.310003Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3a0c9d65f167b31b is starting a new election at term 1"} {"level":"info","ts":"2026-05-29T11:28:01.310073Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3a0c9d65f167b31b became pre-candidate at term 1"} {"level":"info","ts":"2026-05-29T11:28:01.310115Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3a0c9d65f167b31b received MsgPreVoteResp from 3a0c9d65f167b31b at term 1"} {"level":"info","ts":"2026-05-29T11:28:01.310154Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3a0c9d65f167b31b became candidate at term 2"} {"level":"info","ts":"2026-05-29T11:28:01.31017Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3a0c9d65f167b31b received MsgVoteResp from 3a0c9d65f167b31b at term 2"} {"level":"info","ts":"2026-05-29T11:28:01.31019Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3a0c9d65f167b31b became leader at term 2"} {"level":"info","ts":"2026-05-29T11:28:01.310214Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3a0c9d65f167b31b elected leader 3a0c9d65f167b31b at term 2"} {"level":"info","ts":"2026-05-29T11:28:01.31814Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3a0c9d65f167b31b","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.9:2379]}","request-path":"/0/members/3a0c9d65f167b31b/attributes","cluster-id":"86e523b598166645","publish-timeout":"7s"} {"level":"info","ts":"2026-05-29T11:28:01.318174Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-29T11:28:01.318574Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-29T11:28:01.318763Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-29T11:28:01.319026Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-29T11:28:01.319116Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-29T11:28:01.32115Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-29T11:28:01.321508Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.9:2379"} {"level":"info","ts":"2026-05-29T11:28:01.321717Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"86e523b598166645","local-member-id":"3a0c9d65f167b31b","cluster-version":"3.5"} {"level":"info","ts":"2026-05-29T11:28:01.321808Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-29T11:28:01.321951Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-29T11:28:06.454929Z","caller":"traceutil/trace.go:171","msg":"trace[1509937017] transaction","detail":"{read_only:false; response_revision:232; number_of_response:1; }","duration":"195.519618ms","start":"2026-05-29T11:28:06.259387Z","end":"2026-05-29T11:28:06.454907Z","steps":["trace[1509937017] 'process raft request' (duration: 195.350945ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:28:06.712367Z","caller":"traceutil/trace.go:171","msg":"trace[149622689] transaction","detail":"{read_only:false; response_revision:233; number_of_response:1; }","duration":"437.675752ms","start":"2026-05-29T11:28:06.274653Z","end":"2026-05-29T11:28:06.712328Z","steps":["trace[149622689] 'process raft request' (duration: 423.64977ms)","trace[149622689] 'compare' (duration: 13.477721ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T11:28:06.712788Z","caller":"traceutil/trace.go:171","msg":"trace[552344424] transaction","detail":"{read_only:false; number_of_response:0; response_revision:234; }","duration":"437.312454ms","start":"2026-05-29T11:28:06.275439Z","end":"2026-05-29T11:28:06.712751Z","steps":["trace[552344424] 'process raft request' (duration: 436.830485ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:28:06.712392Z","caller":"traceutil/trace.go:171","msg":"trace[1623225190] transaction","detail":"{read_only:false; response_revision:234; number_of_response:1; }","duration":"437.62859ms","start":"2026-05-29T11:28:06.274728Z","end":"2026-05-29T11:28:06.712357Z","steps":["trace[1623225190] 'process raft request' (duration: 437.452577ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:28:06.712557Z","caller":"traceutil/trace.go:171","msg":"trace[1541871189] transaction","detail":"{read_only:false; number_of_response:0; response_revision:234; }","duration":"437.572599ms","start":"2026-05-29T11:28:06.274905Z","end":"2026-05-29T11:28:06.712477Z","steps":["trace[1541871189] 'process raft request' (duration: 437.331305ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:28:06.713307Z","caller":"traceutil/trace.go:171","msg":"trace[1042939799] transaction","detail":"{read_only:false; response_revision:235; number_of_response:1; }","duration":"437.802655ms","start":"2026-05-29T11:28:06.275492Z","end":"2026-05-29T11:28:06.713295Z","steps":["trace[1042939799] 'process raft request' (duration: 437.56745ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:28:06.713303Z","caller":"traceutil/trace.go:171","msg":"trace[1379663605] transaction","detail":"{read_only:false; response_revision:236; number_of_response:1; }","duration":"329.058466ms","start":"2026-05-29T11:28:06.384222Z","end":"2026-05-29T11:28:06.713281Z","steps":["trace[1379663605] 'process raft request' (duration: 328.946244ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:28:06.713233Z","caller":"traceutil/trace.go:171","msg":"trace[2058105418] linearizableReadLoop","detail":"{readStateIndex:242; appliedIndex:238; }","duration":"438.248613ms","start":"2026-05-29T11:28:06.274965Z","end":"2026-05-29T11:28:06.713213Z","steps":["trace[2058105418] 'read index received' (duration: 179.826185ms)","trace[2058105418] 'applied index is now lower than readState.Index' (duration: 258.421488ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T11:28:06.713718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T11:28:06.274638Z","time spent":"438.107339ms","remote":"127.0.0.1:43104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5872,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-29T11:28:06.71386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T11:28:06.27543Z","time spent":"437.417697ms","remote":"127.0.0.1:43104","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-29T11:28:06.714077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T11:28:06.27472Z","time spent":"438.194271ms","remote":"127.0.0.1:43104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5498,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-29T11:28:06.714346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T11:28:06.274897Z","time spent":"438.051669ms","remote":"127.0.0.1:43104","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-29T11:28:06.714507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T11:28:06.275486Z","time spent":"437.873726ms","remote":"127.0.0.1:43104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3953,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-29T11:28:06.71454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T11:28:06.384202Z","time spent":"329.181929ms","remote":"127.0.0.1:42986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1932,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-29T11:28:06.714456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.437936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4015"} {"level":"info","ts":"2026-05-29T11:28:06.715129Z","caller":"traceutil/trace.go:171","msg":"trace[1077079267] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:236; }","duration":"440.17205ms","start":"2026-05-29T11:28:06.27494Z","end":"2026-05-29T11:28:06.715112Z","steps":["trace[1077079267] 'agreement among raft nodes before linearized reading' (duration: 438.523868ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T11:28:06.715182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T11:28:06.274934Z","time spent":"440.234651ms","remote":"127.0.0.1:43088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4038,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-05-29T11:28:06.765837Z","caller":"traceutil/trace.go:171","msg":"trace[1003994738] transaction","detail":"{read_only:false; response_revision:237; number_of_response:1; }","duration":"306.369026ms","start":"2026-05-29T11:28:06.45943Z","end":"2026-05-29T11:28:06.765799Z","steps":["trace[1003994738] 'process raft request' (duration: 306.152772ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T11:28:06.765878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.44318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-29T11:28:06.765869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.947338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T11:28:06.766007Z","caller":"traceutil/trace.go:171","msg":"trace[1973210934] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:237; }","duration":"236.603105ms","start":"2026-05-29T11:28:06.52938Z","end":"2026-05-29T11:28:06.765983Z","steps":["trace[1973210934] 'agreement among raft nodes before linearized reading' (duration: 236.37418ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:28:06.76604Z","caller":"traceutil/trace.go:171","msg":"trace[1146583085] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:237; }","duration":"355.166242ms","start":"2026-05-29T11:28:06.410847Z","end":"2026-05-29T11:28:06.766013Z","steps":["trace[1146583085] 'agreement among raft nodes before linearized reading' (duration: 354.920747ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T11:28:06.766065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T11:28:06.459403Z","time spent":"306.58587ms","remote":"127.0.0.1:42954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":638,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-29T11:28:06.766105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T11:28:06.410822Z","time spent":"355.266705ms","remote":"127.0.0.1:43166","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-29T11:28:06.868689Z","caller":"traceutil/trace.go:171","msg":"trace[327935610] linearizableReadLoop","detail":"{readStateIndex:247; appliedIndex:246; }","duration":"102.946145ms","start":"2026-05-29T11:28:06.765715Z","end":"2026-05-29T11:28:06.868662Z","steps":["trace[327935610] 'read index received' (duration: 86.012267ms)","trace[327935610] 'applied index is now lower than readState.Index' (duration: 16.932808ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T11:28:06.86879Z","caller":"traceutil/trace.go:171","msg":"trace[1959832222] transaction","detail":"{read_only:false; response_revision:238; number_of_response:1; }","duration":"144.032661ms","start":"2026-05-29T11:28:06.724705Z","end":"2026-05-29T11:28:06.868738Z","steps":["trace[1959832222] 'process raft request' (duration: 126.939929ms)","trace[1959832222] 'compare' (duration: 16.875508ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T11:28:06.868844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.234035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4015"} {"level":"info","ts":"2026-05-29T11:28:06.869318Z","caller":"traceutil/trace.go:171","msg":"trace[1175489891] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:238; }","duration":"144.737154ms","start":"2026-05-29T11:28:06.724554Z","end":"2026-05-29T11:28:06.869291Z","steps":["trace[1175489891] 'agreement among raft nodes before linearized reading' (duration: 144.188844ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T11:28:06.868868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.974305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:2920"} {"level":"info","ts":"2026-05-29T11:28:06.869493Z","caller":"traceutil/trace.go:171","msg":"trace[1118844374] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:238; }","duration":"151.655029ms","start":"2026-05-29T11:28:06.717828Z","end":"2026-05-29T11:28:06.869483Z","steps":["trace[1118844374] 'agreement among raft nodes before linearized reading' (duration: 150.936605ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T11:28:06.868898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.145908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:3466"} {"level":"info","ts":"2026-05-29T11:28:06.869692Z","caller":"traceutil/trace.go:171","msg":"trace[1407103728] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:238; }","duration":"151.981795ms","start":"2026-05-29T11:28:06.717701Z","end":"2026-05-29T11:28:06.869682Z","steps":["trace[1407103728] 'agreement among raft nodes before linearized reading' (duration: 151.144189ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:28:40.703139Z","caller":"traceutil/trace.go:171","msg":"trace[182803730] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"221.579893ms","start":"2026-05-29T11:28:40.481337Z","end":"2026-05-29T11:28:40.702917Z","steps":["trace[182803730] 'process raft request' (duration: 221.388549ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:28:44.335114Z","caller":"traceutil/trace.go:171","msg":"trace[1159848115] linearizableReadLoop","detail":"{readStateIndex:612; appliedIndex:611; }","duration":"126.054998ms","start":"2026-05-29T11:28:44.209029Z","end":"2026-05-29T11:28:44.335084Z","steps":["trace[1159848115] 'read index received' (duration: 125.334734ms)","trace[1159848115] 'applied index is now lower than readState.Index' (duration: 719.254µs)"],"step_count":2} {"level":"info","ts":"2026-05-29T11:28:44.335171Z","caller":"traceutil/trace.go:171","msg":"trace[558001648] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"288.622342ms","start":"2026-05-29T11:28:44.046526Z","end":"2026-05-29T11:28:44.335149Z","steps":["trace[558001648] 'process raft request' (duration: 288.038821ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T11:28:44.33529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.254891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T11:28:44.335388Z","caller":"traceutil/trace.go:171","msg":"trace[739706151] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:590; }","duration":"126.383494ms","start":"2026-05-29T11:28:44.20897Z","end":"2026-05-29T11:28:44.335354Z","steps":["trace[739706151] 'agreement among raft nodes before linearized reading' (duration: 126.264842ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T11:28:44.902144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.421111ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-29T11:28:44.902242Z","caller":"traceutil/trace.go:171","msg":"trace[695118162] linearizableReadLoop","detail":"{readStateIndex:615; appliedIndex:614; }","duration":"541.647187ms","start":"2026-05-29T11:28:44.360581Z","end":"2026-05-29T11:28:44.902228Z","steps":["trace[695118162] 'read index received' (duration: 88.809128ms)","trace[695118162] 'applied index is now lower than readState.Index' (duration: 452.836919ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T11:28:44.902337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"541.726839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:420"} {"level":"info","ts":"2026-05-29T11:28:44.90236Z","caller":"traceutil/trace.go:171","msg":"trace[204498380] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:592; }","duration":"541.815121ms","start":"2026-05-29T11:28:44.360538Z","end":"2026-05-29T11:28:44.902353Z","steps":["trace[204498380] 'agreement among raft nodes before linearized reading' (duration: 541.725939ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:28:44.902273Z","caller":"traceutil/trace.go:171","msg":"trace[917256198] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"552.940606ms","start":"2026-05-29T11:28:44.349302Z","end":"2026-05-29T11:28:44.902242Z","steps":["trace[917256198] 'process raft request' (duration: 100.111747ms)","trace[917256198] 'compare' (duration: 452.091385ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T11:28:44.902385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T11:28:44.360518Z","time spent":"541.861781ms","remote":"127.0.0.1:43072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":443,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"warn","ts":"2026-05-29T11:28:44.902485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T11:28:44.349294Z","time spent":"553.116729ms","remote":"127.0.0.1:43104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17126,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T11:28:44.928783Z","caller":"traceutil/trace.go:171","msg":"trace[124365308] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"530.308208ms","start":"2026-05-29T11:28:44.398454Z","end":"2026-05-29T11:28:44.928762Z","steps":["trace[124365308] 'process raft request' (duration: 529.826839ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T11:28:44.928906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T11:28:44.398429Z","time spent":"530.42035ms","remote":"127.0.0.1:43378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-29T11:29:58.237403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.389675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-29T11:29:58.237564Z","caller":"traceutil/trace.go:171","msg":"trace[1109677101] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:1045; }","duration":"148.613389ms","start":"2026-05-29T11:29:58.088921Z","end":"2026-05-29T11:29:58.237534Z","steps":["trace[1109677101] 'count revisions from in-memory index tree' (duration: 148.283813ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:29:58.238135Z","caller":"traceutil/trace.go:171","msg":"trace[1758734555] transaction","detail":"{read_only:false; response_revision:1046; number_of_response:1; }","duration":"143.461341ms","start":"2026-05-29T11:29:58.094628Z","end":"2026-05-29T11:29:58.238089Z","steps":["trace[1758734555] 'process raft request' (duration: 100.542658ms)","trace[1758734555] 'compare' (duration: 42.469924ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T11:30:34.54663Z","caller":"traceutil/trace.go:171","msg":"trace[1914991291] transaction","detail":"{read_only:false; response_revision:1236; number_of_response:1; }","duration":"200.416053ms","start":"2026-05-29T11:30:34.346185Z","end":"2026-05-29T11:30:34.546601Z","steps":["trace[1914991291] 'process raft request' (duration: 200.241399ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T11:30:35.162045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.349275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-29T11:30:35.162149Z","caller":"traceutil/trace.go:171","msg":"trace[273946084] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1242; }","duration":"280.520099ms","start":"2026-05-29T11:30:34.881607Z","end":"2026-05-29T11:30:35.162127Z","steps":["trace[273946084] 'range keys from in-memory index tree' (duration: 280.130381ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T11:30:35.16287Z","caller":"traceutil/trace.go:171","msg":"trace[1177201827] transaction","detail":"{read_only:false; response_revision:1243; number_of_response:1; }","duration":"109.446908ms","start":"2026-05-29T11:30:35.053408Z","end":"2026-05-29T11:30:35.162855Z","steps":["trace[1177201827] 'process raft request' (duration: 95.171035ms)","trace[1177201827] 'compare' (duration: 13.182902ms)"],"step_count":2}