-- Attempting call on SIP/07112529826@qsc for application AGI(routing.php,/tmp/email2fax/1248517710-282163000/test.pdf.tif) (Retry 1) == Using SIP RTP CoS mark 5 == Using UDPTL CoS mark 5 Audio is at 93.189.169.91 port 16898 Adding codec 0x4 (ulaw) to SDP Adding non-codec 0x1 (telephone-event) to SDP Reliably Transmitting (no NAT) to 213.148.136.2:5060: INVITE sip:07112529826@sip.qsc.de SIP/2.0 Via: SIP/2.0/UDP 93.189.169.91:5060;branch=z9hG4bK4c4ef7d9;rport Max-Forwards: 70 From: "0711123456" ;tag=as587a9568 To: Contact: Call-ID: 7e5e52897dc4f1f2660cb2b5475bd234@qsc.de CSeq: 102 INVITE User-Agent: Asterisk PBX SVN-branch-1.6.0-r208752 Date: Sat, 25 Jul 2009 10:28:31 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO Supported: replaces, timer Content-Type: application/sdp Content-Length: 282 v=0 o=root 1791264393 1791264393 IN IP4 93.189.169.91 s=Asterisk PBX SVN-branch-1.6.0-r208752 c=IN IP4 93.189.169.91 t=0 0 m=audio 16898 RTP/AVP 0 101 a=rtpmap:0 PCMU/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=silenceSupp:off - - - - a=ptime:20 a=sendrecv --- stars24*CLI> <--- SIP read from UDP://213.148.136.2:5060 ---> SIP/2.0 100 Trying Via: SIP/2.0/UDP 93.189.169.91:5060;branch=z9hG4bK4c4ef7d9;rport=5060 Call-ID: 7e5e52897dc4f1f2660cb2b5475bd234@qsc.de From: "0711123456";tag=as587a9568 To: CSeq: 102 INVITE Content-Length: 0 <-------------> --- (7 headers 0 lines) --- stars24*CLI> <--- SIP read from UDP://213.148.136.2:5060 ---> SIP/2.0 407 Proxy Authentication Required Via: SIP/2.0/UDP 93.189.169.91:5060;branch=z9hG4bK4c4ef7d9;rport=5060 Call-ID: 7e5e52897dc4f1f2660cb2b5475bd234@qsc.de From: "0711123456";tag=as587a9568 To: ;tag=c34aee5d CSeq: 102 INVITE Proxy-Authenticate: Digest realm="qsc.de",nonce="4a6adf7bcbef4add901ed42d5a3f1b0181dd9551",qop="auth" Server: QSC SIP Router Content-Length: 0 <-------------> --- (9 headers 0 lines) --- Transmitting (no NAT) to 213.148.136.2:5060: ACK sip:07112529826@sip.qsc.de SIP/2.0 Via: SIP/2.0/UDP 93.189.169.91:5060;branch=z9hG4bK4c4ef7d9;rport Max-Forwards: 70 From: "0711123456" ;tag=as587a9568 To: ;tag=c34aee5d Contact: Call-ID: 7e5e52897dc4f1f2660cb2b5475bd234@qsc.de CSeq: 102 ACK User-Agent: Asterisk PBX SVN-branch-1.6.0-r208752 Content-Length: 0 --- Audio is at 93.189.169.91 port 16898 Adding codec 0x4 (ulaw) to SDP Adding non-codec 0x1 (telephone-event) to SDP Reliably Transmitting (no NAT) to 213.148.136.2:5060: INVITE sip:07112529826@sip.qsc.de SIP/2.0 Via: SIP/2.0/UDP 93.189.169.91:5060;branch=z9hG4bK2b1dde5d;rport Max-Forwards: 70 From: "0711123456" ;tag=as587a9568 To: Contact: Call-ID: 7e5e52897dc4f1f2660cb2b5475bd234@qsc.de CSeq: 103 INVITE User-Agent: Asterisk PBX SVN-branch-1.6.0-r208752 Proxy-Authorization: Digest username="02152994430", realm="qsc.de", algorithm=MD5, uri="sip:07112529826@sip.qsc.de", nonce="4a6adf7bcbef4add901ed42d5a3f1b0181dd9551", response="4c7af8e5a8af13eb9077f04beb018bac", qop=auth, cnonce="29d51f72", nc=00000001 Date: Sat, 25 Jul 2009 10:28:31 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO Supported: replaces, timer Content-Type: application/sdp Content-Length: 282 v=0 o=root 1791264393 1791264394 IN IP4 93.189.169.91 s=Asterisk PBX SVN-branch-1.6.0-r208752 c=IN IP4 93.189.169.91 t=0 0 m=audio 16898 RTP/AVP 0 101 a=rtpmap:0 PCMU/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=silenceSupp:off - - - - a=ptime:20 a=sendrecv --- stars24*CLI> <--- SIP read from UDP://213.148.136.2:5060 ---> SIP/2.0 100 Trying Via: SIP/2.0/UDP 93.189.169.91:5060;branch=z9hG4bK2b1dde5d;rport=5060 Call-ID: 7e5e52897dc4f1f2660cb2b5475bd234@qsc.de From: "0711123456";tag=as587a9568 To: CSeq: 103 INVITE Content-Length: 0 <-------------> --- (7 headers 0 lines) --- stars24*CLI> <--- SIP read from UDP://213.148.136.2:5060 ---> SIP/2.0 200 OK Via: SIP/2.0/UDP 93.189.169.91:5060;branch=z9hG4bK2b1dde5d;rport=5060 Call-ID: 7e5e52897dc4f1f2660cb2b5475bd234@qsc.de From: "0711123456";tag=as587a9568 To: ;tag=46a22968 CSeq: 103 INVITE Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,REGISTER,INFO,PRACK,SUBSCRIBE,NOTIFY,UPDATE,MESSAGE,REFER Supported: 100rel,replaces,timer,precondition,histinfo Contact: Content-Length: 207 Content-Type: application/sdp v=0 o=HuaweiSoftX3000 9601380 9601380 IN IP4 213.148.136.2 s=Sip Call c=IN IP4 213.148.136.2 t=0 0 m=audio 36324 RTP/AVP 0 101 a=rtpmap:0 PCMU/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 <-------------> --- (11 headers 9 lines) --- Found RTP audio format 0 Found RTP audio format 101 Peer audio RTP is at port 213.148.136.2:36324 Found audio description format PCMU for ID 0 Found audio description format telephone-event for ID 101 Got unsupported a:fmtp in SDP offer Capabilities: us - 0x4 (ulaw), peer - audio=0x4 (ulaw)/video=0x0 (nothing)/text=0x0 (nothing), combined - 0x4 (ulaw) Non-codec capabilities (dtmf): us - 0x1 (telephone-event), peer - 0x1 (telephone-event), combined - 0x1 (telephone-event) Peer audio RTP is at port 213.148.136.2:36324 list_route: hop: set_destination: Parsing for address/port to send to set_destination: set destination to 213.148.136.2, port 5060 Transmitting (no NAT) to 213.148.136.2:5060: ACK sip:213.148.136.2:5060;user=phone SIP/2.0 Via: SIP/2.0/UDP 93.189.169.91:5060;branch=z9hG4bK43846035;rport Max-Forwards: 70 From: "0711123456" ;tag=as587a9568 To: ;tag=46a22968 Contact: Call-ID: 7e5e52897dc4f1f2660cb2b5475bd234@qsc.de CSeq: 103 ACK User-Agent: Asterisk PBX SVN-branch-1.6.0-r208752 Content-Length: 0 --- > Channel SIP/qsc-08231078 was answered. > Launching AGI(routing.php,/tmp/email2fax/1248517710-282163000/test.pdf.tif) on SIP/qsc-08231078 -- Launched AGI Script /var/lib/asterisk/agi-bin/routing.php routing.php,/tmp/email2fax/1248517710-282163000/test.pdf.tif: 'agi_request' => 'routing.php' routing.php,/tmp/email2fax/1248517710-282163000/test.pdf.tif: 'agi_channel' => 'SIP/qsc-08231078' routing.php,/tmp/email2fax/1248517710-282163000/test.pdf.tif: 'agi_language' => 'en' routing.php,/tmp/email2fax/1248517710-282163000/test.pdf.tif: 'agi_type' => 'SIP' routing.php,/tmp/email2fax/1248517710-282163000/test.pdf.tif: 'agi_uniqueid' => '1248517711.2' routing.php,/tmp/email2fax/1248517710-282163000/test.pdf.tif: 'agi_version' => 'SVN-branch-1.6.0-r208752' routing.php,/tmp/email2fax/1248517710-282163000/test.pdf.tif: 'agi_callerid' => '0711123456' routing.php,/tmp/email2fax/1248517710-282163000/test.pdf.tif: 'agi_calleridname' => 'unknown' routing.php,/tmp/email2fax/1248517710-282163000/test.pdf.tif: 'agi_callingpres' => '0' routing.php,/tmp/email2fax/1248517710-282163000/test.pdf.tif: 'agi_callingani2' => '0' routing.php,/tmp/email2fax/1248517710-282163000/test.pdf.tif: 'agi_callington' => '0' routing.php,/tmp/email2fax/1248517710-282163000/test.pdf.tif: 'agi_callingtns' => '0' routing.php,/tmp/email2fax/1248517710-282163000/test.pdf.tif: 'agi_dnid' => 'unknown' routing.php,/tmp/email2fax/1248517710-282163000/test.pdf.tif: 'agi_rdnis' => 'unknown' routing.php,/tmp/email2fax/1248517710-282163000/test.pdf.tif: 'agi_context' => 'default' routing.php,/tmp/email2fax/1248517710-282163000/test.pdf.tif: 'agi_extension' => '' routing.php,/tmp/email2fax/1248517710-282163000/test.pdf.tif: 'agi_priority' => '1' routing.php,/tmp/email2fax/1248517710-282163000/test.pdf.tif: 'agi_enhanced' => '0.0' routing.php,/tmp/email2fax/1248517710-282163000/test.pdf.tif: 'agi_accountcode' => '' routing.php,/tmp/email2fax/1248517710-282163000/test.pdf.tif: 'agi_threadid' => '-1225352304' routing.php,/tmp/email2fax/1248517710-282163000/test.pdf.tif: 'agi_arg_1' => '/tmp/email2fax/1248517710-282163000/test.pdf.tif' routing.php,/tmp/email2fax/1248517710-282163000/test.pdf.tif: routing.php,/tmp/email2fax/1248517710-282163000/test.pdf.tif: string(57) "unknown ; SIP/qsc-08231078 ; 1248517711.2 ; ; ; unknown"n routing.php,/tmp/email2fax/1248517710-282163000/test.pdf.tif: >> EXEC SendFAX /tmp/email2fax/1248517710-282163000/test.pdf.tif -- AGI Script Executing Application: (SendFAX) Options: (/tmp/email2fax/1248517710-282163000/test.pdf.tif) stars24*CLI> <--- SIP read from UDP://213.148.136.2:5060 ---> hello <-------------> stars24*CLI> <--- SIP read from UDP://213.148.136.2:5060 ---> hello <-------------> stars24*CLI> <--- SIP read from UDP://213.148.136.2:5060 ---> hello <-------------> stars24*CLI> <--- SIP read from UDP://213.148.136.2:5060 ---> hello <-------------> stars24*CLI> <--- SIP read from UDP://213.148.136.2:5060 ---> hello <-------------> stars24*CLI> <--- SIP read from UDP://213.148.136.2:5060 ---> hello <-------------> stars24*CLI> <--- SIP read from UDP://213.148.136.2:5060 ---> hello <-------------> stars24*CLI> <--- SIP read from UDP://213.148.136.2:5060 ---> hello <-------------> stars24*CLI> <--- SIP read from UDP://213.148.136.2:5060 ---> hello <-------------> stars24*CLI> <--- SIP read from UDP://213.148.136.2:5060 ---> hello <-------------> stars24*CLI> <--- SIP read from UDP://213.148.136.2:5060 ---> hello <-------------> stars24*CLI> <--- SIP read from UDP://213.148.136.2:5060 ---> hello <-------------> stars24*CLI> <--- SIP read from UDP://213.148.136.2:5060 ---> hello <-------------> stars24*CLI> <--- SIP read from UDP://213.148.136.2:5060 ---> hello <-------------> stars24*CLI> <--- SIP read from UDP://213.148.136.2:5060 ---> hello <-------------> stars24*CLI> <--- SIP read from UDP://213.148.136.2:5060 ---> hello <-------------> stars24*CLI> <--- SIP read from UDP://213.148.136.2:5060 ---> hello <-------------> stars24*CLI> <--- SIP read from UDP://213.148.136.2:5060 ---> hello <-------------> stars24*CLI> <--- SIP read from UDP://213.148.136.2:5060 ---> hello <-------------> stars24*CLI> <--- SIP read from UDP://213.148.136.2:5060 ---> hello <-------------> stars24*CLI> <--- SIP read from UDP://213.148.136.2:5060 ---> hello <-------------> stars24*CLI> <--- SIP read from UDP://213.148.136.2:5060 ---> hello <-------------> stars24*CLI> <--- SIP read from UDP://213.148.136.2:5060 ---> hello <-------------> stars24*CLI> <--- SIP read from UDP://213.148.136.2:5060 ---> hello <-------------> stars24*CLI> <--- SIP read from UDP://213.148.136.2:5060 ---> hello <-------------> stars24*CLI> <--- SIP read from UDP://213.148.136.2:5060 ---> hello <-------------> stars24*CLI> <--- SIP read from UDP://213.148.136.2:5060 ---> hello <-------------> stars24*CLI> <--- SIP read from UDP://213.148.136.2:5060 ---> hello <-------------> stars24*CLI> <--- SIP read from UDP://213.148.136.2:5060 ---> hello <-------------> stars24*CLI> <--- SIP read from UDP://213.148.136.2:5060 ---> hello <-------------> stars24*CLI> <--- SIP read from UDP://213.148.136.2:5060 ---> hello <-------------> stars24*CLI> <--- SIP read from UDP://213.148.136.2:5060 ---> hello <-------------> stars24*CLI> <--- SIP read from UDP://213.148.136.2:5060 ---> hello <-------------> stars24*CLI> <--- SIP read from UDP://213.148.136.2:5060 ---> hello <-------------> stars24*CLI> <--- SIP read from UDP://213.148.136.2:5060 ---> hello <-------------> stars24*CLI> <--- SIP read from UDP://213.148.136.2:5060 ---> hello <-------------> [Jul 25 10:33:32] WARNING[26594]: app_fax.c:479 transmit_audio: It looks like we hung. Aborting. [Jul 25 10:33:32] WARNING[26594]: app_fax.c:178 phase_e_handler: Error transmitting fax. result=49: The call dropped prematurely. [Jul 25 10:33:32] WARNING[26594]: app_fax.c:677 transmit: Transmission error routing.php,/tmp/email2fax/1248517710-282163000/test.pdf.tif: >> GET VARIABLE ANSWEREDTIME routing.php,/tmp/email2fax/1248517710-282163000/test.pdf.tif: >> GET VARIABLE DIALSTATUS routing.php,/tmp/email2fax/1248517710-282163000/test.pdf.tif: >> GET VARIABLE FAXSTATUS routing.php,/tmp/email2fax/1248517710-282163000/test.pdf.tif: >> GET VARIABLE FAXERROR routing.php,/tmp/email2fax/1248517710-282163000/test.pdf.tif: >> GET VARIABLE FAXMODE routing.php,/tmp/email2fax/1248517710-282163000/test.pdf.tif: >> GET VARIABLE FAXPAGES routing.php,/tmp/email2fax/1248517710-282163000/test.pdf.tif: >> GET VARIABLE FAXBITRATE routing.php,/tmp/email2fax/1248517710-282163000/test.pdf.tif: >> GET VARIABLE FAXRESOLUTION routing.php,/tmp/email2fax/1248517710-282163000/test.pdf.tif: >> GET VARIABLE REMOTESTATIONID routing.php,/tmp/email2fax/1248517710-282163000/test.pdf.tif: string(48) " FAILED The call dropped prematurely audio "n -- AGI Script routing.php completed, returning 0 Scheduling destruction of SIP dialog '7e5e52897dc4f1f2660cb2b5475bd234@qsc.de' in 32000 ms (Method: INVITE) set_destination: Parsing for address/port to send to set_destination: set destination to 213.148.136.2, port 5060 Reliably Transmitting (no NAT) to 213.148.136.2:5060: BYE sip:213.148.136.2:5060;user=phone SIP/2.0 Via: SIP/2.0/UDP 93.189.169.91:5060;branch=z9hG4bK34d43753;rport Max-Forwards: 70 From: "0711123456" ;tag=as587a9568 To: ;tag=46a22968 Call-ID: 7e5e52897dc4f1f2660cb2b5475bd234@qsc.de CSeq: 104 BYE User-Agent: Asterisk PBX SVN-branch-1.6.0-r208752 Proxy-Authorization: Digest username="02152994430", realm="qsc.de", algorithm=MD5, uri="sip:213.148.136.2:5060", nonce="4a6adf7bcbef4add901ed42d5a3f1b0181dd9551", response="4011d9d9bdf7b5a9bd59a641ccf9c675", qop=auth, cnonce="2ce51b5e", nc=00000002 X-Asterisk-HangupCause: Normal Clearing X-Asterisk-HangupCauseCode: 16 Content-Length: 0 --- [Jul 25 10:33:32] NOTICE[26594]: pbx_spool.c:357 attempt_thread: Call completed to SIP/07112529826@qsc stars24*CLI> <--- SIP read from UDP://213.148.136.2:5060 ---> SIP/2.0 200 OK Via: SIP/2.0/UDP 93.189.169.91:5060;branch=z9hG4bK34d43753;rport=5060 Call-ID: 7e5e52897dc4f1f2660cb2b5475bd234@qsc.de From: "0711123456";tag=as587a9568 To: ;tag=46a22968 CSeq: 104 BYE Content-Length: 0 <-------------> --- (7 headers 0 lines) --- Really destroying SIP dialog '7e5e52897dc4f1f2660cb2b5475bd234@qsc.de' Method: INVITE stars24*CLI>