<p>Some debug output just before the crash</p>
<pre><code>Dec 21 17:17:02 kamailio-1889-0 kamailio[39875]: INFO: <script>: SET_QUEUE_STATUS: user='1018-customer0000' - ci='89374MDk1OWQxYjk0MDFmYzg3MmU3MDA5NjcyMDI3NTRmNDI'
Dec 21 17:17:02 kamailio-1889-0 kamailio[39875]: INFO: <script>: set dispatch to a='asterisk-green-profile1-foerdc.query.consul' b='asterisk-green-profile1-foeedc.query.consul' c='asterisk-blue-profile1-foerdc.query.consul' d='asterisk-blue-profile1-foeedc.query.consul' ci='89374MDk1OWQxYjk0MDFmYzg3MmU3MDA5NjcyMDI3NTRmNDI'
Dec 21 17:17:02 kamailio-1889-0 kamailio[39875]: INFO: <script>: Device State URL is 'http://asterisk-green-profile1-foerdc.query.consul:8088/' - ci='89374MDk1OWQxYjk0MDFmYzg3MmU3MDA5NjcyMDI3NTRmNDI'
Dec 21 17:17:02 kamailio-1889-0 kamailio[39875]: DEBUG: http_async_client [http_async_client_mod.c:476]: set_query_cparam(): param set to 'AriFoehnUser'
Dec 21 17:17:02 kamailio-1889-0 kamailio[39875]: DEBUG: http_async_client [http_async_client_mod.c:476]: set_query_cparam(): param set to 'passwordfake0'
Dec 21 17:17:02 kamailio-1889-0 kamailio[39875]: DEBUG: http_async_client [async_http.c:411]: async_send_query(): no pre-existing transaction, switching to transaction-less behavior
Dec 21 17:17:02 kamailio-1889-0 kamailio[39875]: DEBUG: http_async_client [async_http.c:578]: async_push_query(): query sent [http://asterisk-green-profile1-foerdc.query.consul:8088/ari/deviceStates/Custom:1018-customer0000] (0x7f4b57bc6488) to worker 1
Dec 21 17:17:02 kamailio-1889-0 kamailio[39875]: INFO: <script>: SET_QUEUE_STATUS: Device='1018-customer0000' to be enabled req_id=39875-1076 ci='89374MDk1OWQxYjk0MDFmYzg3MmU3MDA5NjcyMDI3NTRmNDI'
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [async_http.c:348]: notification_socket_cb(): query received: [http://asterisk-green-profile1-foerdc.query.consul:8088/ari/deviceStates/Custom:1018-customer0000] (0x7f4b57bc6488)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:423]: new_request(): received query http://asterisk-green-profile1-foerdc.query.consul:8088/ari/deviceStates/Custom:1018-customer0000 with timeout 100, tls_verify_peer 0, tls_verify_host 0 (param=0x7f4b57bc6488)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-> 0x7f4b57e47c20 (14)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:119]: build_http_m_cell(): hash id for 0x7f4b57e47c20 is 922
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:130]: link_http_m_cell(): linking new cell 0x7f4b57acaff8 to table 0x7f4b57463150 [922]
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:523]: new_request(): set username to AriFoehnUser [authmethod 1]
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:530]: new_request(): Adding easy 0x7f4b57e47c20 to multi 0x7f4b574361e0 (http://asterisk-green-profile1-foerdc.query.consul:8088/ari/deviceStates/Custom:1018-customer0000)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:53]: multi_timer_cb(): multi_timer_cb: Setting timeout to 1 ms
Dec 21 17:17:02 kamailio-1889-0 kamailio[39875]: INFO: <script>: set dispatch to a='asterisk-green-profile1-foerdc.query.consul' b='asterisk-green-profile1-foeedc.query.consul' c='asterisk-blue-profile1-foerdc.query.consul' d='asterisk-blue-profile1-foeedc.query.consul' ci='89374MDk1OWQxYjk0MDFmYzg3MmU3MDA5NjcyMDI3NTRmNDI'
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:67]: timer_cb(): timeout on socket -1
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:161]: sock_cb(): socket callback: s=23 e=0x7f4b57e47c20 what=IN
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:179]: sock_cb(): Adding data: IN
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-> 0x7f4b57e47c20 (14)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:615]: setsock(): added event 0xca8d80 to socket 23
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:53]: multi_timer_cb(): multi_timer_cb: Setting timeout to 1 ms
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:561]: check_multi_info(): REMAINING: 1
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-> 0x7f4b57e47c20 (14)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012
---
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:96]: event_cb(): activity 2 on socket 23: action 1
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:129]: event_cb(): performing action 1 on socket 23
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: HTTP/1.1 200 OK#015#012 [17]
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-> 0x7f4b57e47c20 (14)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e47c20)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: Server: Asterisk/13.17.0#015#012 [26]
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-> 0x7f4b57e47c20 (14)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e47c20)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: Date: Thu, 21 Dec 2017 17:17:02 GMT#015#012 [37]
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-> 0x7f4b57e47c20 (14)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e47c20)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: Cache-Control: no-cache, no-store#015#012 [35]
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-> 0x7f4b57e47c20 (14)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e47c20)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: Content-type: application/json#015#012 [32]
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-> 0x7f4b57e47c20 (14)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e47c20)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: Content-Length: 57#015#012 [20]
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-> 0x7f4b57e47c20 (14)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e47c20)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: #015#012 [2]
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-> 0x7f4b57e47c20 (14)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e47c20)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: {"state":"UNAVAILABLE","name":"Custom:1018-customer0000"} [57]
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-> 0x7f4b57e47c20 (14)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e47c20)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:161]: sock_cb(): socket callback: s=23 e=0x7f4b57e47c20 what=REMOVE
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:166]: sock_cb(): freeing event 0xca8d80
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:131]: event_cb(): action 1 on socket 23 performed
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:561]: check_multi_info(): REMAINING: 0
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:568]: check_multi_info(): DONE: http://asterisk-green-profile1-foerdc.query.consul:8088/ari/deviceStates/Custom:1018-customer0000 => (0) 
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-> 0x7f4b57e47c20 (14)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [async_http.c:135]: async_http_cb(): query result = HTTP/1.1 200 OK#015#012Server: Asterisk/13.17.0#015#012Date: Thu, 21 Dec 2017 17:17:02 GMT#015#012Cache-Control: no-cache, no-store#015#012Content-type: application/json#015#012Content-Length: 57#015#012#015#012{"state":"UNAVAILABLE","name":"Custom:1018-customer0000"} [226]
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [async_http.c:187]: async_http_cb(): successfully parsed http reply 0x7f4b684e20c0
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: INFO: <script>: QUEUE_CHECK_STATUS_OR_SET QueueDevice='1018-customer0000'  is in state='UNAVAILABLE' req_id=39875-1076 ci='123'
Dec 21 17:17:02 kamailio-1889-0 kamailio[39867]: INFO: <script>: SET_QUEUE_STATUS: user='1016-customer0000' - ci='85992MDU2ODE1ZjZkOGI5OTM3ZDAxODBhZWE1MGQwNjkwNzc'
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [async_http.c:411]: async_send_query(): no pre-existing transaction, switching to transaction-less behavior
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [async_http.c:578]: async_push_query(): query sent [http://asterisk-green-profile1-foerdc.query.consul:8088/ari/asterisk/variable] (0x7f4b57a3fde0) to worker 1
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [async_http.h:133]: free_async_query(): freeing query 0x7f4b57bc6488
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:579]: check_multi_info(): reply: [200] HTTP/1.1 200 OK#015#012Server: Asterisk/13.17.0#015#012Date: Thu, 21 Dec 2017 17:17:02 GMT#015#012Cache-Control: no-cache, no-store#015#012Content-type: ap
plication/json#015#012Content-Length: 57#015#012#015#012{"state":"UNAVAILABLE","name":"Custom:1018-customer0000"} [226]
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:584]: check_multi_info(): cleaning up cell 0x7f4b57acaff8
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:589]: check_multi_info(): Removing handle 0x7f4b57e47c20
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:53]: multi_timer_cb(): multi_timer_cb: Setting timeout to -1 ms
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:147]: event_cb(): last transfer done, kill timeout
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [async_http.c:348]: notification_socket_cb(): query received: [http://asterisk-green-profile1-foerdc.query.consul:8088/ari/asterisk/variable] (0x7f4b57a3fde0)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:423]: new_request(): received query http://asterisk-green-profile1-foerdc.query.consul:8088/ari/asterisk/variable with timeout 10000, tls_verify_peer 0, tls_verify_host 0 (param=0x7f4b57a3fde0)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-> 0x7f4b57e47c20 (14)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39867]: INFO: <script>: set dispatch to a='asterisk-green-profile1-foerdc.query.consul' b='asterisk-green-profile1-foeedc.query.consul' c='asterisk-blue-profile1-foerdc.query.consul' d='asterisk-blue-profile1-foeedc.query.consul' ci='85992MDU2ODE1ZjZkOGI5OTM3ZDAxODBhZWE1MGQwNjkwNzc'
Dec 21 17:17:02 kamailio-1889-0 kamailio[39867]: INFO: <script>: Device State URL is 'http://asterisk-green-profile1-foerdc.query.consul:8088/' - ci='85992MDU2ODE1ZjZkOGI5OTM3ZDAxODBhZWE1MGQwNjkwNzc'
Dec 21 17:17:02 kamailio-1889-0 kamailio[39867]: DEBUG: http_async_client [http_async_client_mod.c:476]: set_query_cparam(): param set to 'AriFoehnUser'
Dec 21 17:17:02 kamailio-1889-0 kamailio[39867]: DEBUG: http_async_client [http_async_client_mod.c:476]: set_query_cparam(): param set to 'passwordfake0'
---
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922
Dec 21 17:17:02 kamailio-1889-0 kamailio[39867]: DEBUG: http_async_client [async_http.c:411]: async_send_query(): no pre-existing transaction, switching to transaction-less behavior
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:119]: build_http_m_cell(): hash id for 0x7f4b57e47c20 is 922
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:130]: link_http_m_cell(): linking new cell 0x7f4b57acaff8 to table 0x7f4b57463150 [922]
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:530]: new_request(): Adding easy 0x7f4b57e47c20 to multi 0x7f4b574361e0 (http://asterisk-green-profile1-foerdc.query.consul:8088/ari/asterisk/variable)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39867]: DEBUG: http_async_client [async_http.c:578]: async_push_query(): query sent [http://asterisk-green-profile1-foerdc.query.consul:8088/ari/deviceStates/Custom:1016-customer0000] (0x7f4b57bc6488) to worker 1
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:53]: multi_timer_cb(): multi_timer_cb: Setting timeout to 1 ms
Dec 21 17:17:02 kamailio-1889-0 kamailio[39867]: INFO: <script>: SET_QUEUE_STATUS: Device='1016-customer0000' to be enabled req_id=39867-1065 ci='85992MDU2ODE1ZjZkOGI5OTM3ZDAxODBhZWE1MGQwNjkwNzc'
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [async_http.c:348]: notification_socket_cb(): query received: [http://asterisk-green-profile1-foerdc.query.consul:8088/ari/deviceStates/Custom:1016-customer0000] (0x7f4b57bc6488)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:423]: new_request(): received query http://asterisk-green-profile1-foerdc.query.consul:8088/ari/deviceStates/Custom:1016-customer0000 with timeout 100, tls_verify_peer 0, tls_verify_host 0 (param=0x7f4b57bc6488)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e3ef20 (8)-> 0x7f4b57e3ef20 (14)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e3ef20 is 51
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:119]: build_http_m_cell(): hash id for 0x7f4b57e3ef20 is 51
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:130]: link_http_m_cell(): linking new cell 0x7f4b57c32a08 to table 0x7f4b57463150 [51]
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:523]: new_request(): set username to AriFoehnUser [authmethod 1]
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:530]: new_request(): Adding easy 0x7f4b57e3ef20 to multi 0x7f4b574361e0 (http://asterisk-green-profile1-foerdc.query.consul:8088/ari/deviceStates/Custom:1016-customer0000)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:53]: multi_timer_cb(): multi_timer_cb: Setting timeout to 1 ms
Dec 21 17:17:02 kamailio-1889-0 kamailio[39867]: INFO: <script>: set dispatch to a='asterisk-green-profile1-foerdc.query.consul' b='asterisk-green-profile1-foeedc.query.consul' c='asterisk-blue-profile1-foerdc.query.consul' d='asterisk-blue-profile1-foeedc.query.consul' ci='85992MDU2ODE1ZjZkOGI5OTM3ZDAxODBhZWE1MGQwNjkwNzc'
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:67]: timer_cb(): timeout on socket -1
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:161]: sock_cb(): socket callback: s=23 e=0x7f4b57e3ef20 what=IN
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:179]: sock_cb(): Adding data: IN
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e3ef20 (8)-> 0x7f4b57e3ef20 (14)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e3ef20 is 51
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e3ef20 found on table entry 51#012
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:615]: setsock(): added event 0xca8d80 to socket 23
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:53]: multi_timer_cb(): multi_timer_cb: Setting timeout to 1 ms
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:561]: check_multi_info(): REMAINING: 2
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e3ef20 (8)-> 0x7f4b57e3ef20 (14)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e3ef20 is 51
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e3ef20 found on table entry 51#012
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:96]: event_cb(): activity 2 on socket 23: action 1
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:129]: event_cb(): performing action 1 on socket 23
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: HTTP/1.1 200 OK#015#012 [17]
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e3ef20 (8)-> 0x7f4b57e3ef20 (14)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e3ef20 is 51
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e3ef20 found on table entry 51#012
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e3ef20)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: Server: Asterisk/13.17.0#015#012 [26]
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e3ef20 (8)-> 0x7f4b57e3ef20 (14)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e3ef20 is 51
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e3ef20 found on table entry 51#012
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e3ef20)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: Date: Thu, 21 Dec 2017 17:17:02 GMT#015#012 [37]
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e3ef20 (8)-> 0x7f4b57e3ef20 (14)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e3ef20 is 51
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e3ef20 found on table entry 51#012
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e3ef20)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: Cache-Control: no-cache, no-store#015#012 [35]
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e3ef20 (8)-> 0x7f4b57e3ef20 (14)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e3ef20 is 51
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e3ef20 found on table entry 51#012
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e3ef20)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: Content-type: application/json#015#012 [32]
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e3ef20 (8)-> 0x7f4b57e3ef20 (14)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e3ef20 is 51
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e3ef20 found on table entry 51#012
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e3ef20)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: Content-Length: 55#015#012 [20]
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e3ef20 (8)-> 0x7f4b57e3ef20 (14)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e3ef20 is 51
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e3ef20 found on table entry 51#012
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e3ef20)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: #015#012 [2]
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e3ef20 (8)-> 0x7f4b57e3ef20 (14)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e3ef20 is 51
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e3ef20 found on table entry 51#012
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e3ef20)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: {"state":"NOT_INUSE","name":"Custom:1016-customer0000"} [55]
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e3ef20 (8)-> 0x7f4b57e3ef20 (14)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e3ef20 is 51
---
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e3ef20 found on table entry 51#012
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e3ef20)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:161]: sock_cb(): socket callback: s=23 e=0x7f4b57e3ef20 what=REMOVE
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:166]: sock_cb(): freeing event 0xca8d80
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:131]: event_cb(): action 1 on socket 23 performed
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:561]: check_multi_info(): REMAINING: 1
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:568]: check_multi_info(): DONE: http://asterisk-green-profile1-foerdc.query.consul:8088/ari/deviceStates/Custom:1016-customer0000 => (0) 
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e3ef20 (8)-> 0x7f4b57e3ef20 (14)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e3ef20 is 51
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e3ef20 found on table entry 51#012
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [async_http.c:135]: async_http_cb(): query result = HTTP/1.1 200 OK#015#012Server: Asterisk/13.17.0#015#012Date: Thu, 21 Dec 2017 17:17:02 GMT#015#012Cache-Control: no-cache, no-store#015#012Content-type: app
lication/json#015#012Content-Length: 55#015#012#015#012{"state":"NOT_INUSE","name":"Custom:1016-customer0000"} [224]
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [async_http.c:187]: async_http_cb(): successfully parsed http reply 0x7f4b684e20c0
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: INFO: <script>: QUEUE_CHECK_STATUS_OR_SET QueueDevice='1016-customer0000'  is in state='NOT_INUSE' req_id=39867-1065 ci='123'
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [async_http.h:133]: free_async_query(): freeing query 0x7f4b57bc6488
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:579]: check_multi_info(): reply: [200] HTTP/1.1 200 OK#015#012Server: Asterisk/13.17.0#015#012Date: Thu, 21 Dec 2017 17:17:02 GMT#015#012Cache-Control: no-cache, no-store#015#012Content-type: ap
plication/json#015#012Content-Length: 55#015#012#015#012{"state":"NOT_INUSE","name":"Custom:1016-customer0000"} [224]
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:584]: check_multi_info(): cleaning up cell 0x7f4b57c32a08
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:589]: check_multi_info(): Removing handle 0x7f4b57e3ef20
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:53]: multi_timer_cb(): multi_timer_cb: Setting timeout to 1 ms
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:67]: timer_cb(): timeout on socket -1
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:53]: multi_timer_cb(): multi_timer_cb: Setting timeout to 1 ms
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:561]: check_multi_info(): REMAINING: 1
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:67]: timer_cb(): timeout on socket -1
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:53]: multi_timer_cb(): multi_timer_cb: Setting timeout to 1 ms
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:561]: check_multi_info(): REMAINING: 1
Dec 21 17:17:02 kamailio-1889-0 kamailio[39847]: INFO: <script>: default onreply_route ci='4d37030636fbea05-39875@127.0.0.1' from='sip:1018-customer0000@sip.serverfake.com' to='<null>' method='REGISTER' status='200 src='172.18.241.29:5080'
Dec 21 17:17:02 kamailio-1889-0 kamailio[39857]: INFO: <script>: from NAT address rm='NOTIFY' ci='89374MTk0MmI1OGYyYWVmNTUwYmEwZmM3OGFmZGNlNjdjOTk'
Dec 21 17:17:02 kamailio-1889-0 kamailio[39857]: INFO: <script>: RELAY: method='NOTIFY' ip='172.18.241.29:5080' du='<null>' ru='sip:6B9500CD-5A3BAC99000C4A96-DCE61700@1.2.3.4.5;transport=udp' fu='sip:Unknown@sip.serverfake.com:5080' ci='89374MTk0MmI1OGYyYWVmNTUwYmEwZmM3OGFmZGNlNjdjOTk'
Dec 21 17:17:02 kamailio-1889-0 kamailio[39857]: INFO: <script>: RELAY_BRANCH rm='NOTIFY' - ci='89374MTk0MmI1OGYyYWVmNTUwYmEwZmM3OGFmZGNlNjdjOTk'
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:67]: timer_cb(): timeout on socket -1
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:53]: multi_timer_cb(): multi_timer_cb: Setting timeout to 3 ms
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:561]: check_multi_info(): REMAINING: 1
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:67]: timer_cb(): timeout on socket -1
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:53]: multi_timer_cb(): multi_timer_cb: Setting timeout to 1 ms
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:561]: check_multi_info(): REMAINING: 1
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:67]: timer_cb(): timeout on socket -1
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:161]: sock_cb(): socket callback: s=25 e=0x7f4b57e47c20 what=OUT
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:179]: sock_cb(): Adding data: OUT
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-> 0x7f4b57e47c20 (14)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012
Dec 21 17:17:02 kamailio-1889-0 kamailio[39851]: INFO: <script>: default onreply_route ci='4d37030636fbe9fb-39867@127.0.0.1' from='sip:1016-customer0000@sip.serverfake.com' to='<null>' method='REGISTER' status='200 src='172.18.241.29:5080'
Dec 21 17:17:02 kamailio-1889-0 kamailio[39849]: INFO: <script>: from NAT address rm='NOTIFY' ci='2f7392ee04d01c7f1ca209d4268a9e87@sip.serverfake.com'
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:615]: setsock(): added event 0xca8d80 to socket 25
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:53]: multi_timer_cb(): multi_timer_cb: Setting timeout to 199 ms
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:561]: check_multi_info(): REMAINING: 1
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-> 0x7f4b57e47c20 (14)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:96]: event_cb(): activity 4 on socket 25: action 2
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:129]: event_cb(): performing action 2 on socket 25
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:161]: sock_cb(): socket callback: s=25 e=0x7f4b57e47c20 what=IN
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:184]: sock_cb(): Changing action from OUT to IN
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:615]: setsock(): added event 0xca8d80 to socket 25
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:131]: event_cb(): action 2 on socket 25 performed
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:561]: check_multi_info(): REMAINING: 1
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-> 0x7f4b57e47c20 (14)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:96]: event_cb(): activity 2 on socket 25: action 1
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:129]: event_cb(): performing action 1 on socket 25
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: HTTP/1.1 401 Unauthorized#015#012 [27]
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-> 0x7f4b57e47c20 (14)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e47c20)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: Server: Asterisk/13.17.0#015#012 [26]
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-> 0x7f4b57e47c20 (14)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012
---
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e47c20)
cec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: Date: Thu, 21 Dec 2017 17:17:02 GMT#015#012 [37]
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-> 0x7f4b57e47c20 (14)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e47c20)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: Cache-Control: no-cache, no-store#015#012 [35]
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-> 0x7f4b57e47c20 (14)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922
Dec 21 17:17:02 kamailio-1889-0 kamailio[39849]: INFO: <script>: tenant=<null> call_type='outbound_b' from='sip:Unknown@sip.serverfake.com:5080' to='sip:1016-customer0000@kamailio-leader.query.consul' ci='2f7392ee04d01c7f1ca209d4268a9e87@sip.serverfake.com'
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e47c20)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: WWW-Authenticate: Basic realm="Asterisk REST Interface"#015#012 [57]
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-> 0x7f4b57e47c20 (14)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e47c20)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: Content-type: application/json#015#012 [32]
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-> 0x7f4b57e47c20 (14)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e47c20)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: Content-Length: 37#015#012 [20]
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-> 0x7f4b57e47c20 (14)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e47c20)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: #015#012 [2]
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-> 0x7f4b57e47c20 (14)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39849]: INFO: <script>: RELAY: method='NOTIFY' ip='172.18.241.29:5080' du='<null>' ru='sip:4a64058e38255f44@1.2.3.4.5;transport=udp' fu='sip:Unknown@sip.serverfake.com:5080' ci='2f7392ee04d01c7f1ca209d4268a9e87@sip.serverfake.com'
Dec 21 17:17:02 kamailio-1889-0 kamailio[39849]: INFO: <script>: RELAY_BRANCH rm='NOTIFY' - ci='2f7392ee04d01c7f1ca209d4268a9e87@sip.serverfake.com'
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e47c20)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: {"message":"Authentication required"} [37]
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-> 0x7f4b57e47c20 (14)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e47c20)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:161]: sock_cb(): socket callback: s=25 e=0x7f4b57e47c20 what=REMOVE
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:166]: sock_cb(): freeing event 0xca8d80
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:131]: event_cb(): action 1 on socket 25 performed
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:561]: check_multi_info(): REMAINING: 0
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:568]: check_multi_info(): DONE: http://asterisk-green-profile1-foerdc.query.consul:8088/ari/asterisk/variable => (0) 
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-> 0x7f4b57e47c20 (14)
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [async_http.c:135]: async_http_cb(): query result = HTTP/1.1 401 Unauthorized#015#012Server: Asterisk/13.17.0#015#012Date: Thu, 21 Dec 2017 17:17:02 GMT#015#012Cache-Control: no-cache, no-store#015#012WWW-Aut
henticate: Basic realm="Asterisk REST Interface"#015#012Content-type: application/json#015#012Content-Length: 37#015#012#015#012{"message":"Authentication required"} [273]
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [async_http.c:187]: async_http_cb(): successfully parsed http reply 0x7f4b684e20c0
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: INFO: <script>: HTTP_SET reply correctly req_id='39894-157'
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [async_http.h:133]: free_async_query(): freeing query 0x7f4b57a3fde0
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:579]: check_multi_info(): reply: [401] HTTP/1.1 401 Unauthorized#015#012Server: Asterisk/13.17.0#015#012Date: Thu, 21 Dec 2017 17:17:02 GMT#015#012Cache-Control: no-cache, no-store#015#012WWW-Authenticate: Basic realm="Asterisk REST Interface"#015#012Content-type: application/json#015#012Content-Length: 37#015#012#015#012{"message":"Authentication required"} [273]
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:584]: check_multi_info(): cleaning up cell 0x7f4b57acaff8
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:589]: check_multi_info(): Removing handle 0x7f4b57e47c20
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:53]: multi_timer_cb(): multi_timer_cb: Setting timeout to -1 ms
Dec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:147]: event_cb(): last transfer done, kill timeout
Dec 21 17:17:02 kamailio-1889-0 kamailio[39862]: INFO: <script>: default onreply_route ci='2f7392ee04d01c7f1ca209d4268a9e87@sip.serverfake.com' from='sip:Unknown@sip.serverfake.com:5080' to='<null>' method='NOTIFY' status='200 src='1.2.3.4.5:5060'
Dec 21 17:17:02 kamailio-1889-0 kamailio[39874]: INFO: <script>: default onreply_route ci='89374MTk0MmI1OGYyYWVmNTUwYmEwZmM3OGFmZGNlNjdjOTk' from='sip:Unknown@sip.serverfake.com:5080' to='<null>' method='NOTIFY' status='200 src='1.2.3.4.5:5060'
Dec 21 17:17:05 kamailio-1889-0 kamailio[39866]: ERROR: <script>: auth_challenge error '-4' fu='sip:200-eloy@sip.serverfake.com' ci='84929NTkyYzNmMWFmZDc3NDQ1MGZhN2NhOTM5N2JkOWI1YmQ'
Dec 21 17:17:05 kamailio-1889-0 kamailio[39877]: INFO: <script>: SET_QUEUE_STATUS: user='200-eloy' - ci='84929NTkyYzNmMWFmZDc3NDQ1MGZhN2NhOTM5N2JkOWI1YmQ'
Dec 21 17:17:05 kamailio-1889-0 kamailio[39877]: INFO: <script>: set dispatch to a='asterisk-green-profile1-foeedc.query.consul' b='asterisk-green-profile1-foerdc.query.consul' c='asterisk-blue-profile1-foeedc.query.consul' d='asterisk-blue-profile1-foerdc.query.consul' ci='84929NTkyYzNmMWFmZDc3NDQ1MGZhN2NhOTM5N2JkOWI1YmQ'
Dec 21 17:17:05 kamailio-1889-0 kamailio[39877]: INFO: <script>: Device State URL is 'http://asterisk-green-profile1-foeedc.query.consul:8088/' - ci='84929NTkyYzNmMWFmZDc3NDQ1MGZhN2NhOTM5N2JkOWI1YmQ'
Dec 21 17:17:05 kamailio-1889-0 kamailio[39877]: DEBUG: http_async_client [http_async_client_mod.c:476]: set_query_cparam(): param set to 'AriFoehnUser'
Dec 21 17:17:05 kamailio-1889-0 kamailio[39877]: DEBUG: http_async_client [http_async_client_mod.c:476]: set_query_cparam(): param set to 'passwordfake0'
Dec 21 17:17:05 kamailio-1889-0 kamailio[39877]: DEBUG: http_async_client [async_http.c:411]: async_send_query(): no pre-existing transaction, switching to transaction-less behavior
Dec 21 17:17:05 kamailio-1889-0 kamailio[39877]: : <core> [core/mem/q_malloc.c:483]: qm_free(): BUG: qm_free: freeing already freed pointer (0x7f4b573fb7c8), called from http_async_client: async_http.c: set_query_params(633), first free http_async_client: http_multi.c: curl_shm_free(334) - aborting
Dec 21 17:17:11 kamailio-1889-0 kamailio[39911]: CRITICAL: <core> [core/pass_fd.c:277]: receive_fd(): EOF on 70
Dec 21 17:17:11 kamailio-1889-0 kamailio[39829]: ALERT: <core> [main.c:743]: handle_sigs(): child process 39877 exited by a signal 6
</code></pre>

<p style="font-size:small;-webkit-text-size-adjust:none;color:#666;">—<br />You are receiving this because you are subscribed to this thread.<br />Reply to this email directly, <a href="https://github.com/kamailio/kamailio/issues/1340#issuecomment-353561342">view it on GitHub</a>, or <a href="https://github.com/notifications/unsubscribe-auth/AF36ZVKwEKH0xLvi0Fc66Z2SYCwsK6mIks5tC3mPgaJpZM4Qs2oq">mute the thread</a>.<img alt="" height="1" src="https://github.com/notifications/beacon/AF36ZYFkw4318r2SORx-PZ-yjBZm2AJEks5tC3mPgaJpZM4Qs2oq.gif" width="1" /></p>
<div itemscope itemtype="http://schema.org/EmailMessage">
<div itemprop="action" itemscope itemtype="http://schema.org/ViewAction">
  <link itemprop="url" href="https://github.com/kamailio/kamailio/issues/1340#issuecomment-353561342"></link>
  <meta itemprop="name" content="View Issue"></meta>
</div>
<meta itemprop="description" content="View this Issue on GitHub"></meta>
</div>

<script type="application/json" data-scope="inboxmarkup">{"api_version":"1.0","publisher":{"api_key":"05dde50f1d1a384dd78767c55493e4bb","name":"GitHub"},"entity":{"external_key":"github/kamailio/kamailio","title":"kamailio/kamailio","subtitle":"GitHub repository","main_image_url":"https://cloud.githubusercontent.com/assets/143418/17495839/a5054eac-5d88-11e6-95fc-7290892c7bb5.png","avatar_image_url":"https://cloud.githubusercontent.com/assets/143418/15842166/7c72db34-2c0b-11e6-9aed-b52498112777.png","action":{"name":"Open in GitHub","url":"https://github.com/kamailio/kamailio"}},"updates":{"snippets":[{"icon":"PERSON","message":"@linuxmaniac in #1340: Some debug output just before the crash\r\n```\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39875]: INFO: \u003cscript\u003e: SET_QUEUE_STATUS: user='1018-customer0000' - ci='89374MDk1OWQxYjk0MDFmYzg3MmU3MDA5NjcyMDI3NTRmNDI'\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39875]: INFO: \u003cscript\u003e: set dispatch to a='asterisk-green-profile1-foerdc.query.consul' b='asterisk-green-profile1-foeedc.query.consul' c='asterisk-blue-profile1-foerdc.query.consul' d='asterisk-blue-profile1-foeedc.query.consul' ci='89374MDk1OWQxYjk0MDFmYzg3MmU3MDA5NjcyMDI3NTRmNDI'\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39875]: INFO: \u003cscript\u003e: Device State URL is 'http://asterisk-green-profile1-foerdc.query.consul:8088/' - ci='89374MDk1OWQxYjk0MDFmYzg3MmU3MDA5NjcyMDI3NTRmNDI'\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39875]: DEBUG: http_async_client [http_async_client_mod.c:476]: set_query_cparam(): param set to 'AriFoehnUser'\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39875]: DEBUG: http_async_client [http_async_client_mod.c:476]: set_query_cparam(): param set to 'passwordfake0'\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39875]: DEBUG: http_async_client [async_http.c:411]: async_send_query(): no pre-existing transaction, switching to transaction-less behavior\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39875]: DEBUG: http_async_client [async_http.c:578]: async_push_query(): query sent [http://asterisk-green-profile1-foerdc.query.consul:8088/ari/deviceStates/Custom:1018-customer0000] (0x7f4b57bc6488) to worker 1\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39875]: INFO: \u003cscript\u003e: SET_QUEUE_STATUS: Device='1018-customer0000' to be enabled req_id=39875-1076 ci='89374MDk1OWQxYjk0MDFmYzg3MmU3MDA5NjcyMDI3NTRmNDI'\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [async_http.c:348]: notification_socket_cb(): query received: [http://asterisk-green-profile1-foerdc.query.consul:8088/ari/deviceStates/Custom:1018-customer0000] (0x7f4b57bc6488)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:423]: new_request(): received query http://asterisk-green-profile1-foerdc.query.consul:8088/ari/deviceStates/Custom:1018-customer0000 with timeout 100, tls_verify_peer 0, tls_verify_host 0 (param=0x7f4b57bc6488)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-\u003e 0x7f4b57e47c20 (14)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:119]: build_http_m_cell(): hash id for 0x7f4b57e47c20 is 922\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:130]: link_http_m_cell(): linking new cell 0x7f4b57acaff8 to table 0x7f4b57463150 [922]\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:523]: new_request(): set username to AriFoehnUser [authmethod 1]\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:530]: new_request(): Adding easy 0x7f4b57e47c20 to multi 0x7f4b574361e0 (http://asterisk-green-profile1-foerdc.query.consul:8088/ari/deviceStates/Custom:1018-customer0000)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:53]: multi_timer_cb(): multi_timer_cb: Setting timeout to 1 ms\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39875]: INFO: \u003cscript\u003e: set dispatch to a='asterisk-green-profile1-foerdc.query.consul' b='asterisk-green-profile1-foeedc.query.consul' c='asterisk-blue-profile1-foerdc.query.consul' d='asterisk-blue-profile1-foeedc.query.consul' ci='89374MDk1OWQxYjk0MDFmYzg3MmU3MDA5NjcyMDI3NTRmNDI'\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:67]: timer_cb(): timeout on socket -1\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:161]: sock_cb(): socket callback: s=23 e=0x7f4b57e47c20 what=IN\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:179]: sock_cb(): Adding data: IN\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-\u003e 0x7f4b57e47c20 (14)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:615]: setsock(): added event 0xca8d80 to socket 23\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:53]: multi_timer_cb(): multi_timer_cb: Setting timeout to 1 ms\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:561]: check_multi_info(): REMAINING: 1\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-\u003e 0x7f4b57e47c20 (14)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012\r\n---\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:96]: event_cb(): activity 2 on socket 23: action 1\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:129]: event_cb(): performing action 1 on socket 23\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: HTTP/1.1 200 OK#015#012 [17]\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-\u003e 0x7f4b57e47c20 (14)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e47c20)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: Server: Asterisk/13.17.0#015#012 [26]\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-\u003e 0x7f4b57e47c20 (14)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e47c20)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: Date: Thu, 21 Dec 2017 17:17:02 GMT#015#012 [37]\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-\u003e 0x7f4b57e47c20 (14)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e47c20)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: Cache-Control: no-cache, no-store#015#012 [35]\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-\u003e 0x7f4b57e47c20 (14)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e47c20)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: Content-type: application/json#015#012 [32]\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-\u003e 0x7f4b57e47c20 (14)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e47c20)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: Content-Length: 57#015#012 [20]\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-\u003e 0x7f4b57e47c20 (14)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e47c20)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: #015#012 [2]\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-\u003e 0x7f4b57e47c20 (14)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e47c20)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: {\"state\":\"UNAVAILABLE\",\"name\":\"Custom:1018-customer0000\"} [57]\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-\u003e 0x7f4b57e47c20 (14)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e47c20)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:161]: sock_cb(): socket callback: s=23 e=0x7f4b57e47c20 what=REMOVE\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:166]: sock_cb(): freeing event 0xca8d80\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:131]: event_cb(): action 1 on socket 23 performed\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:561]: check_multi_info(): REMAINING: 0\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:568]: check_multi_info(): DONE: http://asterisk-green-profile1-foerdc.query.consul:8088/ari/deviceStates/Custom:1018-customer0000 =\u003e (0) \r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-\u003e 0x7f4b57e47c20 (14)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [async_http.c:135]: async_http_cb(): query result = HTTP/1.1 200 OK#015#012Server: Asterisk/13.17.0#015#012Date: Thu, 21 Dec 2017 17:17:02 GMT#015#012Cache-Control: no-cache, no-store#015#012Content-type: application/json#015#012Content-Length: 57#015#012#015#012{\"state\":\"UNAVAILABLE\",\"name\":\"Custom:1018-customer0000\"} [226]\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [async_http.c:187]: async_http_cb(): successfully parsed http reply 0x7f4b684e20c0\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: INFO: \u003cscript\u003e: QUEUE_CHECK_STATUS_OR_SET QueueDevice='1018-customer0000'  is in state='UNAVAILABLE' req_id=39875-1076 ci='123'\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39867]: INFO: \u003cscript\u003e: SET_QUEUE_STATUS: user='1016-customer0000' - ci='85992MDU2ODE1ZjZkOGI5OTM3ZDAxODBhZWE1MGQwNjkwNzc'\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [async_http.c:411]: async_send_query(): no pre-existing transaction, switching to transaction-less behavior\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [async_http.c:578]: async_push_query(): query sent [http://asterisk-green-profile1-foerdc.query.consul:8088/ari/asterisk/variable] (0x7f4b57a3fde0) to worker 1\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [async_http.h:133]: free_async_query(): freeing query 0x7f4b57bc6488\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:579]: check_multi_info(): reply: [200] HTTP/1.1 200 OK#015#012Server: Asterisk/13.17.0#015#012Date: Thu, 21 Dec 2017 17:17:02 GMT#015#012Cache-Control: no-cache, no-store#015#012Content-type: ap\r\nplication/json#015#012Content-Length: 57#015#012#015#012{\"state\":\"UNAVAILABLE\",\"name\":\"Custom:1018-customer0000\"} [226]\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:584]: check_multi_info(): cleaning up cell 0x7f4b57acaff8\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:589]: check_multi_info(): Removing handle 0x7f4b57e47c20\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:53]: multi_timer_cb(): multi_timer_cb: Setting timeout to -1 ms\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:147]: event_cb(): last transfer done, kill timeout\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [async_http.c:348]: notification_socket_cb(): query received: [http://asterisk-green-profile1-foerdc.query.consul:8088/ari/asterisk/variable] (0x7f4b57a3fde0)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:423]: new_request(): received query http://asterisk-green-profile1-foerdc.query.consul:8088/ari/asterisk/variable with timeout 10000, tls_verify_peer 0, tls_verify_host 0 (param=0x7f4b57a3fde0)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-\u003e 0x7f4b57e47c20 (14)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39867]: INFO: \u003cscript\u003e: set dispatch to a='asterisk-green-profile1-foerdc.query.consul' b='asterisk-green-profile1-foeedc.query.consul' c='asterisk-blue-profile1-foerdc.query.consul' d='asterisk-blue-profile1-foeedc.query.consul' ci='85992MDU2ODE1ZjZkOGI5OTM3ZDAxODBhZWE1MGQwNjkwNzc'\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39867]: INFO: \u003cscript\u003e: Device State URL is 'http://asterisk-green-profile1-foerdc.query.consul:8088/' - ci='85992MDU2ODE1ZjZkOGI5OTM3ZDAxODBhZWE1MGQwNjkwNzc'\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39867]: DEBUG: http_async_client [http_async_client_mod.c:476]: set_query_cparam(): param set to 'AriFoehnUser'\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39867]: DEBUG: http_async_client [http_async_client_mod.c:476]: set_query_cparam(): param set to 'passwordfake0'\r\n---\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39867]: DEBUG: http_async_client [async_http.c:411]: async_send_query(): no pre-existing transaction, switching to transaction-less behavior\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:119]: build_http_m_cell(): hash id for 0x7f4b57e47c20 is 922\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:130]: link_http_m_cell(): linking new cell 0x7f4b57acaff8 to table 0x7f4b57463150 [922]\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:530]: new_request(): Adding easy 0x7f4b57e47c20 to multi 0x7f4b574361e0 (http://asterisk-green-profile1-foerdc.query.consul:8088/ari/asterisk/variable)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39867]: DEBUG: http_async_client [async_http.c:578]: async_push_query(): query sent [http://asterisk-green-profile1-foerdc.query.consul:8088/ari/deviceStates/Custom:1016-customer0000] (0x7f4b57bc6488) to worker 1\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:53]: multi_timer_cb(): multi_timer_cb: Setting timeout to 1 ms\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39867]: INFO: \u003cscript\u003e: SET_QUEUE_STATUS: Device='1016-customer0000' to be enabled req_id=39867-1065 ci='85992MDU2ODE1ZjZkOGI5OTM3ZDAxODBhZWE1MGQwNjkwNzc'\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [async_http.c:348]: notification_socket_cb(): query received: [http://asterisk-green-profile1-foerdc.query.consul:8088/ari/deviceStates/Custom:1016-customer0000] (0x7f4b57bc6488)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:423]: new_request(): received query http://asterisk-green-profile1-foerdc.query.consul:8088/ari/deviceStates/Custom:1016-customer0000 with timeout 100, tls_verify_peer 0, tls_verify_host 0 (param=0x7f4b57bc6488)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e3ef20 (8)-\u003e 0x7f4b57e3ef20 (14)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e3ef20 is 51\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:119]: build_http_m_cell(): hash id for 0x7f4b57e3ef20 is 51\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:130]: link_http_m_cell(): linking new cell 0x7f4b57c32a08 to table 0x7f4b57463150 [51]\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:523]: new_request(): set username to AriFoehnUser [authmethod 1]\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:530]: new_request(): Adding easy 0x7f4b57e3ef20 to multi 0x7f4b574361e0 (http://asterisk-green-profile1-foerdc.query.consul:8088/ari/deviceStates/Custom:1016-customer0000)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:53]: multi_timer_cb(): multi_timer_cb: Setting timeout to 1 ms\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39867]: INFO: \u003cscript\u003e: set dispatch to a='asterisk-green-profile1-foerdc.query.consul' b='asterisk-green-profile1-foeedc.query.consul' c='asterisk-blue-profile1-foerdc.query.consul' d='asterisk-blue-profile1-foeedc.query.consul' ci='85992MDU2ODE1ZjZkOGI5OTM3ZDAxODBhZWE1MGQwNjkwNzc'\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:67]: timer_cb(): timeout on socket -1\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:161]: sock_cb(): socket callback: s=23 e=0x7f4b57e3ef20 what=IN\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:179]: sock_cb(): Adding data: IN\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e3ef20 (8)-\u003e 0x7f4b57e3ef20 (14)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e3ef20 is 51\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e3ef20 found on table entry 51#012\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:615]: setsock(): added event 0xca8d80 to socket 23\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:53]: multi_timer_cb(): multi_timer_cb: Setting timeout to 1 ms\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:561]: check_multi_info(): REMAINING: 2\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e3ef20 (8)-\u003e 0x7f4b57e3ef20 (14)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e3ef20 is 51\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e3ef20 found on table entry 51#012\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:96]: event_cb(): activity 2 on socket 23: action 1\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:129]: event_cb(): performing action 1 on socket 23\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: HTTP/1.1 200 OK#015#012 [17]\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e3ef20 (8)-\u003e 0x7f4b57e3ef20 (14)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e3ef20 is 51\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e3ef20 found on table entry 51#012\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e3ef20)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: Server: Asterisk/13.17.0#015#012 [26]\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e3ef20 (8)-\u003e 0x7f4b57e3ef20 (14)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e3ef20 is 51\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e3ef20 found on table entry 51#012\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e3ef20)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: Date: Thu, 21 Dec 2017 17:17:02 GMT#015#012 [37]\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e3ef20 (8)-\u003e 0x7f4b57e3ef20 (14)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e3ef20 is 51\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e3ef20 found on table entry 51#012\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e3ef20)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: Cache-Control: no-cache, no-store#015#012 [35]\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e3ef20 (8)-\u003e 0x7f4b57e3ef20 (14)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e3ef20 is 51\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e3ef20 found on table entry 51#012\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e3ef20)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: Content-type: application/json#015#012 [32]\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e3ef20 (8)-\u003e 0x7f4b57e3ef20 (14)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e3ef20 is 51\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e3ef20 found on table entry 51#012\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e3ef20)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: Content-Length: 55#015#012 [20]\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e3ef20 (8)-\u003e 0x7f4b57e3ef20 (14)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e3ef20 is 51\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e3ef20 found on table entry 51#012\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e3ef20)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: #015#012 [2]\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e3ef20 (8)-\u003e 0x7f4b57e3ef20 (14)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e3ef20 is 51\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e3ef20 found on table entry 51#012\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e3ef20)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: {\"state\":\"NOT_INUSE\",\"name\":\"Custom:1016-customer0000\"} [55]\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e3ef20 (8)-\u003e 0x7f4b57e3ef20 (14)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e3ef20 is 51\r\n---\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e3ef20 found on table entry 51#012\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e3ef20)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:161]: sock_cb(): socket callback: s=23 e=0x7f4b57e3ef20 what=REMOVE\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:166]: sock_cb(): freeing event 0xca8d80\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:131]: event_cb(): action 1 on socket 23 performed\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:561]: check_multi_info(): REMAINING: 1\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:568]: check_multi_info(): DONE: http://asterisk-green-profile1-foerdc.query.consul:8088/ari/deviceStates/Custom:1016-customer0000 =\u003e (0) \r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e3ef20 (8)-\u003e 0x7f4b57e3ef20 (14)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e3ef20 is 51\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e3ef20 found on table entry 51#012\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [async_http.c:135]: async_http_cb(): query result = HTTP/1.1 200 OK#015#012Server: Asterisk/13.17.0#015#012Date: Thu, 21 Dec 2017 17:17:02 GMT#015#012Cache-Control: no-cache, no-store#015#012Content-type: app\r\nlication/json#015#012Content-Length: 55#015#012#015#012{\"state\":\"NOT_INUSE\",\"name\":\"Custom:1016-customer0000\"} [224]\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [async_http.c:187]: async_http_cb(): successfully parsed http reply 0x7f4b684e20c0\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: INFO: \u003cscript\u003e: QUEUE_CHECK_STATUS_OR_SET QueueDevice='1016-customer0000'  is in state='NOT_INUSE' req_id=39867-1065 ci='123'\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [async_http.h:133]: free_async_query(): freeing query 0x7f4b57bc6488\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:579]: check_multi_info(): reply: [200] HTTP/1.1 200 OK#015#012Server: Asterisk/13.17.0#015#012Date: Thu, 21 Dec 2017 17:17:02 GMT#015#012Cache-Control: no-cache, no-store#015#012Content-type: ap\r\nplication/json#015#012Content-Length: 55#015#012#015#012{\"state\":\"NOT_INUSE\",\"name\":\"Custom:1016-customer0000\"} [224]\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:584]: check_multi_info(): cleaning up cell 0x7f4b57c32a08\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:589]: check_multi_info(): Removing handle 0x7f4b57e3ef20\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:53]: multi_timer_cb(): multi_timer_cb: Setting timeout to 1 ms\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:67]: timer_cb(): timeout on socket -1\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:53]: multi_timer_cb(): multi_timer_cb: Setting timeout to 1 ms\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:561]: check_multi_info(): REMAINING: 1\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:67]: timer_cb(): timeout on socket -1\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:53]: multi_timer_cb(): multi_timer_cb: Setting timeout to 1 ms\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:561]: check_multi_info(): REMAINING: 1\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39847]: INFO: \u003cscript\u003e: default onreply_route ci='4d37030636fbea05-39875@127.0.0.1' from='sip:1018-customer0000@sip.serverfake.com' to='\u003cnull\u003e' method='REGISTER' status='200 src='172.18.241.29:5080'\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39857]: INFO: \u003cscript\u003e: from NAT address rm='NOTIFY' ci='89374MTk0MmI1OGYyYWVmNTUwYmEwZmM3OGFmZGNlNjdjOTk'\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39857]: INFO: \u003cscript\u003e: RELAY: method='NOTIFY' ip='172.18.241.29:5080' du='\u003cnull\u003e' ru='sip:6B9500CD-5A3BAC99000C4A96-DCE61700@1.2.3.4.5;transport=udp' fu='sip:Unknown@sip.serverfake.com:5080' ci='89374MTk0MmI1OGYyYWVmNTUwYmEwZmM3OGFmZGNlNjdjOTk'\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39857]: INFO: \u003cscript\u003e: RELAY_BRANCH rm='NOTIFY' - ci='89374MTk0MmI1OGYyYWVmNTUwYmEwZmM3OGFmZGNlNjdjOTk'\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:67]: timer_cb(): timeout on socket -1\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:53]: multi_timer_cb(): multi_timer_cb: Setting timeout to 3 ms\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:561]: check_multi_info(): REMAINING: 1\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:67]: timer_cb(): timeout on socket -1\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:53]: multi_timer_cb(): multi_timer_cb: Setting timeout to 1 ms\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:561]: check_multi_info(): REMAINING: 1\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:67]: timer_cb(): timeout on socket -1\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:161]: sock_cb(): socket callback: s=25 e=0x7f4b57e47c20 what=OUT\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:179]: sock_cb(): Adding data: OUT\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-\u003e 0x7f4b57e47c20 (14)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39851]: INFO: \u003cscript\u003e: default onreply_route ci='4d37030636fbe9fb-39867@127.0.0.1' from='sip:1016-customer0000@sip.serverfake.com' to='\u003cnull\u003e' method='REGISTER' status='200 src='172.18.241.29:5080'\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39849]: INFO: \u003cscript\u003e: from NAT address rm='NOTIFY' ci='2f7392ee04d01c7f1ca209d4268a9e87@sip.serverfake.com'\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:615]: setsock(): added event 0xca8d80 to socket 25\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:53]: multi_timer_cb(): multi_timer_cb: Setting timeout to 199 ms\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:561]: check_multi_info(): REMAINING: 1\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-\u003e 0x7f4b57e47c20 (14)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:96]: event_cb(): activity 4 on socket 25: action 2\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:129]: event_cb(): performing action 2 on socket 25\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:161]: sock_cb(): socket callback: s=25 e=0x7f4b57e47c20 what=IN\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:184]: sock_cb(): Changing action from OUT to IN\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:615]: setsock(): added event 0xca8d80 to socket 25\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:131]: event_cb(): action 2 on socket 25 performed\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:561]: check_multi_info(): REMAINING: 1\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-\u003e 0x7f4b57e47c20 (14)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:96]: event_cb(): activity 2 on socket 25: action 1\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:129]: event_cb(): performing action 1 on socket 25\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: HTTP/1.1 401 Unauthorized#015#012 [27]\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-\u003e 0x7f4b57e47c20 (14)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e47c20)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: Server: Asterisk/13.17.0#015#012 [26]\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-\u003e 0x7f4b57e47c20 (14)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012\r\n---\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e47c20)\r\ncec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: Date: Thu, 21 Dec 2017 17:17:02 GMT#015#012 [37]\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-\u003e 0x7f4b57e47c20 (14)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e47c20)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: Cache-Control: no-cache, no-store#015#012 [35]\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-\u003e 0x7f4b57e47c20 (14)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39849]: INFO: \u003cscript\u003e: tenant=\u003cnull\u003e call_type='outbound_b' from='sip:Unknown@sip.serverfake.com:5080' to='sip:1016-customer0000@kamailio-leader.query.consul' ci='2f7392ee04d01c7f1ca209d4268a9e87@sip.serverfake.com'\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e47c20)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: WWW-Authenticate: Basic realm=\"Asterisk REST Interface\"#015#012 [57]\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-\u003e 0x7f4b57e47c20 (14)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e47c20)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: Content-type: application/json#015#012 [32]\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-\u003e 0x7f4b57e47c20 (14)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e47c20)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: Content-Length: 37#015#012 [20]\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-\u003e 0x7f4b57e47c20 (14)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e47c20)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: #015#012 [2]\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-\u003e 0x7f4b57e47c20 (14)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39849]: INFO: \u003cscript\u003e: RELAY: method='NOTIFY' ip='172.18.241.29:5080' du='\u003cnull\u003e' ru='sip:4a64058e38255f44@1.2.3.4.5;transport=udp' fu='sip:Unknown@sip.serverfake.com:5080' ci='2f7392ee04d01c7f1ca209d4268a9e87@sip.serverfake.com'\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39849]: INFO: \u003cscript\u003e: RELAY_BRANCH rm='NOTIFY' - ci='2f7392ee04d01c7f1ca209d4268a9e87@sip.serverfake.com'\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e47c20)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:249]: write_cb(): data received: {\"message\":\"Authentication required\"} [37]\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-\u003e 0x7f4b57e47c20 (14)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:289]: write_cb(): getting easy handler info (0x7f4b57e47c20)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:161]: sock_cb(): socket callback: s=25 e=0x7f4b57e47c20 what=REMOVE\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:166]: sock_cb(): freeing event 0xca8d80\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:131]: event_cb(): action 1 on socket 25 performed\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:561]: check_multi_info(): REMAINING: 0\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:568]: check_multi_info(): DONE: http://asterisk-green-profile1-foerdc.query.consul:8088/ari/asterisk/variable =\u003e (0) \r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:80]: build_hash_key(): received id 0x7f4b57e47c20 (8)-\u003e 0x7f4b57e47c20 (14)\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:93]: build_hash_key(): hash for 0x7f4b57e47c20 is 922\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [hm_hash.c:157]: http_m_cell_lookup(): http_m_cell with easy=0x7f4b57e47c20 found on table entry 922#012\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [async_http.c:135]: async_http_cb(): query result = HTTP/1.1 401 Unauthorized#015#012Server: Asterisk/13.17.0#015#012Date: Thu, 21 Dec 2017 17:17:02 GMT#015#012Cache-Control: no-cache, no-store#015#012WWW-Aut\r\nhenticate: Basic realm=\"Asterisk REST Interface\"#015#012Content-type: application/json#015#012Content-Length: 37#015#012#015#012{\"message\":\"Authentication required\"} [273]\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [async_http.c:187]: async_http_cb(): successfully parsed http reply 0x7f4b684e20c0\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: INFO: \u003cscript\u003e: HTTP_SET reply correctly req_id='39894-157'\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [async_http.h:133]: free_async_query(): freeing query 0x7f4b57a3fde0\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:579]: check_multi_info(): reply: [401] HTTP/1.1 401 Unauthorized#015#012Server: Asterisk/13.17.0#015#012Date: Thu, 21 Dec 2017 17:17:02 GMT#015#012Cache-Control: no-cache, no-store#015#012WWW-Authenticate: Basic realm=\"Asterisk REST Interface\"#015#012Content-type: application/json#015#012Content-Length: 37#015#012#015#012{\"message\":\"Authentication required\"} [273]\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:584]: check_multi_info(): cleaning up cell 0x7f4b57acaff8\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:589]: check_multi_info(): Removing handle 0x7f4b57e47c20\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:53]: multi_timer_cb(): multi_timer_cb: Setting timeout to -1 ms\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39894]: DEBUG: http_async_client [http_multi.c:147]: event_cb(): last transfer done, kill timeout\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39862]: INFO: \u003cscript\u003e: default onreply_route ci='2f7392ee04d01c7f1ca209d4268a9e87@sip.serverfake.com' from='sip:Unknown@sip.serverfake.com:5080' to='\u003cnull\u003e' method='NOTIFY' status='200 src='1.2.3.4.5:5060'\r\nDec 21 17:17:02 kamailio-1889-0 kamailio[39874]: INFO: \u003cscript\u003e: default onreply_route ci='89374MTk0MmI1OGYyYWVmNTUwYmEwZmM3OGFmZGNlNjdjOTk' from='sip:Unknown@sip.serverfake.com:5080' to='\u003cnull\u003e' method='NOTIFY' status='200 src='1.2.3.4.5:5060'\r\nDec 21 17:17:05 kamailio-1889-0 kamailio[39866]: ERROR: \u003cscript\u003e: auth_challenge error '-4' fu='sip:200-eloy@sip.serverfake.com' ci='84929NTkyYzNmMWFmZDc3NDQ1MGZhN2NhOTM5N2JkOWI1YmQ'\r\nDec 21 17:17:05 kamailio-1889-0 kamailio[39877]: INFO: \u003cscript\u003e: SET_QUEUE_STATUS: user='200-eloy' - ci='84929NTkyYzNmMWFmZDc3NDQ1MGZhN2NhOTM5N2JkOWI1YmQ'\r\nDec 21 17:17:05 kamailio-1889-0 kamailio[39877]: INFO: \u003cscript\u003e: set dispatch to a='asterisk-green-profile1-foeedc.query.consul' b='asterisk-green-profile1-foerdc.query.consul' c='asterisk-blue-profile1-foeedc.query.consul' d='asterisk-blue-profile1-foerdc.query.consul' ci='84929NTkyYzNmMWFmZDc3NDQ1MGZhN2NhOTM5N2JkOWI1YmQ'\r\nDec 21 17:17:05 kamailio-1889-0 kamailio[39877]: INFO: \u003cscript\u003e: Device State URL is 'http://asterisk-green-profile1-foeedc.query.consul:8088/' - ci='84929NTkyYzNmMWFmZDc3NDQ1MGZhN2NhOTM5N2JkOWI1YmQ'\r\nDec 21 17:17:05 kamailio-1889-0 kamailio[39877]: DEBUG: http_async_client [http_async_client_mod.c:476]: set_query_cparam(): param set to 'AriFoehnUser'\r\nDec 21 17:17:05 kamailio-1889-0 kamailio[39877]: DEBUG: http_async_client [http_async_client_mod.c:476]: set_query_cparam(): param set to 'passwordfake0'\r\nDec 21 17:17:05 kamailio-1889-0 kamailio[39877]: DEBUG: http_async_client [async_http.c:411]: async_send_query(): no pre-existing transaction, switching to transaction-less behavior\r\nDec 21 17:17:05 kamailio-1889-0 kamailio[39877]: : \u003ccore\u003e [core/mem/q_malloc.c:483]: qm_free(): BUG: qm_free: freeing already freed pointer (0x7f4b573fb7c8), called from http_async_client: async_http.c: set_query_params(633), first free http_async_client: http_multi.c: curl_shm_free(334) - aborting\r\nDec 21 17:17:11 kamailio-1889-0 kamailio[39911]: CRITICAL: \u003ccore\u003e [core/pass_fd.c:277]: receive_fd(): EOF on 70\r\nDec 21 17:17:11 kamailio-1889-0 kamailio[39829]: ALERT: \u003ccore\u003e [main.c:743]: handle_sigs(): child process 39877 exited by a signal 6\r\n```"}],"action":{"name":"View Issue","url":"https://github.com/kamailio/kamailio/issues/1340#issuecomment-353561342"}}}</script>