{"level":"warn","ts":"2026-08-13T07:46:59.069094Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-13T07:46:59.069192Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.169:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.169:2380","--initial-cluster=instance=https://199.204.45.169:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.169:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.169:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-08-13T07:46:59.069351Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-13T07:46:59.069369Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.169:2380"]} {"level":"info","ts":"2026-08-13T07:46:59.069392Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-08-13T07:46:59.070316Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"]} {"level":"info","ts":"2026-08-13T07:46:59.070537Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.169:2380"],"listen-peer-urls":["https://199.204.45.169:2380"],"advertise-client-urls":["https://199.204.45.169:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.169:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-08-13T07:46:59.077868Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.384497ms"} {"level":"info","ts":"2026-08-13T07:46:59.084521Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1c917701ce165bac","cluster-id":"bfb5247022b87cb1"} {"level":"info","ts":"2026-08-13T07:46:59.084607Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=()"} {"level":"info","ts":"2026-08-13T07:46:59.084635Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became follower at term 0"} {"level":"info","ts":"2026-08-13T07:46:59.08465Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1c917701ce165bac [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-13T07:46:59.084666Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became follower at term 1"} {"level":"info","ts":"2026-08-13T07:46:59.084704Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=(2058557354321271724)"} {"level":"warn","ts":"2026-08-13T07:46:59.092459Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-13T07:46:59.094934Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-13T07:46:59.095985Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-08-13T07:46:59.100406Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1c917701ce165bac","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-13T07:46:59.100612Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-13T07:46:59.100759Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-13T07:46:59.100845Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-13T07:46:59.101717Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1c917701ce165bac","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-13T07:46:59.102055Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=(2058557354321271724)"} {"level":"info","ts":"2026-08-13T07:46:59.102187Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"bfb5247022b87cb1","local-member-id":"1c917701ce165bac","added-peer-id":"1c917701ce165bac","added-peer-peer-urls":["https://199.204.45.169:2380"]} {"level":"info","ts":"2026-08-13T07:46:59.11009Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-08-13T07:46:59.110242Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.169:2380"} {"level":"info","ts":"2026-08-13T07:46:59.110309Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.169:2380"} {"level":"info","ts":"2026-08-13T07:46:59.110543Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1c917701ce165bac","initial-advertise-peer-urls":["https://199.204.45.169:2380"],"listen-peer-urls":["https://199.204.45.169:2380"],"advertise-client-urls":["https://199.204.45.169:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-13T07:46:59.110586Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-13T07:46:59.38584Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac is starting a new election at term 1"} {"level":"info","ts":"2026-08-13T07:46:59.385928Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became pre-candidate at term 1"} {"level":"info","ts":"2026-08-13T07:46:59.385958Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac received MsgPreVoteResp from 1c917701ce165bac at term 1"} {"level":"info","ts":"2026-08-13T07:46:59.385975Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became candidate at term 2"} {"level":"info","ts":"2026-08-13T07:46:59.385985Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac received MsgVoteResp from 1c917701ce165bac at term 2"} {"level":"info","ts":"2026-08-13T07:46:59.385999Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became leader at term 2"} {"level":"info","ts":"2026-08-13T07:46:59.386017Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1c917701ce165bac elected leader 1c917701ce165bac at term 2"} {"level":"info","ts":"2026-08-13T07:46:59.388008Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T07:46:59.389896Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1c917701ce165bac","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.169:2379]}","request-path":"/0/members/1c917701ce165bac/attributes","cluster-id":"bfb5247022b87cb1","publish-timeout":"7s"} {"level":"info","ts":"2026-08-13T07:46:59.390015Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-13T07:46:59.390096Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-13T07:46:59.390728Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-13T07:46:59.39075Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-13T07:46:59.390899Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"bfb5247022b87cb1","local-member-id":"1c917701ce165bac","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T07:46:59.390999Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T07:46:59.391023Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T07:46:59.391906Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-13T07:46:59.393634Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.169:2379"} {"level":"warn","ts":"2026-08-13T07:47:04.382642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.329188ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-13T07:47:04.382851Z","caller":"traceutil/trace.go:171","msg":"trace[333248181] transaction","detail":"{read_only:false; response_revision:276; number_of_response:1; }","duration":"234.196621ms","start":"2026-08-13T07:47:04.148608Z","end":"2026-08-13T07:47:04.382805Z","steps":["trace[333248181] 'process raft request' (duration: 234.14476ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:47:04.382867Z","caller":"traceutil/trace.go:171","msg":"trace[398634946] linearizableReadLoop","detail":"{readStateIndex:281; appliedIndex:280; }","duration":"234.225123ms","start":"2026-08-13T07:47:04.148602Z","end":"2026-08-13T07:47:04.382827Z","steps":["trace[398634946] 'read index received' (duration: 60.226163ms)","trace[398634946] 'applied index is now lower than readState.Index' (duration: 173.99347ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T07:47:04.382826Z","caller":"traceutil/trace.go:171","msg":"trace[613799085] transaction","detail":"{read_only:false; response_revision:275; number_of_response:1; }","duration":"250.755059ms","start":"2026-08-13T07:47:04.132039Z","end":"2026-08-13T07:47:04.382794Z","steps":["trace[613799085] 'process raft request' (duration: 76.76947ms)","trace[613799085] 'compare' (duration: 173.158453ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T07:47:04.383051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.438477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-08-13T07:47:04.383088Z","caller":"traceutil/trace.go:171","msg":"trace[243542753] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:276; }","duration":"234.498987ms","start":"2026-08-13T07:47:04.148577Z","end":"2026-08-13T07:47:04.383075Z","steps":["trace[243542753] 'agreement among raft nodes before linearized reading' (duration: 234.376365ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:47:04.386204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.556966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T07:47:04.386265Z","caller":"traceutil/trace.go:171","msg":"trace[504963032] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:276; }","duration":"237.630377ms","start":"2026-08-13T07:47:04.148621Z","end":"2026-08-13T07:47:04.386251Z","steps":["trace[504963032] 'agreement among raft nodes before linearized reading' (duration: 237.512185ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:47:04.386565Z","caller":"traceutil/trace.go:171","msg":"trace[339679767] transaction","detail":"{read_only:false; number_of_response:0; response_revision:276; }","duration":"140.136841ms","start":"2026-08-13T07:47:04.246417Z","end":"2026-08-13T07:47:04.386554Z","steps":["trace[339679767] 'process raft request' (duration: 139.656752ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:47:04.386715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.72889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T07:47:04.386752Z","caller":"traceutil/trace.go:171","msg":"trace[537947409] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:276; }","duration":"121.800351ms","start":"2026-08-13T07:47:04.264941Z","end":"2026-08-13T07:47:04.386741Z","steps":["trace[537947409] 'agreement among raft nodes before linearized reading' (duration: 121.74288ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:47:04.38686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.954035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-08-13T07:47:04.386975Z","caller":"traceutil/trace.go:171","msg":"trace[2082469375] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:276; }","duration":"237.067827ms","start":"2026-08-13T07:47:04.149889Z","end":"2026-08-13T07:47:04.386956Z","steps":["trace[2082469375] 'agreement among raft nodes before linearized reading' (duration: 236.918094ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:47:04.387202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.327593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T07:47:04.387256Z","caller":"traceutil/trace.go:171","msg":"trace[886697957] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:276; }","duration":"143.421284ms","start":"2026-08-13T07:47:04.243822Z","end":"2026-08-13T07:47:04.387243Z","steps":["trace[886697957] 'agreement among raft nodes before linearized reading' (duration: 143.343543ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:47:04.57333Z","caller":"traceutil/trace.go:171","msg":"trace[647574627] transaction","detail":"{read_only:false; response_revision:279; number_of_response:1; }","duration":"182.747317ms","start":"2026-08-13T07:47:04.390551Z","end":"2026-08-13T07:47:04.573299Z","steps":["trace[647574627] 'process raft request' (duration: 182.595044ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:47:04.573564Z","caller":"traceutil/trace.go:171","msg":"trace[706398307] linearizableReadLoop","detail":"{readStateIndex:292; appliedIndex:284; }","duration":"138.818226ms","start":"2026-08-13T07:47:04.434716Z","end":"2026-08-13T07:47:04.573534Z","steps":["trace[706398307] 'read index received' (duration: 138.325337ms)","trace[706398307] 'applied index is now lower than readState.Index' (duration: 491.539µs)"],"step_count":2} {"level":"warn","ts":"2026-08-13T07:47:04.573744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.456298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4017"} {"level":"info","ts":"2026-08-13T07:47:04.573776Z","caller":"traceutil/trace.go:171","msg":"trace[1857900556] transaction","detail":"{read_only:false; response_revision:280; number_of_response:1; }","duration":"183.124603ms","start":"2026-08-13T07:47:04.390632Z","end":"2026-08-13T07:47:04.573756Z","steps":["trace[1857900556] 'process raft request' (duration: 182.586983ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:47:04.573808Z","caller":"traceutil/trace.go:171","msg":"trace[349144573] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:285; }","duration":"185.553861ms","start":"2026-08-13T07:47:04.388237Z","end":"2026-08-13T07:47:04.573791Z","steps":["trace[349144573] 'agreement among raft nodes before linearized reading' (duration: 185.413178ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:47:04.574015Z","caller":"traceutil/trace.go:171","msg":"trace[529936962] transaction","detail":"{read_only:false; response_revision:281; number_of_response:1; }","duration":"183.247477ms","start":"2026-08-13T07:47:04.390752Z","end":"2026-08-13T07:47:04.573999Z","steps":["trace[529936962] 'process raft request' (duration: 182.546343ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:47:04.574012Z","caller":"traceutil/trace.go:171","msg":"trace[527871069] transaction","detail":"{read_only:false; response_revision:284; number_of_response:1; }","duration":"182.730688ms","start":"2026-08-13T07:47:04.391266Z","end":"2026-08-13T07:47:04.573997Z","steps":["trace[527871069] 'process raft request' (duration: 182.172926ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:47:04.574153Z","caller":"traceutil/trace.go:171","msg":"trace[2075007363] transaction","detail":"{read_only:false; response_revision:282; number_of_response:1; }","duration":"183.393739ms","start":"2026-08-13T07:47:04.390746Z","end":"2026-08-13T07:47:04.57414Z","steps":["trace[2075007363] 'process raft request' (duration: 182.605464ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:47:04.574287Z","caller":"traceutil/trace.go:171","msg":"trace[1066814926] transaction","detail":"{read_only:false; response_revision:283; number_of_response:1; }","duration":"183.436111ms","start":"2026-08-13T07:47:04.390837Z","end":"2026-08-13T07:47:04.574273Z","steps":["trace[1066814926] 'process raft request' (duration: 182.567064ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:47:04.574363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.877779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4017"} {"level":"info","ts":"2026-08-13T07:47:04.574292Z","caller":"traceutil/trace.go:171","msg":"trace[1141851136] transaction","detail":"{read_only:false; response_revision:285; number_of_response:1; }","duration":"182.646396ms","start":"2026-08-13T07:47:04.391631Z","end":"2026-08-13T07:47:04.574278Z","steps":["trace[1141851136] 'process raft request' (duration: 181.85477ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:47:04.574416Z","caller":"traceutil/trace.go:171","msg":"trace[82509381] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:285; }","duration":"183.953681ms","start":"2026-08-13T07:47:04.39045Z","end":"2026-08-13T07:47:04.574403Z","steps":["trace[82509381] 'agreement among raft nodes before linearized reading' (duration: 183.86922ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:47:04.575067Z","caller":"traceutil/trace.go:171","msg":"trace[1866458235] transaction","detail":"{read_only:false; response_revision:278; number_of_response:1; }","duration":"187.247782ms","start":"2026-08-13T07:47:04.38777Z","end":"2026-08-13T07:47:04.575018Z","steps":["trace[1866458235] 'process raft request' (duration: 185.231504ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:47:04.577271Z","caller":"traceutil/trace.go:171","msg":"trace[1356356027] transaction","detail":"{read_only:false; response_revision:286; number_of_response:1; }","duration":"138.4642ms","start":"2026-08-13T07:47:04.438779Z","end":"2026-08-13T07:47:04.577243Z","steps":["trace[1356356027] 'process raft request' (duration: 138.332697ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:47:42.69554Z","caller":"traceutil/trace.go:171","msg":"trace[1312510314] linearizableReadLoop","detail":"{readStateIndex:659; appliedIndex:658; }","duration":"176.678333ms","start":"2026-08-13T07:47:42.518781Z","end":"2026-08-13T07:47:42.695459Z","steps":["trace[1312510314] 'read index received' (duration: 175.873941ms)","trace[1312510314] 'applied index is now lower than readState.Index' (duration: 803.442µs)"],"step_count":2} {"level":"warn","ts":"2026-08-13T07:47:42.69592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.112889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.169\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-13T07:47:42.695978Z","caller":"traceutil/trace.go:171","msg":"trace[934870490] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"192.752574ms","start":"2026-08-13T07:47:42.503184Z","end":"2026-08-13T07:47:42.695936Z","steps":["trace[934870490] 'process raft request' (duration: 191.662438ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:47:42.697431Z","caller":"traceutil/trace.go:171","msg":"trace[1176781776] range","detail":"{range_begin:/registry/masterleases/199.204.45.169; range_end:; response_count:1; response_revision:634; }","duration":"177.381053ms","start":"2026-08-13T07:47:42.518739Z","end":"2026-08-13T07:47:42.69612Z","steps":["trace[1176781776] 'agreement among raft nodes before linearized reading' (duration: 177.055399ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:47:43.586429Z","caller":"traceutil/trace.go:171","msg":"trace[1477763865] linearizableReadLoop","detail":"{readStateIndex:664; appliedIndex:663; }","duration":"350.876938ms","start":"2026-08-13T07:47:43.235528Z","end":"2026-08-13T07:47:43.586405Z","steps":["trace[1477763865] 'read index received' (duration: 350.26772ms)","trace[1477763865] 'applied index is now lower than readState.Index' (duration: 608.628µs)"],"step_count":2} {"level":"info","ts":"2026-08-13T07:47:43.586481Z","caller":"traceutil/trace.go:171","msg":"trace[1773021326] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"362.984161ms","start":"2026-08-13T07:47:43.223468Z","end":"2026-08-13T07:47:43.586452Z","steps":["trace[1773021326] 'process raft request' (duration: 362.513665ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:47:43.586749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.105181ms","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-08-13T07:47:43.586739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.196332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-08-13T07:47:43.58679Z","caller":"traceutil/trace.go:171","msg":"trace[1054755883] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:638; }","duration":"223.190781ms","start":"2026-08-13T07:47:43.363589Z","end":"2026-08-13T07:47:43.58678Z","steps":["trace[1054755883] 'agreement among raft nodes before linearized reading' (duration: 222.930648ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:47:43.586792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:47:43.223437Z","time spent":"363.083042ms","remote":"127.0.0.1:52282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T07:47:43.586841Z","caller":"traceutil/trace.go:171","msg":"trace[1152353866] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:638; }","duration":"351.345365ms","start":"2026-08-13T07:47:43.235474Z","end":"2026-08-13T07:47:43.58682Z","steps":["trace[1152353866] 'agreement among raft nodes before linearized reading' (duration: 351.00866ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:47:43.5869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:47:43.235457Z","time spent":"351.433416ms","remote":"127.0.0.1:52474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-13T07:49:17.688587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.436062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T07:49:17.68869Z","caller":"traceutil/trace.go:171","msg":"trace[197506674] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:1885; }","duration":"123.590683ms","start":"2026-08-13T07:49:17.565075Z","end":"2026-08-13T07:49:17.688665Z","steps":["trace[197506674] 'count revisions from in-memory index tree' (duration: 123.351581ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:49:17.893121Z","caller":"traceutil/trace.go:171","msg":"trace[1725730511] transaction","detail":"{read_only:false; response_revision:1886; number_of_response:1; }","duration":"155.980654ms","start":"2026-08-13T07:49:17.737122Z","end":"2026-08-13T07:49:17.893103Z","steps":["trace[1725730511] 'process raft request' (duration: 155.865333ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:49:17.893144Z","caller":"traceutil/trace.go:171","msg":"trace[1140845373] linearizableReadLoop","detail":"{readStateIndex:1960; appliedIndex:1960; }","duration":"147.170177ms","start":"2026-08-13T07:49:17.745957Z","end":"2026-08-13T07:49:17.893127Z","steps":["trace[1140845373] 'read index received' (duration: 147.161607ms)","trace[1140845373] 'applied index is now lower than readState.Index' (duration: 7.38µs)"],"step_count":2} {"level":"warn","ts":"2026-08-13T07:49:17.893393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.433719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ad15f61c-6aee-4408-9e30-bbefc5772d23\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-08-13T07:49:17.893441Z","caller":"traceutil/trace.go:171","msg":"trace[444972285] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ad15f61c-6aee-4408-9e30-bbefc5772d23; range_end:; response_count:1; response_revision:1886; }","duration":"147.54035ms","start":"2026-08-13T07:49:17.74589Z","end":"2026-08-13T07:49:17.89343Z","steps":["trace[444972285] 'agreement among raft nodes before linearized reading' (duration: 147.323558ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:49:17.960068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.06683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ad15f61c-6aee-4408-9e30-bbefc5772d23\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-08-13T07:49:17.960171Z","caller":"traceutil/trace.go:171","msg":"trace[425650626] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ad15f61c-6aee-4408-9e30-bbefc5772d23; range_end:; response_count:1; response_revision:1886; }","duration":"197.221082ms","start":"2026-08-13T07:49:17.762927Z","end":"2026-08-13T07:49:17.960148Z","steps":["trace[425650626] 'agreement among raft nodes before linearized reading' (duration: 196.95735ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:49:18.320571Z","caller":"traceutil/trace.go:171","msg":"trace[1746964329] linearizableReadLoop","detail":"{readStateIndex:1963; appliedIndex:1962; }","duration":"233.236333ms","start":"2026-08-13T07:49:18.087298Z","end":"2026-08-13T07:49:18.320535Z","steps":["trace[1746964329] 'read index received' (duration: 187.499692ms)","trace[1746964329] 'applied index is now lower than readState.Index' (duration: 45.735181ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T07:49:18.320946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.634928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-08-13T07:49:18.321005Z","caller":"traceutil/trace.go:171","msg":"trace[244182880] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1888; }","duration":"233.729398ms","start":"2026-08-13T07:49:18.087263Z","end":"2026-08-13T07:49:18.320993Z","steps":["trace[244182880] 'agreement among raft nodes before linearized reading' (duration: 233.576357ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:49:18.321129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.887983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T07:49:18.321194Z","caller":"traceutil/trace.go:171","msg":"trace[1399519766] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1888; }","duration":"207.987974ms","start":"2026-08-13T07:49:18.113189Z","end":"2026-08-13T07:49:18.321177Z","steps":["trace[1399519766] 'agreement among raft nodes before linearized reading' (duration: 207.876283ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:49:18.321154Z","caller":"traceutil/trace.go:171","msg":"trace[1694167503] transaction","detail":"{read_only:false; response_revision:1888; number_of_response:1; }","duration":"247.778447ms","start":"2026-08-13T07:49:18.073322Z","end":"2026-08-13T07:49:18.3211Z","steps":["trace[1694167503] 'process raft request' (duration: 201.548751ms)","trace[1694167503] 'compare' (duration: 45.364448ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T07:49:18.321671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.7983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-08-13T07:49:18.321761Z","caller":"traceutil/trace.go:171","msg":"trace[1561708377] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1888; }","duration":"221.910701ms","start":"2026-08-13T07:49:18.099837Z","end":"2026-08-13T07:49:18.321748Z","steps":["trace[1561708377] 'agreement among raft nodes before linearized reading' (duration: 221.109304ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:49:51.68478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.448515ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-13T07:49:51.684967Z","caller":"traceutil/trace.go:171","msg":"trace[894117906] transaction","detail":"{read_only:false; response_revision:2128; number_of_response:1; }","duration":"196.475478ms","start":"2026-08-13T07:49:51.488461Z","end":"2026-08-13T07:49:51.684936Z","steps":["trace[894117906] 'process raft request' (duration: 72.781971ms)","trace[894117906] 'compare' (duration: 123.352064ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T07:49:52.649812Z","caller":"traceutil/trace.go:171","msg":"trace[1963042548] transaction","detail":"{read_only:false; response_revision:2129; number_of_response:1; }","duration":"165.999491ms","start":"2026-08-13T07:49:52.483787Z","end":"2026-08-13T07:49:52.649787Z","steps":["trace[1963042548] 'process raft request' (duration: 165.85077ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:49:53.061328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.399006ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-13T07:49:53.061724Z","caller":"traceutil/trace.go:171","msg":"trace[592668694] transaction","detail":"{read_only:false; response_revision:2130; number_of_response:1; }","duration":"575.878082ms","start":"2026-08-13T07:49:52.485807Z","end":"2026-08-13T07:49:53.061685Z","steps":["trace[592668694] 'process raft request' (duration: 304.035192ms)","trace[592668694] 'compare' (duration: 271.041673ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T07:49:53.061818Z","caller":"traceutil/trace.go:171","msg":"trace[1653153033] transaction","detail":"{read_only:false; response_revision:2131; number_of_response:1; }","duration":"143.029335ms","start":"2026-08-13T07:49:52.918724Z","end":"2026-08-13T07:49:53.061753Z","steps":["trace[1653153033] 'process raft request' (duration: 142.723783ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:49:53.06205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:49:52.485784Z","time spent":"576.133944ms","remote":"127.0.0.1:52474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T07:49:53.062094Z","caller":"traceutil/trace.go:171","msg":"trace[1977716601] linearizableReadLoop","detail":"{readStateIndex:2211; appliedIndex:2209; }","duration":"539.770245ms","start":"2026-08-13T07:49:52.522278Z","end":"2026-08-13T07:49:53.062048Z","steps":["trace[1977716601] 'read index received' (duration: 127.388961ms)","trace[1977716601] 'applied index is now lower than readState.Index' (duration: 412.370684ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T07:49:53.0624Z","caller":"traceutil/trace.go:171","msg":"trace[2096043081] transaction","detail":"{read_only:false; response_revision:2132; number_of_response:1; }","duration":"138.648305ms","start":"2026-08-13T07:49:52.923735Z","end":"2026-08-13T07:49:53.062383Z","steps":["trace[2096043081] 'process raft request' (duration: 138.579974ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:49:53.062468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.183388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-08-13T07:49:53.062533Z","caller":"traceutil/trace.go:171","msg":"trace[1433341112] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2131; }","duration":"540.285829ms","start":"2026-08-13T07:49:52.522228Z","end":"2026-08-13T07:49:53.062514Z","steps":["trace[1433341112] 'agreement among raft nodes before linearized reading' (duration: 540.064737ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:49:53.062618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.855186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.169\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-13T07:49:53.062661Z","caller":"traceutil/trace.go:171","msg":"trace[763472350] range","detail":"{range_begin:/registry/masterleases/199.204.45.169; range_end:; response_count:1; response_revision:2132; }","duration":"538.920066ms","start":"2026-08-13T07:49:52.523729Z","end":"2026-08-13T07:49:53.062649Z","steps":["trace[763472350] 'agreement among raft nodes before linearized reading' (duration: 538.689084ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:49:53.062681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:49:52.522168Z","time spent":"540.39821ms","remote":"127.0.0.1:52474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-13T07:49:53.0627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.697985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-08-13T07:49:53.062739Z","caller":"traceutil/trace.go:171","msg":"trace[413256998] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2132; }","duration":"108.801317ms","start":"2026-08-13T07:49:52.953925Z","end":"2026-08-13T07:49:53.062726Z","steps":["trace[413256998] 'agreement among raft nodes before linearized reading' (duration: 108.686796ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:49:53.062784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.244237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-08-13T07:49:53.062695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:49:52.523717Z","time spent":"538.968396ms","remote":"127.0.0.1:52204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.169\" "} {"level":"info","ts":"2026-08-13T07:49:53.062812Z","caller":"traceutil/trace.go:171","msg":"trace[609115568] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2132; }","duration":"467.307647ms","start":"2026-08-13T07:49:52.595496Z","end":"2026-08-13T07:49:53.062804Z","steps":["trace[609115568] 'agreement among raft nodes before linearized reading' (duration: 467.220777ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:49:53.062838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:49:52.595475Z","time spent":"467.357068ms","remote":"127.0.0.1:52474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-08-13T07:49:53.295491Z","caller":"traceutil/trace.go:171","msg":"trace[1405100692] transaction","detail":"{read_only:false; response_revision:2135; number_of_response:1; }","duration":"176.464377ms","start":"2026-08-13T07:49:53.118984Z","end":"2026-08-13T07:49:53.295448Z","steps":["trace[1405100692] 'process raft request' (duration: 173.168956ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:52:50.633322Z","caller":"traceutil/trace.go:171","msg":"trace[925608882] linearizableReadLoop","detail":"{readStateIndex:3307; appliedIndex:3306; }","duration":"114.707311ms","start":"2026-08-13T07:52:50.518582Z","end":"2026-08-13T07:52:50.633289Z","steps":["trace[925608882] 'read index received' (duration: 114.524916ms)","trace[925608882] 'applied index is now lower than readState.Index' (duration: 180.985µs)"],"step_count":2} {"level":"info","ts":"2026-08-13T07:52:50.633395Z","caller":"traceutil/trace.go:171","msg":"trace[1705498152] transaction","detail":"{read_only:false; response_revision:3186; number_of_response:1; }","duration":"115.313407ms","start":"2026-08-13T07:52:50.518066Z","end":"2026-08-13T07:52:50.63338Z","steps":["trace[1705498152] 'process raft request' (duration: 115.02772ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:52:50.634187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.542194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T07:52:50.634294Z","caller":"traceutil/trace.go:171","msg":"trace[1497097341] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:3186; }","duration":"115.700619ms","start":"2026-08-13T07:52:50.518569Z","end":"2026-08-13T07:52:50.634269Z","steps":["trace[1497097341] 'agreement among raft nodes before linearized reading' (duration: 114.890206ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:52:50.681348Z","caller":"traceutil/trace.go:171","msg":"trace[2018705513] transaction","detail":"{read_only:false; response_revision:3188; number_of_response:1; }","duration":"157.255175ms","start":"2026-08-13T07:52:50.524054Z","end":"2026-08-13T07:52:50.681309Z","steps":["trace[2018705513] 'process raft request' (duration: 157.182003ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:52:50.681745Z","caller":"traceutil/trace.go:171","msg":"trace[1946639962] transaction","detail":"{read_only:false; response_revision:3187; number_of_response:1; }","duration":"163.027305ms","start":"2026-08-13T07:52:50.51871Z","end":"2026-08-13T07:52:50.681737Z","steps":["trace[1946639962] 'process raft request' (duration: 162.15641ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:52:50.756507Z","caller":"traceutil/trace.go:171","msg":"trace[355179479] linearizableReadLoop","detail":"{readStateIndex:3309; appliedIndex:3309; }","duration":"123.0604ms","start":"2026-08-13T07:52:50.633421Z","end":"2026-08-13T07:52:50.756481Z","steps":["trace[355179479] 'read index received' (duration: 123.051349ms)","trace[355179479] 'applied index is now lower than readState.Index' (duration: 7.561µs)"],"step_count":2} {"level":"warn","ts":"2026-08-13T07:52:50.941513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.212622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-08-13T07:52:50.94161Z","caller":"traceutil/trace.go:171","msg":"trace[329241493] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:3188; }","duration":"417.341766ms","start":"2026-08-13T07:52:50.524247Z","end":"2026-08-13T07:52:50.941589Z","steps":["trace[329241493] 'agreement among raft nodes before linearized reading' (duration: 232.333331ms)","trace[329241493] 'range keys from in-memory index tree' (duration: 184.712396ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T07:52:50.941644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:52:50.524182Z","time spent":"417.454289ms","remote":"127.0.0.1:52378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-08-13T07:52:51.478844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.719417ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T07:52:51.479635Z","caller":"traceutil/trace.go:171","msg":"trace[2039688632] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:3189; }","duration":"250.502478ms","start":"2026-08-13T07:52:51.229091Z","end":"2026-08-13T07:52:51.479594Z","steps":["trace[2039688632] 'range keys from in-memory index tree' (duration: 249.687365ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:52:51.479033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.732525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-08-13T07:52:51.480002Z","caller":"traceutil/trace.go:171","msg":"trace[338562452] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:3189; }","duration":"269.712962ms","start":"2026-08-13T07:52:51.210242Z","end":"2026-08-13T07:52:51.479955Z","steps":["trace[338562452] 'range keys from in-memory index tree' (duration: 268.569341ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:52:52.406403Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6605830649917056935,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-13T07:52:52.907009Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6605830649917056935,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-13T07:52:52.979729Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.272608762s","expected-duration":"1s"} {"level":"info","ts":"2026-08-13T07:52:52.980158Z","caller":"traceutil/trace.go:171","msg":"trace[1779029143] transaction","detail":"{read_only:false; response_revision:3191; number_of_response:1; }","duration":"1.273103996s","start":"2026-08-13T07:52:51.707031Z","end":"2026-08-13T07:52:52.980135Z","steps":["trace[1779029143] 'process raft request' (duration: 1.272934291s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:52:52.980288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:52:51.707011Z","time spent":"1.273191337s","remote":"127.0.0.1:52474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T07:52:52.981032Z","caller":"traceutil/trace.go:171","msg":"trace[274794215] transaction","detail":"{read_only:false; response_revision:3192; number_of_response:1; }","duration":"1.260664627s","start":"2026-08-13T07:52:51.720354Z","end":"2026-08-13T07:52:52.981019Z","steps":["trace[274794215] 'process raft request' (duration: 1.260572775s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:52:52.981086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:52:51.720325Z","time spent":"1.260732159s","remote":"127.0.0.1:52474","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-08-13T07:52:52.981148Z","caller":"traceutil/trace.go:171","msg":"trace[198813435] transaction","detail":"{read_only:false; response_revision:3193; number_of_response:1; }","duration":"1.095293798s","start":"2026-08-13T07:52:51.885846Z","end":"2026-08-13T07:52:52.98114Z","steps":["trace[198813435] 'process raft request' (duration: 1.095142634s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:52:52.981193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:52:51.885824Z","time spent":"1.09534422s","remote":"127.0.0.1:52474","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-08-13T07:52:52.981244Z","caller":"traceutil/trace.go:171","msg":"trace[528183954] linearizableReadLoop","detail":"{readStateIndex:3315; appliedIndex:3311; }","duration":"1.077969457s","start":"2026-08-13T07:52:51.903266Z","end":"2026-08-13T07:52:52.981236Z","steps":["trace[528183954] 'read index received' (duration: 1.076702502s)","trace[528183954] 'applied index is now lower than readState.Index' (duration: 1.266035ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T07:52:52.981257Z","caller":"traceutil/trace.go:171","msg":"trace[1207838032] transaction","detail":"{read_only:false; response_revision:3194; number_of_response:1; }","duration":"1.056080069s","start":"2026-08-13T07:52:51.925169Z","end":"2026-08-13T07:52:52.981249Z","steps":["trace[1207838032] 'process raft request' (duration: 1.055939625s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:52:52.981308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:52:51.925138Z","time spent":"1.056148561s","remote":"127.0.0.1:52474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T07:52:52.981345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.078080509s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-13T07:52:52.981366Z","caller":"traceutil/trace.go:171","msg":"trace[1577184167] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3194; }","duration":"1.078151211s","start":"2026-08-13T07:52:51.903209Z","end":"2026-08-13T07:52:52.98136Z","steps":["trace[1577184167] 'agreement among raft nodes before linearized reading' (duration: 1.078069869s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:52:52.981422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"583.163985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-08-13T07:52:52.981384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:52:51.903182Z","time spent":"1.078198193s","remote":"127.0.0.1:52474","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-08-13T07:52:52.981462Z","caller":"traceutil/trace.go:171","msg":"trace[1806235284] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3194; }","duration":"583.239267ms","start":"2026-08-13T07:52:52.398211Z","end":"2026-08-13T07:52:52.98145Z","steps":["trace[1806235284] 'agreement among raft nodes before linearized reading' (duration: 583.124154ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:52:52.981491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:52:52.398197Z","time spent":"583.287358ms","remote":"127.0.0.1:52474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-13T07:52:52.981519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.456331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T07:52:52.981542Z","caller":"traceutil/trace.go:171","msg":"trace[1888098420] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3194; }","duration":"549.521663ms","start":"2026-08-13T07:52:52.432014Z","end":"2026-08-13T07:52:52.981536Z","steps":["trace[1888098420] 'agreement among raft nodes before linearized reading' (duration: 549.484402ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:52:52.981563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:52:52.431999Z","time spent":"549.555853ms","remote":"127.0.0.1:52192","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-08-13T07:52:52.981662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.41335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T07:52:52.981679Z","caller":"traceutil/trace.go:171","msg":"trace[651750965] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3194; }","duration":"549.456471ms","start":"2026-08-13T07:52:52.432217Z","end":"2026-08-13T07:52:52.981674Z","steps":["trace[651750965] 'agreement among raft nodes before linearized reading' (duration: 549.428541ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:52:52.981694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:52:52.432203Z","time spent":"549.487702ms","remote":"127.0.0.1:52184","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-08-13T07:52:52.981791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"571.014685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T07:52:52.981816Z","caller":"traceutil/trace.go:171","msg":"trace[1962960343] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:3194; }","duration":"571.052587ms","start":"2026-08-13T07:52:52.410755Z","end":"2026-08-13T07:52:52.981807Z","steps":["trace[1962960343] 'agreement among raft nodes before linearized reading' (duration: 571.015246ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:52:52.981836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:52:52.410749Z","time spent":"571.080077ms","remote":"127.0.0.1:46100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-08-13T07:52:52.981861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"574.822758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-13T07:52:52.981933Z","caller":"traceutil/trace.go:171","msg":"trace[1787765975] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:3194; }","duration":"574.912661ms","start":"2026-08-13T07:52:52.406988Z","end":"2026-08-13T07:52:52.981901Z","steps":["trace[1787765975] 'agreement among raft nodes before linearized reading' (duration: 574.829149ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:52:52.981961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:52:52.406978Z","time spent":"574.976603ms","remote":"127.0.0.1:46210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":30,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"info","ts":"2026-08-13T07:55:26.957502Z","caller":"traceutil/trace.go:171","msg":"trace[493470983] linearizableReadLoop","detail":"{readStateIndex:4929; appliedIndex:4928; }","duration":"285.271103ms","start":"2026-08-13T07:55:26.672211Z","end":"2026-08-13T07:55:26.957482Z","steps":["trace[493470983] 'read index received' (duration: 285.240562ms)","trace[493470983] 'applied index is now lower than readState.Index' (duration: 29.691µs)"],"step_count":2} {"level":"info","ts":"2026-08-13T07:55:26.95757Z","caller":"traceutil/trace.go:171","msg":"trace[62457899] transaction","detail":"{read_only:false; response_revision:4751; number_of_response:1; }","duration":"286.209679ms","start":"2026-08-13T07:55:26.671315Z","end":"2026-08-13T07:55:26.957525Z","steps":["trace[62457899] 'process raft request' (duration: 286.054186ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:55:26.95768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.464696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"info","ts":"2026-08-13T07:55:26.957714Z","caller":"traceutil/trace.go:171","msg":"trace[821782089] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:4751; }","duration":"285.542567ms","start":"2026-08-13T07:55:26.672161Z","end":"2026-08-13T07:55:26.957704Z","steps":["trace[821782089] 'agreement among raft nodes before linearized reading' (duration: 285.413155ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:55:26.965019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.81261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16233"} {"level":"info","ts":"2026-08-13T07:55:26.965081Z","caller":"traceutil/trace.go:171","msg":"trace[273783575] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4752; }","duration":"283.915821ms","start":"2026-08-13T07:55:26.68115Z","end":"2026-08-13T07:55:26.965066Z","steps":["trace[273783575] 'agreement among raft nodes before linearized reading' (duration: 283.744998ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:55:26.965146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.552233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-08-13T07:55:26.965252Z","caller":"traceutil/trace.go:171","msg":"trace[65376236] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4752; }","duration":"272.700246ms","start":"2026-08-13T07:55:26.692522Z","end":"2026-08-13T07:55:26.965222Z","steps":["trace[65376236] 'agreement among raft nodes before linearized reading' (duration: 272.35608ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:55:26.965321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.325711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-1\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T07:55:26.965364Z","caller":"traceutil/trace.go:171","msg":"trace[1870039042] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-1; range_end:; response_count:0; response_revision:4752; }","duration":"292.387882ms","start":"2026-08-13T07:55:26.672967Z","end":"2026-08-13T07:55:26.965355Z","steps":["trace[1870039042] 'agreement among raft nodes before linearized reading' (duration: 292.325191ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:55:26.965536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.760528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/openstack/\" range_end:\"/registry/limitranges/openstack0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T07:55:26.965573Z","caller":"traceutil/trace.go:171","msg":"trace[1476770124] range","detail":"{range_begin:/registry/limitranges/openstack/; range_end:/registry/limitranges/openstack0; response_count:0; response_revision:4752; }","duration":"292.798298ms","start":"2026-08-13T07:55:26.672765Z","end":"2026-08-13T07:55:26.965563Z","steps":["trace[1476770124] 'agreement among raft nodes before linearized reading' (duration: 292.736467ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:55:26.965547Z","caller":"traceutil/trace.go:171","msg":"trace[892590328] transaction","detail":"{read_only:false; response_revision:4752; number_of_response:1; }","duration":"281.482811ms","start":"2026-08-13T07:55:26.684046Z","end":"2026-08-13T07:55:26.965529Z","steps":["trace[892590328] 'process raft request' (duration: 280.734719ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:55:27.272512Z","caller":"traceutil/trace.go:171","msg":"trace[1123648786] linearizableReadLoop","detail":"{readStateIndex:4943; appliedIndex:4941; }","duration":"156.004547ms","start":"2026-08-13T07:55:27.116488Z","end":"2026-08-13T07:55:27.272493Z","steps":["trace[1123648786] 'read index received' (duration: 148.92187ms)","trace[1123648786] 'applied index is now lower than readState.Index' (duration: 7.081927ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T07:55:27.272633Z","caller":"traceutil/trace.go:171","msg":"trace[1713485003] transaction","detail":"{read_only:false; response_revision:4765; number_of_response:1; }","duration":"167.144542ms","start":"2026-08-13T07:55:27.105479Z","end":"2026-08-13T07:55:27.272624Z","steps":["trace[1713485003] 'process raft request' (duration: 166.966349ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:55:27.272777Z","caller":"traceutil/trace.go:171","msg":"trace[1620211911] transaction","detail":"{read_only:false; response_revision:4764; number_of_response:1; }","duration":"167.767462ms","start":"2026-08-13T07:55:27.104958Z","end":"2026-08-13T07:55:27.272726Z","steps":["trace[1620211911] 'process raft request' (duration: 160.304399ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:55:27.27287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.037508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-28c85cf1-cc63-4a39-9089-6db61f896eec\" ","response":"range_response_count:1 size:1450"} {"level":"info","ts":"2026-08-13T07:55:27.27291Z","caller":"traceutil/trace.go:171","msg":"trace[1039514142] range","detail":"{range_begin:/registry/persistentvolumes/pvc-28c85cf1-cc63-4a39-9089-6db61f896eec; range_end:; response_count:1; response_revision:4765; }","duration":"176.10639ms","start":"2026-08-13T07:55:27.096795Z","end":"2026-08-13T07:55:27.272901Z","steps":["trace[1039514142] 'agreement among raft nodes before linearized reading' (duration: 175.960188ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:55:27.272931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.199501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/prometheus-operated\" ","response":"range_response_count:1 size:993"} {"level":"info","ts":"2026-08-13T07:55:27.27301Z","caller":"traceutil/trace.go:171","msg":"trace[1400267924] range","detail":"{range_begin:/registry/services/specs/monitoring/prometheus-operated; range_end:; response_count:1; response_revision:4765; }","duration":"176.323974ms","start":"2026-08-13T07:55:27.096668Z","end":"2026-08-13T07:55:27.272992Z","steps":["trace[1400267924] 'agreement among raft nodes before linearized reading' (duration: 176.10714ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:55:27.339635Z","caller":"traceutil/trace.go:171","msg":"trace[1644762522] transaction","detail":"{read_only:false; response_revision:4766; number_of_response:1; }","duration":"218.980288ms","start":"2026-08-13T07:55:27.120621Z","end":"2026-08-13T07:55:27.339601Z","steps":["trace[1644762522] 'process raft request' (duration: 218.610632ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:55:27.339833Z","caller":"traceutil/trace.go:171","msg":"trace[1299990992] transaction","detail":"{read_only:false; response_revision:4767; number_of_response:1; }","duration":"205.969933ms","start":"2026-08-13T07:55:27.133833Z","end":"2026-08-13T07:55:27.339803Z","steps":["trace[1299990992] 'process raft request' (duration: 205.688938ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:55:27.340007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.285971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:4849"} {"level":"info","ts":"2026-08-13T07:55:27.340095Z","caller":"traceutil/trace.go:171","msg":"trace[32891763] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4767; }","duration":"214.390573ms","start":"2026-08-13T07:55:27.125684Z","end":"2026-08-13T07:55:27.340074Z","steps":["trace[32891763] 'agreement among raft nodes before linearized reading' (duration: 214.144958ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:55:27.408586Z","caller":"traceutil/trace.go:171","msg":"trace[1004751335] transaction","detail":"{read_only:false; response_revision:4768; number_of_response:1; }","duration":"128.496573ms","start":"2026-08-13T07:55:27.280062Z","end":"2026-08-13T07:55:27.408559Z","steps":["trace[1004751335] 'process raft request' (duration: 116.119519ms)","trace[1004751335] 'compare' (duration: 12.064949ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T07:55:27.408974Z","caller":"traceutil/trace.go:171","msg":"trace[688959480] transaction","detail":"{read_only:false; response_revision:4770; number_of_response:1; }","duration":"127.874253ms","start":"2026-08-13T07:55:27.281078Z","end":"2026-08-13T07:55:27.408952Z","steps":["trace[688959480] 'process raft request' (duration: 127.69808ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:55:27.409183Z","caller":"traceutil/trace.go:171","msg":"trace[837923568] transaction","detail":"{read_only:false; response_revision:4769; number_of_response:1; }","duration":"128.94737ms","start":"2026-08-13T07:55:27.280217Z","end":"2026-08-13T07:55:27.409164Z","steps":["trace[837923568] 'process raft request' (duration: 128.257019ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:55:27.409398Z","caller":"traceutil/trace.go:171","msg":"trace[1975838645] transaction","detail":"{read_only:false; response_revision:4771; number_of_response:1; }","duration":"127.855372ms","start":"2026-08-13T07:55:27.281524Z","end":"2026-08-13T07:55:27.409379Z","steps":["trace[1975838645] 'process raft request' (duration: 127.377024ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:55:27.409777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.367804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/prometheus-operated\" ","response":"range_response_count:1 size:993"} {"level":"info","ts":"2026-08-13T07:55:27.409867Z","caller":"traceutil/trace.go:171","msg":"trace[1913647584] range","detail":"{range_begin:/registry/services/specs/monitoring/prometheus-operated; range_end:; response_count:1; response_revision:4771; }","duration":"130.506246ms","start":"2026-08-13T07:55:27.279347Z","end":"2026-08-13T07:55:27.409854Z","steps":["trace[1913647584] 'agreement among raft nodes before linearized reading' (duration: 130.243082ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:55:27.40994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.369354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rabbitmq-keystone-default-user\" ","response":"range_response_count:1 size:1321"} {"level":"info","ts":"2026-08-13T07:55:27.410164Z","caller":"traceutil/trace.go:171","msg":"trace[636612129] range","detail":"{range_begin:/registry/secrets/openstack/rabbitmq-keystone-default-user; range_end:; response_count:1; response_revision:4771; }","duration":"130.599769ms","start":"2026-08-13T07:55:27.279461Z","end":"2026-08-13T07:55:27.410061Z","steps":["trace[636612129] 'agreement among raft nodes before linearized reading' (duration: 130.068829ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:55:27.460331Z","caller":"traceutil/trace.go:171","msg":"trace[874255141] transaction","detail":"{read_only:false; response_revision:4773; number_of_response:1; }","duration":"107.341523ms","start":"2026-08-13T07:55:27.352967Z","end":"2026-08-13T07:55:27.460309Z","steps":["trace[874255141] 'process raft request' (duration: 107.235361ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:55:27.460452Z","caller":"traceutil/trace.go:171","msg":"trace[164096608] transaction","detail":"{read_only:false; response_revision:4772; number_of_response:1; }","duration":"116.118579ms","start":"2026-08-13T07:55:27.344293Z","end":"2026-08-13T07:55:27.460411Z","steps":["trace[164096608] 'process raft request' (duration: 115.788702ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:55:27.461092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.572203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:9448"} {"level":"info","ts":"2026-08-13T07:55:27.461159Z","caller":"traceutil/trace.go:171","msg":"trace[1832938342] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:4773; }","duration":"117.685544ms","start":"2026-08-13T07:55:27.343459Z","end":"2026-08-13T07:55:27.461144Z","steps":["trace[1832938342] 'agreement among raft nodes before linearized reading' (duration: 116.978043ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:55:40.049988Z","caller":"traceutil/trace.go:171","msg":"trace[958868020] transaction","detail":"{read_only:false; response_revision:4962; number_of_response:1; }","duration":"102.243357ms","start":"2026-08-13T07:55:39.94772Z","end":"2026-08-13T07:55:40.049964Z","steps":["trace[958868020] 'process raft request' (duration: 102.117365ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:55:40.050031Z","caller":"traceutil/trace.go:171","msg":"trace[179332330] transaction","detail":"{read_only:false; response_revision:4961; number_of_response:1; }","duration":"107.321838ms","start":"2026-08-13T07:55:39.942673Z","end":"2026-08-13T07:55:40.049995Z","steps":["trace[179332330] 'process raft request' (duration: 94.531222ms)","trace[179332330] 'compare' (duration: 12.487171ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T07:56:16.470597Z","caller":"traceutil/trace.go:171","msg":"trace[450356164] transaction","detail":"{read_only:false; response_revision:5280; number_of_response:1; }","duration":"144.879348ms","start":"2026-08-13T07:56:16.325687Z","end":"2026-08-13T07:56:16.470566Z","steps":["trace[450356164] 'process raft request' (duration: 129.973802ms)","trace[450356164] 'compare' (duration: 14.783703ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T07:56:59.618848Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2917} {"level":"info","ts":"2026-08-13T07:56:59.695865Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2917,"took":"75.541434ms","hash":143026648,"current-db-size-bytes":54919168,"current-db-size":"55 MB","current-db-size-in-use-bytes":29372416,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-08-13T07:56:59.696022Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":143026648,"revision":2917,"compact-revision":-1} {"level":"info","ts":"2026-08-13T08:01:59.625748Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5599} {"level":"info","ts":"2026-08-13T08:01:59.709703Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5599,"took":"82.249825ms","hash":2004721852,"current-db-size-bytes":54919168,"current-db-size":"55 MB","current-db-size-in-use-bytes":18382848,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-08-13T08:01:59.709779Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2004721852,"revision":5599,"compact-revision":2917} {"level":"info","ts":"2026-08-13T08:02:26.004854Z","caller":"traceutil/trace.go:171","msg":"trace[519473228] linearizableReadLoop","detail":"{readStateIndex:7849; appliedIndex:7848; }","duration":"203.532861ms","start":"2026-08-13T08:02:25.801302Z","end":"2026-08-13T08:02:26.004835Z","steps":["trace[519473228] 'read index received' (duration: 203.332707ms)","trace[519473228] 'applied index is now lower than readState.Index' (duration: 197.414µs)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:02:26.005015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.685334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T08:02:26.00504Z","caller":"traceutil/trace.go:171","msg":"trace[299330983] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:7571; }","duration":"203.765086ms","start":"2026-08-13T08:02:25.801267Z","end":"2026-08-13T08:02:26.005032Z","steps":["trace[299330983] 'agreement among raft nodes before linearized reading' (duration: 203.689335ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:02:26.005118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.313942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:pvc-protection-controller\" ","response":"range_response_count:1 size:728"} {"level":"info","ts":"2026-08-13T08:02:26.005191Z","caller":"traceutil/trace.go:171","msg":"trace[1529201022] range","detail":"{range_begin:/registry/clusterroles/system:controller:pvc-protection-controller; range_end:; response_count:1; response_revision:7571; }","duration":"202.421676ms","start":"2026-08-13T08:02:25.802752Z","end":"2026-08-13T08:02:26.005173Z","steps":["trace[1529201022] 'agreement among raft nodes before linearized reading' (duration: 202.254693ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:02:26.005187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.059987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:coredns\" ","response":"range_response_count:1 size:415"} {"level":"info","ts":"2026-08-13T08:02:26.005521Z","caller":"traceutil/trace.go:171","msg":"trace[85658643] range","detail":"{range_begin:/registry/clusterrolebindings/system:coredns; range_end:; response_count:1; response_revision:7571; }","duration":"160.233661ms","start":"2026-08-13T08:02:25.845054Z","end":"2026-08-13T08:02:26.005287Z","steps":["trace[85658643] 'agreement among raft nodes before linearized reading' (duration: 160.016726ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:26.005606Z","caller":"traceutil/trace.go:171","msg":"trace[773631370] transaction","detail":"{read_only:false; response_revision:7571; number_of_response:1; }","duration":"232.034691ms","start":"2026-08-13T08:02:25.773554Z","end":"2026-08-13T08:02:26.005588Z","steps":["trace[773631370] 'process raft request' (duration: 231.140812ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:26.426142Z","caller":"traceutil/trace.go:171","msg":"trace[163590472] transaction","detail":"{read_only:false; response_revision:7576; number_of_response:1; }","duration":"217.035302ms","start":"2026-08-13T08:02:26.209079Z","end":"2026-08-13T08:02:26.426114Z","steps":["trace[163590472] 'process raft request' (duration: 216.487789ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:26.426548Z","caller":"traceutil/trace.go:171","msg":"trace[1610353654] linearizableReadLoop","detail":"{readStateIndex:7855; appliedIndex:7854; }","duration":"182.543559ms","start":"2026-08-13T08:02:26.243994Z","end":"2026-08-13T08:02:26.426537Z","steps":["trace[1610353654] 'read index received' (duration: 182.302144ms)","trace[1610353654] 'applied index is now lower than readState.Index' (duration: 239.375µs)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:02:26.426661Z","caller":"traceutil/trace.go:171","msg":"trace[501240390] transaction","detail":"{read_only:false; response_revision:7577; number_of_response:1; }","duration":"217.123335ms","start":"2026-08-13T08:02:26.20953Z","end":"2026-08-13T08:02:26.426653Z","steps":["trace[501240390] 'process raft request' (duration: 216.971231ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:02:26.426793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.788344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:replicaset-controller\" ","response":"range_response_count:1 size:843"} {"level":"info","ts":"2026-08-13T08:02:26.426835Z","caller":"traceutil/trace.go:171","msg":"trace[2023356295] range","detail":"{range_begin:/registry/clusterroles/system:controller:replicaset-controller; range_end:; response_count:1; response_revision:7577; }","duration":"182.868385ms","start":"2026-08-13T08:02:26.243958Z","end":"2026-08-13T08:02:26.426826Z","steps":["trace[2023356295] 'agreement among raft nodes before linearized reading' (duration: 182.762263ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:02:26.426923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.677408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:discovery\" ","response":"range_response_count:1 size:694"} {"level":"info","ts":"2026-08-13T08:02:26.426997Z","caller":"traceutil/trace.go:171","msg":"trace[192865235] range","detail":"{range_begin:/registry/clusterrolebindings/system:discovery; range_end:; response_count:1; response_revision:7577; }","duration":"171.775771ms","start":"2026-08-13T08:02:26.255202Z","end":"2026-08-13T08:02:26.426978Z","steps":["trace[192865235] 'agreement among raft nodes before linearized reading' (duration: 171.648088ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:02:27.434045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"558.732479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:kube-controller-manager\" ","response":"range_response_count:1 size:745"} {"level":"info","ts":"2026-08-13T08:02:27.4341Z","caller":"traceutil/trace.go:171","msg":"trace[566665016] range","detail":"{range_begin:/registry/clusterrolebindings/system:kube-controller-manager; range_end:; response_count:1; response_revision:7577; }","duration":"558.796521ms","start":"2026-08-13T08:02:26.87529Z","end":"2026-08-13T08:02:27.434087Z","steps":["trace[566665016] 'range keys from in-memory index tree' (duration: 558.672759ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:02:27.434127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:02:26.875252Z","time spent":"558.869113ms","remote":"127.0.0.1:52572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":768,"request content":"key:\"/registry/clusterrolebindings/system:kube-controller-manager\" "} {"level":"warn","ts":"2026-08-13T08:02:27.434337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"903.612462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:replication-controller\" ","response":"range_response_count:1 size:830"} {"level":"info","ts":"2026-08-13T08:02:27.434353Z","caller":"traceutil/trace.go:171","msg":"trace[1702113811] range","detail":"{range_begin:/registry/clusterroles/system:controller:replication-controller; range_end:; response_count:1; response_revision:7577; }","duration":"903.663643ms","start":"2026-08-13T08:02:26.530683Z","end":"2026-08-13T08:02:27.434347Z","steps":["trace[1702113811] 'range keys from in-memory index tree' (duration: 903.53194ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:02:27.434367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:02:26.530657Z","time spent":"903.705993ms","remote":"127.0.0.1:52562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":853,"request content":"key:\"/registry/clusterroles/system:controller:replication-controller\" "} {"level":"warn","ts":"2026-08-13T08:02:27.434604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"832.60204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/certificates/\" range_end:\"/registry/secretgen.k14s.io/certificates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T08:02:27.43465Z","caller":"traceutil/trace.go:171","msg":"trace[1255103274] range","detail":"{range_begin:/registry/secretgen.k14s.io/certificates/; range_end:/registry/secretgen.k14s.io/certificates0; response_count:0; response_revision:7577; }","duration":"832.687772ms","start":"2026-08-13T08:02:26.601951Z","end":"2026-08-13T08:02:27.434638Z","steps":["trace[1255103274] 'count revisions from in-memory index tree' (duration: 832.474278ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:02:27.434672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:02:26.601937Z","time spent":"832.729623ms","remote":"127.0.0.1:33448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":28,"request content":"key:\"/registry/secretgen.k14s.io/certificates/\" range_end:\"/registry/secretgen.k14s.io/certificates0\" count_only:true "} {"level":"warn","ts":"2026-08-13T08:02:27.434675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"578.028866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-13T08:02:27.43472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"745.488982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-13T08:02:27.434744Z","caller":"traceutil/trace.go:171","msg":"trace[1721044710] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/; range_end:/registry/secretgen.k14s.io/passwords0; response_count:0; response_revision:7577; }","duration":"745.551993ms","start":"2026-08-13T08:02:26.689184Z","end":"2026-08-13T08:02:27.434736Z","steps":["trace[1721044710] 'count revisions from in-memory index tree' (duration: 745.253827ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:27.434748Z","caller":"traceutil/trace.go:171","msg":"trace[683269823] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:7577; }","duration":"578.140329ms","start":"2026-08-13T08:02:26.856591Z","end":"2026-08-13T08:02:27.434731Z","steps":["trace[683269823] 'range keys from in-memory index tree' (duration: 577.963985ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:02:27.43476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:02:26.689164Z","time spent":"745.591634ms","remote":"127.0.0.1:33406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":5,"response size":30,"request content":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true "} {"level":"warn","ts":"2026-08-13T08:02:27.43479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:02:26.856575Z","time spent":"578.20514ms","remote":"127.0.0.1:52686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":28,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"info","ts":"2026-08-13T08:02:28.297718Z","caller":"traceutil/trace.go:171","msg":"trace[469743885] linearizableReadLoop","detail":"{readStateIndex:7859; appliedIndex:7858; }","duration":"247.400718ms","start":"2026-08-13T08:02:28.050251Z","end":"2026-08-13T08:02:28.297652Z","steps":["trace[469743885] 'read index received' (duration: 247.211054ms)","trace[469743885] 'applied index is now lower than readState.Index' (duration: 188.774µs)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:02:28.298082Z","caller":"traceutil/trace.go:171","msg":"trace[643034550] transaction","detail":"{read_only:false; response_revision:7581; number_of_response:1; }","duration":"288.125418ms","start":"2026-08-13T08:02:28.009944Z","end":"2026-08-13T08:02:28.298069Z","steps":["trace[643034550] 'process raft request' (duration: 287.572655ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:02:28.298322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.056873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-13T08:02:28.298356Z","caller":"traceutil/trace.go:171","msg":"trace[913816751] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7581; }","duration":"248.130795ms","start":"2026-08-13T08:02:28.050216Z","end":"2026-08-13T08:02:28.298347Z","steps":["trace[913816751] 'agreement among raft nodes before linearized reading' (duration: 248.015162ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:02:28.298486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.366513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:resourcequota-controller\" ","response":"range_response_count:1 size:700"} {"level":"info","ts":"2026-08-13T08:02:28.298515Z","caller":"traceutil/trace.go:171","msg":"trace[1936566895] range","detail":"{range_begin:/registry/clusterroles/system:controller:resourcequota-controller; range_end:; response_count:1; response_revision:7581; }","duration":"244.404063ms","start":"2026-08-13T08:02:28.054102Z","end":"2026-08-13T08:02:28.298506Z","steps":["trace[1936566895] 'agreement among raft nodes before linearized reading' (duration: 244.349572ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:02:28.29886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.788801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T08:02:28.298886Z","caller":"traceutil/trace.go:171","msg":"trace[462100519] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7581; }","duration":"186.824761ms","start":"2026-08-13T08:02:28.112054Z","end":"2026-08-13T08:02:28.298879Z","steps":["trace[462100519] 'agreement among raft nodes before linearized reading' (duration: 186.7833ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:02:28.29902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.960716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-13T08:02:28.29904Z","caller":"traceutil/trace.go:171","msg":"trace[668164045] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:7581; }","duration":"241.018057ms","start":"2026-08-13T08:02:28.058017Z","end":"2026-08-13T08:02:28.299035Z","steps":["trace[668164045] 'agreement among raft nodes before linearized reading' (duration: 240.958766ms)"],"step_count":1}