{ "_id":"_design/global_resources", "_rev":"68-efb5ca6765817fd73e6f93a2617cf4fd", "language":"javascript", "views":{ "}crossbar_listing":{ "}map":"function(doc) { if (doc.pvt_type != 'resource' || doc.pvt_deleted) return; emit(doc._id, {'id': doc._id, 'name': doc.name, 'enabled': doc.enabled, 'weight': doc.weight_cost}); }"}{ "_id":"_design/resources", "_rev":"1-2e4b6a0741420eb999a8bd10174a4219", "language":"javascript", "views":{ "}listing_active_by_weigth":{ ", "map":"function(doc) { if (doc.pvt_type != 'resource' || ! doc.enabled || doc.pvt_deleted) return; emit([doc.weight_cost, doc._id], doc.name); }"}listing_by_id":{ "}map":"function(doc) { if (doc.pvt_type != 'resource' || doc.pvt_deleted) return; emit(doc._id, doc.name); }"}
I have three test installations for now.
- One installation is operated by apps.2600hz.com. And outbound calls were functioning. Actually I erased databases a day ago and didn't set up all the needed documents back yet.
- Second one: accounts are created over crossbar. Latest Winkstart from github used. Everything works fine except outbound calls. The new method to choose in Winkstart which carrier to use seems to be not finished yet. And while trying to create "no_match" callflow I'am receiving an error.
- The third installation indicates the current problem with Cluster Manager. Clicking the Update link makes nothing. Actually all my three installations can not be updated at the moment because of that trouble.
Kind regards,
Kirill
FORMAT_ERROR is ignorable; those are log lines that failed to be
formatted properly (a known bug that will be patched in the next
release). It does not affect anything though.
- --
James Aimonetti
Distributed Systems Engineer / DJ MC_
2600hz | http://2600hz.com
sip:ja...@2600hz.com
tel: 415.886.7905
-----BEGIN PGP SIGNATURE-----
Version: GnuPG v1.4.10 (GNU/Linux)
Comment: Using GnuPG with Mozilla - http://enigmail.mozdev.org/
iQEcBAEBAgAGBQJPjzgZAAoJENc77s1OYoGgUOMH/2WW+k8JMReAT2YIr3Eih2Bq
fn7Xj3irFKY6+DmCKrIZpUOFbsXE+o8yiDgEbu3u2sbcJUazPYklTRY8Q27byyqb
RBId+a2nj8LGiUnzbOjM22rNzVF/CAC5JgQqTr63lpM0gigRtQhCqDJwwWzDFGCd
bRrjkPyE/ABhVmE25A6TyB8t1iQzTb+jn5OncMzTqKWurPe6X0mnhPcx1AExbnbm
+KBoJQPtSRyTzREvGsjKRFvvzTwK4h7IXssyv+CLlAyEFT2wedAw7UETehaQOYiI
VfaUq+QLwQT2WcXmUjtjm8cWAUihqpDx62+gErofSto4JPPD35vXFuAYTsjCHnQ=
=D2q4
-----END PGP SIGNATURE-----
Apr 24 12:51:55 w1 whistle_apps[4913]: |4adf44a2...@192.168.1.138|cf_route_req:20 (<0.992.0>) received route requestApr 24 12:51:55 w1 whistle_apps[4913]: |4adf44a2...@192.168.1.138|cf_util:281 (<0.992.0>) searching for callflow in account%2Fc8%2Fb0%2Ff6f8fc69794c095f1b2ac241a88e to satisfy '78129169944'Apr 24 12:51:55 w1 whistle_apps[4913]: |4adf44a2...@192.168.1.138|cf_util:318 (<0.992.0>) lookup callflow patterns for 78129169944 in account%2Fc8%2Fb0%2Ff6f8fc69794c095f1b2ac241a88eApr 24 12:51:55 w1 whistle_apps[4913]: |4adf44a2...@192.168.1.138|cf_util:281 (<0.992.0>) searching for callflow in account%2Fc8%2Fb0%2Ff6f8fc69794c095f1b2ac241a88e to satisfy 'no_match'Apr 24 12:51:55 w1 whistle_apps[4913]: |4adf44a2...@192.168.1.138|cf_route_req:23 (<0.992.0>) callflow 4a045948b6ed9e99563c86992467f4f5 in c8b0f6f8fc69794c095f1b2ac241a88e satisfies requestApr 24 12:51:55 w1 whistle_apps[4913]: |4adf44a2...@192.168.1.138|cf_route_req:79 (<0.992.0>) sent route response to park the callApr 24 12:51:55 w1 whistle_apps[4913]: <0.1003.0> CRASH REPORT Process <0.1003.0> with 0 neighbours crashed with reason: {badmatch,false}Apr 24 12:51:55 w1 whistle_apps[4913]: <0.456.0> Supervisor ts_onnet_sup had child <<"onnet-onnet-4a...@192.168.1.138">> started with {ts_from_onnet,start_link,undefined} at <0.1003.0> exit with reason {badmatch,false} in context child_terminated
[root@w1 ~]# cat /var/log/2600hz-platform.log
Apr 24 17:39:22 w1 2600hz[26798]: |frees...@w6.onnet.su|ecallmgr_fs_auth:120 (<0.762.0>) received fetch request for INVITE (567b3bf2-5a58-4249-a630-8782eb8f9987) user creds from frees...@w6.onnet.suApr 24 17:39:22 w1 2600hz[26798]: |567b3bf2-5a58-4249-a630-8782eb8f9987|ecallmgr_fs_auth:250 (<0.1276.0>) looking up credentials of user_...@office.sip2.onnet.su for a INVITEApr 24 17:39:22 w1 whistle_apps[26557]: |567b3bf2-5a58-4249-a630-8782eb8f9987|reg_authn_req:24 (<0.5005.0>) received SIP authentication requestApr 24 17:39:22 w1 whistle_apps[26557]: |567b3bf2-5a58-4249-a630-8782eb8f9987|reg_util:102 (<0.5005.0>) looking up auth creds for user_...@office.sip2.onnet.suApr 24 17:39:22 w1 whistle_apps[26557]: |567b3bf2-5a58-4249-a630-8782eb8f9987|wh_util:107 (<0.5005.0>) account c8b0f6f8fc69794c095f1b2ac241a88e enabled flag is trueApr 24 17:39:22 w1 whistle_apps[26557]: |567b3bf2-5a58-4249-a630-8782eb8f9987|reg_util:124 (<0.5005.0>) pulling auth user from cacheApr 24 17:39:22 w1 whistle_apps[26557]: |567b3bf2-5a58-4249-a630-8782eb8f9987|reg_authn_req:63 (<0.5005.0>) sending SIP authentication reply, with credentialsApr 24 17:39:22 w1 2600hz[26798]: |567b3bf2-5a58-4249-a630-8782eb8f9987|ecallmgr_fs_auth:258 (<0.1276.0>) received authn_respApr 24 17:39:22 w1 2600hz[26798]: |567b3bf2-5a58-4249-a630-8782eb8f9987|ecallmgr_fs_auth:263 (<0.1276.0>) sending XML to 'frees...@w6.onnet.su': <document type="freeswitch/xml">#012 <section name="directory">#012 <domain name="office.sip2.onnet.su">#012 <user id="user_mfwcdo">#012 <params>#012 <param name="password" value="lyh0ygfohojs"/>#012 </params>#012 <variables>#012 <variable name="ecallmgr_Authorizing-ID" value="ea9869047a369924ef4b8de9bd23f9af" />#012 <variable name="ecallmgr_Inception" value="on-net" />#012 <variable name="ecallmgr_Authorizing-Type" value="device" />#012 <variable name="ecallmgr_Account-ID" value="c8b0f6f8fc69794c095f1b2ac241a88e" />#012 <variable name="ecallmgr_Realm" value="office.sip2.onnet.su" />#012 <variable name="ecallmgr_Username" value="user_mfwcdo" />#012#012 </variables>#012 </user>#012 </domain>#012 </section>#012</document>Apr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|cf_route_req:20 (<0.5010.0>) received route requestApr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|ts_route_req:31 (<0.5012.0>) onnet call startingApr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|cf_util:281 (<0.5010.0>) searching for callflow in account%2Fc8%2Fb0%2Ff6f8fc69794c095f1b2ac241a88e to satisfy '78129169944'Apr 24 17:39:22 w1 whistle_apps[26557]: <0.5013.0> CRASH REPORT Process <0.5013.0> with 0 neighbours crashed with reason: {badmatch,false}Apr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|cf_util:318 (<0.5010.0>) lookup callflow patterns for 78129169944 in account%2Fc8%2Fb0%2Ff6f8fc69794c095f1b2ac241a88eApr 24 17:39:22 w1 whistle_apps[26557]: <0.472.0> Supervisor ts_onnet_sup started ts_from_onnet:start_link({struct,[{<<"Custom-Channel-Vars">>,{struct,[{<<"Username">>,<<"user_mfwcdo">>},{<<"Realm">>,<<...>>},...]}},...]}) at pid <0.5013.0>Apr 24 17:39:22 w1 whistle_apps[26557]: <0.472.0> Supervisor ts_onnet_sup had child <<"onnet-onnet-5f...@192.168.1.138">> started with {ts_from_onnet,start_link,undefined} at <0.5013.0> exit with reason {badmatch,false} in context child_terminatedApr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|cf_util:281 (<0.5010.0>) searching for callflow in account%2Fc8%2Fb0%2Ff6f8fc69794c095f1b2ac241a88e to satisfy 'no_match'Apr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|cf_route_req:23 (<0.5010.0>) callflow 4a045948b6ed9e99563c8699248e0ba2 in c8b0f6f8fc69794c095f1b2ac241a88e satisfies requestApr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|cf_route_req:79 (<0.5010.0>) sent route response to park the callApr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|cf_route_win:20 (<0.5021.0>) received route winApr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|cf_route_win:23 (<0.5021.0>) bootstrapping callflow executerApr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|cf_attributes:324 (<0.5021.0>) object ea9869047a369924ef4b8de9bd23f9af is owned by 9434ae56ddd87cdecf4d6f68c813f027Apr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|cf_attributes:117 (<0.5021.0>) find external caller id on ea9869047a369924ef4b8de9bd23f9af, 9434ae56ddd87cdecf4d6f68c813f027, c8b0f6f8fc69794c095f1b2ac241a88eApr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|cf_attributes:129 (<0.5021.0>) found external caller id on ea9869047a369924ef4b8de9bd23f9afApr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|cf_attributes:385 (<0.5021.0>) find friendly name on 9434ae56ddd87cdecf4d6f68c813f027, ea9869047a369924ef4b8de9bd23f9afApr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|cf_attributes:392 (<0.5021.0>) using name 'Office Administrator' from 9434ae56ddd87cdecf4d6f68c813f027Apr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|cf_attributes:142 (<0.5021.0>) attempting to prepend caller id 78124906700 'Office Administrator'Apr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|cf_attributes:146 (<0.5021.0>) using caller id 78124906700 'Office Administrator'Apr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|cf_attributes:324 (<0.5021.0>) object ea9869047a369924ef4b8de9bd23f9af is owned by 9434ae56ddd87cdecf4d6f68c813f027Apr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|cf_attributes:289 (<0.5021.0>) find moh attr media_id on ea9869047a369924ef4b8de9bd23f9af, 9434ae56ddd87cdecf4d6f68c813f027, c8b0f6f8fc69794c095f1b2ac241a88eApr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|cf_attributes:293 (<0.5021.0>) unable to find moh attribute media_idApr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|cf_route_win:52 (<0.5021.0>) call has been setup, passing control to callflow executerApr 24 17:39:22 w1 whistle_apps[26557]: |00000000000|gen_listener:198 (<0.5025.0>) starting new gen_listener proc: cf_exeApr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|cf_exe:229 (<0.5025.0>) executing callflow 4a045948b6ed9e99563c8699248e0ba2Apr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|cf_exe:230 (<0.5025.0>) account id c8b0f6f8fc69794c095f1b2ac241a88eApr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|cf_exe:231 (<0.5025.0>) request 78129...@office.sip2.onnet.suApr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|cf_exe:232 (<0.5025.0>) to 78129...@office.sip2.onnet.suApr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|cf_exe:233 (<0.5025.0>) from user_...@office.sip2.onnet.suApr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|cf_exe:234 (<0.5025.0>) CID Office Administrator 78124906700Apr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|cf_exe:235 (<0.5025.0>) inception on-netApr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|cf_exe:236 (<0.5025.0>) authorizing id ea9869047a369924ef4b8de9bd23f9afApr 24 17:39:22 w1 whistle_apps[26557]: <0.5028.0> Supervisor amqp_channel_sup started undefined at pid <0.5029.0>Apr 24 17:39:22 w1 whistle_apps[26557]: <0.5028.0> Supervisor amqp_channel_sup started undefined at pid <0.5030.0>Apr 24 17:39:22 w1 whistle_apps[26557]: <0.5028.0> Supervisor amqp_channel_sup started undefined at pid <0.5031.0>Apr 24 17:39:22 w1 whistle_apps[26557]: |00000000000|amqp_host:559 (<0.119.0>) Opened channel <0.5030.0>Apr 24 17:39:22 w1 whistle_apps[26557]: |00000000000|amqp_host:574 (<0.119.0>) Started channel <0.5030.0> for caller <0.5025.0>Apr 24 17:39:22 w1 whistle_apps[26557]: |00000000000|amqp_host:208 (<0.119.0>) Channel <0.5030.0> exists for proc <0.5025.0>, but we aren't consuming yetApr 24 17:39:22 w1 whistle_apps[26557]: |00000000000|amqp_host:466 (<0.5034.0>) sending exchange.declare to <0.126.0> (federated: false)Apr 24 17:39:22 w1 whistle_apps[26557]: |00000000000|amqp_host:469 (<0.5034.0>) exchange declaredApr 24 17:39:22 w1 whistle_apps[26557]: |00000000000|amqp_host:466 (<0.5036.0>) sending exchange.declare to <0.126.0> (federated: false)Apr 24 17:39:22 w1 whistle_apps[26557]: |00000000000|amqp_host:469 (<0.5036.0>) exchange declaredApr 24 17:39:22 w1 whistle_apps[26557]: |00000000000|amqp_host:466 (<0.5042.0>) sending exchange.declare to <0.126.0> (federated: false)Apr 24 17:39:22 w1 whistle_apps[26557]: |00000000000|amqp_host:469 (<0.5042.0>) exchange declaredApr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|gen_listener:413 (<0.5025.0>) consuming from our queueApr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|cf_exe:479 (<0.5025.0>) moving to action cf_offnetApr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|cf_attributes:117 (<0.5046.0>) find emergency caller id on ea9869047a369924ef4b8de9bd23f9af, 9434ae56ddd87cdecf4d6f68c813f027, c8b0f6f8fc69794c095f1b2ac241a88eApr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|cf_attributes:385 (<0.5046.0>) find friendly name on 9434ae56ddd87cdecf4d6f68c813f027, ea9869047a369924ef4b8de9bd23f9afApr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|cf_attributes:392 (<0.5046.0>) using name 'Office Administrator' from 9434ae56ddd87cdecf4d6f68c813f027Apr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|cf_attributes:142 (<0.5046.0>) attempting to prepend caller id 78124906700 'Office Administrator'Apr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|cf_attributes:146 (<0.5046.0>) using caller id 78124906700 'Office Administrator'Apr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|cf_attributes:117 (<0.5046.0>) find external caller id on ea9869047a369924ef4b8de9bd23f9af, 9434ae56ddd87cdecf4d6f68c813f027, c8b0f6f8fc69794c095f1b2ac241a88eApr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|cf_attributes:129 (<0.5046.0>) found external caller id on ea9869047a369924ef4b8de9bd23f9afApr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|cf_attributes:385 (<0.5046.0>) find friendly name on 9434ae56ddd87cdecf4d6f68c813f027, ea9869047a369924ef4b8de9bd23f9afApr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|cf_attributes:392 (<0.5046.0>) using name 'Office Administrator' from 9434ae56ddd87cdecf4d6f68c813f027Apr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|cf_attributes:142 (<0.5046.0>) attempting to prepend caller id 78124906700 'Office Administrator'Apr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|cf_attributes:146 (<0.5046.0>) using caller id 78124906700 'Office Administrator'Apr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|stepswitch_outbound:35 (<0.5050.0>) received outbound requestApr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|whapps_config:217 (<0.5050.0>) fetched config stepswitch(default) [<<"outbound_user_field">>]: <<"Request">>Apr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|stepswitch_outbound:39 (<0.5050.0>) outbound request to 78129169944 from account c8b0f6f8fc69794c095f1b2ac241a88eApr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|wh_number_manager:401 (<0.5050.0>) attempting to lookup '78129169944' in 'numbers%2F78129'Apr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|wh_number_manager:422 (<0.5050.0>) failed to lookup number: not_foundApr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|stepswitch_util:35 (<0.5050.0>) 78129169944 is not associated with any account, not_foundApr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|stepswitch_outbound:379 (<0.5050.0>) found resource c375da45b4942a917b1ac3b8381587c3 (sip:78129...@94.125.0.218;fs_path=94.125.0.114)Apr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|stepswitch_outbound:91 (<0.5050.0>) found resources that handle the number...to the cloud!Apr 24 17:39:22 w1 whistle_apps[26557]: <0.5053.0> Supervisor amqp_channel_sup started undefined at pid <0.5054.0>Apr 24 17:39:22 w1 whistle_apps[26557]: <0.5053.0> Supervisor amqp_channel_sup started undefined at pid <0.5055.0>Apr 24 17:39:22 w1 whistle_apps[26557]: <0.5053.0> Supervisor amqp_channel_sup started undefined at pid <0.5056.0>Apr 24 17:39:22 w1 whistle_apps[26557]: |00000000000|amqp_host:559 (<0.119.0>) Opened channel <0.5055.0>Apr 24 17:39:22 w1 whistle_apps[26557]: |00000000000|amqp_host:574 (<0.119.0>) Started channel <0.5055.0> for caller <0.5050.0>Apr 24 17:39:22 w1 whistle_apps[26557]: |00000000000|amqp_host:208 (<0.119.0>) Channel <0.5055.0> exists for proc <0.5050.0>, but we aren't consuming yetApr 24 17:39:22 w1 whistle_apps[26557]: |00000000000|amqp_host:466 (<0.5059.0>) sending exchange.declare to <0.126.0> (federated: false)Apr 24 17:39:22 w1 whistle_apps[26557]: |00000000000|amqp_host:469 (<0.5059.0>) exchange declaredApr 24 17:39:22 w1 whistle_apps[26557]: |00000000000|amqp_host:466 (<0.5061.0>) sending exchange.declare to <0.126.0> (federated: false)Apr 24 17:39:22 w1 whistle_apps[26557]: |00000000000|amqp_host:469 (<0.5061.0>) exchange declaredApr 24 17:39:22 w1 whistle_apps[26557]: |00000000000|amqp_host:466 (<0.5065.0>) sending exchange.declare to <0.126.0> (federated: false)Apr 24 17:39:22 w1 whistle_apps[26557]: |00000000000|amqp_host:469 (<0.5065.0>) exchange declaredApr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|stepswitch_outbound:271 (<0.5050.0>) consuming call eventsApr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|stepswitch_outbound:284 (<0.5050.0>) sending rate requestApr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|stepswitch_outbound:105 (<0.5050.0>) set outbound caller id to 78124906700 'Office Administrator'Apr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|whapps_config:217 (<0.5050.0>) fetched config stepswitch(default) [<<"format_from_uri">>]: falseApr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|stepswitch_outbound:116 (<0.5050.0>) setting from-uri to undefinedApr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|whapps_config:217 (<0.5050.0>) fetched config stepswitch(default) [<<"bridge_timeout">>]: 30000Apr 24 17:39:22 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|hon_rater:25 (<0.5072.0>) valid rating requestApr 24 17:39:22 w1 whistle_apps[26557]: emulator Error in process <0.5072.0> on node 'whistl...@w1.onnet.su' with exit value: {{badmatch,<<11 bytes>>},[{hon_util,candidate_rates,2},{hon_rater,get_rate_data,1},{hon_rater,handle_req,2}]}#012Apr 24 17:39:23 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|whapps_config:217 (<0.5050.0>) fetched config stepswitch(default) [<<"max_shortdial_correction">>]: 5Apr 24 17:39:23 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|stepswitch_outbound:45 (<0.5050.0>) error attempting global resources to 78129169944Apr 24 17:39:23 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|stepswitch_outbound:446 (<0.5050.0>) FORMAT ERROR: "error during outbound request: ~s" [[123,[34,<<"Request">>,34],58,[123,[34,<<"Custom-Channel-Vars">>,34],58,[123,[34,<<"Account-ID">>,34],58,[34,<<"c8b0f6f8fc69794c095f1b2ac241a88e">>,34],125],44,[34,<<"Dial-Endpoint-Method">>,34],58,[34,<<"single">>,34],44,[34,<<"Outgoing-Caller-ID-Number">>,34],58,[34,<<"78124906700">>,34],44,[34,<<"Outgoing-Caller-ID-Name">>,34],58,[34,<<"Office Administrator">>,34],44,[34,<<"Continue-On-Fail">>,34],58,[34,<<"true">>,34],44,[34,<<"Endpoints">>,34],58,[91,[123,[34,<<"Endpoint-Options">>,34],58,<<"{}">>,44,[34,<<"Endpoint-Type">>,34],58,[34,<<"sip">>,34],44,[34,<<"Custom-Channel-Vars">>,34],58,[123,[34,<<"Resource-ID">>,34],58,[34,<<"c375da45b4942a917b1ac3b8381587c3">>,34],125],44,[34,<<"Codecs">>,34],58,[91,[34,<<"PCMU">>,34],44,[34,<<"PCMA">>,34],93],44,[34,<<"Endpoint-Progress-Timeout">>,34],58,[34,<<"8">>,34],44,[34,<<"Callee-ID-Number">>,34],58,[34,<<"78129169944">>,34],44,[34,<<"Callee-ID-Name">>,34],58,[34,<<"78129169944">>,34],44,[34,<<"To-DID">>,34],58,[34,<<"78129169944">>,34],44,[34,<<"Route">>,34],58,[34,<<"sip:78129...@94.125.0.218;fs_path=94.125.0.114">>,34],44,[34,<<"Invite-Format">>,34],58,[34,<<"e164">>,34],125],93],44,[34,<<"Call-ID">>,34],58,[34,<<"5f463df-...@192.168.1.138">>,34],44,[34,<<"Application-Name">>,34],58,[34,<<"bridge">>,34],44,[34,<<"App-Version">>,34],58,[34,<<"0.2.0">>,34],44,[34,<<"App-Name">>,34],58,[34,<<"stepswitch">>,34],44,[34,<<"Event-Name">>,34],58,[34,<<"command">>,34],44,[34,<<"Event-Category">>,34],58,[34,<<"call">>,34],44,[34,<<"Server-ID">>,34],58,[34,<<"amq.gen-aquRNrZpts5J0pgJNZA/Rw==">>,34],125],44,[34,<<"Error-Message">>,34],58,[34,<<"Could not execute dialplan action: bridge">>,34],44,[34,<<"Msg-ID">>,34],58,[34,<<>>,34],44,[34,<<"App-Version">>,34],58,[34,<<"0.8.0">>,34],44,[34,<<"App-Name">>,34],58,[34,<<"ecallmgr">>,34],44,[34,<<"Event-Name">>,34],58,[34,<<"dialplan">>,34],44,[34,<<"Event-CatApr 24 17:39:23 w1 whistle_apps[26557]: |00000000000|amqp_host:499 (<0.119.0>) recieved notification monitored process <0.5050.0> died normal, searching for referenceApr 24 17:39:23 w1 whistle_apps[26557]: |00000000000|amqp_host:637 (<0.119.0>) reference was for consumer <0.5050.0>, removing channel <0.5055.0>Apr 24 17:39:23 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|cf_offnet:52 (<0.5046.0>) offnet request error, attempting to find failure branch for sip:500:NORMAL_TEMPORARY_FAILUREApr 24 17:39:23 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|cf_exe:280 (<0.5025.0>) attempted undefined child NORMAL_TEMPORARY_FAILUREApr 24 17:39:23 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|cf_exe:280 (<0.5025.0>) attempted undefined child sip:500Apr 24 17:39:23 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|wh_call_response:105 (<0.5046.0>) attempting to send default response for NORMAL_TEMPORARY_FAILUREApr 24 17:39:23 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|whapps_config:217 (<0.5046.0>) fetched config call_response(default) [<<"NORMAL_TEMPORARY_FAILURE">>]: {struct,[{<<"Code">>,<<"503">>},{<<"Message">>,<<"Normal temporary failure">>},{<<"Media">>,<<"/system_media/fault-can_not_be_completed_at_this_time">>}]}Apr 24 17:39:23 w1 whistle_apps[26557]: <0.5055.0> Channel (<0.5055.0>): dropping method {{'basic.cancel',<<"amq.gen-aquRNrZpts5J0pgJNZA/Rw==">>,true},none} from server because channel is closingApr 24 17:39:24 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|media_listener:195 (<0.5126.0>) trying to find first attachment in doc fault-can_not_be_completed_at_this_time in db system_mediaApr 24 17:39:24 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|media_listener:206 (<0.5126.0>) found attachment to stream: fault-can_not_be_completed_at_this_time.wavApr 24 17:39:24 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|whapps_config:217 (<0.5126.0>) fetched config media_mgr(default) [<<"port">>]: 24517Apr 24 17:39:24 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|whapps_config:217 (<0.5126.0>) fetched config media_mgr(default) [<<"use_vlc">>]: falseApr 24 17:39:24 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|media_listener:75 (<0.5126.0>) final stream URL: http://w1.onnet.su:24517/single/system_media/fault-can_not_be_completed_at_this_time/fault-can_not_be_completed_at_this_time.wavApr 24 17:39:24 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|media_listener:52 (<0.5126.0>) file server at <0.4833.0> for system_media/fault-can_not_be_completed_at_this_time/fault-can_not_be_completed_at_this_time.wavApr 24 17:39:24 w1 whistle_apps[26557]: |5a54f719528c338c98d16b5e4da169e4|media_single:20 (<0.5130.0>) fetching system_media/fault-can_not_be_completed_at_this_time/fault-can_not_be_completed_at_this_time.wavApr 24 17:39:24 w1 whistle_apps[26557]: |00000000000|media_file:114 (<0.4833.0>) returning media contentsApr 24 17:39:24 w1 whistle_apps[26557]: |5a54f719528c338c98d16b5e4da169e4|media_single:63 (<0.5130.0>) terminatingApr 24 17:39:25 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|whapps_call_command:1122 (<0.5046.0>) channel was hungup while waiting for noopApr 24 17:39:25 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|cf_exe:317 (<0.5025.0>) continuing to child _Apr 24 17:39:25 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|cf_exe:320 (<0.5025.0>) wildcard child does not exist, we are lost...Apr 24 17:39:25 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|cf_exe:446 (<0.5025.0>) callflow execution has been stopped: normalApr 24 17:39:25 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|gen_listener:457 (<0.5025.0>) cf_exe terminated cleanly, going downApr 24 17:39:25 w1 whistle_apps[26557]: |00000000000|amqp_host:499 (<0.119.0>) recieved notification monitored process <0.5025.0> died normal, searching for referenceApr 24 17:39:25 w1 whistle_apps[26557]: |00000000000|amqp_host:637 (<0.119.0>) reference was for consumer <0.5025.0>, removing channel <0.5030.0>Apr 24 17:39:25 w1 whistle_apps[26557]: <0.5030.0> Channel (<0.5030.0>): dropping method {{'basic.cancel',<<"amq.gen-FvAPkGZEyHlqE6QWTxb0uQ==">>,true},none} from server because channel is closingApr 24 17:39:25 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|whapps_config:217 (<0.5148.0>) fetched config hangups(default) [<<"ignore_hangup_causes">>]: [<<"NO_ANSWER">>,<<"USER_BUSY">>,<<"NO_USER_RESPONSE">>,<<"LOSE_RACE">>,<<"ATTENDED_TRANSFER">>,<<"ORIGINATOR_CANCEL">>,<<"NORMAL_CLEARING">>]Apr 24 17:39:25 w1 whistle_apps[26557]: |5f463df-...@192.168.1.138|cdr_listener:70 (<0.5147.0>) saving CDR to account%2Fc8%2Fb0%2Ff6f8fc69794c095f1b2ac241a88eApr 24 17:39:26 w1 whistle_apps[26557]: |00000000000|cf_util:281 (<0.5154.0>) searching for callflow in account%2Fc8%2Fb0%2Ff6f8fc69794c095f1b2ac241a88e to satisfy 'user_mfwcdo'Apr 24 17:39:26 w1 whistle_apps[26557]: |00000000000|cf_util:318 (<0.5154.0>) lookup callflow patterns for user_mfwcdo in account%2Fc8%2Fb0%2Ff6f8fc69794c095f1b2ac241a88eApr 24 17:39:26 w1 whistle_apps[26557]: |00000000000|cf_util:281 (<0.5154.0>) searching for callflow in account%2Fc8%2Fb0%2Ff6f8fc69794c095f1b2ac241a88e to satisfy 'no_match'[root@w1 ~]#
{
"_id": "4a045948b6ed9e99563c8699248e0688",
"_rev": "3-e81b1aba1cf8f0a79e3b441b617f411b",
"weight_cost": "50",
"enabled": true,
"gateways": [
{
"invite_format": "e164",
"prefix": "",
"codecs": [
"PCMU",
"PCMA"
],
"progress_timeout": "6",
"server": "94.125.0.218",
"username": "",
"password": "",
"realm": "whistle.onnet.su",
"format_from_uri": true,
"suffix": ""
}
],
"rules": [
".*"
],
"caller_id_options": {
"type": "external"
},
"type": "local",
"name": "gw",
"emergency": false,
"grace_period": 5,
"flags": [
],
"id": "4a045948b6ed9e99563c8699248e0688",
"pvt_type": "resource",
"pvt_vsn": "1",
"pvt_account_id": "c8b0f6f8fc69794c095f1b2ac241a88e",
"pvt_account_db": "account%2Fc8%2Fb0%2Ff6f8fc69794c095f1b2ac241a88e",
"pvt_created": 63502491256,
"pvt_modified": 63502497916
}
format_from_uri": true, - was added couple minutes ago just to see whether it will help){
"_id": "c375da45b4942a917b1ac3b8381587c3",
"_rev": "10-e6b5a7780c2775da816944195bd512b5",
"name": "globaldialogic",
"enabled": true,
"gateways": [
{
"invite_format": "e164",
"prefix": "",
"codecs": [
"PCMU",
"PCMA"
],
"progress_timeout": "6",
"server": "94.125.0.218",
"username": "",
"password": "",
"realm": "whistle.onnet.su",
"format_from_uri": true,
"suffix": ""
}
],
"rules": [
".*"
],
"pvt_type": "resource"
}
name": "globaldialogic") that was in offnet database for a long time...{
"_id": "c375da45b4942a917b1ac3b8381587c3",
"_rev": "10-e6b5a7780c2775da816944195bd512b5",
"name": "globaldialogic",
"enabled": true,
"gateways": [
{
"invite_format": "e164",
"prefix": "",
"codecs": [
"PCMU",
"PCMA"
],
"progress_timeout": "6",
"server": "94.125.0.218",
"username": "",
"password": "",
"realm": "whistle.onnet.su",
"format_from_uri": true,
"suffix": ""
}
],
"rules": [
".*"
],
"pvt_type": "resource"
Yes- I received this on multiple occasions:
Your message did not reach some or all of the intended recipients.
Subject: 2600hz Feature Sponsorship
Sent: 4/24/2012 8:55 PM
The following recipient(s) cannot be reached:
'i...@onnet.su' on 4/24/2012 10:35 PM
None of your e-mail accounts could send to this recipient.
Please just call into our office – it'll be easier. 415-886-7900.
May 23 20:16:50 w1 2600hz[8234]: |828a2d76...@192.168.1.201|ecallmgr_call_control:729 (<0.7504.0>) FORMAT ERROR: "sending execution error: ~s" [[123,[34,<<"Request">>,34],58,[123,[34,<<"Custom-Channel-Vars">>,34],58,[123,[34,<<"Account-ID">>,34],58,[34,<<"c8b0f6f8fc69794c095f1b2ac241a88e">>,34],125],44,[34,<<"Dial-Endpoint-Method">>,34],58,[34,<<"single">>,34],44,[34,<<"Outgoing-Caller-ID-Number">>,34],58,[34,<<"78123634500">>,34],44,[34,<<"Outgoing-Caller-ID-Name">>,34],58,[34,<<"Sweet Home">>,34],44,[34,<<"Continue-On-Fail">>,34],58,[34,<<"true">>,34],44,[34,<<"Endpoints">>,34],58,[91,[123,[34,<<"Endpoint-Options">>,34],58,<<"{}">>,44,[34,<<"Endpoint-Type">>,34],58,[34,<<"sip">>,34],44,[34,<<"Auth-Password">>,34],58,[34,<<>>,34],44,[34,<<"Auth-User">>,34],58,[34,<<>>,34],44,[34,<<"Custom-Channel-Vars">>,34],58,[123,[34,<<"Resource-ID">>,34],58,[34,<<"c375da45b4942a917b1ac3b8381587c3">>,34],125],44,[34,<<"Codecs">>,34],58,[91,[34,<<"PCMU">>,34],44,[34,<<"PCMA">>,34],93],44,[34,<<"Endpoint-Progress-Timeout">>,34],58,[34,<<"8">>,34],44,[34,<<"Callee-ID-Number">>,34],58,[34,<<"78129169944">>,34],44,[34,<<"Callee-ID-Name">>,34],58,[34,<<"78129169944">>,34],44,[34,<<"To-DID">>,34],58,[34,<<"78129169944">>,34],44,[34,<<"Route">>,34],58,[34,<<"sip:78129...@94.125.0.218">>,34],44,[34,<<"Invite-Format">>,34],58,[34,<<"e164">>,34],125],93],44,[34,<<"Call-ID">>,34],58,[34,<<"828a2d76-3d5d...@192.168.1.201">>,34],44,[34,<<"Application-Name">>,34],58,[34,<<"bridge">>,34],44,[34,<<"Node">>,34],58,[34,<<"whistl...@w1.onnet.su">>,34],44,[34,<<"App-Version">>,34],58,[34,<<"0.2.0">>,34],44,[34,<<"App-Name">>,34],58,[34,<<"stepswitch">>,34],44,[34,<<"Event-Name">>,34],58,[34,<<"command">>,34],44,[34,<<"Event-Category">>,34],58,[34,<<"call">>,34],44,[34,<<"Server-ID">>,34],58,[34,<<"amq.gen-nnGOGMxiqmAZDEP0jEhk0Q==">>,34],125],44,[34,<<"Error-Message">>,34],58,[34,<<"Could not execute dialplan action: bridge">>,34],44,[34,<<"Msg-ID">>,34],58,[34,<<>>,34],44,[34,<<"Node">>,34],58,[34,<<"ecall...@w1.onnet.su">>,34],44,
May 23 20:16:50 w1 2600hz[8234]: |828a2d76...@192.168.1.201|wh_amqp_connection:93 (<0.7504.0>) publish to exchange 'callevt' with routing key 'call.event.828a2d76-3d5d9c35%40192%2E168%2E1%2E201' via channel <0.7507.0>May 23 20:16:50 w1 2600hz[8234]: |828a2d76...@192.168.1.201|ecallmgr_call_control:215 (<0.7530.0>) control queue <0.7504.0> channel execute completion for 'set'May 23 20:16:50 w1 2600hz[8234]: |828a2d76...@192.168.1.201|ecallmgr_call_control:215 (<0.7534.0>) control queue <0.7504.0> channel execute completion for 'set'May 23 20:16:50 w1 2600hz[8234]: |828a2d76...@192.168.1.201|ecallmgr_call_control:215 (<0.7538.0>) control queue <0.7504.0> channel execute completion for 'set'May 23 20:16:50 w1 2600hz[7516]: |828a2d76...@192.168.1.201|whapps_config:217 (<0.11586.2>) fetched config stepswitch(default) [<<"max_shortdial_correction">>]: 5
May 23 20:16:50 w1 2600hz[7516]: |828a2d76...@192.168.1.201|stepswitch_outbound:572 (<0.11586.2>) error during outbound request: {"Request":{"Custom-Channel-Vars":{"Account-ID":"c8b0f6f8fc69794c095f1b2ac241a88e"},"Dial-Endpoint-Method":"single","Outgoing-Caller-ID-Number":"78123634500","Outgoing-Caller-ID-Name":"Sweet Home","Continue-On-Fail":"true","Endpoints":[{"Endpoint-Options":{},"Endpoint-Type":"sip","Auth-Password":"","Auth-User":"","Custom-Channel-Vars":{"Resource-ID":"c375da45b4942a917b1ac3b8381587c3"},"Codecs":["PCMU","PCMA"],"Endpoint-Progress-Timeout":"8","Callee-ID-Number":"78129169944","Callee-ID-Name":"78129169944","To-DID":"78129169944","Route":"sip:7812916...@94.125.0.218","Invite-Format":"e164"}],"Call-ID":"828a2d76-...@192.168.1.201","Application-Name":"bridge","Node":"whistl...@w1.onnet.su","App-Version":"0.2.0","App-Name":"stepswitch","Event-Name":"command","Event-Category":"call","Server-ID":"amq.gen-nnGOGMxiqmAZDEP0jEhk0Q=="},"Error-Message":"Could not execute dialplan action: bridge","Msg-ID":"","Node":"ecall...@w1.onnet.su","App-Version":"0.8.0","App-Name":"ecallmgr","Event-Name":"dialplan","Event-Category":"error","Server-ID":""}
Why could such error occurs: registrar returned no endpoints
[root@w1 ~]# service whapps status
Searching for running whapps on 'whist...@w1.onnet.su'[hotornot,jonny5,sysconf,conference,cdr,trunkstore,registrar,hangups,notify,media_mgr,crossbar,callflow,stepswitch]
FS cli:2012-05-23 20:16:50.271500 [NOTICE] mod_commands.c:5305 log|828a2d...@192.168.1.201|whistle error while building command bridge: registrar returned no endpoints
2600hz-platform.log:May 23 20:16:48 w1 2600hz[7516]: |828a2d7...@192.168.1.201|stepswitch_util:35 (<0.11586.2>) 78129169944 is not associated with any account, not_foundMay 23 20:16:48 w1 2600hz[7516]: |828a2d7...@192.168.1.201|stepswitch_outbound:495 (<0.11586.2>) found resource c375da45b4942a917b1ac3b8381587c3 (sip:78129...@94.125.0.218)May 23 20:16:48 w1 2600hz[7516]: |828a2d7...@192.168.1.201|stepswitch_outbound:112 (<0.11586.2>) found resources that bridge the number...to the cloud!
May 23 20:16:48 w1 2600hz[7516]: <0.11588.2> Supervisor amqp_channel_sup started undefined at pid <0.11589.2>May 23 20:16:48 w1 2600hz[7516]: <0.11588.2> Supervisor amqp_channel_sup started undefined at pid <0.11590.2>May 23 20:16:48 w1 2600hz[7516]: <0.11588.2> Supervisor amqp_channel_sup started undefined at pid <0.11591.2>May 23 20:16:48 w1 2600hz[7516]: |00000000000|wh_amqp_connection:275 (<0.105.0>) started new AMQP channel <0.11590.2> for process <0.11586.2>May 23 20:16:48 w1 2600hz[7516]: |00000000000|wh_amqp_connection:320 (<0.105.0>) updating tag for <0.11586.2> from <<>> to <<"amq.gen-nnGOGMxiqmAZDEP0jEhk0Q==">>
May 23 20:16:48 w1 2600hz[7516]: |828a2d7...@192.168.1.201|wh_amqp_connection:185 (<0.11586.2>) attempting to create new topic exchange 'callevt' via channel <0.121.0>May 23 20:16:48 w1 2600hz[7516]: |828a2d7...@192.168.1.201|wh_amqp_connection:185 (<0.11586.2>) attempting to create new topic exchange 'callmgr' via channel <0.121.0>May 23 20:16:48 w1 2600hz[7516]: |828a2d7...@192.168.1.201|wh_amqp_connection:185 (<0.11586.2>) attempting to create new direct exchange 'targeted' via channel <0.121.0>May 23 20:16:48 w1 2600hz[7516]: |828a2d7...@192.168.1.201|stepswitch_outbound:399 (<0.11586.2>) sending rate requestMay 23 20:16:48 w1 2600hz[7516]: |828a2d7...@192.168.1.201|wh_amqp_connection:93 (<0.11586.2>) publish to exchange 'callmgr' with routing key 'call.rating.828a2d76-3d5d9c35%40192%2E168%2E1%2E201' via channel <0.11590.2>May 23 20:16:48 w1 2600hz[7516]: |828a2d7...@192.168.1.201|stepswitch_outbound:126 (<0.11586.2>) set outbound caller id to 78123634500 'Sweet Home'May 23 20:16:48 w1 2600hz[7516]: |828a2d7...@192.168.1.201|whapps_config:217 (<0.11586.2>) fetched config stepswitch(default) [<<"format_from_uri">>]: falseMay 23 20:16:48 w1 2600hz[7516]: |828a2d7...@192.168.1.201|stepswitch_outbound:137 (<0.11586.2>) setting from-uri to undefinedMay 23 20:16:48 w1 2600hz[7516]: |828a2d7...@192.168.1.201|wh_amqp_connection:93 (<0.11586.2>) publish to exchange 'callctl' with routing key 'amq.gen-hE1coUDx7VRc+KDdKVHhkw==' via channel <0.11590.2>May 23 20:16:48 w1 2600hz[7516]: |828a2d7...@192.168.1.201|whapps_config:217 (<0.11586.2>) fetched config stepswitch(default) [<<"bridge_timeout">>]: 30000May 23 20:16:48 w1 2600hz[7516]: |828a2d7...@192.168.1.201|hon_rater:25 (<0.11595.2>) valid rating requestMay 23 20:16:48 w1 2600hz[8234]: |828a2d7...@192.168.1.201|ecallmgr_call_control:650 (<0.7504.0>) inserting at the tail of the control queue call command 'bridge'May 23 20:16:48 w1 2600hz[8234]: |828a2d7...@192.168.1.201|ecallmgr_call_control:668 (<0.7504.0>) executing call command 'bridge' <<>>
May 23 20:16:48 w1 2600hz[8234]: |undefined|ecallmgr_registrar:174 (<0.7525.0>) looking up registration information for undefined@undefinedMay 23 20:16:48 w1 2600hz[8234]: |undefined|ecallmgr_registrar:184 (<0.7525.0>) valid cached registration not found, querying whappsMay 23 20:16:48 w1 2600hz[8234]: |00000000000|wh_amqp_worker:185 (<0.1104.0>) published request with msg id 9c50403f8f86598c for <0.7525.0>May 23 20:16:48 w1 2600hz[8234]: |00000000000|wh_api:353 (<0.7526.0>) failed to find key 'Realm' on API messageMay 23 20:16:48 w1 2600hz[8234]: |00000000000|wh_api:211 (<0.7526.0>) failing API JSON: {"Event-Name":"reg_query","Event-Category":"directory","Server-ID":"amq.gen-hBOg1qgjKIBsD5yOdu47Zg==","Call-ID":"00000000000","Msg-ID":"9c50403f8f86598c","Server-ID":"","App-Name":"ecallmgr","App-Version":"0.8.0","Node":"ecal...@w1.onnet.su"}May 23 20:16:48 w1 2600hz[8234]: <0.7526.0> CRASH REPORT Process <0.7526.0> with 0 neighbours crashed with reason: {badmatch,{error,"Proplist failed validation for reg_query"}}
May 23 20:16:48 w1 2600hz[7516]: emulator Error in process <0.11595.2> on node 'whist...@w1.onnet.su' with exit value: {{badmatch,<<11 bytes>>},[{hon_util,find_candidate_rates,2},{hon_rater,get_rate_data,1},{hon_rater,handle_req,2}]}#012May 23 20:16:48 w1 2600hz[8234]: |828a2d7...@192.168.1.201|ecallmgr_call_events:357 (<0.7509.0>) publishing call event channel_execute 'set(effective_caller_id_name=Sweet Home)'
May 23 20:16:48 w1 2600hz[8234]: |00000000000|wh_amqp_connection:93 (<0.1109.0>) publish to exchange 'callevt' with routing key 'call.event.828a2d76-3d5d9c35%40192%2E168%2E1%2E201' via channel <0.6374.0>
May 23 20:16:48 w1 2600hz[8234]: |828a2d7...@192.168.1.201|ecallmgr_call_events:354 (<0.7509.0>) publishing call event channel_execute_complete 'set(effective_caller_id_name=Sweet Home)' result: _none_
May 23 20:16:48 w1 2600hz[8234]: |00000000000|wh_amqp_connection:93 (<0.1114.0>) publish to exchange 'callevt' with routing key 'call.event.828a2d76-3d5d9c35%40192%2E168%2E1%2E201' via channel <0.7037.0>
May 23 20:16:48 w1 2600hz[8234]: |828a2d7...@192.168.1.201|ecallmgr_call_events:357 (<0.7509.0>) publishing call event channel_execute 'set(ecallmgr_Authorizing-ID=4a045948b6ed9e99563c86992400b6f1)'
May 23 20:16:48 w1 2600hz[8234]: |00000000000|wh_amqp_connection:93 (<0.119.0>) publish to exchange 'callevt' with routing key 'call.event.828a2d76-3d5d9c35%40192%2E168%2E1%2E201' via channel <0.7169.0>
May 23 20:16:48 w1 2600hz[8234]: |828a2d7...@192.168.1.201|ecallmgr_call_events:354 (<0.7509.0>) publishing call event channel_execute_complete 'set(ecallmgr_Authorizing-ID=4a045948b6ed9e99563c86992400b6f1)' result: _none_
May 23 20:16:48 w1 2600hz[8234]: |00000000000|wh_amqp_connection:93 (<0.124.0>) publish to exchange 'callevt' with routing key 'call.event.828a2d76-3d5d9c35%40192%2E168%2E1%2E201' via channel <0.6936.0>
May 23 20:16:48 w1 2600hz[8234]: |828a2d7...@192.168.1.201|ecallmgr_call_events:357 (<0.7509.0>) publishing call event channel_execute 'set(ecallmgr_Inception=on-net)'
May 23 20:16:48 w1 2600hz[8234]: |00000000000|wh_amqp_connection:93 (<0.129.0>) publish to exchange 'callevt' with routing key 'call.event.828a2d76-3d5d9c35%40192%2E168%2E1%2E201' via channel <0.6559.0>
May 23 20:16:48 w1 2600hz[8234]: |828a2d7...@192.168.1.201|ecallmgr_call_events:354 (<0.7509.0>) publishing call event channel_execute_complete 'set(ecallmgr_Inception=on-net)' result: _none_
May 23 20:16:48 w1 2600hz[8234]: |00000000000|wh_amqp_connection:93 (<0.139.0>) publish to exchange 'callevt' with routing key 'call.event.828a2d76-3d5d9c35%40192%2E168%2E1%2E201' via channel <0.6902.0>
May 23 20:16:48 w1 2600hz[8234]: |828a2d7...@192.168.1.201|ecallmgr_call_events:357 (<0.7509.0>) publishing call event channel_execute 'set(ecallmgr_Authorizing-Type=device)'
May 23 20:16:48 w1 2600hz[8234]: |00000000000|wh_amqp_connection:93 (<0.144.0>) publish to exchange 'callevt' with routing key 'call.event.828a2d76-3d5d9c35%40192%2E168%2E1%2E201' via channel <0.6535.0>
May 23 20:16:49 w1 2600hz[8234]: |828a2d7...@192.168.1.201|ecallmgr_call_events:354 (<0.7509.0>) publishing call event channel_execute_complete 'set(ecallmgr_Authorizing-Type=device)' result: _none_
May 23 20:16:49 w1 2600hz[8234]: |00000000000|wh_amqp_connection:93 (<0.149.0>) publish to exchange 'callevt' with routing key 'call.event.828a2d76-3d5d9c35%40192%2E168%2E1%2E201' via channel <0.7137.0>
May 23 20:16:49 w1 2600hz[8234]: |828a2d7...@192.168.1.201|ecallmgr_call_events:357 (<0.7509.0>) publishing call event channel_execute 'set(ecallmgr_Account-ID=c8b0f6f8fc69794c095f1b2ac241a88e)'
May 23 20:16:49 w1 2600hz[8234]: |00000000000|wh_amqp_connection:93 (<0.154.0>) publish to exchange 'callevt' with routing key 'call.event.828a2d76-3d5d9c35%40192%2E168%2E1%2E201' via channel <0.6877.0>
May 23 20:16:49 w1 2600hz[8234]: |828a2d7...@192.168.1.201|ecallmgr_call_events:354 (<0.7509.0>) publishing call event channel_execute_complete 'set(ecallmgr_Account-ID=c8b0f6f8fc69794c095f1b2ac241a88e)' result: _none_
May 23 20:16:49 w1 2600hz[8234]: |00000000000|wh_amqp_connection:93 (<0.164.0>) publish to exchange 'callevt' with routing key 'call.event.828a2d76-3d5d9c35%40192%2E168%2E1%2E201' via channel <0.7121.0>
May 23 20:16:49 w1 2600hz[8234]: |828a2d7...@192.168.1.201|ecallmgr_call_events:357 (<0.7509.0>) publishing call event channel_execute 'set(ecallmgr_Realm=office.sip2.onnet.su)'
May 23 20:16:49 w1 2600hz[8234]: |00000000000|wh_amqp_connection:93 (<0.169.0>) publish to exchange 'callevt' with routing key 'call.event.828a2d76-3d5d9c35%40192%2E168%2E1%2E201' via channel <0.6818.0>
May 23 20:16:49 w1 2600hz[8234]: |828a2d7...@192.168.1.201|ecallmgr_call_events:354 (<0.7509.0>) publishing call event channel_execute_complete 'set(ecallmgr_Realm=office.sip2.onnet.su)' result: _none_
May 23 20:16:49 w1 2600hz[8234]: |00000000000|wh_amqp_connection:93 (<0.159.0>) publish to exchange 'callevt' with routing key 'call.event.828a2d76-3d5d9c35%40192%2E168%2E1%2E201' via channel <0.6511.0>
May 23 20:16:49 w1 2600hz[8234]: |828a2d7...@192.168.1.201|ecallmgr_call_events:357 (<0.7509.0>) publishing call event channel_execute 'set(ecallmgr_Username=user_mga4xs)'
May 23 20:16:49 w1 2600hz[8234]: |00000000000|wh_amqp_connection:93 (<0.174.0>) publish to exchange 'callevt' with routing key 'call.event.828a2d76-3d5d9c35%40192%2E168%2E1%2E201' via channel <0.6478.0>
May 23 20:16:49 w1 2600hz[8234]: |828a2d7...@192.168.1.201|ecallmgr_call_events:354 (<0.7509.0>) publishing call event channel_execute_complete 'set(ecallmgr_Username=user_mga4xs)' result: _none_
May 23 20:16:49 w1 2600hz[8234]: |00000000000|wh_amqp_connection:93 (<0.179.0>) publish to exchange 'callevt' with routing key 'call.event.828a2d76-3d5d9c35%40192%2E168%2E1%2E201' via channel <0.7109.0>
May 23 20:16:49 w1 2600hz[8234]: |828a2d7...@192.168.1.201|ecallmgr_call_events:357 (<0.7509.0>) publishing call event channel_execute 'set(local_var_clobber=true)'
May 23 20:16:49 w1 2600hz[8234]: |00000000000|wh_amqp_connection:93 (<0.184.0>) publish to exchange 'callevt' with routing key 'call.event.828a2d76-3d5d9c35%40192%2E168%2E1%2E201' via channel <0.6787.0>
May 23 20:16:49 w1 2600hz[8234]: |828a2d7...@192.168.1.201|ecallmgr_call_events:354 (<0.7509.0>) publishing call event channel_execute_complete 'set(local_var_clobber=true)' result: _none_
May 23 20:16:49 w1 2600hz[8234]: |00000000000|wh_amqp_connection:93 (<0.189.0>) publish to exchange 'callevt' with routing key 'call.event.828a2d76-3d5d9c35%40192%2E168%2E1%2E201' via channel <0.6454.0>
May 23 20:16:49 w1 2600hz[8234]: |828a2d7...@192.168.1.201|ecallmgr_call_events:357 (<0.7509.0>) publishing call event channel_execute 'set(ecallmgr_Owner-ID=4a045948b6ed9e99563c86992400b46f)'
May 23 20:16:49 w1 2600hz[8234]: |00000000000|wh_amqp_connection:93 (<0.194.0>) publish to exchange 'callevt' with routing key 'call.event.828a2d76-3d5d9c35%40192%2E168%2E1%2E201' via channel <0.7097.0>
May 23 20:16:50 w1 2600hz[8234]: |828a2d7...@192.168.1.201|ecallmgr_call_events:354 (<0.7509.0>) publishing call event channel_execute_complete 'set(ecallmgr_Owner-ID=4a045948b6ed9e99563c86992400b46f)' result: _none_
May 23 20:16:50 w1 2600hz[8234]: |00000000000|wh_amqp_connection:93 (<0.199.0>) publish to exchange 'callevt' with routing key 'call.event.828a2d76-3d5d9c35%40192%2E168%2E1%2E201' via channel <0.6752.0>May 23 20:16:50 w1 2600hz[8234]: |00000000000|wh_amqp_worker:290 (<0.1104.0>) timeout after 2003May 23 20:16:50 w1 2600hz[8234]: |00000000000|wh_amqp_worker:291 (<0.1104.0>) request timeout exceeded for msg id: 9c50403f8f86598cMay 23 20:16:50 w1 2600hz[8234]: |undefined|ecallmgr_registrar:195 (<0.7525.0>) did not receive registrar response: timeout
May 23 20:16:50 w1 2600hz[8234]: |828a2d7...@192.168.1.201|ecallmgr_call_control:703 (<0.7504.0>) error while executing command bridge: <<"registrar returned no endpoints">>
May 23 20:16:50 w1 2600hz[8234]: |undefined|ecallmgr_fs_xml:149 (<0.7524.0>) failed to lookup user undefined@undefined in the registrarMay 23 20:16:50 w1 2600hz[8234]: |undefined|ecallmgr_util:214 (<0.7524.0>) unable to build route to endpoint
May 23 20:16:50 w1 2600hz[8234]: |828a2d7...@192.168.1.201|ecallmgr_call_control:729 (<0.7504.0>) FORMAT ERROR: "sending execution error: ~s" [[123,[34,<<"Request">>,34],58,[123,[34,<<"Custom-Channel-Vars">>,34],58,[123,[34,<<"Account-ID">>,34],58,[34,<<"c8b0f6f8fc69794c095f1b2ac241a88e">>,34],125],44,[34,<<"Dial-Endpoint-Method">>,34],58,[34,<<"single">>,34],44,[34,<<"Outgoing-Caller-ID-Number">>,34],58,[34,<<"78123634500">>,34],44,[34,<<"Outgoing-Caller-ID-Name">>,34],58,[34,<<"Sweet Home">>,34],44,[34,<<"Continue-On-Fail">>,34],58,[34,<<"true">>,34],44,[34,<<"Endpoints">>,34],58,[91,[123,[34,<<"Endpoint-Options">>,34],58,<<"{}">>,44,[34,<<"Endpoint-Type">>,34],58,[34,<<"sip">>,34],44,[34,<<"Auth-Password">>,34],58,[34,<<>>,34],44,[34,<<"Auth-User">>,34],58,[34,<<>>,34],44,[34,<<"Custom-Channel-Vars">>,34],58,[123,[34,<<"Resource-ID">>,34],58,[34,<<"c375da45b4942a917b1ac3b8381587c3">>,34],125],44,[34,<<"Codecs">>,34],58,[91,[34,<<"PCMU">>,34],44,[34,<<"PCMA">>,34],93],44,[34,<<"Endpoint-Progress-Timeout">>,34],58,[34,<<"8">>,34],44,[34,<<"Callee-ID-Number">>,34],58,[34,<<"78129169944">>,34],44,[34,<<"Callee-ID-Name">>,34],58,[34,<<"78129169944">>,34],44,[34,<<"To-DID">>,34],58,[34,<<"78129169944">>,34],44,[34,<<"Route">>,34],58,[34,<<"sip:78129...@94.125.0.218">>,34],44,[34,<<"Invite-Format">>,34],58,[34,<<"e164">>,34],125],93],44,[34,<<"Call-ID">>,34],58,[34,<<"828a2d76-3d5d...@192.168.1.201">>,34],44,[34,<<"Application-Name">>,34],58,[34,<<"bridge">>,34],44,[34,<<"Node">>,34],58,[34,<<"whistl...@w1.onnet.su">>,34],44,[34,<<"App-Version">>,34],58,[34,<<"0.2.0">>,34],44,[34,<<"App-Name">>,34],58,[34,<<"stepswitch">>,34],44,[34,<<"Event-Name">>,34],58,[34,<<"command">>,34],44,[34,<<"Event-Category">>,34],58,[34,<<"call">>,34],44,[34,<<"Server-ID">>,34],58,[34,<<"amq.gen-nnGOGMxiqmAZDEP0jEhk0Q==">>,34],125],44,[34,<<"Error-Message">>,34],58,[34,<<"Could not execute dialplan action: bridge">>,34],44,[34,<<"Msg-ID">>,34],58,[34,<<>>,34],44,[34,<<"Node">>,34],58,[34,<<"ecall...@w1.onnet.su">>,34],44,May 23 20:16:50 w1 2600hz[8234]: |828a2d7...@192.168.1.201|wh_amqp_connection:93 (<0.7504.0>) publish to exchange 'callevt' with routing key 'call.event.828a2d76-3d5d9c35%40192%2E168%2E1%2E201' via channel <0.7507.0>May 23 20:16:50 w1 2600hz[8234]: |828a2d7...@192.168.1.201|ecallmgr_call_control:215 (<0.7530.0>) control queue <0.7504.0> channel execute completion for 'set'May 23 20:16:50 w1 2600hz[8234]: |828a2d7...@192.168.1.201|ecallmgr_call_control:215 (<0.7534.0>) control queue <0.7504.0> channel execute completion for 'set'May 23 20:16:50 w1 2600hz[8234]: |828a2d7...@192.168.1.201|ecallmgr_call_control:215 (<0.7538.0>) control queue <0.7504.0> channel execute completion for 'set'May 23 20:16:50 w1 2600hz[7516]: |828a2d7...@192.168.1.201|whapps_config:217 (<0.11586.2>) fetched config stepswitch(default) [<<"max_shortdial_correction">>]: 5May 23 20:16:50 w1 2600hz[7516]: |828a2d7...@192.168.1.201|stepswitch_outbound:572 (<0.11586.2>) error during outbound request: {"Request":{"Custom-Channel-Vars":{"Account-ID":"c8b0f6f8fc69794c095f1b2ac241a88e"},"Dial-Endpoint-Method":"single","Outgoing-Caller-ID-Number":"78123634500","Outgoing-Caller-ID-Name":"Sweet Home","Continue-On-Fail":"true","Endpoints":[{"Endpoint-Options":{},"Endpoint-Type":"sip","Auth-Password":"","Auth-User":"","Custom-Channel-Vars":{"Resource-ID":"c375da45b4942a917b1ac3b8381587c3"},"Codecs":["PCMU","PCMA"],"Endpoint-Progress-Timeout":"8","Callee-ID-Number":"78129169944","Callee-ID-Name":"78129169944","To-DID":"78129169944","Route":"sip:7812916...@94.125.0.218","Invite-Format":"e164"}],"Call-ID":"828a2d76-...@192.168.1.201","Application-Name":"bridge","Node":"whistl...@w1.onnet.su","App-Version":"0.2.0","App-Name":"stepswitch","Event-Name":"command","Event-Category":"call","Server-ID":"amq.gen-nnGOGMxiqmAZDEP0jEhk0Q=="},"Error-Message":"Could not execute dialplan action: bridge","Msg-ID":"","Node":"ecall...@w1.onnet.su","App-Version":"0.8.0","App-Name":"ecallmgr","Event-Name":"dialplan","Event-Category":"error","Server-ID":""}May 23 20:16:50 w1 2600hz[7516]: |828a2d7...@192.168.1.201|wh_amqp_connection:93 (<0.11586.2>) publish to exchange 'targeted' with routing key 'amq.gen-8O6ukmn+cJf3dJ9h7ya6KA==' via channel <0.11590.2>
May 23 20:16:50 w1 2600hz[7516]: |00000000000|wh_amqp_connection:344 (<0.105.0>) recieved notification monitored process <0.11586.2> died normal, searching for referenceMay 23 20:16:50 w1 2600hz[7516]: |00000000000|wh_amqp_connection:490 (<0.105.0>) reference was for consumer <0.11586.2>, removing channel <0.11590.2>
May 23 20:16:50 w1 2600hz[7516]: |828a2d7...@192.168.1.201|cf_offnet:52 (<0.11579.2>) offnet request error, attempting to find failure branch for sip:500:NORMAL_TEMPORARY_FAILUREMay 23 20:16:50 w1 2600hz[7516]: |828a2d7...@192.168.1.201|cf_exe:280 (<0.11572.2>) attempted undefined child NORMAL_TEMPORARY_FAILURE
Regards,Kirill