Страница 2 из 3

Re: TRANSFER_CONTEXT и DAHDI (Возврат звонков)

Добавлено: 05 апр 2016, 14:16
shines2
ded писал(а):Есть решение конечно.
Включите вербозность и дебаг побольше и приведите кусок лога - что происходит при разговоре, если нажимается flash.
Вот лог. Насчет "побольше" не уверен, в logger.conf: full => notice,warning,error,debug,verbose,dtmf,fax
1234567890 звонит на 5555555, попадает в очередь, потом на 139, 139 через флэш вызывает 184, кладет трубку, 184 и 1234567890 связываются

Код: Выделить всё

[Apr  5 14:00:28] VERBOSE[24020][C-00000162] sig_pri.c:     -- Accepting call from '1234567890' to '5555555' on channel 0/2, span 1
[Apr  5 14:00:28] VERBOSE[26512][C-00000162] pbx.c:     -- Executing [5555555@from_ptsn:1] NoOp("DAHDI/i1/1234567890-ac", ""Эксперимент 1234567890"") in new stack
[Apr  5 14:00:28] VERBOSE[26512][C-00000162] pbx.c:     -- Executing [5555555@from_ptsn:2] Queue("DAHDI/i1/1234567890-ac", "hostes,t,,,,,qh") in new stack
[Apr  5 14:00:28] VERBOSE[26512][C-00000162] res_musiconhold.c:     -- Started music on hold, class 'default', on DAHDI/i1/1234567890-ac
[Apr  5 14:00:28] VERBOSE[26512][C-00000162] sig_pri.c:     -- Requested transfer capability: 0x00 - SPEECH
[Apr  5 14:00:28] VERBOSE[26512][C-00000162] app_queue.c:     -- DAHDI/i2/139-1eb is ringing
[Apr  5 14:00:32] VERBOSE[26512][C-00000162] app_queue.c:     -- DAHDI/i2/139-1eb connected line has changed. Saving it until answer for DAHDI/i1/1234567890-ac
[Apr  5 14:00:32] VERBOSE[26512][C-00000162] app_queue.c:     -- DAHDI/i2/139-1eb answered DAHDI/i1/1234567890-ac
[Apr  5 14:00:32] VERBOSE[26512][C-00000162] res_musiconhold.c:     -- Stopped music on hold on DAHDI/i1/1234567890-ac
[Apr  5 14:00:32] VERBOSE[26512][C-00000162] pbx.c:     -- Executing [s@macro-qh:1] NoOp("DAHDI/i2/139-1eb", ""This is macro-qh"") in new stack
[Apr  5 14:00:38] VERBOSE[24021][C-00000163] sig_pri.c:     -- Accepting overlap call from '139' to '<unspecified>' on channel 0/15, span 2
[Apr  5 14:00:38] VERBOSE[26515][C-00000163] sig_pri.c:     -- Starting simple switch on 'DAHDI/i2/139-1ec'
[Apr  5 14:00:38] DTMF[26515][C-00000163] channel.c: DTMF end '1' received on DAHDI/i2/139-1ec, duration 0 ms
[Apr  5 14:00:38] DTMF[26515][C-00000163] channel.c: DTMF end accepted without begin '1' on DAHDI/i2/139-1ec
[Apr  5 14:00:38] DTMF[26515][C-00000163] channel.c: DTMF end passthrough '1' on DAHDI/i2/139-1ec
[Apr  5 14:00:38] DTMF[26515][C-00000163] channel.c: DTMF end '8' received on DAHDI/i2/139-1ec, duration 0 ms
[Apr  5 14:00:38] DTMF[26515][C-00000163] channel.c: DTMF end accepted without begin '8' on DAHDI/i2/139-1ec
[Apr  5 14:00:38] DTMF[26515][C-00000163] channel.c: DTMF end passthrough '8' on DAHDI/i2/139-1ec
[Apr  5 14:00:39] DTMF[26515][C-00000163] channel.c: DTMF end '4' received on DAHDI/i2/139-1ec, duration 0 ms
[Apr  5 14:00:39] DTMF[26515][C-00000163] channel.c: DTMF end accepted without begin '4' on DAHDI/i2/139-1ec
[Apr  5 14:00:39] DTMF[26515][C-00000163] channel.c: DTMF end passthrough '4' on DAHDI/i2/139-1ec
[Apr  5 14:00:42] VERBOSE[26515][C-00000163] pbx.c:     -- Executing [184@from_ldk:1] NoOp("DAHDI/i2/139-1ec", ""Вызов абонента LDK"") in new stack
[Apr  5 14:00:42] VERBOSE[26515][C-00000163] pbx.c:     -- Executing [184@from_ldk:2] Answer("DAHDI/i2/139-1ec", "") in new stack
[Apr  5 14:00:42] VERBOSE[26515][C-00000163] pbx.c:     -- Executing [184@from_ldk:3] Dial("DAHDI/i2/139-1ec", "DAHDI/g1/184") in new stack
[Apr  5 14:00:42] VERBOSE[26515][C-00000163] sig_pri.c:     -- Requested transfer capability: 0x00 - SPEECH
[Apr  5 14:00:42] VERBOSE[26515][C-00000163] app_dial.c:     -- Called DAHDI/g1/184
[Apr  5 14:00:42] VERBOSE[26515][C-00000163] app_dial.c:     -- DAHDI/i2/184-1ed is making progress passing it to DAHDI/i2/139-1ec
[Apr  5 14:00:42] VERBOSE[26515][C-00000163] app_dial.c:     -- DAHDI/i2/184-1ed is proceeding passing it to DAHDI/i2/139-1ec
[Apr  5 14:00:42] VERBOSE[26515][C-00000163] app_dial.c:     -- DAHDI/i2/184-1ed is ringing
[Apr  5 14:00:49] VERBOSE[26515][C-00000163] app_dial.c:     -- DAHDI/i2/184-1ed answered DAHDI/i2/139-1ec
[Apr  5 14:00:49] VERBOSE[26515][C-00000163] chan_dahdi.c:     -- Native bridging DAHDI/i2/139-1ec and DAHDI/i2/184-1ed
[Apr  5 14:00:53] VERBOSE[24021][C-00000163] sig_pri.c:     -- Span 2: Channel 0/2 got hangup request, cause 16
[Apr  5 14:00:53] VERBOSE[26515][C-00000163] chan_dahdi.c:     -- Hungup 'DAHDI/i2/184-1ed'
[Apr  5 14:00:53] VERBOSE[26515][C-00000163] pbx.c:   == Spawn extension (from_ldk, 184, 3) exited non-zero on 'DAHDI/i2/139-1ec'
[Apr  5 14:00:53] VERBOSE[26515][C-00000163] chan_dahdi.c:     -- Hungup 'DAHDI/i2/139-1ec'
[Apr  5 14:00:53] VERBOSE[24021][C-00000162] sig_pri.c:     -- Span 2: Channel 0/1 got hangup request, cause 16
[Apr  5 14:00:53] VERBOSE[26512][C-00000162] pbx.c:     -- Executing [h@from_ptsn:1] NoOp("DAHDI/i1/1234567890-ac", ""Exten: h"") in new stack
[Apr  5 14:00:53] VERBOSE[26512][C-00000162] pbx.c:     -- Executing [h@from_ptsn:2] Hangup("DAHDI/i1/1234567890-ac", "") in new stack
[Apr  5 14:00:53] VERBOSE[26512][C-00000162] pbx.c:   == Spawn extension (from_ptsn, h, 2) exited non-zero on 'DAHDI/i1/1234567890-ac'
[Apr  5 14:00:53] VERBOSE[26512][C-00000162] chan_dahdi.c:     -- Hungup 'DAHDI/i2/139-1eb'
[Apr  5 14:00:53] VERBOSE[26512][C-00000162] pbx.c:   == Spawn extension (from_ptsn, 5555555, 2) exited non-zero on 'DAHDI/i1/1234567890-ac'
[Apr  5 14:00:53] VERBOSE[26512][C-00000162] chan_dahdi.c:     -- Hungup 'DAHDI/i1/1234567890-ac'

Re: TRANSFER_CONTEXT и DAHDI (Возврат звонков)

Добавлено: 05 апр 2016, 14:22
shines2
Wapo писал(а):1. Кнопку flash удаляем из аппарата.
2. Штрафуем оператора за ТАКИЕ переводы.

Выбирайте.
ded писал(а):3. Вставляем в зад оператору дистанционно управляемый пистон, который активируется кнопкой flash.
Обратная связь - налицо!
Дело за малым: научиться выявлять использование кнопки flash. Для штрафования и дистанционного управления пистоном. Правда, есть подозрение, что обладание таким знанием даст возможность не использовать предложенные решения 1-3.

Re: TRANSFER_CONTEXT и DAHDI (Возврат звонков)

Добавлено: 05 апр 2016, 14:35
ded
Малоинформативно. Если
full => notice,warning,error,debug,verbose,dtmf,fax
то Вы привели вывод с консоли, а не из /var/log/asterisk/full где будут сообщения DEBUG

core set verbose 10
core set debug 10

Вопрос - что это за макрос? Это ведь не стандартный какой-то?
-- Executing [s@macro-qh:1] NoOp("DAHDI/i2/139-1eb", ""This is macro-qh"")

Re: TRANSFER_CONTEXT и DAHDI (Возврат звонков)

Добавлено: 05 апр 2016, 15:00
shines2
Это full. debag был установлен в 0. Установил в 10 - лог заметно подрос. Попробую найти нужный фрагмент.
Макрос - остатки экспериментов. Там только Noop и все. Указан в Queue. Вызывается, соответственно, когда кто-то из очереди соединяется с оператором.

Re: TRANSFER_CONTEXT и DAHDI (Возврат звонков)

Добавлено: 05 апр 2016, 15:05
ded
Ну, Вы тогда справитесь.

Re: TRANSFER_CONTEXT и DAHDI (Возврат звонков)

Добавлено: 05 апр 2016, 15:31
awsswa
отключите на шлюзе - восприятие кнопки flash

Re: TRANSFER_CONTEXT и DAHDI (Возврат звонков)

Добавлено: 05 апр 2016, 15:57
ded
Так они же привыкли? Его тут же повесят.

Re: TRANSFER_CONTEXT и DAHDI (Возврат звонков)

Добавлено: 05 апр 2016, 16:10
shines2
awsswa писал(а):отключите на шлюзе - восприятие кнопки flash
Это не шлюз. Абоненты подключены к АТС LG LDK-100. Она по E1 к PCI плате 2хЕ1 Parabell Quasar.

Лог. Старался отрезать все, не имеющее отношение к эксперименту, но и не переборщить. Все равно 350 строк осталось. Сам, к сожалению, не понимаю, что искать.

Код: Выделить всё

[Apr  5 15:15:23] DEBUG[24020][C-000001b4] sig_pri.c: prioffset: 3 mastertrunkgroup: 0 logicalspan: 0 result: 3
[Apr  5 15:15:23] DEBUG[24020][C-000001b4] dsp.c: Setup tone 1100 Hz, 500 ms, block_size=160, hits_required=21
[Apr  5 15:15:23] DEBUG[24020][C-000001b4] dsp.c: Setup tone 2100 Hz, 2600 ms, block_size=160, hits_required=116
[Apr  5 15:15:23] DEBUG[24020][C-000001b4] dsp.c: dsp busy pattern set to 0,0,0,0
[Apr  5 15:15:23] DEBUG[24002] cel_radius.c: Unable to create RADIUS record. CEL not recorded!
[Apr  5 15:15:23] VERBOSE[24020][C-000001b4] sig_pri.c:     -- Accepting call from '1234567890' to '5555555' on channel 0/3, span 1
[Apr  5 15:15:23] DEBUG[24020][C-000001b4] chan_dahdi.c: Enabled echo cancellation on channel 3
[Apr  5 15:15:23] DEBUG[26797][C-000001b4] pbx.c: Function result is '1234567890'
[Apr  5 15:15:23] DEBUG[26797][C-000001b4] pbx.c: Launching 'NoOp'
[Apr  5 15:15:23] VERBOSE[26797][C-000001b4] pbx.c:     -- Executing [5555555@from_ptsn:1] NoOp("DAHDI/i1/1234567890-e1", ""Эксперимент 1234567890"") in new stack
[Apr  5 15:15:23] DEBUG[26797][C-000001b4] pbx.c: Launching 'Queue'
[Apr  5 15:15:23] VERBOSE[26797][C-000001b4] pbx.c:     -- Executing [5555555@from_ptsn:2] Queue("DAHDI/i1/1234567890-e1", "hostes,t,,,,,qh") in new stack
[Apr  5 15:15:23] DEBUG[26797][C-000001b4] app_queue.c: queue: hostes, options: t, url: , announce: , timeout: , agi: , macro: qh, gosub: , rule: , position: 
[Apr  5 15:15:23] DEBUG[26797][C-000001b4] app_queue.c: NO QUEUE_PRIO variable found. Using default.
[Apr  5 15:15:23] DEBUG[26797][C-000001b4] app_queue.c: queue: hostes, expires: 0, priority: 0
[Apr  5 15:15:23] DEBUG[26797][C-000001b4] app_queue.c: Queue hostes has no realtime members defined. No need for update
[Apr  5 15:15:23] DEBUG[26797][C-000001b4] devicestate.c: device 'Queue:hostes' state '6'
[Apr  5 15:15:23] DEBUG[26797][C-000001b4] app_queue.c: Queue 'hostes' Join, Channel 'DAHDI/i1/1234567890-e1', Position '1'
[Apr  5 15:15:23] VERBOSE[26797][C-000001b4] res_musiconhold.c:     -- Started music on hold, class 'default', on DAHDI/i1/1234567890-e1
[Apr  5 15:15:23] DEBUG[24008] devicestate.c: No provider found, checking channel drivers for DAHDI - i1/1234567890
[Apr  5 15:15:23] DEBUG[26797][C-000001b4] channel.c: Scheduling timer at (50 requested / 50 actual) timer ticks per second
[Apr  5 15:15:23] DEBUG[26797][C-000001b4] channel.c: Prodding channel 'DAHDI/i1/1234567890-e1'
[Apr  5 15:15:23] DEBUG[24008] devicestate.c: Changing state for DAHDI/i1/1234567890 - state 2 (In use)
[Apr  5 15:15:23] DEBUG[26797][C-000001b4] app_queue.c: There is 1 available member.
[Apr  5 15:15:23] DEBUG[24008] devicestate.c: device 'DAHDI/i1/1234567890' state '2'
[Apr  5 15:15:23] DEBUG[26797][C-000001b4] app_queue.c: It's our turn (DAHDI/i1/1234567890-e1).
[Apr  5 15:15:23] DEBUG[26797][C-000001b4] app_queue.c: DAHDI/i1/1234567890-e1 is trying to call a queue member.
[Apr  5 15:15:23] DEBUG[26797][C-000001b4] app_queue.c: (Parallel) Trying 'DAHDI/g1/139' with metric 0
[Apr  5 15:15:23] DEBUG[24052] app_queue.c: Device 'Queue:hostes' changed to state '6' (Ringing) but we don't care because they're not a member of any queue.
[Apr  5 15:15:23] DEBUG[26797][C-000001b4] chan_dahdi.c: Using channel 32
[Apr  5 15:15:23] DEBUG[26797][C-000001b4] sig_pri.c: sig_pri_request 32
[Apr  5 15:15:23] DEBUG[24052] app_queue.c: Device 'DAHDI/i1/1234567890' changed to state '2' (In use) but we don't care because they're not a member of any queue.
[Apr  5 15:15:23] DEBUG[26797][C-000001b4] dsp.c: Setup tone 1100 Hz, 500 ms, block_size=160, hits_required=21
[Apr  5 15:15:23] DEBUG[26797][C-000001b4] dsp.c: Setup tone 2100 Hz, 2600 ms, block_size=160, hits_required=116
[Apr  5 15:15:23] DEBUG[26797][C-000001b4] dsp.c: dsp busy pattern set to 0,0,0,0
[Apr  5 15:15:23] DEBUG[26797][C-000001b4] channel_internal_api.c: Channel Call ID changing from [C-000001b4] to [C-000001b4]
[Apr  5 15:15:23] DEBUG[24002] cel_radius.c: Unable to create RADIUS record. CEL not recorded!
[Apr  5 15:15:23] DEBUG[26797][C-000001b4] channel.c: Not copying variable CALLEDTON.
[Apr  5 15:15:23] DEBUG[26797][C-000001b4] channel.c: Not copying variable PRIREDIRECTREASON.
[Apr  5 15:15:23] DEBUG[26797][C-000001b4] channel.c: Not copying variable ANI2.
[Apr  5 15:15:23] DEBUG[26797][C-000001b4] channel.c: Not copying variable TRANSFERCAPABILITY.
[Apr  5 15:15:23] DEBUG[26797][C-000001b4] sig_pri.c: CALLER NAME:  NUM: 1234567890
[Apr  5 15:15:23] DEBUG[26797][C-000001b4] sig_pri.c: prioffset: 1 mastertrunkgroup: 0 logicalspan: 0 result: 1
[Apr  5 15:15:23] VERBOSE[26797][C-000001b4] sig_pri.c:     -- Requested transfer capability: 0x00 - SPEECH
[Apr  5 15:15:23] DEBUG[24008] devicestate.c: No provider found, checking channel drivers for DAHDI - i2/139
[Apr  5 15:15:23] DEBUG[24008] devicestate.c: Changing state for DAHDI/i2/139 - state 2 (In use)
[Apr  5 15:15:23] DEBUG[24008] devicestate.c: device 'DAHDI/i2/139' state '2'
[Apr  5 15:15:23] DEBUG[24008] devicestate.c: No provider found, checking channel drivers for DAHDI - i2/139
[Apr  5 15:15:23] DEBUG[24008] devicestate.c: Changing state for DAHDI/i2/139 - state 2 (In use)
[Apr  5 15:15:23] DEBUG[24008] devicestate.c: device 'DAHDI/i2/139' state '2'
[Apr  5 15:15:23] DEBUG[24052] app_queue.c: Device 'DAHDI/i2/139' changed to state '2' (In use) but we don't care because they're not a member of any queue.
[Apr  5 15:15:23] DEBUG[24052] app_queue.c: Device 'DAHDI/i2/139' changed to state '2' (In use) but we don't care because they're not a member of any queue.
[Apr  5 15:15:23] DEBUG[26797][C-000001b4] res_musiconhold.c: DAHDI/i1/1234567890-e1 Opened file 0 '/usr/share/asterisk/moh/manolo_camp-morning_coffee'
[Apr  5 15:15:23] DEBUG[26797][C-000001b4] app_queue.c: Dunno what to do with control type 14
[Apr  5 15:15:23] DEBUG[24021][C-000001b4] sig_pri.c: Queuing frame from PRI_EVENT_PROCEEDING on channel 0/1 span 2
[Apr  5 15:15:23] DEBUG[26797][C-000001b4] app_queue.c: Dunno what to do with control type 15
[Apr  5 15:15:24] DEBUG[24021][C-000001b4] chan_dahdi.c: Enabled echo cancellation on channel 32
[Apr  5 15:15:24] DEBUG[24008] devicestate.c: No provider found, checking channel drivers for DAHDI - i2/139
[Apr  5 15:15:24] DEBUG[24008] devicestate.c: Changing state for DAHDI/i2/139 - state 6 (Ringing)
[Apr  5 15:15:24] DEBUG[24008] devicestate.c: device 'DAHDI/i2/139' state '6'
[Apr  5 15:15:24] VERBOSE[26797][C-000001b4] app_queue.c:     -- DAHDI/i2/139-263 is ringing
[Apr  5 15:15:24] DEBUG[24052] app_queue.c: Device 'DAHDI/i2/139' changed to state '6' (Ringing) but we don't care because they're not a member of any queue.
[Apr  5 15:15:26] DEBUG[24021][C-000001b4] chan_dahdi.c: Echo cancellation already on
[Apr  5 15:15:26] VERBOSE[26797][C-000001b4] app_queue.c:     -- DAHDI/i2/139-263 connected line has changed. Saving it until answer for DAHDI/i1/1234567890-e1
[Apr  5 15:15:26] VERBOSE[26797][C-000001b4] app_queue.c:     -- DAHDI/i2/139-263 answered DAHDI/i1/1234567890-e1
[Apr  5 15:15:26] DEBUG[26797][C-000001b4] chan_dahdi.c: Requested indication 22 on channel DAHDI/i1/1234567890-e1
[Apr  5 15:15:26] DEBUG[26797][C-000001b4] sig_pri.c: Received AST_CONTROL_CONNECTED_LINE on DAHDI/i1/1234567890-e1
[Apr  5 15:15:26] DEBUG[26797][C-000001b4] chan_dahdi.c: Set option TONE VERIFY, mode: MUTECONF(1) on DAHDI/i1/1234567890-e1
[Apr  5 15:15:26] DEBUG[26797][C-000001b4] chan_dahdi.c: Set option TONE VERIFY, mode: MUTECONF(1) on DAHDI/i2/139-263
[Apr  5 15:15:26] DEBUG[24002] cel_radius.c: Unable to create RADIUS record. CEL not recorded!
[Apr  5 15:15:26] VERBOSE[26797][C-000001b4] res_musiconhold.c:     -- Stopped music on hold on DAHDI/i1/1234567890-e1
[Apr  5 15:15:26] DEBUG[26797][C-000001b4] channel.c: Set channel DAHDI/i1/1234567890-e1 to write format alaw
[Apr  5 15:15:26] DEBUG[26797][C-000001b4] channel.c: Scheduling timer at (0 requested / 0 actual) timer ticks per second
[Apr  5 15:15:26] DEBUG[26797][C-000001b4] devicestate.c: device 'Queue:hostes' state '1'


[Apr  5 15:15:26] DEBUG[26797][C-000001b4] app_queue.c: Queue 'hostes' Leave, Channel 'DAHDI/i1/1234567890-e1'
[Apr  5 15:15:26] DEBUG[24008] devicestate.c: No provider found, checking channel drivers for DAHDI - i2/139
[Apr  5 15:15:26] DEBUG[24002] autochan.c: Created autochan 0xb6d12f50 to hold channel DAHDI/i1/1234567890-e1 (0xb6b6c9ec)
[Apr  5 15:15:26] DEBUG[26797][C-000001b4] app_queue.c: app_queue: macro=qh.
[Apr  5 15:15:26] DEBUG[26797][C-000001b4] app.c: DAHDI/i2/139-263 Original location: from_ldk,5555555,1
[Apr  5 15:15:26] DEBUG[26797][C-000001b4] pbx.c: Launching 'NoOp'
[Apr  5 15:15:26] VERBOSE[26797][C-000001b4] pbx.c:     -- Executing [s@macro-qh:1] NoOp("DAHDI/i2/139-263", ""This is macro-qh"") in new stack
[Apr  5 15:15:26] DEBUG[26797][C-000001b4] app_macro.c: Executed application: Noop
[Apr  5 15:15:26] DEBUG[26797][C-000001b4] app.c: Macro exited with status 0
[Apr  5 15:15:26] DEBUG[26797][C-000001b4] app.c: DAHDI/i2/139-263 Ending location: from_ldk,5555555,1
[Apr  5 15:15:26] VERBOSE[26798] app_mixmonitor.c:   == Begin MixMonitor Recording DAHDI/i1/1234567890-e1
[Apr  5 15:15:26] WARNING[26798] file.c: Unable to open file /etc/audio_records/1234567890_139_2016-04-05_151526.wav: No such file or directory
[Apr  5 15:15:26] ERROR[26798] app_mixmonitor.c: Cannot open /etc/audio_records/1234567890_139_2016-04-05_151526.wav
[Apr  5 15:15:26] DEBUG[24052] app_queue.c: Device 'Queue:hostes' changed to state '1' (Not in use) but we don't care because they're not a member of any queue.
[Apr  5 15:15:26] DEBUG[24008] devicestate.c: Changing state for DAHDI/i2/139 - state 2 (In use)
[Apr  5 15:15:26] DEBUG[24008] devicestate.c: device 'DAHDI/i2/139' state '2'
[Apr  5 15:15:26] DEBUG[24052] app_queue.c: Device 'DAHDI/i2/139' changed to state '2' (In use) but we don't care because they're not a member of any queue.
[Apr  5 15:15:26] DEBUG[24008] devicestate.c: No provider found, checking channel drivers for DAHDI - i1/1234567890
[Apr  5 15:15:26] DEBUG[26797][C-000001b4] chan_dahdi.c: Requested indication -1 on channel DAHDI/i1/1234567890-e1
[Apr  5 15:15:26] DEBUG[26797][C-000001b4] features.c: bridge answer set, chan answer set
[Apr  5 15:15:26] DEBUG[26797][C-000001b4] features.c: Removing dialed interfaces datastore on DAHDI/i2/139-263 since we're bridging
[Apr  5 15:15:26] DEBUG[26797][C-000001b4] chan_dahdi.c: Requested indication 20 on channel DAHDI/i1/1234567890-e1
[Apr  5 15:15:26] DEBUG[26797][C-000001b4] chan_dahdi.c: Requested indication 20 on channel DAHDI/i2/139-263
[Apr  5 15:15:26] DEBUG[24002] cel_radius.c: Unable to create RADIUS record. CEL not recorded!
[Apr  5 15:15:26] DEBUG[24008] devicestate.c: Changing state for DAHDI/i1/1234567890 - state 2 (In use)
[Apr  5 15:15:26] DEBUG[24008] devicestate.c: device 'DAHDI/i1/1234567890' state '2'
[Apr  5 15:15:26] DEBUG[24002] cel_radius.c: Unable to create RADIUS record. CEL not recorded!
[Apr  5 15:15:26] DEBUG[24052] app_queue.c: Device 'DAHDI/i1/1234567890' changed to state '2' (In use) but we don't care because they're not a member of any queue.
[Apr  5 15:15:26] DEBUG[24008] devicestate.c: No provider found, checking channel drivers for DAHDI - i1/5555555
[Apr  5 15:15:26] DEBUG[24002] cel_radius.c: Unable to create RADIUS record. CEL not recorded!
[Apr  5 15:15:26] DEBUG[24008] devicestate.c: Changing state for DAHDI/i1/5555555 - state 2 (In use)
[Apr  5 15:15:26] DEBUG[24008] devicestate.c: device 'DAHDI/i1/5555555' state '2'
[Apr  5 15:15:26] DEBUG[24002] cel_radius.c: Unable to create RADIUS record. CEL not recorded!
[Apr  5 15:15:26] DEBUG[24002] cel_radius.c: Unable to create RADIUS record. CEL not recorded!
[Apr  5 15:15:26] DEBUG[24052] app_queue.c: Device 'DAHDI/i1/5555555' changed to state '2' (In use) but we don't care because they're not a member of any queue.
[Apr  5 15:15:29] DEBUG[24021][C-000001b5] sig_pri.c: prioffset: 15 mastertrunkgroup: 0 logicalspan: 0 result: 15
[Apr  5 15:15:29] DEBUG[24021][C-000001b5] dsp.c: Setup tone 1100 Hz, 500 ms, block_size=160, hits_required=21
[Apr  5 15:15:29] DEBUG[24021][C-000001b5] dsp.c: Setup tone 2100 Hz, 2600 ms, block_size=160, hits_required=116
[Apr  5 15:15:29] DEBUG[24021][C-000001b5] dsp.c: dsp busy pattern set to 0,0,0,0
[Apr  5 15:15:29] DEBUG[24021][C-000001b5] sig_pri.c: prioffset: 15 mastertrunkgroup: 0 logicalspan: 0 result: 15
[Apr  5 15:15:29] DEBUG[24008] devicestate.c: No provider found, checking channel drivers for DAHDI - i2/139
[Apr  5 15:15:29] DEBUG[24008] devicestate.c: Changing state for DAHDI/i2/139 - state 2 (In use)
[Apr  5 15:15:29] DEBUG[24008] devicestate.c: device 'DAHDI/i2/139' state '2'
[Apr  5 15:15:29] DEBUG[24002] cel_radius.c: Unable to create RADIUS record. CEL not recorded!
[Apr  5 15:15:29] VERBOSE[26800][C-000001b5] sig_pri.c:     -- Starting simple switch on 'DAHDI/i2/139-264'
[Apr  5 15:15:29] VERBOSE[24021][C-000001b5] sig_pri.c:     -- Accepting overlap call from '139' to '<unspecified>' on channel 0/15, span 2
[Apr  5 15:15:29] DEBUG[24052] app_queue.c: Device 'DAHDI/i2/139' changed to state '2' (In use) but we don't care because they're not a member of any queue.
[Apr  5 15:15:29] DTMF[26800][C-000001b5] channel.c: DTMF end '1' received on DAHDI/i2/139-264, duration 0 ms
[Apr  5 15:15:29] DTMF[26800][C-000001b5] channel.c: DTMF end accepted without begin '1' on DAHDI/i2/139-264
[Apr  5 15:15:29] DTMF[26800][C-000001b5] channel.c: DTMF end passthrough '1' on DAHDI/i2/139-264
[Apr  5 15:15:30] DTMF[26800][C-000001b5] channel.c: DTMF end '8' received on DAHDI/i2/139-264, duration 0 ms
[Apr  5 15:15:30] DTMF[26800][C-000001b5] channel.c: DTMF end accepted without begin '8' on DAHDI/i2/139-264
[Apr  5 15:15:30] DTMF[26800][C-000001b5] channel.c: DTMF end passthrough '8' on DAHDI/i2/139-264
[Apr  5 15:15:30] DTMF[26800][C-000001b5] channel.c: DTMF end '4' received on DAHDI/i2/139-264, duration 0 ms
[Apr  5 15:15:30] DTMF[26800][C-000001b5] channel.c: DTMF end accepted without begin '4' on DAHDI/i2/139-264
[Apr  5 15:15:30] DTMF[26800][C-000001b5] channel.c: DTMF end passthrough '4' on DAHDI/i2/139-264
[Apr  5 15:15:33] DEBUG[26800][C-000001b5] chan_dahdi.c: Enabled echo cancellation on channel 46
[Apr  5 15:15:33] DEBUG[26800][C-000001b5] pbx.c: Launching 'NoOp'
[Apr  5 15:15:33] VERBOSE[26800][C-000001b5] pbx.c:     -- Executing [184@from_ldk:1] NoOp("DAHDI/i2/139-264", ""Вызов абонента LDK"") in new stack
[Apr  5 15:15:33] DEBUG[26800][C-000001b5] pbx.c: Launching 'Answer'
[Apr  5 15:15:33] VERBOSE[26800][C-000001b5] pbx.c:     -- Executing [184@from_ldk:2] Answer("DAHDI/i2/139-264", "") in new stack
[Apr  5 15:15:33] DEBUG[24008] devicestate.c: No provider found, checking channel drivers for DAHDI - i2/139
[Apr  5 15:15:33] DEBUG[26800][C-000001b5] chan_dahdi.c: Requested indication -1 on channel DAHDI/i2/139-264
[Apr  5 15:15:33] DEBUG[24008] devicestate.c: Changing state for DAHDI/i2/139 - state 2 (In use)
[Apr  5 15:15:33] DEBUG[24008] devicestate.c: device 'DAHDI/i2/139' state '2'
[Apr  5 15:15:33] DEBUG[24008] devicestate.c: No provider found, checking channel drivers for DAHDI - i2/139
[Apr  5 15:15:33] DEBUG[24008] devicestate.c: Changing state for DAHDI/i2/139 - state 2 (In use)
[Apr  5 15:15:33] DEBUG[24008] devicestate.c: device 'DAHDI/i2/139' state '2'
[Apr  5 15:15:33] DEBUG[24002] cel_radius.c: Unable to create RADIUS record. CEL not recorded!
[Apr  5 15:15:33] DEBUG[24052] app_queue.c: Device 'DAHDI/i2/139' changed to state '2' (In use) but we don't care because they're not a member of any queue.
[Apr  5 15:15:33] DEBUG[24052] app_queue.c: Device 'DAHDI/i2/139' changed to state '2' (In use) but we don't care because they're not a member of any queue.
[Apr  5 15:15:33] DEBUG[26800][C-000001b5] pbx.c: Result of 'EXTEN' is '184'
[Apr  5 15:15:33] DEBUG[26800][C-000001b5] pbx.c: Launching 'Dial'
[Apr  5 15:15:33] VERBOSE[26800][C-000001b5] pbx.c:     -- Executing [184@from_ldk:3] Dial("DAHDI/i2/139-264", "DAHDI/g1/184") in new stack
[Apr  5 15:15:33] DEBUG[26800][C-000001b5] chan_dahdi.c: Using channel 34
[Apr  5 15:15:33] DEBUG[26800][C-000001b5] sig_pri.c: sig_pri_request 34
[Apr  5 15:15:33] DEBUG[24002] cel_radius.c: Unable to create RADIUS record. CEL not recorded!
[Apr  5 15:15:33] DEBUG[26800][C-000001b5] dsp.c: Setup tone 1100 Hz, 500 ms, block_size=160, hits_required=21
[Apr  5 15:15:33] DEBUG[26800][C-000001b5] dsp.c: Setup tone 2100 Hz, 2600 ms, block_size=160, hits_required=116
[Apr  5 15:15:33] DEBUG[26800][C-000001b5] dsp.c: dsp busy pattern set to 0,0,0,0
[Apr  5 15:15:33] DEBUG[26800][C-000001b5] channel_internal_api.c: Channel Call ID changing from [C-000001b5] to [C-000001b5]
[Apr  5 15:15:33] DEBUG[24002] cel_radius.c: Unable to create RADIUS record. CEL not recorded!
[Apr  5 15:15:33] DEBUG[26800][C-000001b5] rtp_engine.c: Can't find native functions for channel 'DAHDI/i2/184-265'
[Apr  5 15:15:33] DEBUG[26800][C-000001b5] channel.c: Not copying variable DIALEDTIME.
[Apr  5 15:15:33] DEBUG[26800][C-000001b5] channel.c: Not copying variable ANSWEREDTIME.
[Apr  5 15:15:33] DEBUG[26800][C-000001b5] channel.c: Not copying variable DIALEDPEERNAME.
[Apr  5 15:15:33] DEBUG[26800][C-000001b5] channel.c: Not copying variable DIALEDPEERNUMBER.
[Apr  5 15:15:33] DEBUG[26800][C-000001b5] channel.c: Not copying variable DIALSTATUS.
[Apr  5 15:15:33] DEBUG[26800][C-000001b5] channel.c: Not copying variable PRIREDIRECTREASON.
[Apr  5 15:15:33] DEBUG[26800][C-000001b5] channel.c: Not copying variable CALLEDTON.
[Apr  5 15:15:33] DEBUG[26800][C-000001b5] channel.c: Not copying variable ANI2.
[Apr  5 15:15:33] DEBUG[26800][C-000001b5] channel.c: Not copying variable TRANSFERCAPABILITY.
[Apr  5 15:15:33] DEBUG[26800][C-000001b5] sig_pri.c: CALLER NAME:  NUM: 139
[Apr  5 15:15:33] DEBUG[26800][C-000001b5] sig_pri.c: prioffset: 3 mastertrunkgroup: 0 logicalspan: 0 result: 3
[Apr  5 15:15:33] VERBOSE[26800][C-000001b5] sig_pri.c:     -- Requested transfer capability: 0x00 - SPEECH
[Apr  5 15:15:33] VERBOSE[26800][C-000001b5] app_dial.c:     -- Called DAHDI/g1/184
[Apr  5 15:15:33] DEBUG[24008] devicestate.c: No provider found, checking channel drivers for DAHDI - i2/184
[Apr  5 15:15:33] DEBUG[24008] devicestate.c: Changing state for DAHDI/i2/184 - state 2 (In use)
[Apr  5 15:15:33] DEBUG[24008] devicestate.c: device 'DAHDI/i2/184' state '2'
[Apr  5 15:15:33] DEBUG[24008] devicestate.c: No provider found, checking channel drivers for DAHDI - i2/184
[Apr  5 15:15:33] DEBUG[24008] devicestate.c: Changing state for DAHDI/i2/184 - state 2 (In use)
[Apr  5 15:15:33] DEBUG[24008] devicestate.c: device 'DAHDI/i2/184' state '2'
[Apr  5 15:15:33] DEBUG[24052] app_queue.c: Device 'DAHDI/i2/184' changed to state '2' (In use) but we don't care because they're not a member of any queue.
[Apr  5 15:15:33] DEBUG[24052] app_queue.c: Device 'DAHDI/i2/184' changed to state '2' (In use) but we don't care because they're not a member of any queue.
[Apr  5 15:15:33] DEBUG[26800][C-000001b5] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/i2/184-265...
[Apr  5 15:15:33] DEBUG[26800][C-000001b5] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/i2/184-265...
[Apr  5 15:15:33] VERBOSE[26800][C-000001b5] app_dial.c:     -- DAHDI/i2/184-265 is making progress passing it to DAHDI/i2/139-264
[Apr  5 15:15:33] DEBUG[26800][C-000001b5] chan_dahdi.c: Requested indication 14 on channel DAHDI/i2/139-264
[Apr  5 15:15:33] DEBUG[26800][C-000001b5] sig_pri.c: Received AST_CONTROL_PROGRESS on DAHDI/i2/139-264
[Apr  5 15:15:33] DEBUG[24021][C-000001b5] sig_pri.c: Queuing frame from PRI_EVENT_PROCEEDING on channel 0/3 span 2
[Apr  5 15:15:33] VERBOSE[26800][C-000001b5] app_dial.c:     -- DAHDI/i2/184-265 is proceeding passing it to DAHDI/i2/139-264
[Apr  5 15:15:33] DEBUG[26800][C-000001b5] chan_dahdi.c: Requested indication 15 on channel DAHDI/i2/139-264
[Apr  5 15:15:33] DEBUG[26800][C-000001b5] sig_pri.c: Received AST_CONTROL_PROCEEDING on DAHDI/i2/139-264
[Apr  5 15:15:33] DEBUG[24021][C-000001b5] chan_dahdi.c: Enabled echo cancellation on channel 34
[Apr  5 15:15:33] DEBUG[24008] devicestate.c: No provider found, checking channel drivers for DAHDI - i2/184
[Apr  5 15:15:33] DEBUG[24008] devicestate.c: Changing state for DAHDI/i2/184 - state 6 (Ringing)
[Apr  5 15:15:33] DEBUG[24008] devicestate.c: device 'DAHDI/i2/184' state '6'
[Apr  5 15:15:33] DEBUG[24052] app_queue.c: Device 'DAHDI/i2/184' changed to state '6' (Ringing) but we don't care because they're not a member of any queue.
[Apr  5 15:15:33] VERBOSE[26800][C-000001b5] app_dial.c:     -- DAHDI/i2/184-265 is ringing
[Apr  5 15:15:33] DEBUG[26800][C-000001b5] chan_dahdi.c: Requested indication 3 on channel DAHDI/i2/139-264
[Apr  5 15:15:38] DEBUG[24021][C-000001b5] chan_dahdi.c: Echo cancellation already on
[Apr  5 15:15:38] DEBUG[26800][C-000001b5] chan_dahdi.c: Requested indication 22 on channel DAHDI/i2/139-264
[Apr  5 15:15:38] DEBUG[26800][C-000001b5] sig_pri.c: Received AST_CONTROL_CONNECTED_LINE on DAHDI/i2/139-264
[Apr  5 15:15:38] DEBUG[24008] devicestate.c: No provider found, checking channel drivers for DAHDI - i2/184
[Apr  5 15:15:38] VERBOSE[26800][C-000001b5] app_dial.c:     -- DAHDI/i2/184-265 answered DAHDI/i2/139-264
[Apr  5 15:15:38] DEBUG[24008] devicestate.c: Changing state for DAHDI/i2/184 - state 2 (In use)
[Apr  5 15:15:38] DEBUG[24008] devicestate.c: device 'DAHDI/i2/184' state '2'
[Apr  5 15:15:38] DEBUG[26800][C-000001b5] features.c: bridge answer set, chan answer set
[Apr  5 15:15:38] DEBUG[26800][C-000001b5] features.c: Removing dialed interfaces datastore on DAHDI/i2/184-265 since we're bridging
[Apr  5 15:15:38] DEBUG[26800][C-000001b5] chan_dahdi.c: Requested indication 20 on channel DAHDI/i2/139-264
[Apr  5 15:15:38] DEBUG[26800][C-000001b5] chan_dahdi.c: Requested indication 20 on channel DAHDI/i2/184-265
[Apr  5 15:15:38] DEBUG[26800][C-000001b5] chan_dahdi.c: master: 46, slave: 34, nothingok: 0
[Apr  5 15:15:38] DEBUG[26800][C-000001b5] chan_dahdi.c: Stopping tones on 46/0(DAHDI/i2/139-264) talking to 34/0(DAHDI/i2/184-265)
[Apr  5 15:15:38] DEBUG[26800][C-000001b5] chan_dahdi.c: Stopping tones on 34/0(DAHDI/i2/184-265) talking to 46/0(DAHDI/i2/139-264)
[Apr  5 15:15:38] DEBUG[26800][C-000001b5] chan_dahdi.c: Making 34 slave to master 46 at 0
[Apr  5 15:15:38] DEBUG[26800][C-000001b5] chan_dahdi.c: Added 28 to conference 9/46
[Apr  5 15:15:38] DEBUG[26800][C-000001b5] chan_dahdi.c: Added 40 to conference 9/34
[Apr  5 15:15:38] DEBUG[26800][C-000001b5] chan_dahdi.c: Updated conferencing on 46, with 0 conference users
[Apr  5 15:15:38] DEBUG[26800][C-000001b5] chan_dahdi.c: Updated conferencing on 34, with 0 conference users
[Apr  5 15:15:38] VERBOSE[26800][C-000001b5] chan_dahdi.c:     -- Native bridging DAHDI/i2/139-264 and DAHDI/i2/184-265
[Apr  5 15:15:38] DEBUG[24002] cel_radius.c: Unable to create RADIUS record. CEL not recorded!
[Apr  5 15:15:38] DEBUG[24002] cel_radius.c: Unable to create RADIUS record. CEL not recorded!
[Apr  5 15:15:38] DEBUG[24052] app_queue.c: Device 'DAHDI/i2/184' changed to state '2' (In use) but we don't care because they're not a member of any queue.
[Apr  5 15:15:41] VERBOSE[24021][C-000001b5] sig_pri.c:     -- Span 2: Channel 0/3 got hangup request, cause 16
[Apr  5 15:15:41] DEBUG[26800][C-000001b5] chan_dahdi.c: Echo cancellation already on
[Apr  5 15:15:41] DEBUG[26800][C-000001b5] chan_dahdi.c: Echo cancellation already on
[Apr  5 15:15:41] DEBUG[26800][C-000001b5] chan_dahdi.c: Unlinking slave 34 from 46
[Apr  5 15:15:41] DEBUG[26800][C-000001b5] chan_dahdi.c: Removed 28 from conference 9/46
[Apr  5 15:15:41] DEBUG[26800][C-000001b5] chan_dahdi.c: Removed 40 from conference 9/34
[Apr  5 15:15:41] DEBUG[26800][C-000001b5] chan_dahdi.c: Updated conferencing on 46, with 0 conference users
[Apr  5 15:15:41] DEBUG[26800][C-000001b5] channel.c: Returning from native bridge, channels: DAHDI/i2/139-264, DAHDI/i2/184-265
[Apr  5 15:15:41] DEBUG[24002] cel_radius.c: Unable to create RADIUS record. CEL not recorded!
[Apr  5 15:15:41] DEBUG[26800][C-000001b5] cdr_radius.c: Unable to create RADIUS record. CDR not recorded!
[Apr  5 15:15:41] DEBUG[26800][C-000001b5] res_config_sqlite.c: SQL query: INSERT INTO ast_cdr (clid,src,dst,dcontext,channel,dstchannel,lastapp,lastdata,start,answer,end,duration,billsec,disposition,amaflags,uniqueid) VALUES ('139','139','184','from_ldk','DAHDI/i2/139-264','DAHDI/i2/184-265','Dial','DAHDI/g1/184','2016-04-05 15:15:29','2016-04-05 15:15:38','2016-04-05 15:15:41','12','3','ANSWERED','DOCUMENTATION','1459858529.1017')
[Apr  5 15:15:41] DEBUG[26800][C-000001b5] channel.c: Hanging up channel 'DAHDI/i2/184-265'
[Apr  5 15:15:41] DEBUG[26800][C-000001b5] chan_dahdi.c: dahdi_hangup(DAHDI/i2/184-265)
[Apr  5 15:15:41] DEBUG[26800][C-000001b5] chan_dahdi.c: Set option AUDIO MODE, value: ON(1) on DAHDI/i2/184-265
[Apr  5 15:15:41] DEBUG[26800][C-000001b5] sig_pri.c: sig_pri_hangup 34
[Apr  5 15:15:41] DEBUG[26800][C-000001b5] sig_pri.c: Channel 'DAHDI/i2/184-265' MOH-Event: SIG_PRI_MOH_EVENT_RESET in state SIG_PRI_MOH_STATE_IDLE
[Apr  5 15:15:41] DEBUG[26800][C-000001b5] sig_pri.c: Channel 'DAHDI/i2/184-265'  MOH-Next-State: $
[Apr  5 15:15:41] DEBUG[26800][C-000001b5] sig_pri.c: Not yet hungup...  Calling hangup with cause 16, and clearing call
[Apr  5 15:15:41] DEBUG[26800][C-000001b5] chan_dahdi.c: Disabled echo cancellation on channel 34
[Apr  5 15:15:41] DEBUG[26800][C-000001b5] chan_dahdi.c: Set option TDD MODE, value: OFF(0) on DAHDI/i2/184-265
[Apr  5 15:15:41] DEBUG[26800][C-000001b5] chan_dahdi.c: Updated conferencing on 34, with 0 conference users
[Apr  5 15:15:41] DEBUG[26800][C-000001b5] chan_dahdi.c: Set option AUDIO MODE, value: OFF(0) on DAHDI/i2/184-265
[Apr  5 15:15:41] VERBOSE[26800][C-000001b5] chan_dahdi.c:     -- Hungup 'DAHDI/i2/184-265'
[Apr  5 15:15:41] DEBUG[24002] cel_radius.c: Unable to create RADIUS record. CEL not recorded!
[Apr  5 15:15:41] DEBUG[24002] cel_radius.c: Unable to create RADIUS record. CEL not recorded!
[Apr  5 15:15:41] DEBUG[24008] devicestate.c: No provider found, checking channel drivers for DAHDI - i2/184
[Apr  5 15:15:41] DEBUG[24008] devicestate.c: Changing state for DAHDI/i2/184 - state 0 (Unknown)
[Apr  5 15:15:41] DEBUG[24008] devicestate.c: device 'DAHDI/i2/184' state '0'
[Apr  5 15:15:41] DEBUG[24052] app_queue.c: Device 'DAHDI/i2/184' changed to state '0' (Unknown) but we don't care because they're not a member of any queue.
[Apr  5 15:15:41] DEBUG[26800][C-000001b5] app_dial.c: Exiting with DIALSTATUS=ANSWER.
[Apr  5 15:15:41] DEBUG[26800][C-000001b5] pbx.c: Spawn extension (from_ldk,184,3) exited non-zero on 'DAHDI/i2/139-264'
[Apr  5 15:15:41] VERBOSE[26800][C-000001b5] pbx.c:   == Spawn extension (from_ldk, 184, 3) exited non-zero on 'DAHDI/i2/139-264'
[Apr  5 15:15:41] DEBUG[26800][C-000001b5] channel.c: Soft-Hanging up channel 'DAHDI/i2/139-264'
[Apr  5 15:15:41] DEBUG[26800][C-000001b5] channel.c: Hanging up channel 'DAHDI/i2/139-264'
[Apr  5 15:15:41] DEBUG[26800][C-000001b5] chan_dahdi.c: dahdi_hangup(DAHDI/i2/139-264)
[Apr  5 15:15:41] DEBUG[26800][C-000001b5] chan_dahdi.c: Set option AUDIO MODE, value: ON(1) on DAHDI/i2/139-264
[Apr  5 15:15:41] DEBUG[26800][C-000001b5] sig_pri.c: sig_pri_hangup 46
[Apr  5 15:15:41] DEBUG[24002] cel_radius.c: Unable to create RADIUS record. CEL not recorded!
[Apr  5 15:15:41] DEBUG[24002] cel_radius.c: Unable to create RADIUS record. CEL not recorded!
[Apr  5 15:15:41] DEBUG[26800][C-000001b5] sig_pri.c: Channel 'DAHDI/i2/139-264' MOH-Event: SIG_PRI_MOH_EVENT_RESET in state SIG_PRI_MOH_STATE_IDLE
[Apr  5 15:15:41] DEBUG[26800][C-000001b5] sig_pri.c: Channel 'DAHDI/i2/139-264'  MOH-Next-State: $
[Apr  5 15:15:41] DEBUG[26800][C-000001b5] sig_pri.c: Not yet hungup...  Calling hangup with cause 16, and clearing call
[Apr  5 15:15:41] DEBUG[26800][C-000001b5] chan_dahdi.c: Disabled echo cancellation on channel 46
[Apr  5 15:15:41] DEBUG[26800][C-000001b5] chan_dahdi.c: Set option TDD MODE, value: OFF(0) on DAHDI/i2/139-264
[Apr  5 15:15:41] DEBUG[26800][C-000001b5] chan_dahdi.c: Updated conferencing on 46, with 0 conference users
[Apr  5 15:15:41] DEBUG[26800][C-000001b5] chan_dahdi.c: Set option AUDIO MODE, value: OFF(0) on DAHDI/i2/139-264
[Apr  5 15:15:41] VERBOSE[26800][C-000001b5] chan_dahdi.c:     -- Hungup 'DAHDI/i2/139-264'
[Apr  5 15:15:41] DEBUG[24008] devicestate.c: No provider found, checking channel drivers for DAHDI - i2/139
[Apr  5 15:15:41] DEBUG[24008] devicestate.c: Changing state for DAHDI/i2/139 - state 2 (In use)
[Apr  5 15:15:41] DEBUG[24008] devicestate.c: device 'DAHDI/i2/139' state '2'
[Apr  5 15:15:41] DEBUG[24002] cel_radius.c: Unable to create RADIUS record. CEL not recorded!
[Apr  5 15:15:41] DEBUG[24002] cel_radius.c: Unable to create RADIUS record. CEL not recorded!
[Apr  5 15:15:41] DEBUG[24052] app_queue.c: Device 'DAHDI/i2/139' changed to state '2' (In use) but we don't care because they're not a member of any queue.
[Apr  5 15:15:41] VERBOSE[24021][C-000001b4] sig_pri.c:     -- Span 2: Channel 0/1 got hangup request, cause 16
[Apr  5 15:15:41] DEBUG[26797][C-000001b4] chan_dahdi.c: Requested indication 33 on channel DAHDI/i1/1234567890-e1
[Apr  5 15:15:41] DEBUG[26797][C-000001b4] channel.c: Didn't get a frame from channel: DAHDI/i2/139-263
[Apr  5 15:15:41] DEBUG[26797][C-000001b4] chan_dahdi.c: Requested indication 20 on channel DAHDI/i1/1234567890-e1
[Apr  5 15:15:41] DEBUG[26797][C-000001b4] channel.c: Bridge stops bridging channels DAHDI/i1/1234567890-e1 and DAHDI/i2/139-263
[Apr  5 15:15:41] DEBUG[26797][C-000001b4] channel.c: Soft-Hanging up channel 'DAHDI/i1/1234567890-e1'
[Apr  5 15:15:41] DEBUG[26797][C-000001b4] pbx.c: Result of 'EXTEN' is 'h'
[Apr  5 15:15:41] DEBUG[26797][C-000001b4] pbx.c: Launching 'NoOp'
[Apr  5 15:15:41] DEBUG[24002] cel_radius.c: Unable to create RADIUS record. CEL not recorded!
[Apr  5 15:15:41] VERBOSE[26797][C-000001b4] pbx.c:     -- Executing [h@from_ptsn:1] NoOp("DAHDI/i1/1234567890-e1", ""Exten: h"") in new stack
[Apr  5 15:15:41] DEBUG[26797][C-000001b4] pbx.c: Launching 'Hangup'
[Apr  5 15:15:41] VERBOSE[26797][C-000001b4] pbx.c:     -- Executing [h@from_ptsn:2] Hangup("DAHDI/i1/1234567890-e1", "") in new stack
[Apr  5 15:15:41] DEBUG[26797][C-000001b4] channel.c: Soft-Hanging up channel 'DAHDI/i1/1234567890-e1'
[Apr  5 15:15:41] DEBUG[26797][C-000001b4] pbx.c: Spawn extension (from_ptsn,h,2) exited non-zero on 'DAHDI/i1/1234567890-e1'
[Apr  5 15:15:41] VERBOSE[26797][C-000001b4] pbx.c:   == Spawn extension (from_ptsn, h, 2) exited non-zero on 'DAHDI/i1/1234567890-e1'
[Apr  5 15:15:41] DEBUG[26797][C-000001b4] cdr_radius.c: Unable to create RADIUS record. CDR not recorded!
[Apr  5 15:15:41] DEBUG[26797][C-000001b4] res_config_sqlite.c: SQL query: INSERT INTO ast_cdr (clid,src,dst,dcontext,channel,dstchannel,lastapp,lastdata,start,answer,end,duration,billsec,disposition,amaflags,uniqueid) VALUES ('1234567890','1234567890','5555555','from_ptsn','DAHDI/i1/1234567890-e1','DAHDI/i2/139-263','Queue','hostes,t,,,,,qh','2016-04-05 15:15:23','2016-04-05 15:15:26','2016-04-05 15:15:41','18','15','ANSWERED','DOCUMENTATION','1459858523.1015')
[Apr  5 15:15:41] DEBUG[26797][C-000001b4] channel.c: Hanging up channel 'DAHDI/i2/139-263'
[Apr  5 15:15:41] DEBUG[26797][C-000001b4] chan_dahdi.c: dahdi_hangup(DAHDI/i2/139-263)
[Apr  5 15:15:41] DEBUG[26797][C-000001b4] chan_dahdi.c: Set option AUDIO MODE, value: ON(1) on DAHDI/i2/139-263
[Apr  5 15:15:41] DEBUG[26797][C-000001b4] sig_pri.c: sig_pri_hangup 32
[Apr  5 15:15:41] DEBUG[26797][C-000001b4] sig_pri.c: Channel 'DAHDI/i2/139-263' MOH-Event: SIG_PRI_MOH_EVENT_RESET in state SIG_PRI_MOH_STATE_IDLE
[Apr  5 15:15:41] DEBUG[26797][C-000001b4] sig_pri.c: Channel 'DAHDI/i2/139-263'  MOH-Next-State: $
[Apr  5 15:15:41] DEBUG[26797][C-000001b4] sig_pri.c: Not yet hungup...  Calling hangup with cause 16, and clearing call
[Apr  5 15:15:41] DEBUG[26797][C-000001b4] chan_dahdi.c: Disabled echo cancellation on channel 32
[Apr  5 15:15:41] DEBUG[26797][C-000001b4] chan_dahdi.c: Set option TDD MODE, value: OFF(0) on DAHDI/i2/139-263
[Apr  5 15:15:41] DEBUG[26797][C-000001b4] chan_dahdi.c: Updated conferencing on 32, with 0 conference users
[Apr  5 15:15:41] DEBUG[26797][C-000001b4] chan_dahdi.c: Set option AUDIO MODE, value: OFF(0) on DAHDI/i2/139-263
[Apr  5 15:15:41] VERBOSE[26797][C-000001b4] chan_dahdi.c:     -- Hungup 'DAHDI/i2/139-263'
[Apr  5 15:15:41] DEBUG[24008] devicestate.c: No provider found, checking channel drivers for DAHDI - i2/139
[Apr  5 15:15:41] DEBUG[24002] cel_radius.c: Unable to create RADIUS record. CEL not recorded!
[Apr  5 15:15:41] DEBUG[24008] devicestate.c: Changing state for DAHDI/i2/139 - state 0 (Unknown)
[Apr  5 15:15:41] DEBUG[24008] devicestate.c: device 'DAHDI/i2/139' state '0'
[Apr  5 15:15:41] DEBUG[24002] cel_radius.c: Unable to create RADIUS record. CEL not recorded!
[Apr  5 15:15:41] DEBUG[24052] app_queue.c: Device 'DAHDI/i2/139' changed to state '0' (Unknown) but we don't care because they're not a member of any queue.
[Apr  5 15:15:41] DEBUG[26797][C-000001b4] pbx.c: Spawn extension (from_ptsn,5555555,2) exited non-zero on 'DAHDI/i1/1234567890-e1'
[Apr  5 15:15:41] VERBOSE[26797][C-000001b4] pbx.c:   == Spawn extension (from_ptsn, 5555555, 2) exited non-zero on 'DAHDI/i1/1234567890-e1'
[Apr  5 15:15:41] DEBUG[26797][C-000001b4] channel.c: Soft-Hanging up channel 'DAHDI/i1/1234567890-e1'
[Apr  5 15:15:41] DEBUG[26797][C-000001b4] channel.c: Hanging up channel 'DAHDI/i1/1234567890-e1'
[Apr  5 15:15:41] DEBUG[26797][C-000001b4] chan_dahdi.c: dahdi_hangup(DAHDI/i1/1234567890-e1)
[Apr  5 15:15:41] DEBUG[26797][C-000001b4] chan_dahdi.c: Set option AUDIO MODE, value: ON(1) on DAHDI/i1/1234567890-e1
[Apr  5 15:15:41] DEBUG[26797][C-000001b4] sig_pri.c: sig_pri_hangup 3
[Apr  5 15:15:41] DEBUG[26797][C-000001b4] sig_pri.c: Channel 'DAHDI/i1/1234567890-e1' MOH-Event: SIG_PRI_MOH_EVENT_RESET in state SIG_PRI_MOH_STATE_IDLE
[Apr  5 15:15:41] DEBUG[26797][C-000001b4] sig_pri.c: Channel 'DAHDI/i1/1234567890-e1'  MOH-Next-State: $
[Apr  5 15:15:41] DEBUG[26797][C-000001b4] sig_pri.c: Not yet hungup...  Calling hangup with cause 16, and clearing call
[Apr  5 15:15:41] DEBUG[26797][C-000001b4] chan_dahdi.c: Disabled echo cancellation on channel 3
[Apr  5 15:15:41] DEBUG[26797][C-000001b4] chan_dahdi.c: Set option TDD MODE, value: OFF(0) on DAHDI/i1/1234567890-e1
[Apr  5 15:15:41] DEBUG[26797][C-000001b4] chan_dahdi.c: Updated conferencing on 3, with 0 conference users
[Apr  5 15:15:41] DEBUG[26797][C-000001b4] chan_dahdi.c: Set option AUDIO MODE, value: OFF(0) on DAHDI/i1/1234567890-e1
[Apr  5 15:15:41] VERBOSE[26797][C-000001b4] chan_dahdi.c:     -- Hungup 'DAHDI/i1/1234567890-e1'
[Apr  5 15:15:41] DEBUG[26798] autochan.c: Removed autochan 0xb6d12f50 from the list, about to free it
[Apr  5 15:15:41] VERBOSE[26798] app_mixmonitor.c:   == End MixMonitor Recording DAHDI/i1/1234567890-e1
[Apr  5 15:15:41] DEBUG[26798] app_mixmonitor.c: No recipients to forward monitor to, moving on.
[Apr  5 15:15:41] DEBUG[24002] cel_radius.c: Unable to create RADIUS record. CEL not recorded!
[Apr  5 15:15:41] DEBUG[24008] devicestate.c: No provider found, checking channel drivers for DAHDI - i1/1234567890
[Apr  5 15:15:41] DEBUG[24008] devicestate.c: Changing state for DAHDI/i1/1234567890 - state 0 (Unknown)
[Apr  5 15:15:41] DEBUG[24008] devicestate.c: device 'DAHDI/i1/1234567890' state '0'
[Apr  5 15:15:41] DEBUG[24002] cel_radius.c: Unable to create RADIUS record. CEL not recorded!
[Apr  5 15:15:41] DEBUG[24002] cel_radius.c: Unable to create RADIUS record. CEL not recorded!
[Apr  5 15:15:41] DEBUG[24052] app_queue.c: Device 'DAHDI/i1/1234567890' changed to state '0' (Unknown) but we don't care because they're not a member of any queue.
[Apr  5 15:15:41] DEBUG[24002] cel_radius.c: Unable to create RADIUS record. CEL not recorded!
[Apr  5 15:15:41] DEBUG[24002] cel_radius.c: Unable to create RADIUS record. CEL not recorded!
[Apr  5 15:15:41] DEBUG[24008] devicestate.c: No provider found, checking channel drivers for DAHDI - i1/5555555
[Apr  5 15:15:41] DEBUG[24002] cel_radius.c: Unable to create RADIUS record. CEL not recorded!
[Apr  5 15:15:41] DEBUG[24008] devicestate.c: Changing state for DAHDI/i1/5555555 - state 0 (Unknown)
[Apr  5 15:15:41] DEBUG[24008] devicestate.c: device 'DAHDI/i1/5555555' state '0'
[Apr  5 15:15:41] DEBUG[24052] app_queue.c: Device 'DAHDI/i1/5555555' changed to state '0' (Unknown) but we don't care because they're not a member of any queue.
[Apr  5 15:15:41] DEBUG[24002] cel_radius.c: Unable to create RADIUS record. CEL not recorded!
[Apr  5 15:15:41] DEBUG[24002] cel_radius.c: Unable to create RADIUS record. CEL not recorded!
[Apr  5 15:15:41] DEBUG[26799] autochan.c: Removed autochan 0xb6d071a0 from the list, about to free it
[Apr  5 15:15:41] DEBUG[26799] app_mixmonitor.c: No recipients to forward monitor to, moving on.
[Apr  5 15:15:41] DEBUG[24002] cel_radius.c: Unable to create RADIUS record. CEL not recorded!
[Apr  5 15:15:41] DEBUG[24002] cel_radius.c: Unable to create RADIUS record. CEL not recorded!
[Apr  5 15:15:41] DEBUG[24017] rtp_engine.c: Destroyed RTP instance '0xb6d716c4'

Re: TRANSFER_CONTEXT и DAHDI (Возврат звонков)

Добавлено: 05 апр 2016, 16:17
ded
Цитирую кусок chan_dahdi.conf
; Whether or not to enable call waiting on internal extensions
; With this set to 'yes', busy extensions will hear the call-waiting
; tone, and can use hook-flash to switch between callers. The Dial()
; app will not return the "BUSY" result for extensions.
;
callwaiting=yes
Установите callwaiting=no и не будет у ваших абонентов возможности use hook-flash.

Re: TRANSFER_CONTEXT и DAHDI (Возврат звонков)

Добавлено: 05 апр 2016, 16:34
shines2
ded писал(а):Установите callwaiting=no и не будет у ваших абонентов возможности use hook-flash.
Спасибо. Действительно, так уже можно строить рабочее решение.