Summary:	ASTERISK-16110: problem with receivefax
Reporter:	Marek Cervenka (cervajs)	Labels:
Date Opened:	2010-05-17 12:53:36	Date Closed:	2011-06-07 14:00:50
Priority:	Major	Regression?	No
Status:	Closed/Complete	Components:	Resources/res_fax
Versions:		Frequency of Occurrence
Related Issues:
Environment:		Attachments:	( 0) fax_digium.pcap
Description:	i have dialplan like exten => 211,1,ReceiveFAX(/var/spool/asteris/fax/${CALLERID(num)}-${UNIQUEID}.tif) exten => 211,n,noop(FAX RECEIVED) but after [May 17 19:41:21] WARNING[18061]: res_fax.c:700 disable_t38: error while disabling T.38 on channel 'SIP/202-00000001' [May 17 19:41:21] WARNING[18061]: res_fax.c:1277 receivefax_exec: error disabling T.38 mode on SIP/202-00000001 dialplan processing stops. no other rules are executed this happens with t.38 and audio fax mode too i have very similiar problem with app_fax+spandsp scenario: fax+linksys ata -> sip+t.38 -> receivefax i have test box with ssh access if you need ****** ADDITIONAL INFORMATION ******    -- Executing [211@faxtest:1] ReceiveFAX("SIP/202-00000001", "/var/spool/asterisk/fax/202-1274118037.1.tif") in new stack    -- Channel 'SIP/202-00000001' receiving FAX '/var/spool/asterisk/fax/202-1274118037.1.tif' [May 17 19:40:41] NOTICE[18061]: res_fax.c:1083 receivefax_t38_init: Negotiating T.38 for receive on SIP/202-00000001 [May 17 19:40:41] NOTICE[18061]: res_fax.c:1125 receivefax_t38_init: Negotiated T.38 for receive on SIP/202-00000001    -- Channel 'SIP/202-00000001' FAX session '1' started [May 17 19:41:15] DEBUG[18062]: res_fax_digium.c:2275 common_fax_thread: FAX handle 0: event: EVN_PAGE_END (0x3EB), event data: 0x0 [May 17 19:41:15] DEBUG[18062]: res_fax_digium.c:2275 common_fax_thread: FAX handle 0: event: EVN_DOC_END (0x3ED), event data: 0x0    -- FAX handle 0: [ 037.681443 ], entering CLOSING state    -- FAX handle 0: [ 037.681465 ], entering CLOSING state [May 17 19:41:19] DEBUG[18015]: chan_sip.c:21726 handle_incoming: **** Received BYE (8) - Command in SIP BYE [May 17 19:41:19] DEBUG[18015]: chan_sip.c:3286 sip_alreadygone: Setting SIP_ALREADYGONE on dialog f6e05ed1-b1df912@10.0.0.15 [May 17 19:41:19] DEBUG[18015]: chan_sip.c:21226 handle_request_bye: Received bye, issuing owner hangup [May 17 19:41:19] DEBUG[18015]: chan_sip.c:3561 __sip_xmit: Trying to put 'SIP/2.0 200' onto UDP socket destined for 85.71.148.178:5060 [May 17 19:41:19] NOTICE[18061]: res_fax.c:858 generic_fax_exec: Channel 'SIP/202-00000001' did not return a frame; probably hung up. [May 17 19:41:19] DEBUG[18061]: res_fax_digium.c:1990 dgm_fax_cancel: Ignoring cancellation request on channel 'SIP/202-00000001' for session '1' [May 17 19:41:21] DEBUG[18062]: res_fax_digium.c:2275 common_fax_thread: FAX handle 0: event: EVN_COMPLETE (0x3E9), event data: 0x0    -- Channel 'SIP/202-00000001' FAX session '1' is complete, result: 'SUCCESS' (FAX_SUCCESS), error: 'NO_ERROR', pages: 1, resolution: '204x98', transfer rate: '9600', remoteSID: '' [May 17 19:41:21] DEBUG[18061]: res_fax.c:971 generic_fax_exec: channel 'SIP/202-00000001' - event loop stopped { timeout: 8967, ms: 450, res: 0 } [May 17 19:41:21] DEBUG[18061]: res_fax_digium.c:1520 commetrex_session_destroy: FAX handle 0: freeing document queue. [May 17 19:41:21] DEBUG[18061]: res_fax_digium.c:1526 commetrex_session_destroy: FAX handle 0: closing [May 17 19:41:21] DEBUG[18061]: res_fax_digium.c:884 core2_32_T38L_Close: FAX handle 0: closed the T.38 link. [May 17 19:41:21] DEBUG[18061]: res_fax.c:698 disable_t38: Shutting down T.38 on SIP/202-00000001 [May 17 19:41:21] WARNING[18061]: res_fax.c:700 disable_t38: error while disabling T.38 on channel 'SIP/202-00000001' [May 17 19:41:21] WARNING[18061]: res_fax.c:1277 receivefax_exec: error disabling T.38 mode on SIP/202-00000001 [May 17 19:41:21] DEBUG[18061]: pbx.c:3520 pbx_substitute_variables_helper_full: Function result is '202' [May 17 19:41:21] DEBUG[18061]: pbx.c:4306 __ast_pbx_run: Spawn extension (faxtest,211,1) exited non-zero on 'SIP/202-00000001'  == Spawn extension (faxtest, 211, 1) exited non-zero on 'SIP/202-00000001' [May 17 19:41:21] DEBUG[18061]: channel.c:1661 ast_softhangup_nolock: Soft-Hanging up channel 'SIP/202-00000001'
Comments:	By: Matthew Nicholson (mnicholson) 2010-05-17 14:10:13 This warning message is normal when the channel hangs up before sendfax/receivefax exits. By: Marek Cervenka (cervajs) 2010-05-17 17:47:19 the problem is not "warning" message, but that the dialplan stop exten => 211,n,noop(FAX RECEIVED) this is not executed. this is the issue By: Matthew Nicholson (mnicholson) 2010-05-17 18:20:36 That is never executed because the channel hangs up while sendfax/receivefax is executing.  If you still need something to happen in the dialplan, use the 'h' extension. By: John Todd (jtodd) 2010-05-18 14:24:19 So does mnicholson's description match the problem you were having, or should this be re-opened?  I don't want a ticket to be closed for a reason that doesn't quite match the problem described.