{"level":"warn","ts":"2026-07-17T10:57:19.676736Z","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-17T10:57:19.676829Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.111: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.111:2380","--initial-cluster=instance=https://199.19.213.111:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.111:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.111: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-17T10:57:19.676946Z","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-17T10:57:19.676959Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.111:2380"]} {"level":"info","ts":"2026-07-17T10:57:19.676978Z","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-17T10:57:19.677581Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.111:2379"]} {"level":"info","ts":"2026-07-17T10:57:19.677727Z","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.111:2380"],"listen-peer-urls":["https://199.19.213.111:2380"],"advertise-client-urls":["https://199.19.213.111:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.111:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.111: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-17T10:57:19.682241Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.119373ms"} {"level":"info","ts":"2026-07-17T10:57:19.692181Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4edbe0dc99dceaa8","cluster-id":"9f725a00b80fcc82"} {"level":"info","ts":"2026-07-17T10:57:19.692249Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4edbe0dc99dceaa8 switched to configuration voters=()"} {"level":"info","ts":"2026-07-17T10:57:19.692271Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4edbe0dc99dceaa8 became follower at term 0"} {"level":"info","ts":"2026-07-17T10:57:19.692281Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4edbe0dc99dceaa8 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-17T10:57:19.692298Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4edbe0dc99dceaa8 became follower at term 1"} {"level":"info","ts":"2026-07-17T10:57:19.692333Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4edbe0dc99dceaa8 switched to configuration voters=(5682382592936831656)"} {"level":"warn","ts":"2026-07-17T10:57:19.699892Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-17T10:57:19.701199Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-17T10:57:19.702545Z","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-17T10:57:19.705865Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4edbe0dc99dceaa8","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-17T10:57:19.706423Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4edbe0dc99dceaa8","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-17T10:57:19.706921Z","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-17T10:57:19.707Z","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-17T10:57:19.707012Z","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-17T10:57:19.708342Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4edbe0dc99dceaa8 switched to configuration voters=(5682382592936831656)"} {"level":"info","ts":"2026-07-17T10:57:19.708588Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9f725a00b80fcc82","local-member-id":"4edbe0dc99dceaa8","added-peer-id":"4edbe0dc99dceaa8","added-peer-peer-urls":["https://199.19.213.111:2380"]} {"level":"info","ts":"2026-07-17T10:57:19.715263Z","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-17T10:57:19.71545Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.111:2380"} {"level":"info","ts":"2026-07-17T10:57:19.715534Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.111:2380"} {"level":"info","ts":"2026-07-17T10:57:19.715689Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4edbe0dc99dceaa8","initial-advertise-peer-urls":["https://199.19.213.111:2380"],"listen-peer-urls":["https://199.19.213.111:2380"],"advertise-client-urls":["https://199.19.213.111:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.111:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-17T10:57:19.715747Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-17T10:57:20.693404Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4edbe0dc99dceaa8 is starting a new election at term 1"} {"level":"info","ts":"2026-07-17T10:57:20.693481Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4edbe0dc99dceaa8 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-17T10:57:20.693503Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4edbe0dc99dceaa8 received MsgPreVoteResp from 4edbe0dc99dceaa8 at term 1"} {"level":"info","ts":"2026-07-17T10:57:20.693518Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4edbe0dc99dceaa8 became candidate at term 2"} {"level":"info","ts":"2026-07-17T10:57:20.693524Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4edbe0dc99dceaa8 received MsgVoteResp from 4edbe0dc99dceaa8 at term 2"} {"level":"info","ts":"2026-07-17T10:57:20.693535Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4edbe0dc99dceaa8 became leader at term 2"} {"level":"info","ts":"2026-07-17T10:57:20.693544Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4edbe0dc99dceaa8 elected leader 4edbe0dc99dceaa8 at term 2"} {"level":"info","ts":"2026-07-17T10:57:20.694848Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-17T10:57:20.698656Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4edbe0dc99dceaa8","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.111:2379]}","request-path":"/0/members/4edbe0dc99dceaa8/attributes","cluster-id":"9f725a00b80fcc82","publish-timeout":"7s"} {"level":"info","ts":"2026-07-17T10:57:20.699003Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-17T10:57:20.699085Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-17T10:57:20.699099Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-17T10:57:20.699117Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-17T10:57:20.701678Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.111:2379"} {"level":"info","ts":"2026-07-17T10:57:20.702606Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-17T10:57:20.711661Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9f725a00b80fcc82","local-member-id":"4edbe0dc99dceaa8","cluster-version":"3.5"} {"level":"info","ts":"2026-07-17T10:57:20.712199Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-17T10:57:20.712241Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-17T10:57:24.442749Z","caller":"traceutil/trace.go:171","msg":"trace[953580843] linearizableReadLoop","detail":"{readStateIndex:200; appliedIndex:199; }","duration":"231.012093ms","start":"2026-07-17T10:57:24.211701Z","end":"2026-07-17T10:57:24.442713Z","steps":["trace[953580843] 'read index received' (duration: 196.514984ms)","trace[953580843] 'applied index is now lower than readState.Index' (duration: 34.495889ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T10:57:24.442953Z","caller":"traceutil/trace.go:171","msg":"trace[128324794] transaction","detail":"{read_only:false; response_revision:195; number_of_response:1; }","duration":"289.51506ms","start":"2026-07-17T10:57:24.153423Z","end":"2026-07-17T10:57:24.442938Z","steps":["trace[128324794] 'process raft request' (duration: 254.729464ms)","trace[128324794] 'compare' (duration: 34.387536ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T10:57:24.443391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.641009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T10:57:24.443526Z","caller":"traceutil/trace.go:171","msg":"trace[842634948] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:195; }","duration":"231.836015ms","start":"2026-07-17T10:57:24.211665Z","end":"2026-07-17T10:57:24.443501Z","steps":["trace[842634948] 'agreement among raft nodes before linearized reading' (duration: 231.579338ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T10:57:24.770446Z","caller":"traceutil/trace.go:171","msg":"trace[1790188826] transaction","detail":"{read_only:false; response_revision:196; number_of_response:1; }","duration":"324.329668ms","start":"2026-07-17T10:57:24.446073Z","end":"2026-07-17T10:57:24.770402Z","steps":["trace[1790188826] 'process raft request' (duration: 288.026511ms)","trace[1790188826] 'compare' (duration: 36.03311ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T10:57:24.770689Z","caller":"traceutil/trace.go:171","msg":"trace[636574491] linearizableReadLoop","detail":"{readStateIndex:201; appliedIndex:200; }","duration":"324.384469ms","start":"2026-07-17T10:57:24.446265Z","end":"2026-07-17T10:57:24.770649Z","steps":["trace[636574491] 'read index received' (duration: 287.833246ms)","trace[636574491] 'applied index is now lower than readState.Index' (duration: 36.547963ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T10:57:24.770933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.656817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T10:57:24.771133Z","caller":"traceutil/trace.go:171","msg":"trace[2012406882] transaction","detail":"{read_only:false; response_revision:197; number_of_response:1; }","duration":"322.959402ms","start":"2026-07-17T10:57:24.448121Z","end":"2026-07-17T10:57:24.77108Z","steps":["trace[2012406882] 'process raft request' (duration: 322.198593ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T10:57:24.771156Z","caller":"traceutil/trace.go:171","msg":"trace[1948798334] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:0; response_revision:197; }","duration":"324.954245ms","start":"2026-07-17T10:57:24.446178Z","end":"2026-07-17T10:57:24.771133Z","steps":["trace[1948798334] 'agreement among raft nodes before linearized reading' (duration: 324.674037ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T10:57:24.771263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T10:57:24.448104Z","time spent":"323.101795ms","remote":"127.0.0.1:56832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1069,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-17T10:57:24.771304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T10:57:24.446089Z","time spent":"325.18822ms","remote":"127.0.0.1:57026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":28,"request content":"key:\"/registry/endpointslices/default/kubernetes\" "} {"level":"warn","ts":"2026-07-17T10:57:24.771384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.249675ms","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-07-17T10:57:24.771406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T10:57:24.44605Z","time spent":"324.484882ms","remote":"127.0.0.1:56936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3965,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-17T10:57:24.771518Z","caller":"traceutil/trace.go:171","msg":"trace[1196323488] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:197; }","duration":"125.454142ms","start":"2026-07-17T10:57:24.646043Z","end":"2026-07-17T10:57:24.771497Z","steps":["trace[1196323488] 'agreement among raft nodes before linearized reading' (duration: 125.169344ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T10:57:24.987329Z","caller":"traceutil/trace.go:171","msg":"trace[1159376034] transaction","detail":"{read_only:false; response_revision:198; number_of_response:1; }","duration":"214.434143ms","start":"2026-07-17T10:57:24.772862Z","end":"2026-07-17T10:57:24.987296Z","steps":["trace[1159376034] 'process raft request' (duration: 153.273267ms)","trace[1159376034] 'compare' (duration: 60.831926ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T10:57:24.987458Z","caller":"traceutil/trace.go:171","msg":"trace[433372837] transaction","detail":"{read_only:false; response_revision:199; number_of_response:1; }","duration":"208.099557ms","start":"2026-07-17T10:57:24.779343Z","end":"2026-07-17T10:57:24.987442Z","steps":["trace[433372837] 'process raft request' (duration: 207.880642ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T10:57:24.987908Z","caller":"traceutil/trace.go:171","msg":"trace[335465256] transaction","detail":"{read_only:false; response_revision:201; number_of_response:1; }","duration":"207.828669ms","start":"2026-07-17T10:57:24.780067Z","end":"2026-07-17T10:57:24.987896Z","steps":["trace[335465256] 'process raft request' (duration: 207.781598ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T10:57:24.987928Z","caller":"traceutil/trace.go:171","msg":"trace[1784353351] transaction","detail":"{read_only:false; response_revision:200; number_of_response:1; }","duration":"208.400025ms","start":"2026-07-17T10:57:24.779501Z","end":"2026-07-17T10:57:24.987901Z","steps":["trace[1784353351] 'process raft request' (duration: 207.772929ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T10:58:01.174621Z","caller":"traceutil/trace.go:171","msg":"trace[636428252] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"451.015323ms","start":"2026-07-17T10:58:00.723573Z","end":"2026-07-17T10:58:01.174588Z","steps":["trace[636428252] 'process raft request' (duration: 450.888811ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T10:58:01.174714Z","caller":"traceutil/trace.go:171","msg":"trace[135001103] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"445.174678ms","start":"2026-07-17T10:58:00.729529Z","end":"2026-07-17T10:58:01.174703Z","steps":["trace[135001103] 'process raft request' (duration: 444.965933ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T10:58:01.174661Z","caller":"traceutil/trace.go:171","msg":"trace[553952531] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"430.994265ms","start":"2026-07-17T10:58:00.743646Z","end":"2026-07-17T10:58:01.17464Z","steps":["trace[553952531] 'process raft request' (duration: 430.966805ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T10:58:01.174828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T10:58:00.729515Z","time spent":"445.233288ms","remote":"127.0.0.1:56786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-17T10:58:01.174971Z","caller":"traceutil/trace.go:171","msg":"trace[2137221733] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"439.039504ms","start":"2026-07-17T10:58:00.735906Z","end":"2026-07-17T10:58:01.174945Z","steps":["trace[2137221733] 'process raft request' (duration: 438.653837ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T10:58:01.175123Z","caller":"traceutil/trace.go:171","msg":"trace[1458015593] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"431.637237ms","start":"2026-07-17T10:58:00.743461Z","end":"2026-07-17T10:58:01.175098Z","steps":["trace[1458015593] 'process raft request' (duration: 431.125017ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T10:58:01.175208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T10:58:00.743445Z","time spent":"431.714889ms","remote":"127.0.0.1:56786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-17T10:58:01.174661Z","caller":"traceutil/trace.go:171","msg":"trace[608760502] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"438.82824ms","start":"2026-07-17T10:58:00.735806Z","end":"2026-07-17T10:58:01.174634Z","steps":["trace[608760502] 'process raft request' (duration: 438.715988ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T10:58:01.175322Z","caller":"traceutil/trace.go:171","msg":"trace[1931063695] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"451.715477ms","start":"2026-07-17T10:58:00.723512Z","end":"2026-07-17T10:58:01.175228Z","steps":["trace[1931063695] 'process raft request' (duration: 432.527378ms)","trace[1931063695] 'compare' (duration: 18.306622ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T10:58:01.175402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T10:58:00.723494Z","time spent":"451.872541ms","remote":"127.0.0.1:56786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-17T10:58:01.17538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T10:58:00.723567Z","time spent":"451.151446ms","remote":"127.0.0.1:56786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-17T10:58:01.175631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T10:58:00.735898Z","time spent":"439.697778ms","remote":"127.0.0.1:56786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-17T10:58:01.174974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T10:58:00.743618Z","time spent":"431.231709ms","remote":"127.0.0.1:56786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-17T10:58:01.175775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T10:58:00.735783Z","time spent":"439.968603ms","remote":"127.0.0.1:56786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-17T10:58:01.247239Z","caller":"traceutil/trace.go:171","msg":"trace[1769688977] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"491.118902ms","start":"2026-07-17T10:58:00.756089Z","end":"2026-07-17T10:58:01.247208Z","steps":["trace[1769688977] 'process raft request' (duration: 490.911128ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T10:58:01.247557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T10:58:00.75607Z","time spent":"491.270885ms","remote":"127.0.0.1:57290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-17T10:58:01.24761Z","caller":"traceutil/trace.go:171","msg":"trace[1962190928] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"490.49926ms","start":"2026-07-17T10:58:00.757075Z","end":"2026-07-17T10:58:01.247574Z","steps":["trace[1962190928] 'process raft request' (duration: 490.053851ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T10:58:01.247651Z","caller":"traceutil/trace.go:171","msg":"trace[1717402916] transaction","detail":"{read_only:false; number_of_response:1; response_revision:544; }","duration":"490.474239ms","start":"2026-07-17T10:58:00.757145Z","end":"2026-07-17T10:58:01.247619Z","steps":["trace[1717402916] 'process raft request' (duration: 490.043631ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T10:58:01.247785Z","caller":"traceutil/trace.go:171","msg":"trace[2029430235] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"487.048681ms","start":"2026-07-17T10:58:00.760711Z","end":"2026-07-17T10:58:01.24776Z","steps":["trace[2029430235] 'process raft request' (duration: 486.526451ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T10:58:01.247939Z","caller":"traceutil/trace.go:171","msg":"trace[1515492624] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"485.326937ms","start":"2026-07-17T10:58:00.762599Z","end":"2026-07-17T10:58:01.247926Z","steps":["trace[1515492624] 'process raft request' (duration: 484.702405ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T10:58:01.247988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T10:58:00.757068Z","time spent":"490.647413ms","remote":"127.0.0.1:56786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7317,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T10:58:01.249204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T10:58:00.762592Z","time spent":"485.383488ms","remote":"127.0.0.1:56786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-17T10:58:01.248069Z","caller":"traceutil/trace.go:171","msg":"trace[1063928071] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"476.511021ms","start":"2026-07-17T10:58:00.771546Z","end":"2026-07-17T10:58:01.248057Z","steps":["trace[1063928071] 'process raft request' (duration: 476.263187ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T10:58:01.249584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T10:58:00.771527Z","time spent":"478.007821ms","remote":"127.0.0.1:56786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-17T10:58:01.249636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T10:58:00.760704Z","time spent":"487.184373ms","remote":"127.0.0.1:56786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-17T10:58:01.249143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T10:58:00.757139Z","time spent":"490.603101ms","remote":"127.0.0.1:56786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":7366,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T10:58:01.252993Z","caller":"traceutil/trace.go:171","msg":"trace[50167595] linearizableReadLoop","detail":"{readStateIndex:565; appliedIndex:552; }","duration":"451.581855ms","start":"2026-07-17T10:58:00.801342Z","end":"2026-07-17T10:58:01.252924Z","steps":["trace[50167595] 'read index received' (duration: 354.71996ms)","trace[50167595] 'applied index is now lower than readState.Index' (duration: 96.860105ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T10:58:01.253121Z","caller":"traceutil/trace.go:171","msg":"trace[750107517] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"329.644137ms","start":"2026-07-17T10:58:00.923451Z","end":"2026-07-17T10:58:01.253095Z","steps":["trace[750107517] 'process raft request' (duration: 325.636178ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T10:58:01.253247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T10:58:00.92342Z","time spent":"329.729169ms","remote":"127.0.0.1:56786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-17T10:58:01.253387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.034434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-17T10:58:01.253436Z","caller":"traceutil/trace.go:171","msg":"trace[645749415] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:548; }","duration":"452.122915ms","start":"2026-07-17T10:58:00.8013Z","end":"2026-07-17T10:58:01.253423Z","steps":["trace[645749415] 'agreement among raft nodes before linearized reading' (duration: 451.974272ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T10:58:01.253471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T10:58:00.801279Z","time spent":"452.184347ms","remote":"127.0.0.1:57022","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-17T10:58:01.354009Z","caller":"traceutil/trace.go:171","msg":"trace[1054017891] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"171.639544ms","start":"2026-07-17T10:58:01.182324Z","end":"2026-07-17T10:58:01.353964Z","steps":["trace[1054017891] 'process raft request' (duration: 157.956863ms)","trace[1054017891] 'compare' (duration: 13.455036ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T10:58:01.354166Z","caller":"traceutil/trace.go:171","msg":"trace[1192421483] linearizableReadLoop","detail":"{readStateIndex:574; appliedIndex:566; }","duration":"101.106889ms","start":"2026-07-17T10:58:01.253038Z","end":"2026-07-17T10:58:01.354145Z","steps":["trace[1192421483] 'read index received' (duration: 87.463299ms)","trace[1192421483] 'applied index is now lower than readState.Index' (duration: 13.64277ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T10:58:01.354301Z","caller":"traceutil/trace.go:171","msg":"trace[1713047476] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"171.162754ms","start":"2026-07-17T10:58:01.18313Z","end":"2026-07-17T10:58:01.354293Z","steps":["trace[1713047476] 'process raft request' (duration: 170.740296ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T10:58:01.354361Z","caller":"traceutil/trace.go:171","msg":"trace[434835453] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"162.594175ms","start":"2026-07-17T10:58:01.191741Z","end":"2026-07-17T10:58:01.354335Z","steps":["trace[434835453] 'process raft request' (duration: 162.307709ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T10:58:01.354576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.936163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T10:58:01.354605Z","caller":"traceutil/trace.go:171","msg":"trace[640902468] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:556; }","duration":"243.008755ms","start":"2026-07-17T10:58:01.11159Z","end":"2026-07-17T10:58:01.354599Z","steps":["trace[640902468] 'agreement among raft nodes before linearized reading' (duration: 242.934312ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T10:58:01.35464Z","caller":"traceutil/trace.go:171","msg":"trace[2122029198] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"166.228727ms","start":"2026-07-17T10:58:01.188392Z","end":"2026-07-17T10:58:01.354621Z","steps":["trace[2122029198] 'process raft request' (duration: 165.621614ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T10:58:01.354683Z","caller":"traceutil/trace.go:171","msg":"trace[199914224] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"169.375929ms","start":"2026-07-17T10:58:01.185237Z","end":"2026-07-17T10:58:01.354613Z","steps":["trace[199914224] 'process raft request' (duration: 168.718905ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T10:58:01.354884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.065709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-17T10:58:01.354966Z","caller":"traceutil/trace.go:171","msg":"trace[794116257] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"160.258719ms","start":"2026-07-17T10:58:01.194686Z","end":"2026-07-17T10:58:01.354944Z","steps":["trace[794116257] 'process raft request' (duration: 159.388892ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T10:58:01.354982Z","caller":"traceutil/trace.go:171","msg":"trace[2142539714] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:556; }","duration":"191.263632ms","start":"2026-07-17T10:58:01.163699Z","end":"2026-07-17T10:58:01.354962Z","steps":["trace[2142539714] 'agreement among raft nodes before linearized reading' (duration: 190.792642ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T10:58:01.355137Z","caller":"traceutil/trace.go:171","msg":"trace[1711160505] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"158.836291ms","start":"2026-07-17T10:58:01.196288Z","end":"2026-07-17T10:58:01.355124Z","steps":["trace[1711160505] 'process raft request' (duration: 157.82315ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T10:58:01.355029Z","caller":"traceutil/trace.go:171","msg":"trace[940777844] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"171.746927ms","start":"2026-07-17T10:58:01.183269Z","end":"2026-07-17T10:58:01.355016Z","steps":["trace[940777844] 'process raft request' (duration: 170.634594ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T10:58:01.35994Z","caller":"traceutil/trace.go:171","msg":"trace[847167884] transaction","detail":"{read_only:false; number_of_response:0; response_revision:556; }","duration":"106.315232ms","start":"2026-07-17T10:58:01.253615Z","end":"2026-07-17T10:58:01.359931Z","steps":["trace[847167884] 'process raft request' (duration: 105.984936ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T10:58:01.360319Z","caller":"traceutil/trace.go:171","msg":"trace[2115321113] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"103.488395ms","start":"2026-07-17T10:58:01.256809Z","end":"2026-07-17T10:58:01.360298Z","steps":["trace[2115321113] 'process raft request' (duration: 102.838902ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T10:58:02.329704Z","caller":"traceutil/trace.go:171","msg":"trace[521187187] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"119.706402ms","start":"2026-07-17T10:58:02.207817Z","end":"2026-07-17T10:58:02.327524Z","steps":["trace[521187187] 'process raft request' (duration: 58.789805ms)","trace[521187187] 'compare' (duration: 56.54596ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T10:58:02.330645Z","caller":"traceutil/trace.go:171","msg":"trace[540471853] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"104.948612ms","start":"2026-07-17T10:58:02.225653Z","end":"2026-07-17T10:58:02.330602Z","steps":["trace[540471853] 'process raft request' (duration: 103.7892ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T10:58:07.759564Z","caller":"traceutil/trace.go:171","msg":"trace[1961683091] linearizableReadLoop","detail":"{readStateIndex:668; appliedIndex:667; }","duration":"120.422594ms","start":"2026-07-17T10:58:07.639106Z","end":"2026-07-17T10:58:07.759529Z","steps":["trace[1961683091] 'read index received' (duration: 119.843024ms)","trace[1961683091] 'applied index is now lower than readState.Index' (duration: 578.13µs)"],"step_count":2} {"level":"info","ts":"2026-07-17T10:58:07.75966Z","caller":"traceutil/trace.go:171","msg":"trace[1227341405] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"134.661115ms","start":"2026-07-17T10:58:07.624947Z","end":"2026-07-17T10:58:07.759609Z","steps":["trace[1227341405] 'process raft request' (duration: 133.805869ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T10:58:07.759817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.70926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-5l68n\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-07-17T10:58:07.759872Z","caller":"traceutil/trace.go:171","msg":"trace[1411110489] range","detail":"{range_begin:/registry/pods/kube-system/cilium-5l68n; range_end:; response_count:1; response_revision:646; }","duration":"120.826812ms","start":"2026-07-17T10:58:07.639028Z","end":"2026-07-17T10:58:07.759855Z","steps":["trace[1411110489] 'agreement among raft nodes before linearized reading' (duration: 120.633468ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T10:58:08.188223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.502773ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-17T10:58:08.188524Z","caller":"traceutil/trace.go:171","msg":"trace[561875879] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"370.035829ms","start":"2026-07-17T10:58:07.818453Z","end":"2026-07-17T10:58:08.188489Z","steps":["trace[561875879] 'process raft request' (duration: 202.030337ms)","trace[561875879] 'compare' (duration: 167.31706ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T10:58:08.188661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T10:58:07.818424Z","time spent":"370.177983ms","remote":"127.0.0.1:57272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-17T10:58:24.248655Z","caller":"traceutil/trace.go:171","msg":"trace[1740205890] transaction","detail":"{read_only:false; response_revision:812; number_of_response:1; }","duration":"101.151285ms","start":"2026-07-17T10:58:24.147481Z","end":"2026-07-17T10:58:24.248632Z","steps":["trace[1740205890] 'process raft request' (duration: 101.006722ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T10:58:59.969814Z","caller":"traceutil/trace.go:171","msg":"trace[1672878379] linearizableReadLoop","detail":"{readStateIndex:1274; appliedIndex:1272; }","duration":"246.76894ms","start":"2026-07-17T10:58:59.723021Z","end":"2026-07-17T10:58:59.969789Z","steps":["trace[1672878379] 'read index received' (duration: 39.201588ms)","trace[1672878379] 'applied index is now lower than readState.Index' (duration: 207.566302ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T10:58:59.970111Z","caller":"traceutil/trace.go:171","msg":"trace[1361078376] transaction","detail":"{read_only:false; response_revision:1236; number_of_response:1; }","duration":"253.43402ms","start":"2026-07-17T10:58:59.716631Z","end":"2026-07-17T10:58:59.970065Z","steps":["trace[1361078376] 'process raft request' (duration: 253.021384ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T10:58:59.970293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.742266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-07-17T10:58:59.970284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.233918ms","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-17T10:58:59.970361Z","caller":"traceutil/trace.go:171","msg":"trace[260442265] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1236; }","duration":"207.869257ms","start":"2026-07-17T10:58:59.762474Z","end":"2026-07-17T10:58:59.970344Z","steps":["trace[260442265] 'agreement among raft nodes before linearized reading' (duration: 207.576592ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T10:58:59.970417Z","caller":"traceutil/trace.go:171","msg":"trace[1851561941] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1236; }","duration":"247.388291ms","start":"2026-07-17T10:58:59.722983Z","end":"2026-07-17T10:58:59.970371Z","steps":["trace[1851561941] 'agreement among raft nodes before linearized reading' (duration: 246.972264ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T10:59:24.207014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.553629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-17T10:59:24.207103Z","caller":"traceutil/trace.go:171","msg":"trace[1978119107] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1495; }","duration":"114.686331ms","start":"2026-07-17T10:59:24.092401Z","end":"2026-07-17T10:59:24.207088Z","steps":["trace[1978119107] 'range keys from in-memory index tree' (duration: 114.335636ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T10:59:24.20738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.898001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-17T10:59:24.207482Z","caller":"traceutil/trace.go:171","msg":"trace[1844313971] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1495; }","duration":"107.036634ms","start":"2026-07-17T10:59:24.100421Z","end":"2026-07-17T10:59:24.207457Z","steps":["trace[1844313971] 'range keys from in-memory index tree' (duration: 106.702488ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T10:59:24.207597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.168676ms","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-17T10:59:24.2077Z","caller":"traceutil/trace.go:171","msg":"trace[928590739] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1495; }","duration":"107.301918ms","start":"2026-07-17T10:59:24.10038Z","end":"2026-07-17T10:59:24.207682Z","steps":["trace[928590739] 'range keys from in-memory index tree' (duration: 107.023484ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T10:59:47.337861Z","caller":"traceutil/trace.go:171","msg":"trace[1427852210] linearizableReadLoop","detail":"{readStateIndex:1944; appliedIndex:1943; }","duration":"208.067087ms","start":"2026-07-17T10:59:47.129743Z","end":"2026-07-17T10:59:47.33781Z","steps":["trace[1427852210] 'read index received' (duration: 200.674469ms)","trace[1427852210] 'applied index is now lower than readState.Index' (duration: 7.391518ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T10:59:47.338024Z","caller":"traceutil/trace.go:171","msg":"trace[1868013547] transaction","detail":"{read_only:false; response_revision:1887; number_of_response:1; }","duration":"211.376981ms","start":"2026-07-17T10:59:47.126627Z","end":"2026-07-17T10:59:47.338004Z","steps":["trace[1868013547] 'process raft request' (duration: 203.810821ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T10:59:47.338158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.395031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-07-17T10:59:47.338339Z","caller":"traceutil/trace.go:171","msg":"trace[1882229847] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:1887; }","duration":"208.533554ms","start":"2026-07-17T10:59:47.12974Z","end":"2026-07-17T10:59:47.338274Z","steps":["trace[1882229847] 'agreement among raft nodes before linearized reading' (duration: 208.224889ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T10:59:47.411432Z","caller":"traceutil/trace.go:171","msg":"trace[755103908] transaction","detail":"{read_only:false; response_revision:1888; number_of_response:1; }","duration":"277.846426ms","start":"2026-07-17T10:59:47.133537Z","end":"2026-07-17T10:59:47.411384Z","steps":["trace[755103908] 'process raft request' (duration: 277.720645ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T10:59:47.561328Z","caller":"traceutil/trace.go:171","msg":"trace[1883798721] transaction","detail":"{read_only:false; response_revision:1890; number_of_response:1; }","duration":"144.314698ms","start":"2026-07-17T10:59:47.416978Z","end":"2026-07-17T10:59:47.561293Z","steps":["trace[1883798721] 'process raft request' (duration: 45.210061ms)","trace[1883798721] 'compare' (duration: 98.53868ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T10:59:47.56158Z","caller":"traceutil/trace.go:171","msg":"trace[1490230043] transaction","detail":"{read_only:false; response_revision:1893; number_of_response:1; }","duration":"143.745852ms","start":"2026-07-17T10:59:47.417815Z","end":"2026-07-17T10:59:47.561561Z","steps":["trace[1490230043] 'process raft request' (duration: 143.677231ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T10:59:47.561389Z","caller":"traceutil/trace.go:171","msg":"trace[2055405807] transaction","detail":"{read_only:false; response_revision:1891; number_of_response:1; }","duration":"144.374809ms","start":"2026-07-17T10:59:47.416989Z","end":"2026-07-17T10:59:47.561364Z","steps":["trace[2055405807] 'process raft request' (duration: 143.968994ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T10:59:47.561655Z","caller":"traceutil/trace.go:171","msg":"trace[1808523381] transaction","detail":"{read_only:false; response_revision:1892; number_of_response:1; }","duration":"144.564002ms","start":"2026-07-17T10:59:47.417077Z","end":"2026-07-17T10:59:47.561641Z","steps":["trace[1808523381] 'process raft request' (duration: 144.266838ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:00:19.775508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.896714ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-17T11:00:19.776745Z","caller":"traceutil/trace.go:171","msg":"trace[1284965449] transaction","detail":"{read_only:false; response_revision:2158; number_of_response:1; }","duration":"311.524648ms","start":"2026-07-17T11:00:19.465192Z","end":"2026-07-17T11:00:19.776717Z","steps":["trace[1284965449] 'process raft request' (duration: 310.469775ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:00:19.777031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:00:19.465159Z","time spent":"311.654779ms","remote":"127.0.0.1:57022","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T11:00:19.793784Z","caller":"traceutil/trace.go:171","msg":"trace[3040986] linearizableReadLoop","detail":"{readStateIndex:2229; appliedIndex:2226; }","duration":"145.352196ms","start":"2026-07-17T11:00:19.648415Z","end":"2026-07-17T11:00:19.793768Z","steps":["trace[3040986] 'read index received' (duration: 43.09µs)","trace[3040986] 'applied index is now lower than readState.Index' (duration: 145.308176ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T11:00:19.793894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.471039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-17T11:00:19.793925Z","caller":"traceutil/trace.go:171","msg":"trace[791032719] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:2159; }","duration":"145.563209ms","start":"2026-07-17T11:00:19.648352Z","end":"2026-07-17T11:00:19.793915Z","steps":["trace[791032719] 'agreement among raft nodes before linearized reading' (duration: 145.479688ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:00:19.794059Z","caller":"traceutil/trace.go:171","msg":"trace[1767188607] transaction","detail":"{read_only:false; response_revision:2159; number_of_response:1; }","duration":"227.290698ms","start":"2026-07-17T11:00:19.566752Z","end":"2026-07-17T11:00:19.794043Z","steps":["trace[1767188607] 'process raft request' (duration: 209.940898ms)","trace[1767188607] 'compare' (duration: 16.924345ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T11:01:20.528268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.487972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5223"} {"level":"info","ts":"2026-07-17T11:01:20.528335Z","caller":"traceutil/trace.go:171","msg":"trace[1609237033] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2676; }","duration":"177.594017ms","start":"2026-07-17T11:01:20.350728Z","end":"2026-07-17T11:01:20.528322Z","steps":["trace[1609237033] 'range keys from in-memory index tree' (duration: 177.354986ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:01:53.170098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.091887ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-17T11:01:53.170224Z","caller":"traceutil/trace.go:171","msg":"trace[1223829835] transaction","detail":"{read_only:false; response_revision:2902; number_of_response:1; }","duration":"154.135992ms","start":"2026-07-17T11:01:53.016071Z","end":"2026-07-17T11:01:53.170207Z","steps":["trace[1223829835] 'process raft request' (duration: 23.842197ms)","trace[1223829835] 'compare' (duration: 129.974853ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T11:01:53.195376Z","caller":"traceutil/trace.go:171","msg":"trace[942470825] transaction","detail":"{read_only:false; response_revision:2903; number_of_response:1; }","duration":"178.280509ms","start":"2026-07-17T11:01:53.017062Z","end":"2026-07-17T11:01:53.195343Z","steps":["trace[942470825] 'process raft request' (duration: 178.021859ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:04:19.223474Z","caller":"traceutil/trace.go:171","msg":"trace[1735556594] transaction","detail":"{read_only:false; response_revision:4632; number_of_response:1; }","duration":"153.893994ms","start":"2026-07-17T11:04:19.069562Z","end":"2026-07-17T11:04:19.223456Z","steps":["trace[1735556594] 'process raft request' (duration: 153.779741ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:04:19.384223Z","caller":"traceutil/trace.go:171","msg":"trace[1788438294] linearizableReadLoop","detail":"{readStateIndex:4834; appliedIndex:4833; }","duration":"146.059935ms","start":"2026-07-17T11:04:19.238132Z","end":"2026-07-17T11:04:19.384192Z","steps":["trace[1788438294] 'read index received' (duration: 117.451287ms)","trace[1788438294] 'applied index is now lower than readState.Index' (duration: 28.606338ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T11:04:19.384548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.358213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-780668a4-5770-4822-bae4-eed340b40ca7\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-07-17T11:04:19.384612Z","caller":"traceutil/trace.go:171","msg":"trace[1391673536] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-780668a4-5770-4822-bae4-eed340b40ca7; range_end:; response_count:1; response_revision:4632; }","duration":"146.519977ms","start":"2026-07-17T11:04:19.238076Z","end":"2026-07-17T11:04:19.384596Z","steps":["trace[1391673536] 'agreement among raft nodes before linearized reading' (duration: 146.25941ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:04:27.436177Z","caller":"traceutil/trace.go:171","msg":"trace[181029932] transaction","detail":"{read_only:false; response_revision:4730; number_of_response:1; }","duration":"922.677703ms","start":"2026-07-17T11:04:26.513476Z","end":"2026-07-17T11:04:27.436153Z","steps":["trace[181029932] 'process raft request' (duration: 922.525049ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:04:27.436337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:04:26.513448Z","time spent":"922.817286ms","remote":"127.0.0.1:57022","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T11:04:27.45908Z","caller":"traceutil/trace.go:171","msg":"trace[1697915198] linearizableReadLoop","detail":"{readStateIndex:4936; appliedIndex:4934; }","duration":"434.062349ms","start":"2026-07-17T11:04:27.024961Z","end":"2026-07-17T11:04:27.459023Z","steps":["trace[1697915198] 'read index received' (duration: 411.029225ms)","trace[1697915198] 'applied index is now lower than readState.Index' (duration: 23.032044ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T11:04:27.459158Z","caller":"traceutil/trace.go:171","msg":"trace[758766828] transaction","detail":"{read_only:false; response_revision:4731; number_of_response:1; }","duration":"843.542338ms","start":"2026-07-17T11:04:26.61558Z","end":"2026-07-17T11:04:27.459122Z","steps":["trace[758766828] 'process raft request' (duration: 843.314353ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:04:27.459278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.688297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-17T11:04:27.459294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:04:26.61556Z","time spent":"843.661092ms","remote":"127.0.0.1:57022","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T11:04:27.459321Z","caller":"traceutil/trace.go:171","msg":"trace[597706907] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4731; }","duration":"349.773139ms","start":"2026-07-17T11:04:27.109535Z","end":"2026-07-17T11:04:27.459308Z","steps":["trace[597706907] 'agreement among raft nodes before linearized reading' (duration: 349.690177ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:04:27.459378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:04:27.109518Z","time spent":"349.851901ms","remote":"127.0.0.1:40462","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-17T11:04:27.459412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.090111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:660"} {"level":"info","ts":"2026-07-17T11:04:27.459511Z","caller":"traceutil/trace.go:171","msg":"trace[368915477] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:4731; }","duration":"119.212355ms","start":"2026-07-17T11:04:27.340272Z","end":"2026-07-17T11:04:27.459485Z","steps":["trace[368915477] 'agreement among raft nodes before linearized reading' (duration: 118.99785ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:04:27.459641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.660552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1990"} {"level":"info","ts":"2026-07-17T11:04:27.459695Z","caller":"traceutil/trace.go:171","msg":"trace[1503149607] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:4731; }","duration":"434.781825ms","start":"2026-07-17T11:04:27.024898Z","end":"2026-07-17T11:04:27.45968Z","steps":["trace[1503149607] 'agreement among raft nodes before linearized reading' (duration: 434.293694ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:04:27.459739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T11:04:27.024875Z","time spent":"434.851857ms","remote":"127.0.0.1:56940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":2013,"request content":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" "} {"level":"info","ts":"2026-07-17T11:04:27.571112Z","caller":"traceutil/trace.go:171","msg":"trace[396494693] transaction","detail":"{read_only:false; response_revision:4733; number_of_response:1; }","duration":"101.628689ms","start":"2026-07-17T11:04:27.46946Z","end":"2026-07-17T11:04:27.571089Z","steps":["trace[396494693] 'process raft request' (duration: 101.339632ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:04:27.571339Z","caller":"traceutil/trace.go:171","msg":"trace[975167690] transaction","detail":"{read_only:false; response_revision:4734; number_of_response:1; }","duration":"101.629549ms","start":"2026-07-17T11:04:27.469682Z","end":"2026-07-17T11:04:27.571311Z","steps":["trace[975167690] 'process raft request' (duration: 101.316072ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:04:27.571607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.315406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/monitoring/kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:1462"} {"level":"info","ts":"2026-07-17T11:04:27.571689Z","caller":"traceutil/trace.go:171","msg":"trace[375216012] range","detail":"{range_begin:/registry/ingress/monitoring/kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4734; }","duration":"105.561992ms","start":"2026-07-17T11:04:27.466109Z","end":"2026-07-17T11:04:27.571671Z","steps":["trace[375216012] 'agreement among raft nodes before linearized reading' (duration: 105.210884ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T11:04:27.597611Z","caller":"traceutil/trace.go:171","msg":"trace[2059109945] transaction","detail":"{read_only:false; response_revision:4735; number_of_response:1; }","duration":"108.135163ms","start":"2026-07-17T11:04:27.489455Z","end":"2026-07-17T11:04:27.59759Z","steps":["trace[2059109945] 'process raft request' (duration: 107.909258ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T11:04:37.731875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.085947ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-17T11:04:37.732253Z","caller":"traceutil/trace.go:171","msg":"trace[327346655] transaction","detail":"{read_only:false; response_revision:4867; number_of_response:1; }","duration":"149.353917ms","start":"2026-07-17T11:04:37.582857Z","end":"2026-07-17T11:04:37.732211Z","steps":["trace[327346655] 'process raft request' (duration: 36.8429ms)","trace[327346655] 'compare' (duration: 111.913263ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T11:07:20.729721Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3165} {"level":"info","ts":"2026-07-17T11:07:20.822806Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3165,"took":"91.518742ms","hash":392676821,"current-db-size-bytes":58806272,"current-db-size":"59 MB","current-db-size-in-use-bytes":31051776,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-07-17T11:07:20.822918Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":392676821,"revision":3165,"compact-revision":-1}