{"level":"warn","ts":"2026-05-11T10:45:10.772905Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-11T10:45:10.773061Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.196: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.196:2380","--initial-cluster=instance=https://199.19.213.196:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.196:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.196:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-11T10:45:10.773141Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-11T10:45:10.773162Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.196:2380"]} {"level":"info","ts":"2026-05-11T10:45:10.773187Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-11T10:45:10.774077Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.196:2379"]} {"level":"info","ts":"2026-05-11T10:45:10.774333Z","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.196:2380"],"listen-peer-urls":["https://199.19.213.196:2380"],"advertise-client-urls":["https://199.19.213.196:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.196:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.196:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-11T10:45:10.782948Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.335932ms"} {"level":"info","ts":"2026-05-11T10:45:10.790477Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"8f376d4d42da413a","cluster-id":"f5ef03c8da56d984"} {"level":"info","ts":"2026-05-11T10:45:10.790576Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8f376d4d42da413a switched to configuration voters=()"} {"level":"info","ts":"2026-05-11T10:45:10.790608Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8f376d4d42da413a became follower at term 0"} {"level":"info","ts":"2026-05-11T10:45:10.790635Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8f376d4d42da413a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-11T10:45:10.790646Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8f376d4d42da413a became follower at term 1"} {"level":"info","ts":"2026-05-11T10:45:10.790685Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8f376d4d42da413a switched to configuration voters=(10319837249744290106)"} {"level":"warn","ts":"2026-05-11T10:45:10.798627Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-11T10:45:10.800101Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-11T10:45:10.801235Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-11T10:45:10.803314Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"8f376d4d42da413a","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-11T10:45:10.803592Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"8f376d4d42da413a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-11T10:45:10.803667Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-11T10:45:10.80378Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-11T10:45:10.803798Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-11T10:45:10.80406Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8f376d4d42da413a switched to configuration voters=(10319837249744290106)"} {"level":"info","ts":"2026-05-11T10:45:10.804141Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"f5ef03c8da56d984","local-member-id":"8f376d4d42da413a","added-peer-id":"8f376d4d42da413a","added-peer-peer-urls":["https://199.19.213.196:2380"]} {"level":"info","ts":"2026-05-11T10:45:10.808173Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-11T10:45:10.808314Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.196:2380"} {"level":"info","ts":"2026-05-11T10:45:10.808342Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.196:2380"} {"level":"info","ts":"2026-05-11T10:45:10.808451Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"8f376d4d42da413a","initial-advertise-peer-urls":["https://199.19.213.196:2380"],"listen-peer-urls":["https://199.19.213.196:2380"],"advertise-client-urls":["https://199.19.213.196:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.196:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-11T10:45:10.808491Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-11T10:45:11.792178Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8f376d4d42da413a is starting a new election at term 1"} {"level":"info","ts":"2026-05-11T10:45:11.792232Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8f376d4d42da413a became pre-candidate at term 1"} {"level":"info","ts":"2026-05-11T10:45:11.792264Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8f376d4d42da413a received MsgPreVoteResp from 8f376d4d42da413a at term 1"} {"level":"info","ts":"2026-05-11T10:45:11.792278Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8f376d4d42da413a became candidate at term 2"} {"level":"info","ts":"2026-05-11T10:45:11.792286Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8f376d4d42da413a received MsgVoteResp from 8f376d4d42da413a at term 2"} {"level":"info","ts":"2026-05-11T10:45:11.792297Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8f376d4d42da413a became leader at term 2"} {"level":"info","ts":"2026-05-11T10:45:11.792307Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8f376d4d42da413a elected leader 8f376d4d42da413a at term 2"} {"level":"info","ts":"2026-05-11T10:45:11.794536Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-11T10:45:11.794554Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-11T10:45:11.794572Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-11T10:45:11.794808Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"8f376d4d42da413a","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.196:2379]}","request-path":"/0/members/8f376d4d42da413a/attributes","cluster-id":"f5ef03c8da56d984","publish-timeout":"7s"} {"level":"info","ts":"2026-05-11T10:45:11.79551Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-11T10:45:11.79554Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-11T10:45:11.795529Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"f5ef03c8da56d984","local-member-id":"8f376d4d42da413a","cluster-version":"3.5"} {"level":"info","ts":"2026-05-11T10:45:11.795662Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-11T10:45:11.795714Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-11T10:45:11.796526Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-11T10:45:11.799123Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.196:2379"} {"level":"info","ts":"2026-05-11T10:45:13.440913Z","caller":"traceutil/trace.go:171","msg":"trace[161847878] transaction","detail":"{read_only:false; response_revision:61; number_of_response:1; }","duration":"134.084615ms","start":"2026-05-11T10:45:13.306802Z","end":"2026-05-11T10:45:13.440887Z","steps":["trace[161847878] 'process raft request' (duration: 56.145943ms)","trace[161847878] 'compare' (duration: 77.683282ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:45:14.067736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.197316ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-11T10:45:14.067952Z","caller":"traceutil/trace.go:171","msg":"trace[788154653] transaction","detail":"{read_only:false; response_revision:64; number_of_response:1; }","duration":"623.583065ms","start":"2026-05-11T10:45:13.444345Z","end":"2026-05-11T10:45:14.067928Z","steps":["trace[788154653] 'process raft request' (duration: 267.6383ms)","trace[788154653] 'compare' (duration: 355.099812ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:45:14.068018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:45:13.444316Z","time spent":"623.675839ms","remote":"127.0.0.1:41598","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":581,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-11T10:45:14.068188Z","caller":"traceutil/trace.go:171","msg":"trace[498934649] transaction","detail":"{read_only:false; response_revision:65; number_of_response:1; }","duration":"622.668ms","start":"2026-05-11T10:45:13.445503Z","end":"2026-05-11T10:45:14.068171Z","steps":["trace[498934649] 'process raft request' (duration: 622.360179ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:14.069552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:45:13.445472Z","time spent":"622.752033ms","remote":"127.0.0.1:41598","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1088,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T10:45:14.349261Z","caller":"traceutil/trace.go:171","msg":"trace[1369615502] transaction","detail":"{read_only:false; response_revision:66; number_of_response:1; }","duration":"277.939073ms","start":"2026-05-11T10:45:14.071299Z","end":"2026-05-11T10:45:14.349238Z","steps":["trace[1369615502] 'process raft request' (duration: 248.704324ms)","trace[1369615502] 'compare' (duration: 29.063653ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:45:14.355056Z","caller":"traceutil/trace.go:171","msg":"trace[1641900711] transaction","detail":"{read_only:false; response_revision:67; number_of_response:1; }","duration":"282.905873ms","start":"2026-05-11T10:45:14.072119Z","end":"2026-05-11T10:45:14.355024Z","steps":["trace[1641900711] 'process raft request' (duration: 282.633983ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:14.355062Z","caller":"traceutil/trace.go:171","msg":"trace[1952427039] linearizableReadLoop","detail":"{readStateIndex:71; appliedIndex:69; }","duration":"281.625345ms","start":"2026-05-11T10:45:14.073406Z","end":"2026-05-11T10:45:14.355031Z","steps":["trace[1952427039] 'read index received' (duration: 246.608684ms)","trace[1952427039] 'applied index is now lower than readState.Index' (duration: 35.015341ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:45:14.355427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.961157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-admin\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:45:14.355532Z","caller":"traceutil/trace.go:171","msg":"trace[2145376328] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-admin; range_end:; response_count:0; response_revision:68; }","duration":"282.126984ms","start":"2026-05-11T10:45:14.073385Z","end":"2026-05-11T10:45:14.355512Z","steps":["trace[2145376328] 'agreement among raft nodes before linearized reading' (duration: 281.934737ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:14.355215Z","caller":"traceutil/trace.go:171","msg":"trace[854635895] transaction","detail":"{read_only:false; response_revision:68; number_of_response:1; }","duration":"281.466818ms","start":"2026-05-11T10:45:14.073734Z","end":"2026-05-11T10:45:14.355201Z","steps":["trace[854635895] 'process raft request' (duration: 281.170507ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:14.356018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.970557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-11T10:45:14.35611Z","caller":"traceutil/trace.go:171","msg":"trace[977798734] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:68; }","duration":"223.099952ms","start":"2026-05-11T10:45:14.132982Z","end":"2026-05-11T10:45:14.356082Z","steps":["trace[977798734] 'agreement among raft nodes before linearized reading' (duration: 222.959017ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:14.850938Z","caller":"traceutil/trace.go:171","msg":"trace[1813897122] transaction","detail":"{read_only:false; response_revision:93; number_of_response:1; }","duration":"252.108833ms","start":"2026-05-11T10:45:14.598732Z","end":"2026-05-11T10:45:14.850841Z","steps":["trace[1813897122] 'process raft request' (duration: 241.447295ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:49.963604Z","caller":"traceutil/trace.go:171","msg":"trace[453085605] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"124.06419ms","start":"2026-05-11T10:45:49.83952Z","end":"2026-05-11T10:45:49.963584Z","steps":["trace[453085605] 'process raft request' (duration: 123.930424ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:50.231268Z","caller":"traceutil/trace.go:171","msg":"trace[1059421264] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"207.332848ms","start":"2026-05-11T10:45:50.023908Z","end":"2026-05-11T10:45:50.231241Z","steps":["trace[1059421264] 'process raft request' (duration: 206.755933ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:51.229695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"672.973703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-cf2r4\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-11T10:45:51.229877Z","caller":"traceutil/trace.go:171","msg":"trace[638977439] range","detail":"{range_begin:/registry/pods/kube-system/cilium-cf2r4; range_end:; response_count:1; response_revision:590; }","duration":"673.223544ms","start":"2026-05-11T10:45:50.556595Z","end":"2026-05-11T10:45:51.229818Z","steps":["trace[638977439] 'range keys from in-memory index tree' (duration: 672.719992ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:51.230099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:45:50.556571Z","time spent":"673.508157ms","remote":"127.0.0.1:41382","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16989,"request content":"key:\"/registry/pods/kube-system/cilium-cf2r4\" "} {"level":"info","ts":"2026-05-11T10:45:51.231645Z","caller":"traceutil/trace.go:171","msg":"trace[591524198] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"502.326759ms","start":"2026-05-11T10:45:50.729298Z","end":"2026-05-11T10:45:51.231625Z","steps":["trace[591524198] 'process raft request' (duration: 430.453724ms)","trace[591524198] 'compare' (duration: 70.778106ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:45:51.232937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:45:50.72928Z","time spent":"502.416353ms","remote":"127.0.0.1:41284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T10:46:05.699455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.607206ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-11T10:46:05.699617Z","caller":"traceutil/trace.go:171","msg":"trace[1667618917] transaction","detail":"{read_only:false; response_revision:747; number_of_response:1; }","duration":"203.567065ms","start":"2026-05-11T10:46:05.49602Z","end":"2026-05-11T10:46:05.699587Z","steps":["trace[1667618917] 'process raft request' (duration: 65.711637ms)","trace[1667618917] 'compare' (duration: 137.4674ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:47:23.144676Z","caller":"traceutil/trace.go:171","msg":"trace[1248559769] transaction","detail":"{read_only:false; response_revision:1817; number_of_response:1; }","duration":"114.114912ms","start":"2026-05-11T10:47:23.030526Z","end":"2026-05-11T10:47:23.144641Z","steps":["trace[1248559769] 'process raft request' (duration: 70.450763ms)","trace[1248559769] 'compare' (duration: 43.29582ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:47:23.162919Z","caller":"traceutil/trace.go:171","msg":"trace[645941610] transaction","detail":"{read_only:false; response_revision:1818; number_of_response:1; }","duration":"129.532831ms","start":"2026-05-11T10:47:23.033359Z","end":"2026-05-11T10:47:23.162892Z","steps":["trace[645941610] 'process raft request' (duration: 129.400758ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:48:05.269485Z","caller":"traceutil/trace.go:171","msg":"trace[1408082432] transaction","detail":"{read_only:false; response_revision:2153; number_of_response:1; }","duration":"112.345297ms","start":"2026-05-11T10:48:05.157116Z","end":"2026-05-11T10:48:05.269461Z","steps":["trace[1408082432] 'process raft request' (duration: 112.174782ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:48:05.504756Z","caller":"traceutil/trace.go:171","msg":"trace[644125286] transaction","detail":"{read_only:false; response_revision:2154; number_of_response:1; }","duration":"101.120177ms","start":"2026-05-11T10:48:05.403611Z","end":"2026-05-11T10:48:05.504731Z","steps":["trace[644125286] 'process raft request' (duration: 100.996923ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:49:23.643034Z","caller":"traceutil/trace.go:171","msg":"trace[927813062] transaction","detail":"{read_only:false; response_revision:2793; number_of_response:1; }","duration":"102.649517ms","start":"2026-05-11T10:49:23.540363Z","end":"2026-05-11T10:49:23.643012Z","steps":["trace[927813062] 'process raft request' (duration: 102.521832ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:49:29.221637Z","caller":"traceutil/trace.go:171","msg":"trace[1235844490] transaction","detail":"{read_only:false; response_revision:2830; number_of_response:1; }","duration":"148.619484ms","start":"2026-05-11T10:49:29.072992Z","end":"2026-05-11T10:49:29.221611Z","steps":["trace[1235844490] 'process raft request' (duration: 148.479759ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:51:41.393824Z","caller":"traceutil/trace.go:171","msg":"trace[610280595] transaction","detail":"{read_only:false; response_revision:4276; number_of_response:1; }","duration":"111.458021ms","start":"2026-05-11T10:51:41.282325Z","end":"2026-05-11T10:51:41.393783Z","steps":["trace[610280595] 'process raft request' (duration: 110.798434ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:51:52.518024Z","caller":"traceutil/trace.go:171","msg":"trace[1727648976] linearizableReadLoop","detail":"{readStateIndex:4732; appliedIndex:4731; }","duration":"167.739502ms","start":"2026-05-11T10:51:52.350261Z","end":"2026-05-11T10:51:52.518Z","steps":["trace[1727648976] 'read index received' (duration: 167.443929ms)","trace[1727648976] 'applied index is now lower than readState.Index' (duration: 294.533µs)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:51:52.518067Z","caller":"traceutil/trace.go:171","msg":"trace[1536912174] transaction","detail":"{read_only:false; response_revision:4536; number_of_response:1; }","duration":"170.297565ms","start":"2026-05-11T10:51:52.347747Z","end":"2026-05-11T10:51:52.518045Z","steps":["trace[1536912174] 'process raft request' (duration: 170.064232ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:51:52.518365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.058977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:553"} {"level":"info","ts":"2026-05-11T10:51:52.518479Z","caller":"traceutil/trace.go:171","msg":"trace[508891410] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4536; }","duration":"168.214459ms","start":"2026-05-11T10:51:52.350234Z","end":"2026-05-11T10:51:52.518448Z","steps":["trace[508891410] 'agreement among raft nodes before linearized reading' (duration: 167.878355ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:51:52.661541Z","caller":"traceutil/trace.go:171","msg":"trace[859429868] transaction","detail":"{read_only:false; response_revision:4537; number_of_response:1; }","duration":"137.791272ms","start":"2026-05-11T10:51:52.523724Z","end":"2026-05-11T10:51:52.661516Z","steps":["trace[859429868] 'process raft request' (duration: 133.068292ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:51:54.526369Z","caller":"traceutil/trace.go:171","msg":"trace[396411616] transaction","detail":"{read_only:false; response_revision:4558; number_of_response:1; }","duration":"145.867758ms","start":"2026-05-11T10:51:54.380471Z","end":"2026-05-11T10:51:54.526338Z","steps":["trace[396411616] 'process raft request' (duration: 145.254369ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:52:05.3811Z","caller":"traceutil/trace.go:171","msg":"trace[84331071] transaction","detail":"{read_only:false; response_revision:4730; number_of_response:1; }","duration":"115.846888ms","start":"2026-05-11T10:52:05.265233Z","end":"2026-05-11T10:52:05.38108Z","steps":["trace[84331071] 'process raft request' (duration: 115.700035ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:52:49.64677Z","caller":"traceutil/trace.go:171","msg":"trace[255942392] transaction","detail":"{read_only:false; response_revision:5199; number_of_response:1; }","duration":"327.523935ms","start":"2026-05-11T10:52:49.319211Z","end":"2026-05-11T10:52:49.646735Z","steps":["trace[255942392] 'process raft request' (duration: 327.320311ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:52:49.646782Z","caller":"traceutil/trace.go:171","msg":"trace[1002910867] linearizableReadLoop","detail":"{readStateIndex:5421; appliedIndex:5421; }","duration":"271.709771ms","start":"2026-05-11T10:52:49.375047Z","end":"2026-05-11T10:52:49.646756Z","steps":["trace[1002910867] 'read index received' (duration: 271.701931ms)","trace[1002910867] 'applied index is now lower than readState.Index' (duration: 6.75µs)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:52:49.647003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.931906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:660"} {"level":"info","ts":"2026-05-11T10:52:49.647064Z","caller":"traceutil/trace.go:171","msg":"trace[1012162988] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:5199; }","duration":"272.035028ms","start":"2026-05-11T10:52:49.375008Z","end":"2026-05-11T10:52:49.647043Z","steps":["trace[1012162988] 'agreement among raft nodes before linearized reading' (duration: 271.828924ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:52:49.648506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:52:49.319183Z","time spent":"327.679669ms","remote":"127.0.0.1:41294","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":629,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T10:55:11.821606Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3207} {"level":"info","ts":"2026-05-11T10:55:11.902532Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3207,"took":"79.707956ms","hash":115251675,"current-db-size-bytes":57556992,"current-db-size":"58 MB","current-db-size-in-use-bytes":31420416,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-05-11T10:55:11.902585Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":115251675,"revision":3207,"compact-revision":-1}