# Long pauses observed in haproxy logs

**URL:** <https://discourse.haproxy.org/t/long-pauses-observed-in-haproxy-logs/618>\
**Category:** Help!\
**Created:** [August 26, 2016, 9:45pm UTC](https://discourse.haproxy.org/t/long-pauses-observed-in-haproxy-logs/618 "2016-08-26T21:45:26Z")\
**Posts on this page:** 2\
**Page:** 1

<div class="post-metadata">

**Author:** ![mbord](https://avatars.discourse-cdn.com/v4/letter/m/13edae/32.png) [@mbord](https://discourse.haproxy.org/u/mbord)\
**Post date:** [August 26, 2016, 9:45pm UTC](https://discourse.haproxy.org/t/long-pauses-observed-in-haproxy-logs/618/1 "2016-08-26T21:45:26Z")

</div>

Hi,  
I am trying to investigate a application hang where the communication from our app goes through haproxy to the backend database. I was hoping someone could shed some light on what the debug logging means…

During a normal request, I see this:  
Aug 26 17:24:42 orion-lt-01-ibm-292 haproxy29: e[0;36;1mhaproxy.1 | e[0m0000033a:ft\_postgresql.accept(0005)=0013 from [169.44.114.101:49006]  
Aug 26 17:24:42 orion-lt-01-ibm-292 haproxy29: e[0;36;1mhaproxy.1 | e[0m0000033a:bk\_db.srvcls[0013:0014]  
Aug 26 17:24:42 orion-lt-01-ibm-292 haproxy29: e[0;36;1mhaproxy.1 | e[0m0000033a:bk\_db.clicls[0013:0014]  
Aug 26 17:24:42 orion-lt-01-ibm-292 haproxy29: e[0;36;1mhaproxy.1 | e[0m0000033a:bk\_db.closed[0013:0014]

But during the 3minute hang, I see this:  
Aug 26 17:24:42 orion-lt-01-ibm-292 haproxy29: e[0;36;1mhaproxy.1 | e[0m0000033b:ft\_postgresql.accept(0005)=0013 from [169.44.114.101:49060]  
Aug 26 17:25:09 orion-lt-01-ibm-292 haproxy29: e[0;36;1mhaproxy.1 | e[0m0000033c:ft\_postgresql.accept(0005)=0016 from [169.44.14.147:37628]  
Aug 26 17:25:09 orion-lt-01-ibm-292 haproxy29: e[0;36;1mhaproxy.1 | e[0m0000033d:ft\_postgresql.accept(0005)=0017 from [169.44.14.147:37629]  
Aug 26 17:25:40 orion-lt-01-ibm-292 haproxy29: e[0;36;1mhaproxy.1 | e[0m0000033e:ft\_postgresql.accept(0005)=0024 from [169.44.14.147:42686]  
Aug 26 17:25:40 orion-lt-01-ibm-292 haproxy29: e[0;36;1mhaproxy.1 | e[0m0000033f:ft\_postgresql.accept(0005)=0026 from [169.44.14.147:42688]  
Aug 26 17:27:01 orion-lt-01-ibm-292 haproxy29: e[0;36;1mhaproxy.1 | e[0m00000340:GLOBAL.srvcls[0028:ffffffff]  
Aug 26 17:27:01 orion-lt-01-ibm-292 haproxy29: e[0;36;1mhaproxy.1 | e[0m00000340:GLOBAL.clicls[0028:ffffffff]  
Aug 26 17:27:01 orion-lt-01-ibm-292 haproxy29: e[0;36;1mhaproxy.1 | e[0m00000340:GLOBAL.closed[0028:ffffffff]  
Aug 26 17:27:28 orion-lt-01-ibm-292 haproxy29: e[0;36;1mhaproxy.1 | e[0m0000033f:bk\_db.srvcls[0026:0027]  
Aug 26 17:27:28 orion-lt-01-ibm-292 haproxy29: e[0;36;1mhaproxy.1 | e[0m0000033f:bk\_db.clicls[0026:0027]  
Aug 26 17:27:28 orion-lt-01-ibm-292 haproxy29: e[0;36;1mhaproxy.1 | e[0m0000033f:bk\_db.closed[0026:0027]  
Aug 26 17:27:28 orion-lt-01-ibm-292 haproxy29: e[0;36;1mhaproxy.1 | e[0m00000013:bk\_db.srvcls[0029:002b]  
Aug 26 17:27:28 orion-lt-01-ibm-292 haproxy29: e[0;36;1mhaproxy.1 | e[0m00000013:bk\_db.clicls[0029:002b]  
Aug 26 17:27:28 orion-lt-01-ibm-292 haproxy29: e[0;36;1mhaproxy.1 | e[0m00000013:bk\_db.closed[0029:002b]  
Aug 26 17:27:41 orion-lt-01-ibm-292 haproxy29: e[0;36;1mhaproxy.1 | e[0m0000033c:bk\_db.srvcls[0016:0020]  
Aug 26 17:27:41 orion-lt-01-ibm-292 haproxy29: e[0;36;1mhaproxy.1 | e[0m0000033c:bk\_db.clicls[0016:0020]  
Aug 26 17:27:41 orion-lt-01-ibm-292 haproxy29: e[0;36;1mhaproxy.1 | e[0m0000033c:bk\_db.closed[0016:0020]  
Aug 26 17:27:41 orion-lt-01-ibm-292 haproxy29: e[0;36;1mhaproxy.1 | e[0m00000018:bk\_db.srvcls[000a:000b]  
Aug 26 17:27:41 orion-lt-01-ibm-292 haproxy29: e[0;36;1mhaproxy.1 | e[0m00000018:bk\_db.clicls[000a:000b]  
Aug 26 17:27:41 orion-lt-01-ibm-292 haproxy29: e[0;36;1mhaproxy.1 | e[0m00000018:bk\_db.closed[000a:000b]  
Aug 26 17:28:20 orion-lt-01-ibm-292 haproxy29: e[0;36;1mhaproxy.1 | e[0m0000033b:bk\_db.srvcls[0013:0014]  
Aug 26 17:28:20 orion-lt-01-ibm-292 haproxy29: e[0;36;1mhaproxy.1 | e[0m0000033b:bk\_db.clicls[0013:0014]  
Aug 26 17:28:20 orion-lt-01-ibm-292 haproxy29: e[0;36;1mhaproxy.1 | e[0m0000033b:bk\_db.closed[0013:0014]

Can someone interpret this logging and let me know what haproxy is doing during this time?

Thanks!

---

<div class="post-metadata">

**Author:** ![lukastribus](https://avatars.discourse-cdn.com/v4/letter/l/7ea924/32.png) [@lukastribus](https://discourse.haproxy.org/u/lukastribus)\
**Post date:** [September 6, 2016, 2:17pm UTC](https://discourse.haproxy.org/t/long-pauses-observed-in-haproxy-logs/618/2 "2016-09-06T14:17:35Z")

</div>

The debug output is quite useless, please configure http logging instead and provide that output.