pstn8*CLI> originate Local/s@originate-leg2 extension s@originate-leg1 -- Called s@originate-leg2 -- Executing [s@originate-leg2:1] Dial("Local/s@originate-leg2-00000002;2", "SIP/9000,60,U(orig-ans)") in new stack == Using SIP RTP CoS mark 5 Audio is at 15438 Adding codec alaw to SDP Adding codec ulaw to SDP Adding non-codec 0x1 (telephone-event) to SDP Reliably Transmitting (no NAT) to 172.28.128.200:5060: INVITE sip:9000@172.28.128.200:5060;rinstance=5f386d651cac737f;transport=UDP SIP/2.0 Via: SIP/2.0/UDP 172.28.128.20:5060;branch=z9hG4bK6bf6da0a Max-Forwards: 70 From: "Anonymous" ;tag=as165dcdc6 To: Contact: Call-ID: 226f0ddd3395b8ee3484a64436082777@172.28.128.20:5060 CSeq: 102 INVITE User-Agent: Asterisk PBX 16.8.0.ips Date: Wed, 02 Sep 2020 00:49:07 GMT Session-Expires: 1800 Min-SE: 90 Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE Supported: replaces, timer Content-Type: application/sdp Content-Length: 267 v=0 o=root 523195980 523195980 IN IP4 172.28.128.20 s=Asterisk PBX 16.8.0.ips c=IN IP4 172.28.128.20 t=0 0 m=audio 15438 RTP/AVP 8 0 101 a=rtpmap:8 PCMA/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=maxptime:150 a=sendrecv --- -- Called SIP/9000 <--- SIP read from UDP:172.28.128.200:5060 ---> SIP/2.0 100 Trying Via: SIP/2.0/UDP 172.28.128.20:5060;branch=z9hG4bK6bf6da0a To: From: "Anonymous" ;tag=as165dcdc6 Call-ID: 226f0ddd3395b8ee3484a64436082777@172.28.128.20:5060 CSeq: 102 INVITE Content-Length: 0 <-------------> --- (7 headers 0 lines) --- <--- SIP read from UDP:172.28.128.200:5060 ---> SIP/2.0 180 Ringing Via: SIP/2.0/UDP 172.28.128.20:5060;branch=z9hG4bK6bf6da0a Contact: To: ;tag=92cf4279 From: "Anonymous";tag=as165dcdc6 Call-ID: 226f0ddd3395b8ee3484a64436082777@172.28.128.20:5060 CSeq: 102 INVITE User-Agent: Z 3.3.25608 r25552 Content-Length: 0 <-------------> --- (9 headers 0 lines) --- sip_route_dump: route/path hop: -- SIP/9000-00000001 is ringing -- Local/s@originate-leg2-00000002;1 is ringing <--- SIP read from UDP:172.28.128.200:5060 ---> SIP/2.0 200 OK Via: SIP/2.0/UDP 172.28.128.20:5060;branch=z9hG4bK6bf6da0a Require: timer Contact: To: ;tag=92cf4279 From: "Anonymous";tag=as165dcdc6 Call-ID: 226f0ddd3395b8ee3484a64436082777@172.28.128.20:5060 CSeq: 102 INVITE Session-Expires: 1800;refresher=uac Min-SE: 90 Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE Content-Type: application/sdp Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri User-Agent: Z 3.3.25608 r25552 Allow-Events: presence, kpml Content-Length: 111 v=0 o=Z 0 2 IN IP4 172.28.128.200 s=Z c=IN IP4 172.28.128.200 t=0 0 m=audio 8000 RTP/AVP 8 0 a=sendrecv <-------------> --- (16 headers 7 lines) --- Found RTP audio format 8 Found RTP audio format 0 Capabilities: us - (alaw|ulaw), peer - audio=(ulaw|alaw)/video=(nothing)/text=(nothing), combined - (alaw|ulaw) Non-codec capabilities (dtmf): us - 0x1 (telephone-event|), peer - 0x0 (nothing), combined - 0x0 (nothing) > 0x147de8019d50 -- Strict RTP learning after remote address set to: 172.28.128.200:8000 Peer audio RTP is at port 172.28.128.200:8000 sip_route_dump: route/path hop: set_destination: Parsing for address/port to send to set_destination: set destination to 172.28.128.200:5060 Transmitting (no NAT) to 172.28.128.200:5060: ACK sip:9000@172.28.128.200:5060;rinstance=5f386d651cac737f;transport=UDP SIP/2.0 Via: SIP/2.0/UDP 172.28.128.20:5060;branch=z9hG4bK24f88ff0 Max-Forwards: 70 From: "Anonymous" ;tag=as165dcdc6 To: ;tag=92cf4279 Contact: Call-ID: 226f0ddd3395b8ee3484a64436082777@172.28.128.20:5060 CSeq: 102 ACK User-Agent: Asterisk PBX 16.8.0.ips Content-Length: 0 --- -- SIP/9000-00000001 answered Local/s@originate-leg2-00000002;2 -- SIP/9000-00000001 Internal Gosub(orig-ans,s,1) start -- Executing [s@orig-ans:1] Set("SIP/9000-00000001", "DB(test/chan)=SIP/9000-00000001") in new stack -- Executing [s@orig-ans:2] Return("SIP/9000-00000001", "") in new stack == Spawn extension (pstn-outgoing, , 1) exited non-zero on 'SIP/9000-00000001' -- SIP/9000-00000001 Internal Gosub(orig-ans,s,1) complete GOSUB_RETVAL= -- Local/s@originate-leg2-00000002;1 answered -- Executing [s@originate-leg1:1] NoOp("Local/s@originate-leg2-00000002;1", "originate-leg1") in new stack -- Executing [s@originate-leg1:2] ChannelRedirect("Local/s@originate-leg2-00000002;1", "SIP/9000-00000001,bridgewait-forever,s,1") in new stack -- Channel SIP/9000-00000001 joined 'simple_bridge' basic-bridge <81b6278c-7790-436f-b5dd-8672773fd26b> > 0x147de8019d50 -- Strict RTP switching to RTP target address 172.28.128.200:8000 as source -- Channel Local/s@originate-leg2-00000002;2 joined 'simple_bridge' basic-bridge <81b6278c-7790-436f-b5dd-8672773fd26b> -- Auto fallthrough, channel 'Local/s@originate-leg2-00000002;1' status is 'UNKNOWN' -- Channel Local/s@originate-leg2-00000002;2 left 'simple_bridge' basic-bridge <81b6278c-7790-436f-b5dd-8672773fd26b> == Spawn extension (originate-leg2, s, 1) exited non-zero on 'Local/s@originate-leg2-00000002;2' -- Channel SIP/9000-00000001 left 'simple_bridge' basic-bridge <81b6278c-7790-436f-b5dd-8672773fd26b> -- Executing [s@bridgewait-forever:1] BridgeWait("SIP/9000-00000001", "1,,e(n)") in new stack -- SIP/9000-00000001 is entering waiting bridge 1:4109652d-a049-4593-a700-c5e81cbcc1d0 -- Channel SIP/9000-00000001 joined 'holding_bridge' base-bridge <4109652d-a049-4593-a700-c5e81cbcc1d0> > 0x147de8019d50 -- Strict RTP learning complete - Locking on source address 172.28.128.200:8000 pstn8*CLI> originate Local/s@originate-to-moh extension s@bridge-to-moh -- Called s@originate-to-moh -- Executing [s@originate-to-moh:1] Answer("Local/s@originate-to-moh-00000003;2", "") in new stack -- Local/s@originate-to-moh-00000003;1 answered -- Executing [s@bridge-to-moh:1] Wait("Local/s@originate-to-moh-00000003;1", "0.1") in new stack -- Executing [s@bridge-to-moh:2] Bridge("Local/s@originate-to-moh-00000003;1", "SIP/9000-00000001,p") in new stack -- Channel SIP/9000-00000001 left 'holding_bridge' base-bridge <4109652d-a049-4593-a700-c5e81cbcc1d0> -- Channel SIP/9000-00000001 joined 'simple_bridge' basic-bridge <23a86402-0599-48f5-b7af-162de21f3a9f> -- Channel Local/s@originate-to-moh-00000003;1 joined 'simple_bridge' basic-bridge <23a86402-0599-48f5-b7af-162de21f3a9f> -- Playing 'beep.slin' (language 'en') -- Executing [s@originate-to-moh:2] MusicOnHold("Local/s@originate-to-moh-00000003;2", "native-random") in new stack -- Started music on hold, class 'native-random', on channel 'Local/s@originate-to-moh-00000003;2' Reliably Transmitting (no NAT) to 172.28.128.200:5060: OPTIONS sip:9000@172.28.128.200:5060;rinstance=5f386d651cac737f;transport=UDP SIP/2.0 Via: SIP/2.0/UDP 172.28.128.20:5060;branch=z9hG4bK6d5f0e56 Max-Forwards: 70 From: "asterisk" ;tag=as351bf8e0 To: Contact: Call-ID: 2cf9f425294fc12716e6a06b7af2206a@172.28.128.20:5060 CSeq: 102 OPTIONS User-Agent: Asterisk PBX 16.8.0.ips Date: Wed, 02 Sep 2020 00:49:23 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE Supported: replaces, timer Content-Length: 0 --- <--- SIP read from UDP:172.28.128.200:5060 ---> SIP/2.0 200 OK Via: SIP/2.0/UDP 172.28.128.20:5060;branch=z9hG4bK6d5f0e56 Contact: To: ;tag=d2c1af56 From: "asterisk";tag=as351bf8e0 Call-ID: 2cf9f425294fc12716e6a06b7af2206a@172.28.128.20:5060 CSeq: 102 OPTIONS Accept: application/sdp, application/sdp Accept-Language: en Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri User-Agent: Z 3.3.25608 r25552 Allow-Events: presence, kpml Content-Length: 0 <-------------> --- (14 headers 0 lines) --- Really destroying SIP dialog '2cf9f425294fc12716e6a06b7af2206a@172.28.128.20:5060' Method: OPTIONS pstn8*CLI> core show ch channel channels channeltype channeltypes pstn8*CLI> core show channel Local/s@originate-to-moh-00000003;1 Local/s@originate-to-moh-00000003;2 SIP/9000-00000001 pstn8*CLI> core show channel SIP/9000-00000001 -- General -- Name: SIP/9000-00000001 Type: SIP UniqueID: 1599007747.13 LinkedID: 1599007747.11 Caller ID: s Caller ID Name: (N/A) Connected Line ID: (N/A) Connected Line ID Name: (N/A) Eff. Connected Line ID: (N/A) Eff. Connected Line ID Name: (N/A) DNID Digits: (N/A) Language: en State: Up (6) NativeFormats: (alaw) WriteFormat: slin ReadFormat: slin WriteTranscode: Yes (slin@8000)->(alaw@8000) ReadTranscode: Yes (alaw@8000)->(slin@8000) Time to Hangup: 0 Elapsed Time: 0h0m33s Bridge ID: 23a86402-0599-48f5-b7af-162de21f3a9f -- PBX -- Context: bridgewait-forever Extension: s Priority: 1 Call Group: 0 Pickup Group: 0 Application: BridgeWait Data: 1,,e(n) Call Identifer: [C-00000005] Variables: BRIDGEPEER=Local/s@originate-to-moh-00000003;1 GOSUB_RETVAL= DIALEDPEERNUMBER=9000 SIPCALLID=226f0ddd3395b8ee3484a64436082777@172.28.128.20:5060 CDR Variables: level 1: clid="" level 1: src=s level 1: dst=s level 1: dcontext=bridgewait-forever level 1: channel=SIP/9000-00000001 level 1: lastapp=AppDial level 1: lastdata=(Outgoing Line) level 1: start=1599007747.942416 level 1: answer=1599007749.931189 level 1: end=1599007749.958553 level 1: duration=2 level 1: billsec=0 level 1: disposition=8 level 1: amaflags=3 level 1: uniqueid=1599007747.13 level 1: linkedid=1599007747.11 level 1: sequence=9 level 2: clid="" level 2: src=s level 2: dst=s level 2: dcontext=bridgewait-forever level 2: channel=SIP/9000-00000001 level 2: dstchannel=Local/s@originate-to-moh-00000003;1 level 2: lastapp=BridgeWait level 2: lastdata=1,,e(n) level 2: start=1599007757.015974 level 2: answer=1599007757.015974 level 2: end=0.000000 level 2: duration=23 level 2: billsec=23 level 2: disposition=1 level 2: amaflags=3 level 2: uniqueid=1599007747.13 level 2: linkedid=1599007747.11 level 2: sequence=12 -- Streams -- Name: audio Type: audio State: sendrecv Group: -1 Formats: (alaw|slin) Metadata: pstn8*CLI> channel redirect SIP/9000-00000001 bridgewait-loop,s,1 Channel 'SIP/9000-00000001' successfully redirected to bridgewait-loop,s,1 -- Channel SIP/9000-00000001 left 'simple_bridge' basic-bridge <23a86402-0599-48f5-b7af-162de21f3a9f> == Spawn extension (bridgewait-loop, s, 1) exited non-zero on 'SIP/9000-00000001' -- Executing [s@bridgewait-loop:1] Playback("SIP/9000-00000001", "pls-stay-on-line") in new stack -- Playing 'pls-stay-on-line.slin' (language 'en') -- Channel Local/s@originate-to-moh-00000003;1 left 'simple_bridge' basic-bridge <23a86402-0599-48f5-b7af-162de21f3a9f> -- Auto fallthrough, channel 'Local/s@originate-to-moh-00000003;1' status is 'UNKNOWN' -- Stopped music on hold on Local/s@originate-to-moh-00000003;2 == Spawn extension (originate-to-moh, s, 2) exited non-zero on 'Local/s@originate-to-moh-00000003;2' -- Executing [s@bridgewait-loop:2] BridgeWait("SIP/9000-00000001", "1,,e(n)S(10)") in new stack -- SIP/9000-00000001 is entering waiting bridge 1:d3bb2634-1b0a-4932-a678-cbaa600796cf -- Channel SIP/9000-00000001 joined 'holding_bridge' base-bridge pstn8*CLI> core show channel SIP/9000-00000001 -- General -- Name: SIP/9000-00000001 Type: SIP UniqueID: 1599007747.13 LinkedID: 1599007747.11 Caller ID: s Caller ID Name: (N/A) Connected Line ID: (N/A) Connected Line ID Name: (N/A) Eff. Connected Line ID: (N/A) Eff. Connected Line ID Name: (N/A) DNID Digits: (N/A) Language: en State: Up (6) NativeFormats: (alaw) WriteFormat: slin ReadFormat: slin WriteTranscode: Yes (slin@8000)->(alaw@8000) ReadTranscode: Yes (alaw@8000)->(slin@8000) Time to Hangup: 0 Elapsed Time: 0h0m50s Bridge ID: d3bb2634-1b0a-4932-a678-cbaa600796cf -- PBX -- Context: bridgewait-loop Extension: s Priority: 2 Call Group: 0 Pickup Group: 0 Application: BridgeWait Data: 1,,e(n)S(10) Call Identifer: [C-00000005] Variables: PLAYBACKSTATUS=SUCCESS GOSUB_RETVAL= DIALEDPEERNUMBER=9000 SIPCALLID=226f0ddd3395b8ee3484a64436082777@172.28.128.20:5060 CDR Variables: level 1: clid="" level 1: src=s level 1: dst=s level 1: dcontext=bridgewait-forever level 1: channel=SIP/9000-00000001 level 1: lastapp=AppDial level 1: lastdata=(Outgoing Line) level 1: start=1599007747.942416 level 1: answer=1599007749.931189 level 1: end=1599007749.958553 level 1: duration=2 level 1: billsec=0 level 1: disposition=8 level 1: amaflags=3 level 1: uniqueid=1599007747.13 level 1: linkedid=1599007747.11 level 1: sequence=9 level 2: clid="" level 2: src=s level 2: dst=s level 2: dcontext=bridgewait-loop level 2: channel=SIP/9000-00000001 level 2: dstchannel=Local/s@originate-to-moh-00000003;1 level 2: lastapp=BridgeWait level 2: lastdata=1,,e(n) level 2: start=1599007757.015974 level 2: answer=1599007757.015974 level 2: end=1599007791.405306 level 2: duration=34 level 2: billsec=34 level 2: disposition=8 level 2: amaflags=3 level 2: uniqueid=1599007747.13 level 2: linkedid=1599007747.11 level 2: sequence=12 level 3: clid="" level 3: src=s level 3: dst=s level 3: dcontext=bridgewait-loop level 3: channel=SIP/9000-00000001 level 3: lastapp=BridgeWait level 3: lastdata=1,,e(n)S(10) level 3: start=1599007796.446550 level 3: answer=1599007796.446550 level 3: end=0.000000 level 3: duration=1 level 3: billsec=1 level 3: disposition=1 level 3: amaflags=3 level 3: uniqueid=1599007747.13 level 3: linkedid=1599007747.11 level 3: sequence=13 -- Streams -- Name: audio Type: audio State: sendrecv Group: -1 Formats: (alaw|slin) Metadata: -- Channel SIP/9000-00000001 timed out. -- Channel SIP/9000-00000001 left 'holding_bridge' base-bridge == Spawn extension (bridgewait-forever, s, 2) exited non-zero on 'SIP/9000-00000001' -- Executing [s@bridgewait-forever:2] NoOp("SIP/9000-00000001", "This should not happen") in new stack -- Executing [s@bridgewait-forever:3] Wait("SIP/9000-00000001", "120") in new stack pstn8*CLI> core show channel SIP/9000-00000001 -- General -- Name: SIP/9000-00000001 Type: SIP UniqueID: 1599007747.13 LinkedID: 1599007747.11 Caller ID: s Caller ID Name: (N/A) Connected Line ID: (N/A) Connected Line ID Name: (N/A) Eff. Connected Line ID: (N/A) Eff. Connected Line ID Name: (N/A) DNID Digits: (N/A) Language: en State: Up (6) NativeFormats: (alaw) WriteFormat: slin ReadFormat: slin WriteTranscode: Yes (slin@8000)->(alaw@8000) ReadTranscode: Yes (alaw@8000)->(slin@8000) Time to Hangup: 0 Elapsed Time: 0h1m3s Bridge ID: (Not bridged) -- PBX -- Context: bridgewait-forever Extension: s Priority: 3 Call Group: 0 Pickup Group: 0 Application: Wait Data: 120 Call Identifer: [C-00000005] Variables: PLAYBACKSTATUS=SUCCESS GOSUB_RETVAL= DIALEDPEERNUMBER=9000 SIPCALLID=226f0ddd3395b8ee3484a64436082777@172.28.128.20:5060 CDR Variables: level 1: clid="" level 1: src=s level 1: dst=s level 1: dcontext=bridgewait-forever level 1: channel=SIP/9000-00000001 level 1: lastapp=AppDial level 1: lastdata=(Outgoing Line) level 1: start=1599007747.942416 level 1: answer=1599007749.931189 level 1: end=1599007749.958553 level 1: duration=2 level 1: billsec=0 level 1: disposition=8 level 1: amaflags=3 level 1: uniqueid=1599007747.13 level 1: linkedid=1599007747.11 level 1: sequence=9 level 2: clid="" level 2: src=s level 2: dst=s level 2: dcontext=bridgewait-loop level 2: channel=SIP/9000-00000001 level 2: dstchannel=Local/s@originate-to-moh-00000003;1 level 2: lastapp=BridgeWait level 2: lastdata=1,,e(n) level 2: start=1599007757.015974 level 2: answer=1599007757.015974 level 2: end=1599007791.405306 level 2: duration=34 level 2: billsec=34 level 2: disposition=8 level 2: amaflags=3 level 2: uniqueid=1599007747.13 level 2: linkedid=1599007747.11 level 2: sequence=12 level 3: clid="" level 3: src=s level 3: dst=s level 3: dcontext=bridgewait-forever level 3: channel=SIP/9000-00000001 level 3: lastapp=Wait level 3: lastdata=120 level 3: start=1599007796.446550 level 3: answer=1599007796.446550 level 3: end=0.000000 level 3: duration=13 level 3: billsec=13 level 3: disposition=1 level 3: amaflags=3 level 3: uniqueid=1599007747.13 level 3: linkedid=1599007747.11 level 3: sequence=13 -- Streams -- Name: audio Type: audio State: sendrecv Group: -1 Formats: (alaw|slin) Metadata: Reliably Transmitting (no NAT) to 172.28.128.200:5060: OPTIONS sip:9000@172.28.128.200:5060;rinstance=5f386d651cac737f;transport=UDP SIP/2.0 Via: SIP/2.0/UDP 172.28.128.20:5060;branch=z9hG4bK7230e8b8 Max-Forwards: 70 From: "asterisk" ;tag=as5c124d20 To: Contact: Call-ID: 3e537f011fbac93f361badc26f148c95@172.28.128.20:5060 CSeq: 102 OPTIONS User-Agent: Asterisk PBX 16.8.0.ips Date: Wed, 02 Sep 2020 00:50:23 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE Supported: replaces, timer Content-Length: 0 --- <--- SIP read from UDP:172.28.128.200:5060 ---> SIP/2.0 200 OK Via: SIP/2.0/UDP 172.28.128.20:5060;branch=z9hG4bK7230e8b8 Contact: To: ;tag=cc930138 From: "asterisk";tag=as5c124d20 Call-ID: 3e537f011fbac93f361badc26f148c95@172.28.128.20:5060 CSeq: 102 OPTIONS Accept: application/sdp, application/sdp Accept-Language: en Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri User-Agent: Z 3.3.25608 r25552 Allow-Events: presence, kpml Content-Length: 0 <-------------> --- (14 headers 0 lines) --- Really destroying SIP dialog '3e537f011fbac93f361badc26f148c95@172.28.128.20:5060' Method: OPTIONS pstn8*CLI>