Call log explanation

From Kolmisoft Wiki
Jump to navigationJump to search

Call Log

The call log is a data file that contains information about all actions and activities that were involved in the specific call. The call log can be accessed from the Last Calls page by clicking on the icon Icon callinfo.png near the call and pressing Retrieve Log File on the Call-Info page.

Below you can find a call log example and some often cases explained.

Call Log Example

2021-12-28 08:02:05	NOTICE	Date:  2021-12-28, time: 08:02:05, weekday: WD
2021-12-28 08:02:05	NOTICE	CallerID from PAI will be used instead of original CallerID
2021-12-28 08:02:05	NOTICE	Resending Privacy header from caller to callee: none
2021-12-28 08:02:05	NOTICE	CLID: +302222222222, Src: +302222222222, Dst: 9991302333333333, Acc/dev_id: 96, CallerID: +302222222222, uniqueid: 1640678525.5042553, linkedid: 1640678525.5042553, LegA Channel Type: SIP
2021-12-28 08:02:05	NOTICE	Call comes from SIP Proxy with x-MOR-Original-IP: 222.222.222.222, port: 5060
2021-12-28 08:02:05	NOTICE	SourceIP: 111.111.111.111
2021-12-28 08:02:05	NOTICE	Accountcode retrieved by x-MOR-Original-IP: 96
2021-12-28 08:02:05	NOTICE	User's data retrieved: id: 28, lcr_id: 149, balance: -1812.712461, frozen_balance: 0.000000, credit: 5500.000000, blocked: 0, lcr_order: price, tariff_id: 100, postpaid: 1,
day type: WD, exchange rate: 1.000000, ani: 0, tell balance: 0, time: 0, when left: 60s, every: 60s, user currency: EUR, def.curr: EUR, tariff type: user_wholesale, allow loss calls: 0, cid from dids: 0,
cid from did: , record: 0, owner: 0, sipchaninfo: 0, allow duplicate calls: 0, user call limit: 500, device call limit: 0, device active calls: 52, user active calls: 189, is_trunk: 1, vat_percent: 0.000000,
originator_ip: 222.222.222.222, canreinvite: 0, user_allow_recordings: 0, record_forced: 0, recording_forced_enabled: 0, fake_ring: 0, warning balance(wb) active: 1, wb value: 0.000 (call specific: 0.000),
wb call: 0 (call specific: 0), wb file id: 123, grace time: 0, lang: en, lcr_first_prov_perc: 0.000000, change_failed_code_to: 0, device_max_timeout: 0, forward_did: ,
user tell currency: EUR, failover_provider_id: 0, no_failover: 0, anti_resale_auto_answer: 0, device_time_limit_per_day: 0 (used: 0), device_time_limit_per_day_datetime: ,
control_callerid_by_cids: 0, qf_tell balance/time: 0/0, callerid advanced control: 0, block callerid: 0, tell_rate: 0, callerid_number_pool: 0 (type: random), time_zone: Athens,
time_zone_offset: 7200, user's date:  2021-12-28 10:02:05 WD, copy_name_to_number: 0, custom_sip_header: , pbx_pool_id: 1, static DST blacklist/whitelist: blacklist (list id: 6),
tariff_currency: EUR, static SRC blacklist/whitelist: blacklist (list id: 5), daily credit limit: 0.000000 (used: 0.000000), daily_credit_limit_datetime: , minimal_rate_margin_percent: 0.000, custom_dst_header: ,
quality_routing_id: -1, pdd_limit: 0, localize_pai: 1, max_call_rate: 0.000, emergency_callerid:  (pool_id: 0), callerid: , disable_pass_privacy: 0, change_device_pass_pai: 0,
monthly time limit: 0 (used: 0), playback_to_called_party: 0, device b
2021-12-28 08:02:05	NOTICE	Localized CallerID: 302222222222 (cut: +, add: , new_did: , new_tariff_id: 0, new_lcr_id: 0, location_id: 1, change_callerid_name: 0)
2021-12-28 08:02:05	NOTICE	Destination and source localization (combined) info: dst_cut: 9991302, dst_add: 302, src_cut: 302, src_add: 302, new_did: , new_device_id: 0, new_tariff_id: 100, new_lcr_id: 106,
change callerid name: 0, location id: 81
2021-12-28 08:02:05	NOTICE	Localized destination: 302333333333
2021-12-28 08:02:05	NOTICE	Localized callerid: 302222222222
2021-12-28 08:02:05	NOTICE	Rereading user/device data based on tariff id: 100 and lcr id: 106
2021-12-28 08:02:05	NOTICE	New data retrieved: lcr order: price, user currrency: EUR, exchange rate: 1.000000, tariff type: user_wholesale, failover provider id: 0, no_failover: 0, minimal rate margin percent: 0.000000
2021-12-28 08:02:05	NOTICE	Checking static blacklist for source +302222222222
2021-12-28 08:02:05	NOTICE	Checking static blacklist for destination 302333333333
2021-12-28 08:02:05	NOTICE	User wholesale rate: 0.003100, prefix: 302, incr.: 1, min_time: 0, conn_fee: 0.000000, ghost_min_perc_rate: 0.000000%, effective_from: 2020-05-07 07:46:00, blocked: 0
2021-12-28 08:02:05	NOTICE	New LCR data retrieved by prefix: 302, lcr id: 208, order: price, first provider's percent limit: 0.0000
2021-12-28 08:02:05	NOTICE	LCR (id: 208) table:
2021-12-28 08:02:05	NOTICE	Provider name: PROVIDER-X, id: 55, ip: 555.555.555.555, tech: SIP, prefix: 302, tariff_id: 104, rate: 0.002150, increment: 1, min_time: 0, conn_fee: 0.000000, exchange rate: 1.000000, cut: ,
add: +, change tariff: 0, timeout: 60, interpret as failed: no answer: 0, busy: 0, priority: 9, call limit: 1000, active calls: 46, latency: 0.000000, grace_time: 0, percent: 0, fake_ring: 0, use pai: 1, 302 support: 0,
common use: 0, owner_id: 0, time_limit_per_day: 0 (used: 0), time_limit_per_day_datetime: , max_timeout: 0, user_id: -1, periodic_check: 0, alive: 1, callerid_number_pool: 0 (type: random),
effective_from:  2021-06-30 21:00:00, custom_sip_header: X-Routing-Prefs:provider=forthnet;only_valid_cli=1;allowed_src=eea;allowed_dests=2653, inherit_codec: 0, ipaddr: , execute_agi_script: 0, device_id: 107, localize_pai: 1,
privacy_fomain: anonymous.invalid, privacy_callerid: Anonymous, playback_before_dial: 0 (), static_source_list: blacklist, static_source_list_id: 0, src_cut: , src_add: +,
src_change_tariff: 0, enable_mnp_tags: 0, disable_pass_privacy: 0, static_destination_list: blacklist, static_destination_list_id: 0, change_device_pass_pai: 0, time_limit_per_month: 0 (used: 0), usereqphone: 0
2021-12-28 08:02:05	NOTICE	Provider name: PROVIDER-Y, id: 54, ip: 444.444.444.444, tech: SIP, prefix: 302, tariff_id: 104, rate: 0.002150, increment: 1, min_time: 0, conn_fee: 0.000000, exchange rate: 1.000000,
cut: , add: +, change tariff: 0, timeout: 60, interpret as failed: no answer: 0, busy: 0, priority: 8, call limit: 1000, active calls: 87, latency: 0.000000, grace_time: 0, percent: 0, fake_ring: 0, use pai: 1, 302 support: 0,
common use: 0, owner_id: 0, time_limit_per_day: 0 (used: 0), time_limit_per_day_datetime: , max_timeout: 0, user_id: -1, periodic_check: 0, alive: 1, callerid_number_pool: 0 (type: random),
effective_from:  2021-06-30 21:00:00, custom_sip_header: X-Routing-Prefs:provider=forthnet;only_valid_cli=1;allowed_src=eea;allowed_dests=2653, inherit_codec: 0, ipaddr: , execute_agi_script: 0, device_id: 106, localize_pai: 1,
privacy_fomain: anonymous.invalid, privacy_callerid: Anonymous, playback_before_dial: 0 (), static_source_list: blacklist, static_source_list_id: 0, src_cut: , src_add: +,
src_change_tariff: 0, enable_mnp_tags: 0, disable_pass_privacy: 0, static_destination_list: blacklist, static_destination_list_id: 0, change_device_pass_pai: 0, time_limit_per_month: 0 (used: 0), usereqphone: 0
2021-12-28 08:02:05	NOTICE	Retrieved 2 route(s)
2021-12-28 08:02:05	NOTICE	User's total call price for all current calls: 0.000000, balance after adjustment: -1812.712461
2021-12-28 08:02:05	NOTICE	Initial timeout: 71366856
2021-12-28 08:02:05	NOTICE	Timeout after global timeout (7200) adjustment: 7200
2021-12-28 08:02:05	NOTICE	Timeout: 7197, real timeout: 71366856
2021-12-28 08:02:05	NOTICE	Checking global blacklist for source number +302222222222
2021-12-28 08:02:05	NOTICE	Checking static blacklist for destination 302333333333
2021-12-28 08:02:05	NOTICE	SRC record: 0, record_forced: 0, rec_forced_enabled: 0, DST record: 0, record_forced: 0, rec_forced_enabled: 0
2021-12-28 08:02:05	NOTICE	User's (id: 28) balance: -1812.712461, credit: 5500.000000, daily balance limit: 0.000000 (used: 0.000000)
2021-12-28 08:02:05	NOTICE	Checking static blacklist for destination 302333333333
2021-12-28 08:02:05	NOTICE	Provider id: 55 has a blacklist enabled. CallerID: 302222222222, PAI: +302222222222, RPID: . Number Pool id: 0
2021-12-28 08:02:05	NOTICE	Do routing: 0, route_device_name: 
2021-12-28 08:02:05	NOTICE	CallerID after Provider Rules applied: +302222222222 (cut: , add: +, change callerid name: 1, change tariff id: 0, set pai: 0)
2021-12-28 08:02:05	NOTICE	Destination after Provider Rules applied: +302333333333 (cut: , add: +, change tariff: 0, set pai: 0, suffix: )
2021-12-28 08:02:05	NOTICE	Setting P-Asserted-Identity: <sip:+302222222222@111.111.111.111:5060>
2021-12-28 08:02:05	NOTICE	Setting X-Routing-Prefs:provider=forthnet;only_valid_cli=1;allowed_src=eea;allowed_dests=2653
2021-12-28 08:02:05	NOTICE	Provider PROVIDER-X, ip: 555.555.555.555, id: 55
2021-12-28 08:02:05	NOTICE	Dial string (Local to Outside): 'SIP/+302333333333@ipauthDgds4FDd,60,L(7197000:60000:60000)iIgM(mor_answer,1640678525.5042553)'
2021-12-28 08:02:05	NOTICE	Real Duration: 0.274000, Real Billsec: 0.000000, Duration: 1, Billsec: 0
2021-12-28 08:02:05	NOTICE	Res after dialing '0', hangup cause: FAILED
2021-12-28 08:02:05	WARNING	WARNING: Provider failed. Hangupcause: FAILED, code: 21, mor hangupcause: 21, hangupcause to DB: 21
2021-12-28 08:02:05	NOTICE	Checking static blacklist for destination 302333333333
2021-12-28 08:02:05	NOTICE	Provider id: 54 has a blacklist enabled. CallerID: 302222222222, PAI: +302222222222, RPID: . Number Pool id: 0
2021-12-28 08:02:05	NOTICE	Do routing: 0, route_device_name: 
2021-12-28 08:02:05	NOTICE	CallerID after Provider Rules applied: +302222222222 (cut: , add: +, change callerid name: 1, change tariff id: 0, set pai: 0)
2021-12-28 08:02:05	NOTICE	Destination after Provider Rules applied: +302333333333 (cut: , add: +, change tariff: 0, set pai: 0, suffix: )
2021-12-28 08:02:05	NOTICE	Setting P-Asserted-Identity: <sip:+302222222222@111.111.111.111:5060>
2021-12-28 08:02:05	NOTICE	Setting X-Routing-Prefs:provider=forthnet;only_valid_cli=1;allowed_src=eea;allowed_dests=2653
2021-12-28 08:02:05	NOTICE	Provider PROVIDER-Y, ip: 444.444.444.444, id: 54
2021-12-28 08:02:05	NOTICE	Dial string (Local to Outside): 'SIP/+302333333333@ipauthFg4Dsfds,60,L(7197000:60000:60000)iIgM(mor_answer,1640678525.5042553)'
2021-12-28 08:02:06	NOTICE	Real Duration: 0.458000, Real Billsec: 0.000000, Duration: 1, Billsec: 0
2021-12-28 08:02:06	NOTICE	Res after dialing '0', hangup cause: FAILED
2021-12-28 08:02:06	WARNING	WARNING: Provider failed. Hangupcause: FAILED, code: 21, mor hangupcause: 21, hangupcause to DB: 21
2021-12-28 08:02:06	NOTICE	Seconds to bill: 0
2021-12-28 08:02:06	NOTICE	DID billsec: 0, duration: 1
2021-12-28 08:02:06	NOTICE	LegA: FAILED, LegB: FAILED
2021-12-28 08:02:06	NOTICE	Prices after convert to default currency: prov_rate: 0.002150, prov_price: 0.000000, user_rate: 0.003100, user_price: 0.000000
2021-12-28 08:02:06	NOTICE	PDD: 0.000000
2021-12-28 08:02:06	NOTICE	Reseller's balance will be deducted by: 0.000000, and frozen balance by: 0.000000.
2021-12-28 08:02:06	NOTICE	Partner's balance will be deducted by: 0.000000, and frozen balance by: 0.000000.
2021-12-28 08:02:06	NOTICE	User's balance will be deducted by: 0.000000, and frozen balance by: 0.000000.
2021-12-28 08:02:06	NOTICE	User's (id: 28) balance: -1812.717051, credit: 5500.000000, daily balance limit: 0.000000 (used: 0.000000)
2021-12-28 08:02:06	NOTICE	Hangupcause: FAILED, chan->hangupcause: 21, mor hangupcause: 21, hangupcause to DB: 21, [111.111.111.111]
2021-12-28 08:02:06	NOTICE	Application mor started and ended succesfully, with end code: 0, terminated by: terminator

Case examples

Wrong Provider is Used

Sometimes provider is changed in Localization rules and it is difficult to find out where exactly it was changed. This information can be found in call log part:

2021-12-28 08:02:05	NOTICE	Destination and source localization (combined) info: dst_cut: 9991302, dst_add: 302, src_cut: 302, src_add: 302, new_did: , new_device_id: 0, new_tariff_id: 100, new_lcr_id: 106,
change callerid name: 0, location id: 81

In example it is shown that LCR is changed to ID 106 in localization rules. New LCR usually contains other providers.

Wrong Number Format is Used

Information about number format changes can be also found in the same log line as in example above:

2021-12-28 08:02:05	NOTICE	Destination and source localization (combined) info: dst_cut: 9991302, dst_add: 302, src_cut: 302, src_add: 302, new_did: , new_device_id: 0, new_tariff_id: 100, new_lcr_id: 106,
change callerid name: 0, location id: 81

In example we can see that destination number was cut 9991302 and then added 302, in result we have that destination was changed from 9991302333333333 to 302333333333

Call Failed

Call can be failed because various reasons. One of the often reason is Provider Failure. This information can be found in Call Info page and also in a log:

2021-12-28 08:02:05	WARNING	WARNING: Provider failed. Hangupcause: FAILED, code: 21, mor hangupcause: 21, hangupcause to DB: 21

In this case you should contact the provider to know the reason of failure.