{"level":"warn","ts":"2026-08-24T15:15:22.01331Z","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-24T15:15:22.013414Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.18:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.18:2380","--initial-cluster=instance=https://199.19.213.18:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.18:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.18: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-24T15:15:22.013497Z","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-24T15:15:22.013513Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.18:2380"]} {"level":"info","ts":"2026-08-24T15:15:22.013536Z","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-24T15:15:22.014299Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.18:2379"]} {"level":"info","ts":"2026-08-24T15:15:22.014402Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.18:2380"],"listen-peer-urls":["https://199.19.213.18:2380"],"advertise-client-urls":["https://199.19.213.18:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.18:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.18: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-24T15:15:22.018506Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.811658ms"} {"level":"info","ts":"2026-08-24T15:15:22.029248Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6d0358acb671c233","cluster-id":"ba212af698de913f"} {"level":"info","ts":"2026-08-24T15:15:22.029409Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 switched to configuration voters=()"} {"level":"info","ts":"2026-08-24T15:15:22.029471Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 became follower at term 0"} {"level":"info","ts":"2026-08-24T15:15:22.029487Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6d0358acb671c233 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-24T15:15:22.029536Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 became follower at term 1"} {"level":"info","ts":"2026-08-24T15:15:22.029693Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 switched to configuration voters=(7855219673882804787)"} {"level":"warn","ts":"2026-08-24T15:15:22.039359Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-24T15:15:22.044237Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-24T15:15:22.04597Z","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-24T15:15:22.047989Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6d0358acb671c233","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-24T15:15:22.049405Z","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-24T15:15:22.049516Z","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-24T15:15:22.04953Z","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-24T15:15:22.049488Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6d0358acb671c233","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-24T15:15:22.050349Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 switched to configuration voters=(7855219673882804787)"} {"level":"info","ts":"2026-08-24T15:15:22.050462Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ba212af698de913f","local-member-id":"6d0358acb671c233","added-peer-id":"6d0358acb671c233","added-peer-peer-urls":["https://199.19.213.18:2380"]} {"level":"info","ts":"2026-08-24T15:15:22.050733Z","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-24T15:15:22.050944Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6d0358acb671c233","initial-advertise-peer-urls":["https://199.19.213.18:2380"],"listen-peer-urls":["https://199.19.213.18:2380"],"advertise-client-urls":["https://199.19.213.18:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.18:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-24T15:15:22.050986Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-24T15:15:22.05102Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.18:2380"} {"level":"info","ts":"2026-08-24T15:15:22.051044Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.18:2380"} {"level":"info","ts":"2026-08-24T15:15:22.230894Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 is starting a new election at term 1"} {"level":"info","ts":"2026-08-24T15:15:22.230944Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-24T15:15:22.231152Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 received MsgPreVoteResp from 6d0358acb671c233 at term 1"} {"level":"info","ts":"2026-08-24T15:15:22.231174Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 became candidate at term 2"} {"level":"info","ts":"2026-08-24T15:15:22.23119Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 received MsgVoteResp from 6d0358acb671c233 at term 2"} {"level":"info","ts":"2026-08-24T15:15:22.231215Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 became leader at term 2"} {"level":"info","ts":"2026-08-24T15:15:22.231237Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6d0358acb671c233 elected leader 6d0358acb671c233 at term 2"} {"level":"info","ts":"2026-08-24T15:15:22.232439Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6d0358acb671c233","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.18:2379]}","request-path":"/0/members/6d0358acb671c233/attributes","cluster-id":"ba212af698de913f","publish-timeout":"7s"} {"level":"info","ts":"2026-08-24T15:15:22.232655Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-24T15:15:22.232675Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-24T15:15:22.233213Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-24T15:15:22.233411Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-24T15:15:22.23344Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-24T15:15:22.234045Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ba212af698de913f","local-member-id":"6d0358acb671c233","cluster-version":"3.5"} {"level":"info","ts":"2026-08-24T15:15:22.234155Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-24T15:15:22.234188Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-24T15:15:22.235675Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-24T15:15:22.236451Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.18:2379"} {"level":"info","ts":"2026-08-24T15:15:27.543387Z","caller":"traceutil/trace.go:171","msg":"trace[1194939179] transaction","detail":"{read_only:false; number_of_response:0; response_revision:244; }","duration":"101.550282ms","start":"2026-08-24T15:15:27.441797Z","end":"2026-08-24T15:15:27.543348Z","steps":["trace[1194939179] 'process raft request' (duration: 52.094906ms)","trace[1194939179] 'compare' (duration: 49.269013ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:15:27.543543Z","caller":"traceutil/trace.go:171","msg":"trace[39005428] transaction","detail":"{read_only:false; response_revision:245; number_of_response:1; }","duration":"100.80918ms","start":"2026-08-24T15:15:27.44272Z","end":"2026-08-24T15:15:27.543529Z","steps":["trace[39005428] 'process raft request' (duration: 100.563106ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:27.543788Z","caller":"traceutil/trace.go:171","msg":"trace[1653007218] transaction","detail":"{read_only:false; number_of_response:0; response_revision:247; }","duration":"100.601127ms","start":"2026-08-24T15:15:27.443176Z","end":"2026-08-24T15:15:27.543777Z","steps":["trace[1653007218] 'process raft request' (duration: 100.406424ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:27.543922Z","caller":"traceutil/trace.go:171","msg":"trace[1596630658] transaction","detail":"{read_only:false; response_revision:246; number_of_response:1; }","duration":"101.019703ms","start":"2026-08-24T15:15:27.442896Z","end":"2026-08-24T15:15:27.543915Z","steps":["trace[1596630658] 'process raft request' (duration: 100.525586ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:27.543983Z","caller":"traceutil/trace.go:171","msg":"trace[1036724927] transaction","detail":"{read_only:false; response_revision:247; number_of_response:1; }","duration":"100.854301ms","start":"2026-08-24T15:15:27.44312Z","end":"2026-08-24T15:15:27.543975Z","steps":["trace[1036724927] 'process raft request' (duration: 100.351664ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:59.084167Z","caller":"traceutil/trace.go:171","msg":"trace[1719290623] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"118.093871ms","start":"2026-08-24T15:15:58.966048Z","end":"2026-08-24T15:15:59.084142Z","steps":["trace[1719290623] 'process raft request' (duration: 117.911469ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:59.111762Z","caller":"traceutil/trace.go:171","msg":"trace[1747875268] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"129.368051ms","start":"2026-08-24T15:15:58.982371Z","end":"2026-08-24T15:15:59.111739Z","steps":["trace[1747875268] 'process raft request' (duration: 129.050116ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:59.111823Z","caller":"traceutil/trace.go:171","msg":"trace[1650302633] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"122.92513ms","start":"2026-08-24T15:15:58.988893Z","end":"2026-08-24T15:15:59.111818Z","steps":["trace[1650302633] 'process raft request' (duration: 122.595376ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:59.111885Z","caller":"traceutil/trace.go:171","msg":"trace[818521249] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"135.939203ms","start":"2026-08-24T15:15:58.975936Z","end":"2026-08-24T15:15:59.111876Z","steps":["trace[818521249] 'process raft request' (duration: 135.182662ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:59.111959Z","caller":"traceutil/trace.go:171","msg":"trace[1033910742] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"134.293943ms","start":"2026-08-24T15:15:58.977658Z","end":"2026-08-24T15:15:59.111952Z","steps":["trace[1033910742] 'process raft request' (duration: 133.674364ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:59.112024Z","caller":"traceutil/trace.go:171","msg":"trace[1182827277] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"134.219731ms","start":"2026-08-24T15:15:58.977798Z","end":"2026-08-24T15:15:59.112017Z","steps":["trace[1182827277] 'process raft request' (duration: 133.569242ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:59.112087Z","caller":"traceutil/trace.go:171","msg":"trace[656546351] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"132.068074ms","start":"2026-08-24T15:15:58.980012Z","end":"2026-08-24T15:15:59.11208Z","steps":["trace[656546351] 'process raft request' (duration: 131.382555ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:59.111794Z","caller":"traceutil/trace.go:171","msg":"trace[1709565308] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"125.017746ms","start":"2026-08-24T15:15:58.986762Z","end":"2026-08-24T15:15:59.11178Z","steps":["trace[1709565308] 'process raft request' (duration: 124.694032ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:59.112192Z","caller":"traceutil/trace.go:171","msg":"trace[1347123175] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"111.521357ms","start":"2026-08-24T15:15:59.000663Z","end":"2026-08-24T15:15:59.112184Z","steps":["trace[1347123175] 'process raft request' (duration: 110.93006ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:15:59.112256Z","caller":"traceutil/trace.go:171","msg":"trace[1023174360] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"111.670849ms","start":"2026-08-24T15:15:59.000578Z","end":"2026-08-24T15:15:59.112249Z","steps":["trace[1023174360] 'process raft request' (duration: 110.962781ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:16:05.576849Z","caller":"traceutil/trace.go:171","msg":"trace[1663796691] linearizableReadLoop","detail":"{readStateIndex:614; appliedIndex:613; }","duration":"127.318913ms","start":"2026-08-24T15:16:05.449508Z","end":"2026-08-24T15:16:05.576827Z","steps":["trace[1663796691] 'read index received' (duration: 126.473433ms)","trace[1663796691] 'applied index is now lower than readState.Index' (duration: 844.35µs)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:16:05.576957Z","caller":"traceutil/trace.go:171","msg":"trace[1482022492] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"152.311307ms","start":"2026-08-24T15:16:05.424606Z","end":"2026-08-24T15:16:05.576918Z","steps":["trace[1482022492] 'process raft request' (duration: 151.634759ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:16:05.577008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.485437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-7864z\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-08-24T15:16:05.577171Z","caller":"traceutil/trace.go:171","msg":"trace[127205415] range","detail":"{range_begin:/registry/pods/kube-system/cilium-7864z; range_end:; response_count:1; response_revision:590; }","duration":"127.600868ms","start":"2026-08-24T15:16:05.449473Z","end":"2026-08-24T15:16:05.577074Z","steps":["trace[127205415] 'agreement among raft nodes before linearized reading' (duration: 127.473326ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:16:05.87856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.098307ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-24T15:16:05.878771Z","caller":"traceutil/trace.go:171","msg":"trace[968397835] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"284.859974ms","start":"2026-08-24T15:16:05.593885Z","end":"2026-08-24T15:16:05.878745Z","steps":["trace[968397835] 'process raft request' (duration: 88.813246ms)","trace[968397835] 'compare' (duration: 194.924525ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:16:05.878797Z","caller":"traceutil/trace.go:171","msg":"trace[1511539763] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"247.931956ms","start":"2026-08-24T15:16:05.630848Z","end":"2026-08-24T15:16:05.87878Z","steps":["trace[1511539763] 'process raft request' (duration: 247.847565ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:16:05.878815Z","caller":"traceutil/trace.go:171","msg":"trace[382486596] linearizableReadLoop","detail":"{readStateIndex:617; appliedIndex:616; }","duration":"273.884201ms","start":"2026-08-24T15:16:05.604885Z","end":"2026-08-24T15:16:05.87877Z","steps":["trace[382486596] 'read index received' (duration: 77.828644ms)","trace[382486596] 'applied index is now lower than readState.Index' (duration: 196.052577ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:16:05.879082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.180646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"} {"level":"info","ts":"2026-08-24T15:16:05.879144Z","caller":"traceutil/trace.go:171","msg":"trace[1042942900] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:593; }","duration":"274.273936ms","start":"2026-08-24T15:16:05.604853Z","end":"2026-08-24T15:16:05.879127Z","steps":["trace[1042942900] 'agreement among raft nodes before linearized reading' (duration: 274.064174ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:16:06.370824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.400896ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-24T15:16:06.37092Z","caller":"traceutil/trace.go:171","msg":"trace[1307906457] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"465.338016ms","start":"2026-08-24T15:16:05.905565Z","end":"2026-08-24T15:16:06.370903Z","steps":["trace[1307906457] 'process raft request' (duration: 300.798979ms)","trace[1307906457] 'compare' (duration: 164.197133ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:16:06.370973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:16:05.905554Z","time spent":"465.398407ms","remote":"127.0.0.1:60030","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-24T15:16:40.973826Z","caller":"traceutil/trace.go:171","msg":"trace[423319858] transaction","detail":"{read_only:false; response_revision:1001; number_of_response:1; }","duration":"107.546301ms","start":"2026-08-24T15:16:40.866244Z","end":"2026-08-24T15:16:40.97379Z","steps":["trace[423319858] 'process raft request' (duration: 107.353959ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:16:52.209077Z","caller":"traceutil/trace.go:171","msg":"trace[491573054] transaction","detail":"{read_only:false; response_revision:1163; number_of_response:1; }","duration":"105.936592ms","start":"2026-08-24T15:16:52.103091Z","end":"2026-08-24T15:16:52.209028Z","steps":["trace[491573054] 'process raft request' (duration: 105.76983ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:17:15.021142Z","caller":"traceutil/trace.go:171","msg":"trace[1699677131] transaction","detail":"{read_only:false; response_revision:1425; number_of_response:1; }","duration":"114.522043ms","start":"2026-08-24T15:17:14.906598Z","end":"2026-08-24T15:17:15.02112Z","steps":["trace[1699677131] 'process raft request' (duration: 105.185029ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:17:40.551346Z","caller":"traceutil/trace.go:171","msg":"trace[1317759551] transaction","detail":"{read_only:false; response_revision:1842; number_of_response:1; }","duration":"257.204307ms","start":"2026-08-24T15:17:40.294117Z","end":"2026-08-24T15:17:40.551321Z","steps":["trace[1317759551] 'process raft request' (duration: 256.999376ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:17:40.55138Z","caller":"traceutil/trace.go:171","msg":"trace[1740508532] linearizableReadLoop","detail":"{readStateIndex:1913; appliedIndex:1913; }","duration":"176.500354ms","start":"2026-08-24T15:17:40.37484Z","end":"2026-08-24T15:17:40.55134Z","steps":["trace[1740508532] 'read index received' (duration: 176.484783ms)","trace[1740508532] 'applied index is now lower than readState.Index' (duration: 12.631µs)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:17:40.551794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.914607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9591fd58-14fe-4609-aafb-627f68de1ced\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-08-24T15:17:40.551909Z","caller":"traceutil/trace.go:171","msg":"trace[1813014405] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9591fd58-14fe-4609-aafb-627f68de1ced; range_end:; response_count:1; response_revision:1842; }","duration":"177.077949ms","start":"2026-08-24T15:17:40.374805Z","end":"2026-08-24T15:17:40.551883Z","steps":["trace[1813014405] 'agreement among raft nodes before linearized reading' (duration: 176.705645ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:17:40.714234Z","caller":"traceutil/trace.go:171","msg":"trace[162183947] transaction","detail":"{read_only:false; response_revision:1843; number_of_response:1; }","duration":"327.614831ms","start":"2026-08-24T15:17:40.386573Z","end":"2026-08-24T15:17:40.714188Z","steps":["trace[162183947] 'process raft request' (duration: 291.116057ms)","trace[162183947] 'compare' (duration: 35.733627ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:17:40.714467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:17:40.386554Z","time spent":"327.835243ms","remote":"127.0.0.1:60114","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-24T15:17:40.714479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.379012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-24T15:17:40.714678Z","caller":"traceutil/trace.go:171","msg":"trace[1077417976] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1844; }","duration":"247.626104ms","start":"2026-08-24T15:17:40.467038Z","end":"2026-08-24T15:17:40.714664Z","steps":["trace[1077417976] 'agreement among raft nodes before linearized reading' (duration: 247.322521ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:17:40.714828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.691194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-24T15:17:40.715557Z","caller":"traceutil/trace.go:171","msg":"trace[1847260123] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1844; }","duration":"250.451481ms","start":"2026-08-24T15:17:40.465088Z","end":"2026-08-24T15:17:40.715539Z","steps":["trace[1847260123] 'agreement among raft nodes before linearized reading' (duration: 249.630723ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:17:40.714313Z","caller":"traceutil/trace.go:171","msg":"trace[1901596781] linearizableReadLoop","detail":"{readStateIndex:1914; appliedIndex:1913; }","duration":"162.8214ms","start":"2026-08-24T15:17:40.55147Z","end":"2026-08-24T15:17:40.714291Z","steps":["trace[1901596781] 'read index received' (duration: 126.218715ms)","trace[1901596781] 'applied index is now lower than readState.Index' (duration: 36.601125ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:17:52.795746Z","caller":"traceutil/trace.go:171","msg":"trace[1971606710] transaction","detail":"{read_only:false; response_revision:1945; number_of_response:1; }","duration":"200.208841ms","start":"2026-08-24T15:17:52.595518Z","end":"2026-08-24T15:17:52.795727Z","steps":["trace[1971606710] 'process raft request' (duration: 200.08079ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:18:20.275852Z","caller":"traceutil/trace.go:171","msg":"trace[1753439787] linearizableReadLoop","detail":"{readStateIndex:2190; appliedIndex:2189; }","duration":"232.26314ms","start":"2026-08-24T15:18:20.04357Z","end":"2026-08-24T15:18:20.275833Z","steps":["trace[1753439787] 'read index received' (duration: 232.070608ms)","trace[1753439787] 'applied index is now lower than readState.Index' (duration: 191.922µs)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:18:20.276004Z","caller":"traceutil/trace.go:171","msg":"trace[214881061] transaction","detail":"{read_only:false; response_revision:2111; number_of_response:1; }","duration":"233.634072ms","start":"2026-08-24T15:18:20.042333Z","end":"2026-08-24T15:18:20.275967Z","steps":["trace[214881061] 'process raft request' (duration: 233.350599ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:18:20.27614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.544822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-24T15:18:20.276175Z","caller":"traceutil/trace.go:171","msg":"trace[93948810] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:2111; }","duration":"232.600833ms","start":"2026-08-24T15:18:20.043566Z","end":"2026-08-24T15:18:20.276167Z","steps":["trace[93948810] 'agreement among raft nodes before linearized reading' (duration: 232.373901ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:18:20.276248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.022744ms","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-24T15:18:20.276338Z","caller":"traceutil/trace.go:171","msg":"trace[1957671299] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2111; }","duration":"106.166455ms","start":"2026-08-24T15:18:20.170149Z","end":"2026-08-24T15:18:20.276315Z","steps":["trace[1957671299] 'agreement among raft nodes before linearized reading' (duration: 105.891673ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:18:36.896386Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13993704613831196388,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-24T15:18:37.396903Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13993704613831196388,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-24T15:18:37.897919Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13993704613831196388,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-24T15:18:38.398052Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13993704613831196388,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-24T15:18:38.823927Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.476578881s","expected-duration":"1s"} {"level":"info","ts":"2026-08-24T15:18:38.824504Z","caller":"traceutil/trace.go:171","msg":"trace[733555763] transaction","detail":"{read_only:false; response_revision:2196; number_of_response:1; }","duration":"2.477258498s","start":"2026-08-24T15:18:36.34722Z","end":"2026-08-24T15:18:38.824479Z","steps":["trace[733555763] 'process raft request' (duration: 2.476890044s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:18:38.824764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:18:36.347203Z","time spent":"2.477385519s","remote":"127.0.0.1:60114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:18:38.89349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000123629s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-08-24T15:18:38.89358Z","caller":"traceutil/trace.go:171","msg":"trace[310707537] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000299921s","start":"2026-08-24T15:18:36.89326Z","end":"2026-08-24T15:18:38.89356Z","steps":["trace[310707537] 'agreement among raft nodes before linearized reading' (duration: 2.00015579s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:18:38.893658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:18:36.893243Z","time spent":"2.000403922s","remote":"127.0.0.1:59826","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-24T15:18:40.19341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.178719ms","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-24T15:18:40.193518Z","caller":"traceutil/trace.go:171","msg":"trace[782372089] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2196; }","duration":"199.29613ms","start":"2026-08-24T15:18:39.994205Z","end":"2026-08-24T15:18:40.193501Z","steps":["trace[782372089] 'range keys from in-memory index tree' (duration: 199.163749ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:18:40.193666Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.369399317s","expected-duration":"1s"} {"level":"info","ts":"2026-08-24T15:18:40.193967Z","caller":"traceutil/trace.go:171","msg":"trace[676533459] linearizableReadLoop","detail":"{readStateIndex:2285; appliedIndex:2279; }","duration":"3.798514917s","start":"2026-08-24T15:18:36.395441Z","end":"2026-08-24T15:18:40.193956Z","steps":["trace[676533459] 'read index received' (duration: 2.428920108s)","trace[676533459] 'applied index is now lower than readState.Index' (duration: 1.369593929s)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:18:40.194039Z","caller":"traceutil/trace.go:171","msg":"trace[527498513] transaction","detail":"{read_only:false; response_revision:2199; number_of_response:1; }","duration":"2.966849244s","start":"2026-08-24T15:18:37.227137Z","end":"2026-08-24T15:18:40.193987Z","steps":["trace[527498513] 'process raft request' (duration: 2.966740173s)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:18:40.194065Z","caller":"traceutil/trace.go:171","msg":"trace[1114780791] transaction","detail":"{read_only:false; response_revision:2200; number_of_response:1; }","duration":"2.411891015s","start":"2026-08-24T15:18:37.782165Z","end":"2026-08-24T15:18:40.194056Z","steps":["trace[1114780791] 'process raft request' (duration: 2.411734742s)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:18:40.194061Z","caller":"traceutil/trace.go:171","msg":"trace[1917834052] transaction","detail":"{read_only:false; response_revision:2197; number_of_response:1; }","duration":"3.262567552s","start":"2026-08-24T15:18:36.931401Z","end":"2026-08-24T15:18:40.193968Z","steps":["trace[1917834052] 'process raft request' (duration: 3.26236624s)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:18:40.194177Z","caller":"traceutil/trace.go:171","msg":"trace[290467450] transaction","detail":"{read_only:false; response_revision:2201; number_of_response:1; }","duration":"2.260375307s","start":"2026-08-24T15:18:37.933796Z","end":"2026-08-24T15:18:40.194171Z","steps":["trace[290467450] 'process raft request' (duration: 2.260132924s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:18:40.194193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:18:37.227109Z","time spent":"2.966983986s","remote":"127.0.0.1:60114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:18:40.19422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:18:37.933773Z","time spent":"2.260424967s","remote":"127.0.0.1:60114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:18:40.194352Z","caller":"traceutil/trace.go:171","msg":"trace[1018227258] transaction","detail":"{read_only:false; response_revision:2198; number_of_response:1; }","duration":"3.259772647s","start":"2026-08-24T15:18:36.93455Z","end":"2026-08-24T15:18:40.194322Z","steps":["trace[1018227258] 'process raft request' (duration: 3.259301602s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:18:40.194383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:18:36.931359Z","time spent":"3.262849566s","remote":"127.0.0.1:60114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:18:40.19448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.799035343s","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-24T15:18:40.194511Z","caller":"traceutil/trace.go:171","msg":"trace[355574330] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2201; }","duration":"3.799088763s","start":"2026-08-24T15:18:36.395413Z","end":"2026-08-24T15:18:40.194502Z","steps":["trace[355574330] 'agreement among raft nodes before linearized reading' (duration: 3.798986012s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:18:40.194533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:18:36.3954Z","time spent":"3.799127363s","remote":"127.0.0.1:60948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-08-24T15:18:40.194548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:18:36.934524Z","time spent":"3.259916218s","remote":"127.0.0.1:60114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:18:40.194667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.358130222s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-24T15:18:40.194691Z","caller":"traceutil/trace.go:171","msg":"trace[2090649499] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2201; }","duration":"3.358183652s","start":"2026-08-24T15:18:36.8365Z","end":"2026-08-24T15:18:40.194683Z","steps":["trace[2090649499] 'agreement among raft nodes before linearized reading' (duration: 3.358143502s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:18:40.194712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:18:36.836486Z","time spent":"3.358219763s","remote":"127.0.0.1:60942","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-08-24T15:18:40.194896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.993419516s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-24T15:18:40.194921Z","caller":"traceutil/trace.go:171","msg":"trace[118374650] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:2201; }","duration":"1.993485436s","start":"2026-08-24T15:18:38.201429Z","end":"2026-08-24T15:18:40.194915Z","steps":["trace[118374650] 'agreement among raft nodes before linearized reading' (duration: 1.993442246s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:18:40.19494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:18:38.201413Z","time spent":"1.993521698s","remote":"127.0.0.1:60368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":3,"response size":30,"request content":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-08-24T15:18:40.194961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.010919018s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-24T15:18:40.194986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.960579861s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:18:40.195003Z","caller":"traceutil/trace.go:171","msg":"trace[874957313] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:2201; }","duration":"1.010968538s","start":"2026-08-24T15:18:39.184022Z","end":"2026-08-24T15:18:40.194991Z","steps":["trace[874957313] 'agreement among raft nodes before linearized reading' (duration: 1.010888927s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:18:40.195084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.151955345s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-24T15:18:40.195111Z","caller":"traceutil/trace.go:171","msg":"trace[1624396048] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:2201; }","duration":"1.960715642s","start":"2026-08-24T15:18:38.234368Z","end":"2026-08-24T15:18:40.195084Z","steps":["trace[1624396048] 'agreement among raft nodes before linearized reading' (duration: 1.96049023s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:18:40.195132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:18:39.183979Z","time spent":"1.011142139s","remote":"127.0.0.1:59964","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":28,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "} {"level":"info","ts":"2026-08-24T15:18:40.19514Z","caller":"traceutil/trace.go:171","msg":"trace[1272973206] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2201; }","duration":"3.152046025s","start":"2026-08-24T15:18:37.043081Z","end":"2026-08-24T15:18:40.195127Z","steps":["trace[1272973206] 'agreement among raft nodes before linearized reading' (duration: 3.151824773s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:18:40.195184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:18:37.043061Z","time spent":"3.152115037s","remote":"127.0.0.1:60114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-24T15:18:40.195177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:18:38.234305Z","time spent":"1.960853864s","remote":"127.0.0.1:43818","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"warn","ts":"2026-08-24T15:18:40.195281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.816616268s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-24T15:18:40.195306Z","caller":"traceutil/trace.go:171","msg":"trace[140516933] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:2201; }","duration":"2.816667969s","start":"2026-08-24T15:18:37.378631Z","end":"2026-08-24T15:18:40.195299Z","steps":["trace[140516933] 'agreement among raft nodes before linearized reading' (duration: 2.816622118s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:18:40.19531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.216075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-24T15:18:40.195332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:18:37.37862Z","time spent":"2.816705299s","remote":"127.0.0.1:60264","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":30,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "} {"level":"info","ts":"2026-08-24T15:18:40.195344Z","caller":"traceutil/trace.go:171","msg":"trace[371682865] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2201; }","duration":"331.284535ms","start":"2026-08-24T15:18:39.864049Z","end":"2026-08-24T15:18:40.195333Z","steps":["trace[371682865] 'agreement among raft nodes before linearized reading' (duration: 331.224235ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:18:40.195384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:18:39.86403Z","time spent":"331.341737ms","remote":"127.0.0.1:60878","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-08-24T15:18:40.195554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.245125823s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:18:40.195615Z","caller":"traceutil/trace.go:171","msg":"trace[182365053] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:2201; }","duration":"1.245227634s","start":"2026-08-24T15:18:38.950372Z","end":"2026-08-24T15:18:40.1956Z","steps":["trace[182365053] 'agreement among raft nodes before linearized reading' (duration: 1.245119433s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:18:40.195641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.842339517s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-08-24T15:18:40.195662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.008110782s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:18:40.195676Z","caller":"traceutil/trace.go:171","msg":"trace[1539927721] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2201; }","duration":"2.842412138s","start":"2026-08-24T15:18:37.353254Z","end":"2026-08-24T15:18:40.195666Z","steps":["trace[1539927721] 'agreement among raft nodes before linearized reading' (duration: 2.842336768s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:18:40.195666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:18:38.950353Z","time spent":"1.245297144s","remote":"127.0.0.1:60818","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true "} {"level":"warn","ts":"2026-08-24T15:18:40.195716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:18:37.353233Z","time spent":"2.842477049s","remote":"127.0.0.1:60114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-24T15:18:40.195145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.153236327s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-08-24T15:18:40.195791Z","caller":"traceutil/trace.go:171","msg":"trace[1815969204] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2201; }","duration":"3.153883033s","start":"2026-08-24T15:18:37.0419Z","end":"2026-08-24T15:18:40.195783Z","steps":["trace[1815969204] 'agreement among raft nodes before linearized reading' (duration: 3.153187747s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:18:40.195827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:18:37.041862Z","time spent":"3.153949253s","remote":"127.0.0.1:60114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-24T15:18:40.195948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.301672818s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-24T15:18:40.195567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.841921352s","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-24T15:18:40.195618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"801.565464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12381"} {"level":"info","ts":"2026-08-24T15:18:40.19604Z","caller":"traceutil/trace.go:171","msg":"trace[1582777018] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2201; }","duration":"2.842416706s","start":"2026-08-24T15:18:37.353615Z","end":"2026-08-24T15:18:40.196032Z","steps":["trace[1582777018] 'agreement among raft nodes before linearized reading' (duration: 2.841879682s)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:18:40.196055Z","caller":"traceutil/trace.go:171","msg":"trace[1171090546] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2201; }","duration":"802.057368ms","start":"2026-08-24T15:18:39.393983Z","end":"2026-08-24T15:18:40.19604Z","steps":["trace[1171090546] 'agreement among raft nodes before linearized reading' (duration: 801.535753ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:18:40.196068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:18:37.353607Z","time spent":"2.842453078s","remote":"127.0.0.1:60114","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":"info","ts":"2026-08-24T15:18:40.195691Z","caller":"traceutil/trace.go:171","msg":"trace[1524555350] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2201; }","duration":"1.008153912s","start":"2026-08-24T15:18:39.187528Z","end":"2026-08-24T15:18:40.195682Z","steps":["trace[1524555350] 'agreement among raft nodes before linearized reading' (duration: 1.008113612s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:18:40.196121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:18:39.187518Z","time spent":"1.008595506s","remote":"127.0.0.1:59826","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-24T15:18:40.196163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.645508644s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18cec6cd9f0cd25e\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-08-24T15:18:40.196181Z","caller":"traceutil/trace.go:171","msg":"trace[390515781] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18cec6cd9f0cd25e; range_end:; response_count:1; response_revision:2201; }","duration":"1.645551124s","start":"2026-08-24T15:18:38.550624Z","end":"2026-08-24T15:18:40.196175Z","steps":["trace[390515781] 'agreement among raft nodes before linearized reading' (duration: 1.645492893s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:18:40.196092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:18:39.393965Z","time spent":"802.117128ms","remote":"127.0.0.1:60030","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12404,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-08-24T15:18:40.196197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:18:38.550609Z","time spent":"1.645583874s","remote":"127.0.0.1:59906","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":869,"request content":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18cec6cd9f0cd25e\" "} {"level":"info","ts":"2026-08-24T15:18:40.196004Z","caller":"traceutil/trace.go:171","msg":"trace[2036849435] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2201; }","duration":"1.301763089s","start":"2026-08-24T15:18:38.894221Z","end":"2026-08-24T15:18:40.195984Z","steps":["trace[2036849435] 'agreement among raft nodes before linearized reading' (duration: 1.301681098s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:18:40.196302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:18:38.8942Z","time spent":"1.302095732s","remote":"127.0.0.1:59838","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-24T15:18:40.194144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:18:37.782137Z","time spent":"2.411952636s","remote":"127.0.0.1:60114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:19:21.400705Z","caller":"traceutil/trace.go:171","msg":"trace[44035171] transaction","detail":"{read_only:false; response_revision:2532; number_of_response:1; }","duration":"172.054498ms","start":"2026-08-24T15:19:21.228625Z","end":"2026-08-24T15:19:21.40068Z","steps":["trace[44035171] 'process raft request' (duration: 171.884553ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:20:49.146519Z","caller":"traceutil/trace.go:171","msg":"trace[1014044723] transaction","detail":"{read_only:false; response_revision:3003; number_of_response:1; }","duration":"106.236676ms","start":"2026-08-24T15:20:49.040223Z","end":"2026-08-24T15:20:49.146459Z","steps":["trace[1014044723] 'process raft request' (duration: 96.146139ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:20:49.146597Z","caller":"traceutil/trace.go:171","msg":"trace[320343385] transaction","detail":"{read_only:false; response_revision:3004; number_of_response:1; }","duration":"105.50864ms","start":"2026-08-24T15:20:49.041063Z","end":"2026-08-24T15:20:49.146572Z","steps":["trace[320343385] 'process raft request' (duration: 105.133973ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:24:01.898272Z","caller":"traceutil/trace.go:171","msg":"trace[172574423] linearizableReadLoop","detail":"{readStateIndex:4953; appliedIndex:4952; }","duration":"180.203014ms","start":"2026-08-24T15:24:01.718049Z","end":"2026-08-24T15:24:01.898252Z","steps":["trace[172574423] 'read index received' (duration: 176.876368ms)","trace[172574423] 'applied index is now lower than readState.Index' (duration: 3.326046ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:24:01.898394Z","caller":"traceutil/trace.go:171","msg":"trace[170544438] transaction","detail":"{read_only:false; response_revision:4771; number_of_response:1; }","duration":"265.732283ms","start":"2026-08-24T15:24:01.63264Z","end":"2026-08-24T15:24:01.898373Z","steps":["trace[170544438] 'process raft request' (duration: 262.276236ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:24:01.898634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.569338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-581ac0ec-0273-4ae6-92a0-508d9892c280\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-08-24T15:24:01.898738Z","caller":"traceutil/trace.go:171","msg":"trace[1540328076] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-581ac0ec-0273-4ae6-92a0-508d9892c280; range_end:; response_count:1; response_revision:4771; }","duration":"180.73518ms","start":"2026-08-24T15:24:01.717981Z","end":"2026-08-24T15:24:01.898716Z","steps":["trace[1540328076] 'agreement among raft nodes before linearized reading' (duration: 180.406656ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:24:16.846353Z","caller":"traceutil/trace.go:171","msg":"trace[1667807992] transaction","detail":"{read_only:false; response_revision:4966; number_of_response:1; }","duration":"239.34513ms","start":"2026-08-24T15:24:16.606977Z","end":"2026-08-24T15:24:16.846322Z","steps":["trace[1667807992] 'process raft request' (duration: 238.977105ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:25:22.671165Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2858} {"level":"info","ts":"2026-08-24T15:25:22.792575Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2858,"took":"117.839482ms","hash":2529227941,"current-db-size-bytes":53338112,"current-db-size":"53 MB","current-db-size-in-use-bytes":29061120,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-08-24T15:25:22.792737Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2529227941,"revision":2858,"compact-revision":-1} {"level":"info","ts":"2026-08-24T15:28:23.657563Z","caller":"traceutil/trace.go:171","msg":"trace[313879111] transaction","detail":"{read_only:false; response_revision:6763; number_of_response:1; }","duration":"110.317029ms","start":"2026-08-24T15:28:23.547221Z","end":"2026-08-24T15:28:23.657538Z","steps":["trace[313879111] 'process raft request' (duration: 98.994746ms)","trace[313879111] 'compare' (duration: 11.008934ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:30:22.696006Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5510} {"level":"info","ts":"2026-08-24T15:30:22.979984Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5510,"took":"282.578171ms","hash":2957505402,"current-db-size-bytes":53338112,"current-db-size":"53 MB","current-db-size-in-use-bytes":18563072,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-08-24T15:30:22.980038Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2957505402,"revision":5510,"compact-revision":2858}