/balances and /orders calls are not spaced as expected

I'd expect calls to balances/ and orders/ calls to be 2 seconds apart.
The client apparently does his job of spacing them, however, here is the resulting LOG , filtering the lines that interests us.
14:03:24.976 [qtp61227407-23 - //localhost:4567/orders] WARN  - /orders called [c.n.n.w.LogController:57]
14:03:26.977 [qtp61227407-18 - //localhost:4567/balances] WARN  - /balances called [c.n.n.w.LogController:105]
14:03:28.978 [qtp61227407-18 - //localhost:4567/orders] WARN  - /orders called [c.n.n.w.LogController:57]
14:03:30.979 [qtp61227407-18 - //localhost:4567/balances] WARN  - /balances called [c.n.n.w.LogController:105]
14:03:33.128 [qtp61227407-23 - //localhost:4567/orders] WARN  - /orders called [c.n.n.w.LogController:57]
14:03:35.144 [qtp61227407-71 - //localhost:4567/balances] WARN  - /balances called [c.n.n.w.LogController:105]
14:03:38.523 [qtp61227407-17 - //localhost:4567/orders] WARN  - /orders called [c.n.n.w.LogController:57]
14:03:40.393 [qtp61227407-23 - //localhost:4567/balances] WARN  - /balances called [c.n.n.w.LogController:105]
14:03:43.158 [qtp61227407-70 - //localhost:4567/orders] WARN  - /orders called [c.n.n.w.LogController:57]
14:03:45.379 [qtp61227407-17 - //localhost:4567/balances] WARN  - /balances called [c.n.n.w.LogController:105]
14:03:48.152 [qtp61227407-70 - //localhost:4567/orders] WARN  - /orders called [c.n.n.w.LogController:57]
14:03:50.173 [qtp61227407-17 - //localhost:4567/balances] WARN  - /balances called [c.n.n.w.LogController:105]
14:03:53.168 [qtp61227407-17 - //localhost:4567/orders] WARN  - /orders called [c.n.n.w.LogController:57]
14:03:55.544 [qtp61227407-70 - //localhost:4567/balances] WARN  - /balances called [c.n.n.w.LogController:105]
14:03:58.097 [qtp61227407-70 - //localhost:4567/orders] WARN  - /orders called [c.n.n.w.LogController:57]
14:04:00.403 [qtp61227407-23 - //localhost:4567/balances] WARN  - /balances called [c.n.n.w.LogController:105]
14:04:02.199 [qtp61227407-71 - //localhost:4567/orders] WARN  - /orders called [c.n.n.w.LogController:57]
14:04:05.197 [qtp61227407-71 - //localhost:4567/balances] WARN  - /balances called [c.n.n.w.LogController:105]
14:04:07.096 [qtp61227407-23 - //localhost:4567/orders] WARN  - /orders called [c.n.n.w.LogController:57]
14:04:10.160 [qtp61227407-17 - //localhost:4567/balances] WARN  - /balances called [c.n.n.w.LogController:105]
14:04:11.174 [qtp61227407-70 - //localhost:4567/orders] WARN  - /orders called [c.n.n.w.LogController:57]
14:04:15.527 [qtp61227407-23 - //localhost:4567/balances] WARN  - /balances called [c.n.n.w.LogController:105]
14:04:16.201 [qtp61227407-70 - //localhost:4567/orders] WARN  - /orders called [c.n.n.w.LogController:57]
14:04:20.519 [qtp61227407-71 - //localhost:4567/balances] WARN  - /balances called [c.n.n.w.LogController:105]
14:04:21.194 [qtp61227407-23 - //localhost:4567/orders] WARN  - /orders called [c.n.n.w.LogController:57]
14:04:25.095 [qtp61227407-23 - //localhost:4567/balances] WARN  - /balances called [c.n.n.w.LogController:105]
14:04:26.427 [qtp61227407-17 - //localhost:4567/orders] WARN  - /orders called [c.n.n.w.LogController:57]
14:04:29.162 [qtp61227407-17 - //localhost:4567/balances] WARN  - /balances called [c.n.n.w.LogController:105]
14:04:31.095 [qtp61227407-70 - //localhost:4567/orders] WARN  - /orders called [c.n.n.w.LogController:57]
14:04:34.172 [qtp61227407-70 - //localhost:4567/balances] WARN  - /balances called [c.n.n.w.LogController:105]
14:04:35.496 [qtp61227407-71 - //localhost:4567/orders] WARN  - /orders called [c.n.n.w.LogController:57]
14:04:39.513 [qtp61227407-71 - //localhost:4567/balances] WARN  - /balances called [c.n.n.w.LogController:105]
14:04:40.348 [qtp61227407-23 - //localhost:4567/orders] WARN  - /orders called [c.n.n.w.LogController:57]
14:04:44.504 [qtp61227407-71 - //localhost:4567/balances] WARN  - /balances called [c.n.n.w.LogController:105]
14:04:45.353 [qtp61227407-23 - //localhost:4567/orders] WARN  - /orders called [c.n.n.w.LogController:57]
14:04:49.525 [qtp61227407-70 - //localhost:4567/balances] WARN  - /balances called [c.n.n.w.LogController:105]
14:04:50.337 [qtp61227407-71 - //localhost:4567/orders] WARN  - /orders called [c.n.n.w.LogController:57]
14:04:54.506 [qtp61227407-111 - //localhost:4567/balances] WARN  - /balances called [c.n.n.w.LogController:105]
14:04:55.315 [qtp61227407-70 - //localhost:4567/orders] WARN  - /orders called [c.n.n.w.LogController:57]
14:04:58.507 [qtp61227407-71 - //localhost:4567/balances] WARN  - /balances called [c.n.n.w.LogController:105]
14:04:59.316 [qtp61227407-111 - //localhost:4567/orders] WARN  - /orders called [c.n.n.w.LogController:57]
Why is that? maybe async calls?
Comments (2)
