Closed shail248 closed 2 years ago
Hi @shail248! Thanks for letting us know. This is a debug message that was assigned the wrong level. It means the upstream entity was found but wasn't loaded yet at the time the request was received. The issue was fixed in #8410 and will be part of the next Kong release. You can safely disregard this message.
I have a similar problem!
We experienced some 503 errors on some routes. After investigations, we found out there were some kong pods that had this error (balancer not found for failure to get a peer from the ring-balancer
.
it is very confusing!! because if I delete the pod the problem disappears! (or even by killing the process that has this error)
I changed log level to debug, but there was nothing but this single error! this is a part of our debug logs:
2022/02/19 10:44:50 [debug] 1098#0: *1559 [lua] targets.lua:431: queryDns(): querying dns for 10.33.96.7
2022/02/19 10:44:50 [debug] 1098#0: *1559 [lua] targets.lua:346: f(): dns record type changed for 10.33.96.7, nil -> 1
2022/02/19 10:44:50 [debug] 1098#0: *1559 [lua] targets.lua:412: f(): updating balancer based on dns changes for 10.33.96.7
2022/02/19 10:44:50 [debug] 1098#0: *1559 [lua] targets.lua:422: f(): querying dns and updating for 10.33.96.7 completed
2022/02/19 10:44:50 [debug] 1098#0: *1559 [lua] targets.lua:431: queryDns(): querying dns for 10.33.96.10
2022/02/19 10:44:50 [debug] 1098#0: *1559 [lua] targets.lua:346: f(): dns record type changed for 10.33.96.10, nil -> 1
2022/02/19 10:44:50 [debug] 1098#0: *1559 [lua] targets.lua:412: f(): updating balancer based on dns changes for 10.33.96.10
2022/02/19 10:44:50 [debug] 1098#0: *1559 [lua] targets.lua:422: f(): querying dns and updating for 10.33.96.10 completed
2022/02/19 10:44:50 [debug] 1098#0: *1559 [lua] targets.lua:431: queryDns(): querying dns for 10.33.96.8
2022/02/19 10:44:50 [debug] 1098#0: *1559 [lua] targets.lua:346: f(): dns record type changed for 10.33.96.8, nil -> 1
2022/02/19 10:44:50 [debug] 1098#0: *1559 [lua] targets.lua:412: f(): updating balancer based on dns changes for 10.33.96.8
2022/02/19 10:44:50 [debug] 1098#0: *1559 [lua] targets.lua:422: f(): querying dns and updating for 10.33.96.8 completed
2022/02/19 10:44:50 [debug] 1098#0: *1559 [lua] targets.lua:431: queryDns(): querying dns for 10.33.96.5
2022/02/19 10:44:50 [debug] 1098#0: *1559 [lua] targets.lua:346: f(): dns record type changed for 10.33.96.5, nil -> 1
2022/02/19 10:44:50 [debug] 1098#0: *1559 [lua] targets.lua:412: f(): updating balancer based on dns changes for 10.33.96.5
2022/02/19 10:44:50 [debug] 1098#0: *1559 [lua] targets.lua:422: f(): querying dns and updating for 10.33.96.5 completed
2022/02/19 10:44:50 [debug] 1098#0: *1559 [lua] targets.lua:431: queryDns(): querying dns for 10.46.64.2
2022/02/19 10:44:50 [debug] 1098#0: *1559 [lua] targets.lua:346: f(): dns record type changed for 10.46.64.2, nil -> 1
2022/02/19 10:44:50 [debug] 1098#0: *1559 [lua] targets.lua:412: f(): updating balancer based on dns changes for 10.46.64.2
2022/02/19 10:44:50 [debug] 1098#0: *1559 [lua] targets.lua:422: f(): querying dns and updating for 10.46.64.2 completed
2022/02/19 10:44:50 [debug] 1098#0: *1559 [lua] healthcheck.lua:1126: log(): [healthcheck] (0dc6f45b-8f8d-40d2-a504-473544ee190b:syncer.aaa.8080.svc) Got initial target list (0 targets)
2022/02/19 10:44:50 [debug] 1098#0: *1559 [lua] healthcheck.lua:1126: log(): [healthcheck] (0dc6f45b-8f8d-40d2-a504-473544ee190b:syncer.aaa.8080.svc) active check flagged as active
2022/02/19 10:44:50 [debug] 1098#0: *1559 [lua] healthcheck.lua:1126: log(): [healthcheck] (0dc6f45b-8f8d-40d2-a504-473544ee190b:syncer.aaa.8080.svc) Healthchecker started!
2022/02/19 10:44:50 [debug] 1099#0: *1593 [lua] init.lua:1004: balancer(): setting address (try 1): 10.105.145.159:8080
2022/02/19 10:44:50 [debug] 1099#0: *1593 [lua] init.lua:1033: balancer(): enabled connection keepalive (pool=10.105.145.159|8080, pool_size=60, idle_timeout=60, max_requests=100)
2022/02/19 10:44:50 [debug] 1099#0: *1459 [lua] init.lua:1004: balancer(): setting address (try 1): 10.32.32.10:8080
2022/02/19 10:44:50 [debug] 1099#0: *1459 [lua] init.lua:1033: balancer(): enabled connection keepalive (pool=10.32.32.10|8080, pool_size=60, idle_timeout=60, max_requests=100)
2022/02/19 10:44:50 [debug] 1098#0: *1559 [lua] targets.lua:431: queryDns(): querying dns for 10.45.0.12
2022/02/19 10:44:50 [debug] 1098#0: *1559 [lua] targets.lua:346: f(): dns record type changed for 10.45.0.12, nil -> 1
2022/02/19 10:44:50 [debug] 1098#0: *1559 [lua] targets.lua:412: f(): updating balancer based on dns changes for 10.45.0.12
2022/02/19 10:44:50 [debug] 1098#0: *1559 [lua] targets.lua:422: f(): querying dns and updating for 10.45.0.12 completed
2022/02/19 10:44:50 [debug] 1098#0: *1559 [lua] targets.lua:431: queryDns(): querying dns for 10.45.0.16
2022/02/19 10:44:50 [debug] 1098#0: *1559 [lua] targets.lua:346: f(): dns record type changed for 10.45.0.16, nil -> 1
2022/02/19 10:44:50 [debug] 1098#0: *1559 [lua] targets.lua:412: f(): updating balancer based on dns changes for 10.45.0.16
2022/02/19 10:44:50 [debug] 1098#0: *1559 [lua] targets.lua:422: f(): querying dns and updating for 10.45.0.16 completed
2022/02/19 10:44:50 [debug] 1098#0: *1559 [lua] targets.lua:431: queryDns(): querying dns for 10.34.160.0
2022/02/19 10:44:50 [debug] 1098#0: *1559 [lua] targets.lua:346: f(): dns record type changed for 10.34.160.0, nil -> 1
2022/02/19 10:44:50 [debug] 1098#0: *1559 [lua] targets.lua:412: f(): updating balancer based on dns changes for 10.34.160.0
2022/02/19 10:44:50 [debug] 1098#0: *1559 [lua] targets.lua:422: f(): querying dns and updating for 10.34.160.0 completed
2022/02/19 10:44:50 [debug] 1098#0: *1559 [lua] targets.lua:431: queryDns(): querying dns for 10.39.32.10
2022/02/19 10:44:50 [debug] 1098#0: *1559 [lua] targets.lua:346: f(): dns record type changed for 10.39.32.10, nil -> 1
2022/02/19 10:44:50 [debug] 1098#0: *1559 [lua] targets.lua:412: f(): updating balancer based on dns changes for 10.39.32.10
2022/02/19 10:44:50 [debug] 1098#0: *1559 [lua] targets.lua:422: f(): querying dns and updating for 10.39.32.10 completed
2022/02/19 10:44:50 [debug] 1098#0: *1559 [lua] healthcheck.lua:1126: log(): [healthcheck] (0dc6f45b-8f8d-40d2-a504-473544ee190b:sdk-config.metrix.8080.svc) Got initial target list (0 targets)
2022/02/19 10:44:50 [debug] 1098#0: *1559 [lua] healthcheck.lua:1126: log(): [healthcheck] (0dc6f45b-8f8d-40d2-a504-473544ee190b:sdk-config.metrix.8080.svc) active check flagged as active
2022/02/19 10:44:50 [debug] 1098#0: *1559 [lua] healthcheck.lua:1126: log(): [healthcheck] (0dc6f45b-8f8d-40d2-a504-473544ee190b:sdk-config.metrix.8080.svc) Healthchecker started!
2022/02/19 10:44:50 [debug] 1098#0: *1559 [lua] targets.lua:431: queryDns(): querying dns for gateway.xxy.svc
5.213.168.83 - - [19/Feb/2022:10:44:50 +0330] "POST /v2/sdk-error-log/ HTTP/2.0" 200 0 "-" "Dalvik/2.1.0 (Linux; U; Android 11; M2010J19CG Build/RKQ1.201004.002)"
2022/02/19 10:44:50 [error] 1098#0: *1325 [lua] balancers.lua:228: get_balancer(): balancer not found for gateway.xxx.8079.svc, will create it, client: 91.133.219.251, server: kong, request: "POST /v1/events/verify HTTP/2.0", host: "xxx.yyy.zzz", referrer: "https://www.xxx.yy/"
2022/02/19 10:44:50 [debug] 1099#0: *1536 [lua] init.lua:1004: balancer(): setting address (try 1): 10.32.0.3:8080
2022/02/19 10:44:50 [debug] 1099#0: *1536 [lua] init.lua:1033: balancer(): enabled connection keepalive (pool=10.32.0.3|8080, pool_size=60, idle_timeout=60, max_requests=100)
2022/02/19 10:44:50 [debug] 1098#0: *1325 [lua] targets.lua:431: queryDns(): querying dns for 10.39.96.6
2022/02/19 10:44:50 [debug] 1098#0: *1325 [lua] targets.lua:346: f(): dns record type changed for 10.39.96.6, nil -> 1
2022/02/19 10:44:50 [debug] 1098#0: *1325 [lua] targets.lua:412: f(): updating balancer based on dns changes for 10.39.96.6
2022/02/19 10:44:50 [debug] 1098#0: *1325 [lua] targets.lua:422: f(): querying dns and updating for 10.39.96.6 completed
2022/02/19 10:44:50 [debug] 1098#0: *1325 [lua] targets.lua:431: queryDns(): querying dns for 10.33.0.7
2022/02/19 10:44:50 [debug] 1098#0: *1325 [lua] targets.lua:346: f(): dns record type changed for 10.33.0.7, nil -> 1
2022/02/19 10:44:50 [debug] 1098#0: *1325 [lua] targets.lua:412: f(): updating balancer based on dns changes for 10.33.0.7
2022/02/19 10:44:50 [debug] 1098#0: *1325 [lua] targets.lua:422: f(): querying dns and updating for 10.33.0.7 completed
2022/02/19 10:44:50 [debug] 1098#0: *1325 [lua] targets.lua:431: queryDns(): querying dns for 10.35.64.4
2022/02/19 10:44:50 [debug] 1099#0: *1399 [lua] init.lua:1004: balancer(): setting address (try 1): 10.100.62.194:80
2022/02/19 10:44:50 [debug] 1099#0: *1399 [lua] init.lua:1033: balancer(): enabled connection keepalive (pool=10.100.62.194|80, pool_size=60, idle_timeout=60, max_requests=100)
kong version 2.7 kubernetes version 1.22
@locao
Is there an existing issue for this?
Kong version (
$ kong version
)2.6
Current Behavior
Hello All,
I have deployed kong recently in our production environment in EKS.
We are continuously getting this error:
Count of this error is close to 10k per day.
Here is the kong ingress controller and proxy image details:
Ingress controller: kong/kubernetes-ingress-controller:1.3 Kong proxy: kong:2.6
Allocated resource to the pods:
We have used below template for deployment:
Let us know if any further info is required
Regards, Shailesh
Expected Behavior
No response
Steps To Reproduce
No response
Anything else?
No response