[Home]

Summary:ASTERISK-02589: Record application fails with ast_set_read_format: Unable to find a path from GSM to UNKN
Reporter:salimf (salimf)Labels:
Date Opened:2004-10-12 15:42:25Date Closed:2008-01-15 15:10:15.000-0600
Priority:MinorRegression?No
Status:Closed/CompleteComponents:Core/CodecInterface
Versions:Frequency of
Occurrence
Related
Issues:
Environment:Attachments:( 0) mydiff.txt
Description:When connecting in via an IAX2 account I get this error when trying to use the record application. ast_set_read_format: Unable to find a path from GSM to UNKN - strangely enough, the file has actually been recorded.

The strange thing is that if I attempt exactly the same thing from local SIP handset that definitely does not use GSM codec to communicate with the asterisk server it works fine.



The actual codec for the call does not seem to ma

****** ADDITIONAL INFORMATION ******

This is the dialplan fragment that causes the bug, the error occurs at Pri :

exten => 500,1,Festival('Welcome to the IMC recording system')
exten => 500,2,SetVar(FILEBASE='${CALLERIDNUM}__${TIMESTAMP}')
exten => 500,3,SetVar(FILENAME='/var/lib/asterisk/imc/${FILEBASE}')
exten => 500,4,Festival('Please Record your message')
exten => 500,5,Record(${FILENAME}:gsm,3,120)
exten => 500,6,Festival('Convertng to M P 3. This will take a moment.')
exten => 500,7,System('sox ${FILENAME}.gsm ${FILENAME}.mp3')
exten => 500,8,System('rm ${FILENAME}.gsm')
exten => 500,9,Festival('You Said')
exten => 500,10,MP3Player(${FILENAME}.mp3)
exten => 500,11,Festival('Press 1 to keep this recording or press 2 to try again')
exten => 500,12,ResponseTimeout(5)

This is a dump of a one that goes wrong:

Oct 12 21:40:15 NOTICE[114696]: res_musiconhold.c:306 monmp3thread: Request to schedule in the past?!?!
Oct 12 21:40:15 WARNING[114696]: res_musiconhold.c:205 spawn_mp3: Found no files in '/var/lib/asterisk/mohklf'
Oct 12 21:40:15 WARNING[114696]: res_musiconhold.c:275 monmp3thread: unable to spawn mp3player
   -- Accepting unauthenticated call from 217.14.132.162, requested format = 8, actual format = 2
   -- Executing Answer("IAX2/08700683533@voiptalk_sal/1", "") in new stack
   -- Executing Goto("IAX2/08700683533@voiptalk_sal/1", "imc|500|1") in new stack
   -- Goto (imc,500,1)
   -- Executing Festival("IAX2/08700683533@voiptalk_sal/1", "Welcome to the IMC recording system") in new stack
 == Parsing '/etc/asterisk/festival.conf': Found
Oct 12 21:40:34 NOTICE[344083]: chan_iax2.c:2442 iax2_read: I should never be called!
   -- Executing SetVar("IAX2/08700683533@voiptalk_sal/1", "FILEBASE=02083410539__20041012-214034") in new stack
   -- Executing SetVar("IAX2/08700683533@voiptalk_sal/1", "FILENAME=/var/lib/asterisk/imc/02083410539__20041012-214034") in new stack
   -- Executing Festival("IAX2/08700683533@voiptalk_sal/1", "Please Record your message") in new stack
 == Parsing '/etc/asterisk/festival.conf': Found
Oct 12 21:40:36 NOTICE[344083]: chan_iax2.c:2442 iax2_read: I should never be called!
   -- Executing Record("IAX2/08700683533@voiptalk_sal/1", "/var/lib/asterisk/imc/02083410539__20041012-214034:gsm|3|120") in new stack
   -- Playing 'beep' (language 'en')
Oct 12 21:40:41 NOTICE[344083]: channel.c:1724 ast_set_read_format: Unable to find a path from GSM to UNKN
Oct 12 21:40:41 WARNING[344083]: app_record.c:287 record_exec: Unable to restore read format on 'IAX2/08700683533@voiptalk_sal/1'
 == Spawn extension (imc, 500, 5) exited non-zero on 'IAX2/08700683533@voiptalk_sal/1'
   -- Hungup 'IAX2/08700683533@voiptalk_sal/1'


And now the same but with debugging on:

Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX     Subclass: NEW
  Timestamp: 00018ms  SCall: 00103  DCall: 00000 [217.14.132.162:4569]
  VERSION         : 2
  CALLED NUMBER   : 08700683533
  CALLING NUMBER  : 02083410539
  CALLING NAME    : 02083410539
  LANGUAGE        : en
  USERNAME        : 08700683533
  FORMAT          : 8
  CAPABILITY      : 1294
  ADSICPE         : 2
  DATE TIME       : 156020011

   -- Accepting unauthenticated call from 217.14.132.162, requested format = 8, actual format = 2
Tx-Frame Retry[000] -- OSeqno: 000 ISeqno: 001 Type: IAX     Subclass: ACCEPT
  Timestamp: 00015ms  SCall: 00002  DCall: 00103 [217.14.132.162:4569]
  FORMAT          : 2

   -- Executing Answer("IAX2/08700683533@voiptalk_sal/2", "") in new stack
Tx-Frame Retry[000] -- OSeqno: 001 ISeqno: 001 Type: CONTROL Subclass: ANSWER
  Timestamp: 00018ms  SCall: 00002  DCall: 00103 [217.14.132.162:4569]
   -- Executing Goto("IAX2/08700683533@voiptalk_sal/2", "imc|500|1") in new stack
   -- Goto (imc,500,1)
   -- Executing Festival("IAX2/08700683533@voiptalk_sal/2", "Welcome to the IMC recording system") in new stack
 == Parsing '/etc/asterisk/festival.conf': Rx-Frame Retry[ No] -- OSeqno: 001 ISeqno: 001 Type: IAX     Subclass: ACK
  Timestamp: 00015ms  SCall: 00103  DCall: 00002 [217.14.132.162:4569]
Rx-Frame Retry[ No] -- OSeqno: 001 ISeqno: 002 Type: IAX     Subclass: ACK
  Timestamp: 00018ms  SCall: 00103  DCall: 00002 [217.14.132.162:4569]
Foundont*CLI>
Rx-Frame Retry[ No] -- OSeqno: 001 ISeqno: 002 Type: VOICE   Subclass: 2
  Timestamp: 00064ms  SCall: 00103  DCall: 00002 [217.14.132.162:4569]
Tx-Frame Retry[-01] -- OSeqno: 002 ISeqno: 002 Type: IAX     Subclass: ACK
  Timestamp: 00064ms  SCall: 00002  DCall: 00103 [217.14.132.162:4569]
Tx-Frame Retry[000] -- OSeqno: 002 ISeqno: 002 Type: VOICE   Subclass: 2
  Timestamp: 00217ms  SCall: 00002  DCall: 00103 [217.14.132.162:4569]
Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 003 Type: IAX     Subclass: ACK
  Timestamp: 00217ms  SCall: 00103  DCall: 00002 [217.14.132.162:4569]
Oct 12 21:41:17 NOTICE[360467]: chan_iax2.c:2442 iax2_read: I should never be called!
   -- Executing SetVar("IAX2/08700683533@voiptalk_sal/2", "FILEBASE=02083410539__20041012-214117") in new stack
   -- Executing SetVar("IAX2/08700683533@voiptalk_sal/2", "FILENAME=/var/lib/asterisk/imc/02083410539__20041012-214117") in new stack
   -- Executing Festival("IAX2/08700683533@voiptalk_sal/2", "Please Record your message") in new stack
 == Parsing '/etc/asterisk/festival.conf': Found
Oct 12 21:41:19 NOTICE[360467]: chan_iax2.c:2442 iax2_read: I should never be called!
   -- Executing Record("IAX2/08700683533@voiptalk_sal/2", "/var/lib/asterisk/imc/02083410539__20041012-214117:gsm|3|120") in new stack
   -- Playing 'beep' (language 'en')
Oct 12 21:41:24 NOTICE[360467]: channel.c:1724 ast_set_read_format: Unable to find a path from GSM to UNKN
Oct 12 21:41:24 WARNING[360467]: app_record.c:287 record_exec: Unable to restore read format on 'IAX2/08700683533@voiptalk_sal/2'
 == Spawn extension (imc, 500, 5) exited non-zero on 'IAX2/08700683533@voiptalk_sal/2'
   -- Hungup 'IAX2/08700683533@voiptalk_sal/2'
Tx-Frame Retry[000] -- OSeqno: 003 ISeqno: 002 Type: IAX     Subclass: HANGUP
  Timestamp: 09752ms  SCall: 00002  DCall: 00103 [217.14.132.162:4569]
Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 004 Type: IAX     Subclass: ACK
  Timestamp: 09752ms  SCall: 00103  DCall: 00002 [217.14.132.162:4569]
Comments:By: salimf (salimf) 2004-10-12 15:44:12

Actually this ougnt not to be a 'major' bug, because it only seems to affect a very narrow set of circumstances.
By: Mark Spencer (markster) 2004-10-12 17:29:37

This is purely an extraneous output message and has no other practical significance whatsoever.
By: Mark Spencer (markster) 2004-10-12 17:30:29

Fixed in CVS head
By: Russell Bryant (russell) 2004-10-12 22:24:30

fixed in the 1.0 branch
By: Digium Subversion (svnbot) 2008-01-15 15:10:10.000-0600

Repository: asterisk
Revision: 3984

U   trunk/apps/app_record.c

------------------------------------------------------------------------
r3984 | markster | 2008-01-15 15:10:09 -0600 (Tue, 15 Jan 2008) | 2 lines

Eliminate extraneous message (bug ASTERISK-2589)

------------------------------------------------------------------------

http://svn.digium.com/view/asterisk?view=rev&revision=3984
By: Digium Subversion (svnbot) 2008-01-15 15:10:15.000-0600

Repository: asterisk
Revision: 3989

U   branches/v1-0/apps/app_record.c

------------------------------------------------------------------------
r3989 | russell | 2008-01-15 15:10:14 -0600 (Tue, 15 Jan 2008) | 2 lines

get rid of extra error message (bug ASTERISK-2589)

------------------------------------------------------------------------

http://svn.digium.com/view/asterisk?view=rev&revision=3989