[2012-01-02 12:59:26] -- Executing [*830@default-application:100] Page("Local/6055@default-local-d64a;2", "Local/1004@default-local-paging&Local/6000@default-local-paging&Local/6001@default-local-paging&Local/6002@default-local-paging&Local/6003@default-local-paging&Local/6004@default-local-paging&Local/6005@default-local-paging&Local/6006@default-local-paging&Local/6007@default-local-paging&Local/6010@default-local-paging&Local/6057@default-local-paging&Local/6989@default-local-paging") in new stack [2012-01-02 12:59:26] -- Called 1004@default-local-paging [2012-01-02 12:59:26] -- Executing [1004@default-local-paging:1] NoCDR("Local/1004@default-local-paging-837b;2", "") in new stack [2012-01-02 12:59:26] -- Executing [1004@default-local-paging:2] Set("Local/1004@default-local-paging-837b;2", "LOCAL_EXTEN=1004") in new stack [2012-01-02 12:59:26] -- Executing [1004@default-local-paging:3] SIPAddHeader("Local/1004@default-local-paging-837b;2", "Call-Info:\;answer-after=0") in new stack [2012-01-02 12:59:26] -- Executing [1004@default-local-paging:4] Set("Local/1004@default-local-paging-837b;2", "LOCAL_CHANNEL=SIP/1004") in new stack [2012-01-02 12:59:26] -- Executing [1004@default-local-paging:5] Gosub("Local/1004@default-local-paging-837b;2", "all-local-extension,paging,1") in new stack [2012-01-02 12:59:26] -- Executing [paging@all-local-extension:1] Set("Local/1004@default-local-paging-837b;2", "GROUPCOUNT=0") in new stack [2012-01-02 12:59:26] -- Executing [paging@all-local-extension:2] Set("Local/1004@default-local-paging-837b;2", "GROUPCOUNT=0") in new stack [2012-01-02 12:59:26] -- Executing [paging@all-local-extension:3] GotoIf("Local/1004@default-local-paging-837b;2", "0?6") in new stack [2012-01-02 12:59:26] -- Executing [paging@all-local-extension:4] Set("Local/1004@default-local-paging-837b;2", "OUTBOUND_GROUP=1004@INCOMING") in new stack [2012-01-02 12:59:26] -- Executing [paging@all-local-extension:5] Dial("Local/1004@default-local-paging-837b;2", "SIP/1004,5") in new stack [2012-01-02 12:59:26] -- Called 6000@default-local-paging [2012-01-02 12:59:26] -- Executing [6000@default-local-paging:1] NoCDR("Local/6000@default-local-paging-c665;2", "") in new stack [2012-01-02 12:59:26] -- Executing [6000@default-local-paging:2] Set("Local/6000@default-local-paging-c665;2", "LOCAL_EXTEN=6000") in new stack [2012-01-02 12:59:26] -- Executing [6000@default-local-paging:3] SIPAddHeader("Local/6000@default-local-paging-c665;2", ""Call-Info: sip:\;answer-after=0"") in new stack [2012-01-02 12:59:26] == Using UDPTL TOS bits 184 [2012-01-02 12:59:26] == Using UDPTL CoS mark 5 [2012-01-02 12:59:26] WARNING[29013]: app_dial.c:2218 dial_exec_full: Unable to create channel of type 'SIP' (cause 20 - Unknown) [2012-01-02 12:59:26] == Everyone is busy/congested at this time (1:0/0/1) [2012-01-02 12:59:26] -- Executing [paging@all-local-extension:6] Hangup("Local/1004@default-local-paging-837b;2", "20") in new stack [2012-01-02 12:59:26] == Spawn extension (all-local-extension, paging, 6) exited non-zero on 'Local/1004@default-local-paging-837b;2' [2012-01-02 12:59:26] -- Executing [h@all-local-extension:1] Goto("Local/1004@default-local-paging-837b;2", "all-hangup,s,1") in new stack [2012-01-02 12:59:26] -- Goto (all-hangup,s,1) [2012-01-02 12:59:26] -- Executing [s@all-hangup:1] Set("Local/1004@default-local-paging-837b;2", "CDR(hangupside)=") in new stack [2012-01-02 12:59:26] -- Executing [s@all-hangup:2] Set("Local/1004@default-local-paging-837b;2", "CDR(hangupcause)=20") in new stack [2012-01-02 12:59:26] -- Executing [s@all-hangup:3] Set("Local/1004@default-local-paging-837b;2", "CDR(codec1)=ulaw") in new stack [2012-01-02 12:59:26] -- Executing [s@all-hangup:4] Set("Local/1004@default-local-paging-837b;2", "CDR(codec2)=ulaw") in new stack [2012-01-02 12:59:26] -- Called 6001@default-local-paging [2012-01-02 12:59:26] -- Executing [6001@default-local-paging:1] NoCDR("Local/6001@default-local-paging-86d3;2", "") in new stack [2012-01-02 12:59:26] -- Executing [6000@default-local-paging:4] Set("Local/6000@default-local-paging-c665;2", "LOCAL_CHANNEL=SIP/6000") in new stack [2012-01-02 12:59:27] -- Executing [s@all-hangup:5] Set("Local/1004@default-local-paging-837b;2", "CDR(peerip)=") in new stack [2012-01-02 12:59:27] -- Executing [6001@default-local-paging:2] Set("Local/6001@default-local-paging-86d3;2", "LOCAL_EXTEN=6001") in new stack [2012-01-02 12:59:27] -- Executing [6000@default-local-paging:5] Gosub("Local/6000@default-local-paging-c665;2", "all-local-extension,paging,1") in new stack [2012-01-02 12:59:27] -- Executing [s@all-hangup:6] Set("Local/1004@default-local-paging-837b;2", "CDR(recvip)=") in new stack [2012-01-02 12:59:27] -- Executing [6001@default-local-paging:3] SIPAddHeader("Local/6001@default-local-paging-86d3;2", "Call-Info:\;answer-after=0") in new stack [2012-01-02 12:59:27] -- Called 6002@default-local-paging [2012-01-02 12:59:27] -- Executing [6002@default-local-paging:1] NoCDR("Local/6002@default-local-paging-8d10;2", "") in new stack [2012-01-02 12:59:27] -- Executing [s@all-hangup:7] Set("Local/1004@default-local-paging-837b;2", "CDR(fromchan)=") in new stack [2012-01-02 12:59:27] -- Executing [paging@all-local-extension:1] Set("Local/6000@default-local-paging-c665;2", "GROUPCOUNT=0") in new stack [2012-01-02 12:59:27] -- Executing [paging@all-local-extension:2] Set("Local/6000@default-local-paging-c665;2", "GROUPCOUNT=0") in new stack [2012-01-02 12:59:27] -- Executing [paging@all-local-extension:3] GotoIf("Local/6000@default-local-paging-c665;2", "0?6") in new stack [2012-01-02 12:59:27] -- Executing [paging@all-local-extension:4] Set("Local/6000@default-local-paging-c665;2", "OUTBOUND_GROUP=6000@INCOMING") in new stack [2012-01-02 12:59:27] -- Executing [6001@default-local-paging:4] Set("Local/6001@default-local-paging-86d3;2", "LOCAL_CHANNEL=SIP/6001") in new stack [2012-01-02 12:59:27] -- Executing [6002@default-local-paging:2] Set("Local/6002@default-local-paging-8d10;2", "LOCAL_EXTEN=6002") in new stack [2012-01-02 12:59:27] -- Executing [s@all-hangup:8] Set("Local/1004@default-local-paging-837b;2", "CDR(uri)=") in new stack [2012-01-02 12:59:27] -- Executing [paging@all-local-extension:5] Dial("Local/6000@default-local-paging-c665;2", "SIP/6000,5") in new stack [2012-01-02 12:59:27] -- Executing [s@all-hangup:9] Set("Local/1004@default-local-paging-837b;2", "CDR(useragent)=") in new stack [2012-01-02 12:59:27] -- Executing [6001@default-local-paging:5] Gosub("Local/6001@default-local-paging-86d3;2", "all-local-extension,paging,1") in new stack [2012-01-02 12:59:27] -- Executing [6002@default-local-paging:3] SIPAddHeader("Local/6002@default-local-paging-8d10;2", "Alert-Info: Auto Answer") in new stack [2012-01-02 12:59:27] -- Called 6003@default-local-paging [2012-01-02 12:59:27] -- Executing [s@all-hangup:10] Set("Local/1004@default-local-paging-837b;2", "CDR(llp)=") in new stack [2012-01-02 12:59:27] -- Executing [paging@all-local-extension:1] Set("Local/6001@default-local-paging-86d3;2", "GROUPCOUNT=0") in new stack [2012-01-02 12:59:27] -- Executing [6003@default-local-paging:1] NoCDR("Local/6003@default-local-paging-0db6;2", "") in new stack [2012-01-02 12:59:27] == Using UDPTL TOS bits 184 [2012-01-02 12:59:27] == Using UDPTL CoS mark 5 [2012-01-02 12:59:27] -- Executing [6002@default-local-paging:4] Set("Local/6002@default-local-paging-8d10;2", "LOCAL_CHANNEL=SIP/6002") in new stack [2012-01-02 12:59:27] == Using SIP RTP TOS bits 184 [2012-01-02 12:59:27] -- Executing [paging@all-local-extension:2] Set("Local/6001@default-local-paging-86d3;2", "GROUPCOUNT=0") in new stack [2012-01-02 12:59:27] -- Executing [s@all-hangup:11] Set("Local/1004@default-local-paging-837b;2", "CDR(rlp)=") in new stack [2012-01-02 12:59:27] == Using SIP RTP CoS mark 5 [2012-01-02 12:59:27] -- Executing [s@all-hangup:12] Set("Local/1004@default-local-paging-837b;2", "CDR(ljitt)=") in new stack [2012-01-02 12:59:27] -- Executing [6003@default-local-paging:2] Set("Local/6003@default-local-paging-0db6;2", "LOCAL_EXTEN=6003") in new stack [2012-01-02 12:59:27] -- Executing [6002@default-local-paging:5] Gosub("Local/6002@default-local-paging-8d10;2", "all-local-extension,paging,1") in new stack [2012-01-02 12:59:27] -- Executing [paging@all-local-extension:1] Set("Local/6002@default-local-paging-8d10;2", "GROUPCOUNT=0") in new stack [2012-01-02 12:59:27] -- Executing [paging@all-local-extension:2] Set("Local/6002@default-local-paging-8d10;2", "GROUPCOUNT=0") in new stack [2012-01-02 12:59:27] -- Executing [paging@all-local-extension:3] GotoIf("Local/6001@default-local-paging-86d3;2", "0?6") in new stack [2012-01-02 12:59:27] -- Executing [paging@all-local-extension:4] Set("Local/6001@default-local-paging-86d3;2", "OUTBOUND_GROUP=6001@INCOMING") in new stack [2012-01-02 12:59:27] -- Executing [paging@all-local-extension:5] Dial("Local/6001@default-local-paging-86d3;2", "SIP/6001,5") in new stack [2012-01-02 12:59:27] -- Executing [paging@all-local-extension:3] GotoIf("Local/6002@default-local-paging-8d10;2", "0?6") in new stack [2012-01-02 12:59:27] -- Executing [paging@all-local-extension:4] Set("Local/6002@default-local-paging-8d10;2", "OUTBOUND_GROUP=6002@INCOMING") in new stack [2012-01-02 12:59:27] -- Executing [paging@all-local-extension:5] Dial("Local/6002@default-local-paging-8d10;2", "SIP/6002,5") in new stack [2012-01-02 12:59:27] -- Executing [s@all-hangup:13] Set("Local/1004@default-local-paging-837b;2", "CDR(rjitt)=") in new stack [2012-01-02 12:59:27] -- Executing [s@all-hangup:14] GotoIf("Local/1004@default-local-paging-837b;2", "0?all-faxnotify,s,1:15") in new stack [2012-01-02 12:59:27] -- Goto (all-hangup,s,15) [2012-01-02 12:59:27] -- Executing [s@all-hangup:15] ResetCDR("Local/1004@default-local-paging-837b;2", "w") in new stack [2012-01-02 12:59:27] -- Executing [s@all-hangup:16] NoCDR("Local/1004@default-local-paging-837b;2", "") in new stack [2012-01-02 12:59:27] -- Executing [s@all-hangup:17] Hangup("Local/1004@default-local-paging-837b;2", "") in new stack [2012-01-02 12:59:27] -- Called 6004@default-local-paging [2012-01-02 12:59:27] -- Executing [6004@default-local-paging:1] NoCDR("Local/6004@default-local-paging-b482;2", "") in new stack [2012-01-02 12:59:27] == Spawn extension (all-hangup, s, 17) exited non-zero on 'Local/1004@default-local-paging-837b;2' [2012-01-02 12:59:27] -- Executing [6003@default-local-paging:3] SIPAddHeader("Local/6003@default-local-paging-0db6;2", "Alert-Info: Auto Answer") in new stack [2012-01-02 12:59:27] == Using UDPTL TOS bits 184 [2012-01-02 12:59:27] == Using UDPTL CoS mark 5 [2012-01-02 12:59:27] == Using SIP RTP TOS bits 184 [2012-01-02 12:59:27] == Using SIP RTP CoS mark 5 [2012-01-02 12:59:27] -- Executing [6004@default-local-paging:2] Set("Local/6004@default-local-paging-b482;2", "LOCAL_EXTEN=6004") in new stack [2012-01-02 12:59:27] -- Executing [6003@default-local-paging:4] Set("Local/6003@default-local-paging-0db6;2", "LOCAL_CHANNEL=SIP/6003") in new stack [2012-01-02 12:59:27] == Using UDPTL TOS bits 184 [2012-01-02 12:59:27] == Using UDPTL CoS mark 5 [2012-01-02 12:59:27] == Using SIP RTP TOS bits 184 [2012-01-02 12:59:27] == Using SIP RTP CoS mark 5 [2012-01-02 12:59:27] -- Called SIP/6000 [2012-01-02 12:59:27] -- Executing [6003@default-local-paging:5] Gosub("Local/6003@default-local-paging-0db6;2", "all-local-extension,paging,1") in new stack [2012-01-02 12:59:27] -- Executing [6004@default-local-paging:3] SIPAddHeader("Local/6004@default-local-paging-b482;2", "Call-Info:\;answer-after=0") in new stack [2012-01-02 12:59:27] -- SIP/6000-0000000a is ringing [2012-01-02 12:59:27] -- Called 6005@default-local-paging [2012-01-02 12:59:27] -- Executing [6004@default-local-paging:4] Set("Local/6004@default-local-paging-b482;2", "LOCAL_CHANNEL=SIP/6004") in new stack [2012-01-02 12:59:27] -- Executing [paging@all-local-extension:1] Set("Local/6003@default-local-paging-0db6;2", "GROUPCOUNT=0") in new stack [2012-01-02 12:59:27] -- Executing [6005@default-local-paging:1] NoCDR("Local/6005@default-local-paging-7791;2", "") in new stack [2012-01-02 12:59:27] -- Local/6000@default-local-paging-c665;1 is ringing [2012-01-02 12:59:27] -- Executing [6004@default-local-paging:5] Gosub("Local/6004@default-local-paging-b482;2", "all-local-extension,paging,1") in new stack [2012-01-02 12:59:27] -- Executing [paging@all-local-extension:1] Set("Local/6004@default-local-paging-b482;2", "GROUPCOUNT=0") in new stack [2012-01-02 12:59:27] -- Executing [paging@all-local-extension:2] Set("Local/6003@default-local-paging-0db6;2", "GROUPCOUNT=0") in new stack [2012-01-02 12:59:27] -- Called 6006@default-local-paging [2012-01-02 12:59:27] WARNING[29003]: channel.c:1474 __ast_queue_frame: Exceptionally long voice queue length queuing to Local/6055@default-local-d64a;2 [2012-01-02 12:59:27] -- Executing [6006@default-local-paging:1] NoCDR("Local/6006@default-local-paging-0e63;2", "") in new stack [2012-01-02 12:59:28] -- Executing [6005@default-local-paging:2] Set("Local/6005@default-local-paging-7791;2", "LOCAL_EXTEN=6005") in new stack [2012-01-02 12:59:28] -- Executing [paging@all-local-extension:3] GotoIf("Local/6003@default-local-paging-0db6;2", "0?6") in new stack [2012-01-02 12:59:28] -- Executing [paging@all-local-extension:2] Set("Local/6004@default-local-paging-b482;2", "GROUPCOUNT=0") in new stack [2012-01-02 12:59:28] -- Called SIP/6001 [2012-01-02 12:59:28] -- Executing [paging@all-local-extension:4] Set("Local/6003@default-local-paging-0db6;2", "OUTBOUND_GROUP=6003@INCOMING") in new stack [2012-01-02 12:59:28] -- Called SIP/6002 [2012-01-02 12:59:28] -- Executing [paging@all-local-extension:3] GotoIf("Local/6004@default-local-paging-b482;2", "0?6") in new stack [2012-01-02 12:59:28] -- SIP/6000-0000000a answered Local/6000@default-local-paging-c665;2 [2012-01-02 12:59:28] -- Executing [6006@default-local-paging:2] Set("Local/6006@default-local-paging-0e63;2", "LOCAL_EXTEN=6006") in new stack [2012-01-02 12:59:28] -- Executing [6005@default-local-paging:3] SIPAddHeader("Local/6005@default-local-paging-7791;2", "Alert-Info: Auto Answer") in new stack [2012-01-02 12:59:28] -- Executing [paging@all-local-extension:4] Set("Local/6004@default-local-paging-b482;2", "OUTBOUND_GROUP=6004@INCOMING") in new stack [2012-01-02 12:59:28] -- Executing [paging@all-local-extension:5] Dial("Local/6003@default-local-paging-0db6;2", "SIP/6003,5") in new stack [2012-01-02 12:59:28] -- Executing [6006@default-local-paging:3] SIPAddHeader("Local/6006@default-local-paging-0e63;2", "Call-Info:\;answer-after=0") in new stack [2012-01-02 12:59:28] -- Called 6007@default-local-paging [2012-01-02 12:59:28] -- Executing [6006@default-local-paging:4] Set("Local/6006@default-local-paging-0e63;2", "LOCAL_CHANNEL=SIP/6006") in new stack [2012-01-02 12:59:28] -- Executing [6005@default-local-paging:4] Set("Local/6005@default-local-paging-7791;2", "LOCAL_CHANNEL=SIP/6005") in new stack [2012-01-02 12:59:28] -- Executing [6007@default-local-paging:1] NoCDR("Local/6007@default-local-paging-72c2;2", "") in new stack [2012-01-02 12:59:28] -- Executing [paging@all-local-extension:5] Dial("Local/6004@default-local-paging-b482;2", "SIP/6004,5") in new stack [2012-01-02 12:59:28] -- Executing [6006@default-local-paging:5] Gosub("Local/6006@default-local-paging-0e63;2", "all-local-extension,paging,1") in new stack [2012-01-02 12:59:28] -- Executing [6005@default-local-paging:5] Gosub("Local/6005@default-local-paging-7791;2", "all-local-extension,paging,1") in new stack [2012-01-02 12:59:28] -- Executing [paging@all-local-extension:1] Set("Local/6006@default-local-paging-0e63;2", "GROUPCOUNT=0") in new stack [2012-01-02 12:59:28] -- Executing [6007@default-local-paging:2] Set("Local/6007@default-local-paging-72c2;2", "LOCAL_EXTEN=6007") in new stack [2012-01-02 12:59:28] -- Local/6000@default-local-paging-c665;1 answered [2012-01-02 12:59:28] -- Called 6010@default-local-paging [2012-01-02 12:59:28] -- SIP/6001-0000000b answered Local/6001@default-local-paging-86d3;2 [2012-01-02 12:59:28] -- Executing [6010@default-local-paging:1] NoCDR("Local/6010@default-local-paging-634f;2", "") in new stack [2012-01-02 12:59:28] == Using UDPTL TOS bits 184 [2012-01-02 12:59:28] == Using UDPTL CoS mark 5 [2012-01-02 12:59:28] WARNING[29023]: app_dial.c:2218 dial_exec_full: Unable to create channel of type 'SIP' (cause 20 - Unknown) [2012-01-02 12:59:28] == Everyone is busy/congested at this time (1:0/0/1) [2012-01-02 12:59:28] -- Executing [paging@all-local-extension:1] Set("Local/6005@default-local-paging-7791;2", "GROUPCOUNT=0") in new stack [2012-01-02 12:59:28] -- SIP/6002-0000000c answered Local/6002@default-local-paging-8d10;2 [2012-01-02 12:59:28] -- Executing [paging@all-local-extension:2] Set("Local/6006@default-local-paging-0e63;2", "GROUPCOUNT=0") in new stack [2012-01-02 12:59:28] -- Executing [6007@default-local-paging:3] SIPAddHeader("Local/6007@default-local-paging-72c2;2", "Alert-Info: Auto Answer") in new stack [2012-01-02 12:59:28] -- Executing [paging@all-local-extension:2] Set("Local/6005@default-local-paging-7791;2", "GROUPCOUNT=0") in new stack [2012-01-02 12:59:28] -- Created MeetMe conference 1023 for conference '1032736473d' [2012-01-02 12:59:28] -- Executing [6010@default-local-paging:2] Set("Local/6010@default-local-paging-634f;2", "LOCAL_EXTEN=6010") in new stack [2012-01-02 12:59:28] -- Executing [6007@default-local-paging:4] Set("Local/6007@default-local-paging-72c2;2", "LOCAL_CHANNEL=SIP/6007") in new stack [2012-01-02 12:59:28] -- Executing [paging@all-local-extension:3] GotoIf("Local/6006@default-local-paging-0e63;2", "0?6") in new stack [2012-01-02 12:59:28] -- Executing [paging@all-local-extension:6] Hangup("Local/6004@default-local-paging-b482;2", "20") in new stack [2012-01-02 12:59:28] == Using UDPTL TOS bits 184 [2012-01-02 12:59:28] == Using UDPTL CoS mark 5 [2012-01-02 12:59:28] == Using SIP RTP TOS bits 184 [2012-01-02 12:59:28] == Using SIP RTP CoS mark 5 [2012-01-02 12:59:28] -- Executing [paging@all-local-extension:4] Set("Local/6006@default-local-paging-0e63;2", "OUTBOUND_GROUP=6006@INCOMING") in new stack [2012-01-02 12:59:28] == Spawn extension (all-local-extension, paging, 6) exited non-zero on 'Local/6004@default-local-paging-b482;2' [2012-01-02 12:59:28] -- Executing [h@all-local-extension:1] Goto("Local/6004@default-local-paging-b482;2", "all-hangup,s,1") in new stack [2012-01-02 12:59:28] -- Executing [6010@default-local-paging:3] SIPAddHeader("Local/6010@default-local-paging-634f;2", "Alert-Info: Auto Answer") in new stack [2012-01-02 12:59:28] -- Executing [paging@all-local-extension:3] GotoIf("Local/6005@default-local-paging-7791;2", "0?6") in new stack [2012-01-02 12:59:28] -- Executing [6010@default-local-paging:4] Set("Local/6010@default-local-paging-634f;2", "LOCAL_CHANNEL=SIP/6010") in new stack [2012-01-02 12:59:28] -- Goto (all-hangup,s,1) [2012-01-02 12:59:28] -- Executing [s@all-hangup:1] Set("Local/6004@default-local-paging-b482;2", "CDR(hangupside)=") in new stack [2012-01-02 12:59:28] -- Executing [paging@all-local-extension:4] Set("Local/6005@default-local-paging-7791;2", "OUTBOUND_GROUP=6005@INCOMING") in new stack [2012-01-02 12:59:28] -- Executing [paging@all-local-extension:5] Dial("Local/6006@default-local-paging-0e63;2", "SIP/6006,5") in new stack [2012-01-02 12:59:28] -- Executing [6007@default-local-paging:5] Gosub("Local/6007@default-local-paging-72c2;2", "all-local-extension,paging,1") in new stack [2012-01-02 12:59:29] -- Local/6001@default-local-paging-86d3;1 answered [2012-01-02 12:59:29] -- Executing [s@all-hangup:2] Set("Local/6004@default-local-paging-b482;2", "CDR(hangupcause)=20") in new stack [2012-01-02 12:59:29] -- Executing [6010@default-local-paging:5] Gosub("Local/6010@default-local-paging-634f;2", "all-local-extension,paging,1") in new stack [2012-01-02 12:59:29] -- Executing [s@all-hangup:3] Set("Local/6004@default-local-paging-b482;2", "CDR(codec1)=ulaw") in new stack [2012-01-02 12:59:29] WARNING[29003]: channel.c:1474 __ast_queue_frame: Exceptionally long voice queue length queuing to Local/6055@default-local-d64a;2 [2012-01-02 12:59:29] -- Executing [paging@all-local-extension:5] Dial("Local/6005@default-local-paging-7791;2", "SIP/6005,5") in new stack [2012-01-02 12:59:29] -- Called 6057@default-local-paging [2012-01-02 12:59:29] -- Executing [6057@default-local-paging:1] NoCDR("Local/6057@default-local-paging-da0f;2", "") in new stack [2012-01-02 12:59:29] -- Executing [paging@all-local-extension:1] Set("Local/6007@default-local-paging-72c2;2", "GROUPCOUNT=0") in new stack [2012-01-02 12:59:29] -- Executing [s@all-hangup:4] Set("Local/6004@default-local-paging-b482;2", "CDR(codec2)=ulaw") in new stack [2012-01-02 12:59:29] -- Local/6002@default-local-paging-8d10;1 answered [2012-01-02 12:59:29] -- Executing [paging@all-local-extension:1] Set("Local/6010@default-local-paging-634f;2", "GROUPCOUNT=0") in new stack [2012-01-02 12:59:29] -- Executing [s@all-hangup:5] Set("Local/6004@default-local-paging-b482;2", "CDR(peerip)=") in new stack [2012-01-02 12:59:29] -- Executing [paging@all-local-extension:2] Set("Local/6007@default-local-paging-72c2;2", "GROUPCOUNT=0") in new stack [2012-01-02 12:59:29] -- Executing [6057@default-local-paging:2] Set("Local/6057@default-local-paging-da0f;2", "LOCAL_EXTEN=6057") in new stack [2012-01-02 12:59:29] -- Executing [paging@all-local-extension:2] Set("Local/6010@default-local-paging-634f;2", "GROUPCOUNT=0") in new stack [2012-01-02 12:59:29] -- Executing [s@all-hangup:6] Set("Local/6004@default-local-paging-b482;2", "CDR(recvip)=") in new stack [2012-01-02 12:59:29] -- Executing [6057@default-local-paging:3] SIPAddHeader("Local/6057@default-local-paging-da0f;2", "Alert-Info: Ring Answer") in new stack [2012-01-02 12:59:29] -- Executing [s@all-hangup:7] Set("Local/6004@default-local-paging-b482;2", "CDR(fromchan)=") in new stack [2012-01-02 12:59:29] -- Executing [paging@all-local-extension:3] GotoIf("Local/6010@default-local-paging-634f;2", "0?6") in new stack [2012-01-02 12:59:29] -- Executing [s@all-hangup:8] Set("Local/6004@default-local-paging-b482;2", "CDR(uri)=") in new stack [2012-01-02 12:59:29] -- Executing [paging@all-local-extension:3] GotoIf("Local/6007@default-local-paging-72c2;2", "0?6") in new stack [2012-01-02 12:59:29] -- Executing [paging@all-local-extension:4] Set("Local/6010@default-local-paging-634f;2", "OUTBOUND_GROUP=6010@INCOMING") in new stack [2012-01-02 12:59:29] == Using UDPTL TOS bits 184 [2012-01-02 12:59:29] == Using UDPTL CoS mark 5 [2012-01-02 12:59:29] -- Executing [s@all-hangup:9] Set("Local/6004@default-local-paging-b482;2", "CDR(useragent)=") in new stack [2012-01-02 12:59:29] == Using SIP RTP TOS bits 184 [2012-01-02 12:59:29] == Using SIP RTP CoS mark 5 [2012-01-02 12:59:29] -- Executing [h@all-local-extension:1] Goto("Local/6000@default-local-paging-c665;2", "all-hangup,s,1") in new stack [2012-01-02 12:59:29] == Using UDPTL TOS bits 184 [2012-01-02 12:59:29] == Using UDPTL CoS mark 5 [2012-01-02 12:59:29] -- Executing [6057@default-local-paging:4] Set("Local/6057@default-local-paging-da0f;2", "LOCAL_CHANNEL=SIP/6057") in new stack [2012-01-02 12:59:29] == Using SIP RTP TOS bits 184 [2012-01-02 12:59:29] == Using SIP RTP CoS mark 5 [2012-01-02 12:59:29] -- Executing [paging@all-local-extension:4] Set("Local/6007@default-local-paging-72c2;2", "OUTBOUND_GROUP=6007@INCOMING") in new stack [2012-01-02 12:59:29] -- Executing [s@all-hangup:10] Set("Local/6004@default-local-paging-b482;2", "CDR(llp)=") in new stack [2012-01-02 12:59:29] -- Goto (all-hangup,s,1) [2012-01-02 12:59:29] -- Executing [s@all-hangup:1] Set("Local/6000@default-local-paging-c665;2", "CDR(hangupside)=") in new stack [2012-01-02 12:59:30] -- Executing [s@all-hangup:11] Set("Local/6004@default-local-paging-b482;2", "CDR(rlp)=") in new stack [2012-01-02 12:59:30] -- Called 6989@default-local-paging [2012-01-02 12:59:30] -- Executing [paging@all-local-extension:5] Dial("Local/6010@default-local-paging-634f;2", "SIP/6010,5") in new stack [2012-01-02 12:59:30] -- Playing 'beep.ulaw' (language 'en') [2012-01-02 12:59:30] -- Executing [s@all-hangup:2] Set("Local/6000@default-local-paging-c665;2", "CDR(hangupcause)=16") in new stack [2012-01-02 12:59:30] -- Executing [6989@default-local-paging:1] NoCDR("Local/6989@default-local-paging-a24d;2", "") in new stack [2012-01-02 12:59:30] -- Executing [paging@all-local-extension:5] Dial("Local/6007@default-local-paging-72c2;2", "SIP/6007,5") in new stack [2012-01-02 12:59:30] -- Executing [6057@default-local-paging:5] Gosub("Local/6057@default-local-paging-da0f;2", "all-local-extension,paging,1") in new stack [2012-01-02 12:59:30] -- Executing [s@all-hangup:12] Set("Local/6004@default-local-paging-b482;2", "CDR(ljitt)=") in new stack [2012-01-02 12:59:30] -- Executing [s@all-hangup:3] Set("Local/6000@default-local-paging-c665;2", "CDR(codec1)=ulaw") in new stack [2012-01-02 12:59:30] -- Executing [6989@default-local-paging:2] Set("Local/6989@default-local-paging-a24d;2", "LOCAL_EXTEN=6989") in new stack [2012-01-02 12:59:30] -- Executing [s@all-hangup:13] Set("Local/6004@default-local-paging-b482;2", "CDR(rjitt)=") in new stack [2012-01-02 12:59:30] -- Executing [paging@all-local-extension:1] Set("Local/6057@default-local-paging-da0f;2", "GROUPCOUNT=0") in new stack [2012-01-02 12:59:30] -- Executing [s@all-hangup:4] Set("Local/6000@default-local-paging-c665;2", "CDR(codec2)=ulaw") in new stack [2012-01-02 12:59:30] -- Executing [s@all-hangup:14] GotoIf("Local/6004@default-local-paging-b482;2", "0?all-faxnotify,s,1:15") in new stack [2012-01-02 12:59:30] -- Called SIP/6003 [2012-01-02 12:59:30] -- Executing [h@all-local-extension:1] Goto("Local/6001@default-local-paging-86d3;2", "all-hangup,s,1") in new stack [2012-01-02 12:59:30] -- Goto (all-hangup,s,1) [2012-01-02 12:59:30] -- Executing [s@all-hangup:1] Set("Local/6001@default-local-paging-86d3;2", "CDR(hangupside)=") in new stack [2012-01-02 12:59:30] -- Executing [6989@default-local-paging:3] SIPAddHeader("Local/6989@default-local-paging-a24d;2", "Alert-Info: Auto Answer") in new stack [2012-01-02 12:59:30] -- Executing [s@all-hangup:5] Set("Local/6000@default-local-paging-c665;2", "CDR(peerip)=") in new stack [2012-01-02 12:59:30] -- Goto (all-hangup,s,15) [2012-01-02 12:59:30] -- Executing [s@all-hangup:15] ResetCDR("Local/6004@default-local-paging-b482;2", "w") in new stack [2012-01-02 12:59:30] -- Executing [paging@all-local-extension:2] Set("Local/6057@default-local-paging-da0f;2", "GROUPCOUNT=0") in new stack [2012-01-02 12:59:30] -- Executing [s@all-hangup:2] Set("Local/6001@default-local-paging-86d3;2", "CDR(hangupcause)=16") in new stack [2012-01-02 12:59:31] -- Executing [s@all-hangup:6] Set("Local/6000@default-local-paging-c665;2", "CDR(recvip)=") in new stack [2012-01-02 12:59:31] -- Executing [s@all-hangup:16] NoCDR("Local/6004@default-local-paging-b482;2", "") in new stack [2012-01-02 12:59:31] -- Executing [6989@default-local-paging:4] Set("Local/6989@default-local-paging-a24d;2", "LOCAL_CHANNEL=SIP/6989") in new stack [2012-01-02 12:59:31] -- Executing [s@all-hangup:3] Set("Local/6001@default-local-paging-86d3;2", "CDR(codec1)=ulaw") in new stack [2012-01-02 12:59:31] -- Executing [s@all-hangup:17] Hangup("Local/6004@default-local-paging-b482;2", "") in new stack [2012-01-02 12:59:31] -- SIP/6003-0000000d answered Local/6003@default-local-paging-0db6;2 [2012-01-02 12:59:31] -- Executing [s@all-hangup:7] Set("Local/6000@default-local-paging-c665;2", "CDR(fromchan)=") in new stack [2012-01-02 12:59:31] == Using UDPTL TOS bits 184 [2012-01-02 12:59:31] == Using UDPTL CoS mark 5 [2012-01-02 12:59:31] == Using SIP RTP TOS bits 184 [2012-01-02 12:59:31] == Using SIP RTP CoS mark 5 [2012-01-02 12:59:31] -- Executing [paging@all-local-extension:3] GotoIf("Local/6057@default-local-paging-da0f;2", "0?6") in new stack [2012-01-02 12:59:31] -- Executing [s@all-hangup:4] Set("Local/6001@default-local-paging-86d3;2", "CDR(codec2)=ulaw") in new stack [2012-01-02 12:59:31] == Spawn extension (all-hangup, s, 17) exited non-zero on 'Local/6004@default-local-paging-b482;2' [2012-01-02 12:59:31] == Using UDPTL TOS bits 184 [2012-01-02 12:59:31] -- Executing [s@all-hangup:8] Set("Local/6000@default-local-paging-c665;2", "CDR(uri)=") in new stack [2012-01-02 12:59:31] == Using UDPTL CoS mark 5 [2012-01-02 12:59:31] -- Executing [6989@default-local-paging:5] Gosub("Local/6989@default-local-paging-a24d;2", "all-local-extension,paging,1") in new stack [2012-01-02 12:59:31] WARNING[29029]: app_dial.c:2218 dial_exec_full: Unable to create channel of type 'SIP' (cause 20 - Unknown) [2012-01-02 12:59:31] -- Executing [paging@all-local-extension:4] Set("Local/6057@default-local-paging-da0f;2", "OUTBOUND_GROUP=6057@INCOMING") in new stack [2012-01-02 12:59:31] == Everyone is busy/congested at this time (1:0/0/1) [2012-01-02 12:59:31] -- Executing [s@all-hangup:5] Set("Local/6001@default-local-paging-86d3;2", "CDR(peerip)=") in new stack [2012-01-02 12:59:31] -- Executing [paging@all-local-extension:5] Dial("Local/6057@default-local-paging-da0f;2", "SIP/6057,5") in new stack [2012-01-02 12:59:31] -- Executing [s@all-hangup:9] Set("Local/6000@default-local-paging-c665;2", "CDR(useragent)=") in new stack [2012-01-02 12:59:31] -- Executing [s@all-hangup:6] Set("Local/6001@default-local-paging-86d3;2", "CDR(recvip)=") in new stack [2012-01-02 12:59:31] -- Executing [s@all-hangup:10] Set("Local/6000@default-local-paging-c665;2", "CDR(llp)=") in new stack [2012-01-02 12:59:31] -- Called SIP/6006 [2012-01-02 12:59:31] -- Executing [paging@all-local-extension:1] Set("Local/6989@default-local-paging-a24d;2", "GROUPCOUNT=0") in new stack [2012-01-02 12:59:31] -- Executing [s@all-hangup:7] Set("Local/6001@default-local-paging-86d3;2", "CDR(fromchan)=") in new stack [2012-01-02 12:59:31] -- Executing [paging@all-local-extension:6] Hangup("Local/6007@default-local-paging-72c2;2", "20") in new stack [2012-01-02 12:59:31] -- Executing [s@all-hangup:11] Set("Local/6000@default-local-paging-c665;2", "CDR(rlp)=") in new stack [2012-01-02 12:59:31] == Spawn extension (all-local-extension, paging, 6) exited non-zero on 'Local/6007@default-local-paging-72c2;2' [2012-01-02 12:59:31] -- Executing [h@all-local-extension:1] Goto("Local/6007@default-local-paging-72c2;2", "all-hangup,s,1") in new stack [2012-01-02 12:59:31] -- Executing [s@all-hangup:8] Set("Local/6001@default-local-paging-86d3;2", "CDR(uri)=") in new stack [2012-01-02 12:59:32] -- Called SIP/6005 [2012-01-02 12:59:32] -- Executing [s@all-hangup:12] Set("Local/6000@default-local-paging-c665;2", "CDR(ljitt)=") in new stack [2012-01-02 12:59:32] -- Goto (all-hangup,s,1) [2012-01-02 12:59:32] -- Executing [s@all-hangup:1] Set("Local/6007@default-local-paging-72c2;2", "CDR(hangupside)=") in new stack [2012-01-02 12:59:32] -- Executing [s@all-hangup:9] Set("Local/6001@default-local-paging-86d3;2", "CDR(useragent)=") in new stack [2012-01-02 12:59:32] -- Executing [paging@all-local-extension:2] Set("Local/6989@default-local-paging-a24d;2", "GROUPCOUNT=0") in new stack [2012-01-02 12:59:32] -- SIP/6006-0000000e answered Local/6006@default-local-paging-0e63;2 [2012-01-02 12:59:32] -- Local/6003@default-local-paging-0db6;1 answered [2012-01-02 12:59:32] -- Executing [s@all-hangup:2] Set("Local/6007@default-local-paging-72c2;2", "CDR(hangupcause)=20") in new stack [2012-01-02 12:59:32] -- Executing [s@all-hangup:13] Set("Local/6000@default-local-paging-c665;2", "CDR(rjitt)=") in new stack [2012-01-02 12:59:32] -- Executing [s@all-hangup:10] Set("Local/6001@default-local-paging-86d3;2", "CDR(llp)=") in new stack [2012-01-02 12:59:32] -- Executing [paging@all-local-extension:3] GotoIf("Local/6989@default-local-paging-a24d;2", "0?6") in new stack [2012-01-02 12:59:32] -- Executing [paging@all-local-extension:4] Set("Local/6989@default-local-paging-a24d;2", "OUTBOUND_GROUP=6989@INCOMING") in new stack [2012-01-02 12:59:32] == Using UDPTL TOS bits 184 [2012-01-02 12:59:32] == Using UDPTL CoS mark 5 [2012-01-02 12:59:32] -- Executing [s@all-hangup:3] Set("Local/6007@default-local-paging-72c2;2", "CDR(codec1)=ulaw") in new stack [2012-01-02 12:59:32] == Using SIP RTP TOS bits 184 [2012-01-02 12:59:32] == Using SIP RTP CoS mark 5 [2012-01-02 12:59:32] -- Executing [s@all-hangup:11] Set("Local/6001@default-local-paging-86d3;2", "CDR(rlp)=") in new stack [2012-01-02 12:59:32] -- Executing [s@all-hangup:14] GotoIf("Local/6000@default-local-paging-c665;2", "0?all-faxnotify,s,1:15") in new stack [2012-01-02 12:59:32] -- Executing [s@all-hangup:4] Set("Local/6007@default-local-paging-72c2;2", "CDR(codec2)=ulaw") in new stack [2012-01-02 12:59:32] -- Executing [s@all-hangup:12] Set("Local/6001@default-local-paging-86d3;2", "CDR(ljitt)=") in new stack [2012-01-02 12:59:32] -- Goto (all-hangup,s,15) [2012-01-02 12:59:32] -- Executing [s@all-hangup:15] ResetCDR("Local/6000@default-local-paging-c665;2", "w") in new stack [2012-01-02 12:59:32] -- Executing [s@all-hangup:5] Set("Local/6007@default-local-paging-72c2;2", "CDR(peerip)=") in new stack [2012-01-02 12:59:32] -- Executing [s@all-hangup:13] Set("Local/6001@default-local-paging-86d3;2", "CDR(rjitt)=") in new stack [2012-01-02 12:59:33] -- Executing [paging@all-local-extension:5] Dial("Local/6989@default-local-paging-a24d;2", "SIP/6989,5") in new stack [2012-01-02 12:59:33] -- Executing [s@all-hangup:6] Set("Local/6007@default-local-paging-72c2;2", "CDR(recvip)=") in new stack [2012-01-02 12:59:33] -- SIP/6005-0000000f answered Local/6005@default-local-paging-7791;2 [2012-01-02 12:59:33] -- Executing [s@all-hangup:16] NoCDR("Local/6000@default-local-paging-c665;2", "") in new stack [2012-01-02 12:59:33] == Extension Changed 6006[default-local] new state InUse for Notify User 6001 [2012-01-02 12:59:33] -- Executing [s@all-hangup:14] GotoIf("Local/6001@default-local-paging-86d3;2", "0?all-faxnotify,s,1:15") in new stack [2012-01-02 12:59:33] -- Local/6006@default-local-paging-0e63;1 answered [2012-01-02 12:59:33] -- Executing [s@all-hangup:7] Set("Local/6007@default-local-paging-72c2;2", "CDR(fromchan)=") in new stack [2012-01-02 12:59:33] -- Executing [s@all-hangup:17] Hangup("Local/6000@default-local-paging-c665;2", "") in new stack [2012-01-02 12:59:33] -- Goto (all-hangup,s,15) [2012-01-02 12:59:33] -- Executing [h@all-local-extension:1] Goto("Local/6002@default-local-paging-8d10;2", "all-hangup,s,1") in new stack [2012-01-02 12:59:33] -- Executing [s@all-hangup:15] ResetCDR("Local/6001@default-local-paging-86d3;2", "w") in new stack [2012-01-02 12:59:33] -- Executing [s@all-hangup:8] Set("Local/6007@default-local-paging-72c2;2", "CDR(uri)=") in new stack [2012-01-02 12:59:33] == Spawn extension (all-hangup, s, 17) exited non-zero on 'Local/6000@default-local-paging-c665;2' [2012-01-02 12:59:34] WARNING[29011]: channel.c:1474 __ast_queue_frame: Exceptionally long voice queue length queuing to Local/6055@default-local-d64a;1 [2012-01-02 12:59:34] -- Goto (all-hangup,s,1) [2012-01-02 12:59:34] -- Executing [s@all-hangup:16] NoCDR("Local/6001@default-local-paging-86d3;2", "") in new stack [2012-01-02 12:59:34] -- Executing [s@all-hangup:1] Set("Local/6002@default-local-paging-8d10;2", "CDR(hangupside)=") in new stack [2012-01-02 12:59:34] -- Executing [s@all-hangup:9] Set("Local/6007@default-local-paging-72c2;2", "CDR(useragent)=") in new stack [2012-01-02 12:59:34] -- Executing [s@all-hangup:17] Hangup("Local/6001@default-local-paging-86d3;2", "") in new stack [2012-01-02 12:59:34] -- Executing [s@all-hangup:2] Set("Local/6002@default-local-paging-8d10;2", "CDR(hangupcause)=16") in new stack [2012-01-02 12:59:34] -- Executing [s@all-hangup:10] Set("Local/6007@default-local-paging-72c2;2", "CDR(llp)=") in new stack [2012-01-02 12:59:35] == Spawn extension (all-hangup, s, 17) exited non-zero on 'Local/6001@default-local-paging-86d3;2' [2012-01-02 12:59:35] == Using UDPTL TOS bits 184 [2012-01-02 12:59:35] == Using UDPTL CoS mark 5 [2012-01-02 12:59:35] -- Executing [s@all-hangup:3] Set("Local/6002@default-local-paging-8d10;2", "CDR(codec1)=ulaw") in new stack [2012-01-02 12:59:35] WARNING[29062]: app_dial.c:2218 dial_exec_full: Unable to create channel of type 'SIP' (cause 20 - Unknown) [2012-01-02 12:59:35] == Everyone is busy/congested at this time (1:0/0/1) [2012-01-02 12:59:35] -- Local/6005@default-local-paging-7791;1 answered [2012-01-02 12:59:35] -- Executing [s@all-hangup:11] Set("Local/6007@default-local-paging-72c2;2", "CDR(rlp)=") in new stack [2012-01-02 12:59:35] -- Executing [s@all-hangup:4] Set("Local/6002@default-local-paging-8d10;2", "CDR(codec2)=ulaw") in new stack [2012-01-02 12:59:35] -- Executing [s@all-hangup:12] Set("Local/6007@default-local-paging-72c2;2", "CDR(ljitt)=") in new stack lab*CLI> core show locks ======================================================================= === Currently Held Locks ============================================== ======================================================================= === === (): (times locked) === === Thread ID: 0xb7f9ab90 (tps_processing_function started at [ 451] taskprocessor.c ast_taskprocessor_get()) === ---> Lock #0 (event.c): RDLOCK 1452 handle_event &(&ast_event_subs[event_types[i]])->lock 0x820ec58 (1) /usr/sbin/asterisk(ast_bt_get_addresses+0x1a) [0x810573a] /usr/sbin/asterisk(__ast_rwlock_rdlock+0x76) [0x8104d36] /usr/sbin/asterisk [0x80d5db7] /usr/sbin/asterisk [0x8163273] /usr/sbin/asterisk [0x8171f31] /lib/libpthread.so.0 [0x9b6832] /lib/libc.so.6(clone+0x5e) [0xac946e] === ---> Lock #1 (pbx.c): MUTEX 9916 pbx_builtin_setvar_helper chan 0x99d1518 (1) /usr/sbin/asterisk(ast_bt_get_addresses+0x1a) [0x810573a] /usr/sbin/asterisk(__ast_pthread_mutex_lock+0x77) [0x8102227] /usr/sbin/asterisk(pbx_builtin_setvar_helper+0x5a) [0x812872a] /usr/sbin/asterisk(ast_cel_fabricate_channel_from_event+0x514) [0x809d054] /usr/lib/asterisk/modules/cel_custom.so [0xcaae7c] /usr/sbin/asterisk [0x80d5e4e] /usr/sbin/asterisk [0x8163273] /usr/sbin/asterisk [0x8171f31] /lib/libpthread.so.0 [0x9b6832] /lib/libc.so.6(clone+0x5e) [0xac946e] === ------------------------------------------------------------------- === === Thread ID: 0xb744bb90 (tps_processing_function started at [ 451] taskprocessor.c ast_taskprocessor_get()) === ---> Lock #0 (pbx.c): MUTEX 4411 handle_statechange &context_merge_lock 0x81fc3e0 (1) /usr/sbin/asterisk(ast_bt_get_addresses+0x1a) [0x810573a] /usr/sbin/asterisk(__ast_pthread_mutex_lock+0x77) [0x8102227] /usr/sbin/asterisk [0x812d54b] /usr/sbin/asterisk [0x8163273] /usr/sbin/asterisk [0x8171f31] /lib/libpthread.so.0 [0x9b6832] /lib/libc.so.6(clone+0x5e) [0xac946e] === ---> Lock #1 (pbx.c): MUTEX 4418 handle_statechange hint 0xb75ecdc8 (1) /usr/sbin/asterisk(ast_bt_get_addresses+0x1a) [0x810573a] /usr/sbin/asterisk(__ast_pthread_mutex_lock+0x77) [0x8102227] /usr/sbin/asterisk [0x812d5ea] /usr/sbin/asterisk [0x8163273] /usr/sbin/asterisk [0x8171f31] /lib/libpthread.so.0 [0x9b6832] /lib/libc.so.6(clone+0x5e) [0xac946e] === ------------------------------------------------------------------- === === Thread ID: 0xb715bb90 (handle_tcptls_connection started at [ 293] tcptls.c ast_tcptls_server_root()) === ---> Lock #0 (manager.c): MUTEX 4621 process_message act_found 0x94cfe50 (1) /usr/sbin/asterisk(ast_bt_get_addresses+0x1a) [0x810573a] /usr/sbin/asterisk(__ast_pthread_mutex_lock+0x77) [0x8102227] /usr/sbin/asterisk [0x8111319] /usr/sbin/asterisk [0x8114531] /usr/sbin/asterisk [0x81644d2] /usr/sbin/asterisk [0x8171f31] /lib/libpthread.so.0 [0x9b6832] /lib/libc.so.6(clone+0x5e) [0xac946e] === ---> Lock #1 (astobj2.c): MUTEX 661 internal_ao2_callback c 0xb7c87f28 (1) /usr/sbin/asterisk(ast_bt_get_addresses+0x1a) [0x810573a] /usr/sbin/asterisk(__ast_pthread_mutex_lock+0x77) [0x8102227] /usr/sbin/asterisk [0x8081b82] /usr/sbin/asterisk(__ao2_callback+0x4a) [0x80821aa] /usr/sbin/asterisk(__ao2_find+0x26) [0x8082256] /usr/sbin/asterisk [0x80a779f] /usr/sbin/asterisk [0x811821a] /usr/sbin/asterisk [0x8111383] /usr/sbin/asterisk [0x8114531] /usr/sbin/asterisk [0x81644d2] /usr/sbin/asterisk [0x8171f31] /lib/libpthread.so.0 [0x9b6832] /lib/libc.so.6(clone+0x5e) [0xac946e] === ---> Waiting for Lock #2 (channel.c): MUTEX 1692 ast_channel_cmp_cb chan 0x99d3e68 (1) /usr/sbin/asterisk(ast_bt_get_addresses+0x1a) [0x810573a] /usr/sbin/asterisk(__ast_pthread_mutex_lock+0x77) [0x8102227] /usr/sbin/asterisk [0x80ac9a3] /usr/sbin/asterisk [0x8081bf6] /usr/sbin/asterisk(__ao2_callback+0x4a) [0x80821aa] /usr/sbin/asterisk(__ao2_find+0x26) [0x8082256] /usr/sbin/asterisk [0x80a779f] /usr/sbin/asterisk [0x811821a] /usr/sbin/asterisk [0x8111383] /usr/sbin/asterisk [0x8114531] /usr/sbin/asterisk [0x81644d2] /usr/sbin/asterisk [0x8171f31] /lib/libpthread.so.0 [0x9b6832] /lib/libc.so.6(clone+0x5e) [0xac946e] === --- ---> Locked Here: chan_sip.c line 7088 (sip_new) === ------------------------------------------------------------------- === === Thread ID: 0xb6fffb90 (do_monitor started at [25682] chan_sip.c restart_monitor()) === ---> Lock #0 (chan_sip.c): MUTEX 25652 do_monitor &monlock 0x4deb540 (1) /usr/sbin/asterisk(ast_bt_get_addresses+0x1a) [0x810573a] /usr/sbin/asterisk(__ast_pthread_mutex_lock+0x77) [0x8102227] /usr/lib/asterisk/modules/chan_sip.so [0x4d92b64] /usr/sbin/asterisk [0x8171f31] /lib/libpthread.so.0 [0x9b6832] /lib/libc.so.6(clone+0x5e) [0xac946e] === ------------------------------------------------------------------- === === Thread ID: 0xafe4bb90 (pbx_thread started at [ 5328] pbx.c ast_pbx_start()) === ---> Waiting for Lock #0 (channel.c): MUTEX 1409 __ast_queue_frame chan 0x944bf28 (1) /usr/sbin/asterisk(ast_bt_get_addresses+0x1a) [0x810573a] /usr/sbin/asterisk(__ast_pthread_mutex_lock+0x77) [0x8102227] /usr/sbin/asterisk [0x80a5a39] /usr/lib/asterisk/modules/chan_local.so [0x6d1157] /usr/lib/asterisk/modules/chan_local.so [0x6d1c6e] /usr/sbin/asterisk(ast_write+0xdfe) [0x80aa76e] /usr/sbin/asterisk [0x80b1944] /usr/sbin/asterisk(ast_channel_bridge+0x63b) [0x80b21eb] /usr/sbin/asterisk(ast_bridge_call+0x347) [0x80e3c67] /usr/lib/asterisk/modules/app_dial.so [0x3ba336c] /usr/lib/asterisk/modules/app_dial.so [0x3ba7789] /usr/sbin/asterisk(pbx_exec+0xcb) [0x812a1cb] /usr/sbin/asterisk [0x8134585] /usr/sbin/asterisk [0x8137149] /usr/sbin/asterisk [0x8139090] /usr/sbin/asterisk [0x8171f31] /lib/libpthread.so.0 [0x9b6832] /lib/libc.so.6(clone+0x5e) [0xac946e] === --- ---> Locked Here: channel.c line 4774 (ast_write) === ------------------------------------------------------------------- === === Thread ID: 0xafc4bb90 (pbx_thread started at [ 5328] pbx.c ast_pbx_start()) === ---> Lock #0 (channel.c): MUTEX 4774 ast_write chan 0x944bf28 (1) /usr/sbin/asterisk(ast_bt_get_addresses+0x1a) [0x810573a] /usr/sbin/asterisk(__ast_pthread_mutex_trylock+0x76) [0x8103cc6] /usr/sbin/asterisk(ast_write+0x4a) [0x80a99ba] /usr/lib/asterisk/modules/app_meetme.so [0x7e53d1c] /usr/lib/asterisk/modules/app_meetme.so [0x7e59597] /usr/sbin/asterisk(pbx_exec+0xcb) [0x812a1cb] /usr/lib/asterisk/modules/app_page.so [0x8fe00b7] /usr/sbin/asterisk(pbx_exec+0xcb) [0x812a1cb] /usr/sbin/asterisk [0x8134585] /usr/sbin/asterisk [0x8137149] /usr/sbin/asterisk [0x8139090] /usr/sbin/asterisk [0x8171f31] /lib/libpthread.so.0 [0x9b6832] /lib/libc.so.6(clone+0x5e) [0xac946e] === ------------------------------------------------------------------- === === Thread ID: 0xb6f41b90 (handle_tcptls_connection started at [ 293] tcptls.c ast_tcptls_server_root()) === ---> Waiting for Lock #0 (manager.c): MUTEX 4621 process_message act_found 0x94cfe50 (1) /usr/sbin/asterisk(ast_bt_get_addresses+0x1a) [0x810573a] /usr/sbin/asterisk(__ast_pthread_mutex_lock+0x77) [0x8102227] /usr/sbin/asterisk [0x8111319] /usr/sbin/asterisk [0x8114531] /usr/sbin/asterisk [0x81644d2] /usr/sbin/asterisk [0x8171f31] /lib/libpthread.so.0 [0x9b6832] /lib/libc.so.6(clone+0x5e) [0xac946e] === --- ---> Locked Here: manager.c line 4621 (process_message) === ------------------------------------------------------------------- === === Thread ID: 0xafae3b90 (pbx_thread started at [ 5328] pbx.c ast_pbx_start()) === ---> Waiting for Lock #0 (astobj2.c): MUTEX 661 internal_ao2_callback c 0xb7c87f28 (1) /usr/sbin/asterisk(ast_bt_get_addresses+0x1a) [0x810573a] /usr/sbin/asterisk(__ast_pthread_mutex_lock+0x77) [0x8102227] /usr/sbin/asterisk [0x8081b82] /usr/sbin/asterisk(__ao2_callback+0x4a) [0x80821aa] /usr/sbin/asterisk(__ao2_find+0x26) [0x8082256] /usr/sbin/asterisk [0x80a779f] /usr/sbin/asterisk(ast_bridge_call+0x1537) [0x80e4e57] /usr/lib/asterisk/modules/app_dial.so [0x3ba336c] /usr/lib/asterisk/modules/app_dial.so [0x3ba7789] /usr/sbin/asterisk(pbx_exec+0xcb) [0x812a1cb] /usr/sbin/asterisk [0x8134585] /usr/sbin/asterisk [0x8137149] /usr/sbin/asterisk [0x8139090] /usr/sbin/asterisk [0x8171f31] /lib/libpthread.so.0 [0x9b6832] /lib/libc.so.6(clone+0x5e) [0xac946e] === --- ---> Locked Here: astobj2.c line 661 (internal_ao2_callback) === ------------------------------------------------------------------- === === Thread ID: 0xafb5bb90 (async_dial started at [ 727] dial.c ast_dial_run()) === ---> Lock #0 (channel.c): MUTEX 4774 ast_write chan 0x997f9d8 (1) /usr/sbin/asterisk(ast_bt_get_addresses+0x1a) [0x810573a] /usr/sbin/asterisk(__ast_pthread_mutex_trylock+0x76) [0x8103cc6] /usr/sbin/asterisk(ast_write+0x4a) [0x80a99ba] /usr/lib/asterisk/modules/app_meetme.so [0x7e53d1c] /usr/lib/asterisk/modules/app_meetme.so [0x7e59597] /usr/sbin/asterisk(pbx_exec+0xcb) [0x812a1cb] /usr/sbin/asterisk [0x80cbb6e] /usr/sbin/asterisk [0x80cd030] /usr/sbin/asterisk [0x8171f31] /lib/libpthread.so.0 [0x9b6832] /lib/libc.so.6(clone+0x5e) [0xac946e] === ------------------------------------------------------------------- === === Thread ID: 0xafbd3b90 (pbx_thread started at [ 5328] pbx.c ast_pbx_start()) === ---> Waiting for Lock #0 (astobj2.c): MUTEX 661 internal_ao2_callback c 0xb7c87f28 (1) /usr/sbin/asterisk(ast_bt_get_addresses+0x1a) [0x810573a] /usr/sbin/asterisk(__ast_pthread_mutex_lock+0x77) [0x8102227] /usr/sbin/asterisk [0x8081b82] /usr/sbin/asterisk(__ao2_callback+0x4a) [0x80821aa] /usr/sbin/asterisk(__ao2_find+0x26) [0x8082256] /usr/sbin/asterisk [0x80a779f] /usr/sbin/asterisk(ast_bridge_call+0x1537) [0x80e4e57] /usr/lib/asterisk/modules/app_dial.so [0x3ba336c] /usr/lib/asterisk/modules/app_dial.so [0x3ba7789] /usr/sbin/asterisk(pbx_exec+0xcb) [0x812a1cb] /usr/sbin/asterisk [0x8134585] /usr/sbin/asterisk [0x8137149] /usr/sbin/asterisk [0x8139090] /usr/sbin/asterisk [0x8171f31] /lib/libpthread.so.0 [0x9b6832] /lib/libc.so.6(clone+0x5e) [0xac946e] === --- ---> Locked Here: astobj2.c line 661 (internal_ao2_callback) === ------------------------------------------------------------------- === === Thread ID: 0xafe87b90 (pbx_thread started at [ 5328] pbx.c ast_pbx_start()) === ---> Lock #0 (channel.c): MUTEX 7171 update_bridge_vars c1 0x99e6a30 (2) /usr/sbin/asterisk(ast_bt_get_addresses+0x1a) [0x810573a] /usr/sbin/asterisk(__ast_pthread_mutex_lock+0x77) [0x8102227] /usr/sbin/asterisk(pbx_builtin_setvar_helper+0x5a) [0x812872a] /usr/sbin/asterisk [0x80ad207] /usr/sbin/asterisk(ast_channel_bridge+0x5aa) [0x80b215a] /usr/sbin/asterisk(ast_bridge_call+0x347) [0x80e3c67] /usr/lib/asterisk/modules/app_dial.so [0x3ba336c] /usr/lib/asterisk/modules/app_dial.so [0x3ba7789] /usr/sbin/asterisk(pbx_exec+0xcb) [0x812a1cb] /usr/sbin/asterisk [0x8134585] /usr/sbin/asterisk [0x8137149] /usr/sbin/asterisk [0x8139090] /usr/sbin/asterisk [0x8171f31] /lib/libpthread.so.0 [0x9b6832] /lib/libc.so.6(clone+0x5e) [0xac946e] === ------------------------------------------------------------------- === === Thread ID: 0xb7887b90 (async_dial started at [ 727] dial.c ast_dial_run()) === ---> Waiting for Lock #0 (channel.c): MUTEX 6379 ast_do_masquerade channels 0xb7c87f28 (1) /usr/sbin/asterisk(ast_bt_get_addresses+0x1a) [0x810573a] /usr/sbin/asterisk(__ast_pthread_mutex_lock+0x77) [0x8102227] /usr/sbin/asterisk [0x8081b82] /usr/sbin/asterisk(__ao2_callback+0x4a) [0x80821aa] /usr/sbin/asterisk(__ao2_find+0x26) [0x8082256] /usr/sbin/asterisk [0x80a779f] /usr/sbin/asterisk(ast_bridge_call+0x1537) [0x80e4e57] /usr/lib/asterisk/modules/app_dial.so [0x3ba336c] /usr/lib/asterisk/modules/app_dial.so [0x3ba7789] /usr/sbin/asterisk(pbx_exec+0xcb) [0x812a1cb] /usr/sbin/asterisk [0x8134585] /usr/sbin/asterisk [0x8137149] /usr/sbin/asterisk [0x8139090] /usr/sbin/asterisk [0x8171f31] /lib/libpthread.so.0 [0x9b6832] /lib/libc.so.6(clone+0x5e) [0xac946e] === --- ---> Locked Here: astobj2.c line 661 (internal_ao2_callback) === ------------------------------------------------------------------- === === Thread ID: 0xb5787b90 (async_dial started at [ 727] dial.c ast_dial_run()) === ---> Waiting for Lock #0 (astobj2.c): MUTEX 661 internal_ao2_callback c 0xb7c87f28 (1) /usr/sbin/asterisk(ast_bt_get_addresses+0x1a) [0x810573a] /usr/sbin/asterisk(__ast_pthread_mutex_lock+0x77) [0x8102227] /usr/sbin/asterisk [0x8081b82] /usr/sbin/asterisk(__ao2_callback+0x4a) [0x80821aa] /usr/sbin/asterisk(__ao2_find+0x26) [0x8082256] /usr/sbin/asterisk [0x80a779f] /usr/sbin/asterisk(ast_bridge_call+0x1537) [0x80e4e57] /usr/lib/asterisk/modules/app_dial.so [0x3ba336c] /usr/lib/asterisk/modules/app_dial.so [0x3ba7789] /usr/sbin/asterisk(pbx_exec+0xcb) [0x812a1cb] /usr/sbin/asterisk [0x8134585] /usr/sbin/asterisk [0x8137149] /usr/sbin/asterisk [0x8139090] /usr/sbin/asterisk [0x8171f31] /lib/libpthread.so.0 [0x9b6832] /lib/libc.so.6(clone+0x5e) [0xac946e] === --- ---> Locked Here: astobj2.c line 661 (internal_ao2_callback) === ------------------------------------------------------------------- === === Thread ID: 0xafa2fb90 (pbx_thread started at [ 5328] pbx.c ast_pbx_start()) === ---> Waiting for Lock #0 (channel.c): MUTEX 1409 __ast_queue_frame chan 0x94a2378 (1) /usr/sbin/asterisk(ast_bt_get_addresses+0x1a) [0x810573a] /usr/sbin/asterisk(__ast_pthread_mutex_lock+0x77) [0x8102227] /usr/sbin/asterisk [0x80a5a39] /usr/lib/asterisk/modules/chan_local.so [0x6d1157] /usr/lib/asterisk/modules/chan_local.so [0x6d1685] /usr/sbin/asterisk(ast_indicate_data+0x11a) [0x80a559a] /usr/sbin/asterisk(ast_indicate+0x28) [0x80a59f8] /usr/sbin/asterisk(ast_channel_bridge+0x2ba) [0x80b1e6a] /usr/sbin/asterisk(ast_bridge_call+0x347) [0x80e3c67] /usr/lib/asterisk/modules/app_dial.so [0x3ba336c] /usr/lib/asterisk/modules/app_dial.so [0x3ba7789] /usr/sbin/asterisk(pbx_exec+0xcb) [0x812a1cb] /usr/sbin/asterisk [0x8134585] /usr/sbin/asterisk [0x8137149] /usr/sbin/asterisk [0x8139090] /usr/sbin/asterisk [0x8171f31] /lib/libpthread.so.0 [0x9b6832] /lib/libc.so.6(clone+0x5e) [0xac946e] === --- ---> Locked Here: pbx.c line 9916 (pbx_builtin_setvar_helper) === ------------------------------------------------------------------- === === Thread ID: 0xb57c3b90 (async_dial started at [ 727] dial.c ast_dial_run()) === ---> Lock #0 (pbx.c): MUTEX 9916 pbx_builtin_setvar_helper chan 0x94a2378 (1) /usr/sbin/asterisk(ast_bt_get_addresses+0x1a) [0x810573a] /usr/sbin/asterisk(__ast_pthread_mutex_lock+0x77) [0x8102227] /usr/sbin/asterisk(pbx_builtin_setvar_helper+0x5a) [0x812872a] /usr/lib/asterisk/modules/app_meetme.so [0x7e50784] /usr/lib/asterisk/modules/app_meetme.so [0x7e59597] /usr/sbin/asterisk(pbx_exec+0xcb) [0x812a1cb] /usr/sbin/asterisk [0x80cbb6e] /usr/sbin/asterisk [0x80cd030] /usr/sbin/asterisk [0x8171f31] /lib/libpthread.so.0 [0x9b6832] /lib/libc.so.6(clone+0x5e) [0xac946e] === ------------------------------------------------------------------- === === Thread ID: 0xafaa7b90 (pbx_thread started at [ 5328] pbx.c ast_pbx_start()) === ---> Lock #0 (channel.c): MUTEX 7158 update_bridge_vars c0 0xb02cc220 (2) /usr/sbin/asterisk(ast_bt_get_addresses+0x1a) [0x810573a] /usr/sbin/asterisk(__ast_pthread_mutex_lock+0x77) [0x8102227] /usr/sbin/asterisk(pbx_builtin_setvar_helper+0x5a) [0x812872a] /usr/sbin/asterisk [0x80ad0a3] /usr/sbin/asterisk(ast_channel_bridge+0x622) [0x80b21d2] /usr/sbin/asterisk(ast_bridge_call+0x347) [0x80e3c67] /usr/lib/asterisk/modules/app_dial.so [0x3ba336c] /usr/lib/asterisk/modules/app_dial.so [0x3ba7789] /usr/sbin/asterisk(pbx_exec+0xcb) [0x812a1cb] /usr/sbin/asterisk [0x8134585] /usr/sbin/asterisk [0x8137149] /usr/sbin/asterisk [0x8139090] /usr/sbin/asterisk [0x8171f31] /lib/libpthread.so.0 [0x9b6832] /lib/libc.so.6(clone+0x5e) [0xac946e] === ------------------------------------------------------------------- === === Thread ID: 0xb5fc3b90 (pbx_thread started at [ 5328] pbx.c ast_pbx_start()) === ---> Lock #0 (chan_sip.c): MUTEX 7088 sip_new tmp 0x99d3e68 (1) /usr/sbin/asterisk(ast_bt_get_addresses+0x1a) [0x810573a] /usr/sbin/asterisk(__ast_pthread_mutex_lock+0x77) [0x8102227] /usr/lib/asterisk/modules/chan_sip.so [0x4d684be] /usr/lib/asterisk/modules/chan_sip.so [0x4d98bfe] /usr/sbin/asterisk(ast_request+0x1ed) [0x80a424d] /usr/lib/asterisk/modules/app_dial.so [0x3ba37d8] /usr/lib/asterisk/modules/app_dial.so [0x3ba7789] /usr/sbin/asterisk(pbx_exec+0xcb) [0x812a1cb] /usr/sbin/asterisk [0x8134585] /usr/sbin/asterisk [0x8137149] /usr/sbin/asterisk [0x8139090] /usr/sbin/asterisk [0x8171f31] /lib/libpthread.so.0 [0x9b6832] /lib/libc.so.6(clone+0x5e) [0xac946e] === ---> Lock #1 (chan_sip.c): MUTEX 7089 sip_new i 0x9434e00 (1) /usr/sbin/asterisk(ast_bt_get_addresses+0x1a) [0x810573a] /usr/sbin/asterisk(__ast_pthread_mutex_lock+0x77) [0x8102227] /usr/lib/asterisk/modules/chan_sip.so [0x4d684f2] /usr/lib/asterisk/modules/chan_sip.so [0x4d98bfe] /usr/sbin/asterisk(ast_request+0x1ed) [0x80a424d] /usr/lib/asterisk/modules/app_dial.so [0x3ba37d8] /usr/lib/asterisk/modules/app_dial.so [0x3ba7789] /usr/sbin/asterisk(pbx_exec+0xcb) [0x812a1cb] /usr/sbin/asterisk [0x8134585] /usr/sbin/asterisk [0x8137149] /usr/sbin/asterisk [0x8139090] /usr/sbin/asterisk [0x8171f31] /lib/libpthread.so.0 [0x9b6832] /lib/libc.so.6(clone+0x5e) [0xac946e] === ------------------------------------------------------------------- === === Thread ID: 0xafcc3b90 (pbx_thread started at [ 5328] pbx.c ast_pbx_start()) === ---> Lock #0 (chan_sip.c): MUTEX 7088 sip_new tmp 0xb7c93bc8 (2) /usr/sbin/asterisk(ast_bt_get_addresses+0x1a) [0x810573a] /usr/sbin/asterisk(__ast_pthread_mutex_lock+0x77) [0x8102227] /usr/sbin/asterisk(pbx_builtin_setvar_helper+0x5a) [0x812872a] /usr/lib/asterisk/modules/chan_sip.so [0x4d686c2] /usr/lib/asterisk/modules/chan_sip.so [0x4d98bfe] /usr/sbin/asterisk(ast_request+0x1ed) [0x80a424d] /usr/lib/asterisk/modules/app_dial.so [0x3ba37d8] /usr/lib/asterisk/modules/app_dial.so [0x3ba7789] /usr/sbin/asterisk(pbx_exec+0xcb) [0x812a1cb] /usr/sbin/asterisk [0x8134585] /usr/sbin/asterisk [0x8137149] /usr/sbin/asterisk [0x8139090] /usr/sbin/asterisk [0x8171f31] /lib/libpthread.so.0 [0x9b6832] /lib/libc.so.6(clone+0x5e) [0xac946e] === ---> Lock #1 (chan_sip.c): MUTEX 7089 sip_new i 0xb09d07e8 (1) /usr/sbin/asterisk(ast_bt_get_addresses+0x1a) [0x810573a] /usr/sbin/asterisk(__ast_pthread_mutex_lock+0x77) [0x8102227] /usr/lib/asterisk/modules/chan_sip.so [0x4d684f2] /usr/lib/asterisk/modules/chan_sip.so [0x4d98bfe] /usr/sbin/asterisk(ast_request+0x1ed) [0x80a424d] /usr/lib/asterisk/modules/app_dial.so [0x3ba37d8] /usr/lib/asterisk/modules/app_dial.so [0x3ba7789] /usr/sbin/asterisk(pbx_exec+0xcb) [0x812a1cb] /usr/sbin/asterisk [0x8134585] /usr/sbin/asterisk [0x8137149] /usr/sbin/asterisk [0x8139090] /usr/sbin/asterisk [0x8171f31] /lib/libpthread.so.0 [0x9b6832] /lib/libc.so.6(clone+0x5e) [0xac946e] === ---> Waiting for Lock #2 (manager.c): MUTEX 5087 __ast_manager_event_multichan session 0x9a16a88 (1) /usr/sbin/asterisk(ast_bt_get_addresses+0x1a) [0x810573a] /usr/sbin/asterisk(__ast_pthread_mutex_lock+0x77) [0x8102227] /usr/sbin/asterisk(__ast_manager_event_multichan+0x36f) [0x810d5bf] /usr/sbin/asterisk(pbx_builtin_setvar_helper+0x18c) [0x812885c] /usr/lib/asterisk/modules/app_meetme.so [0x7e50784] /usr/lib/asterisk/modules/app_meetme.so [0x7e59597] /usr/sbin/asterisk(pbx_exec+0xcb) [0x812a1cb] /usr/sbin/asterisk [0x80cbb6e] /usr/lib/asterisk/modules/app_dial.so [0x3ba7789] /usr/sbin/asterisk(pbx_exec+0xcb) [0x812a1cb] /usr/sbin/asterisk [0x8134585] /usr/sbin/asterisk [0x8137149] /usr/sbin/asterisk [0x8139090] /usr/sbin/asterisk [0x8171f31] /lib/libpthread.so.0 [0x9b6832] /lib/libc.so.6(clone+0x5e) [0xac946e] === ------------------------------------------------------------------- === === Thread ID: 0xb00d3b90 (handle_tcptls_connection started at [ 293] tcptls.c ast_tcptls_server_root()) === ---> Waiting for Lock #0 (manager.c): MUTEX 4732 get_input s->session 0x9a16a88 (1) /usr/sbin/asterisk(ast_bt_get_addresses+0x1a) [0x810573a] /usr/sbin/asterisk(__ast_pthread_mutex_lock+0x77) [0x8102227] /usr/sbin/asterisk [0x8113ded] /usr/sbin/asterisk [0x81644d2] /usr/sbin/asterisk [0x8171f31] /lib/libpthread.so.0 [0x9b6832] /lib/libc.so.6(clone+0x5e) [0xac946e] === ------------------------------------------------------------------- === ======================================================================= [2012-01-02 12:59:35] -- Executing [paging@all-local-extension:6] Hangup("Local/6989@default-local-paging-a24d;2", "20") in new stack [2012-01-02 12:59:35] -- Executing [s@all-hangup:13] Set("Local/6007@default-local-paging-72c2;2", "CDR(rjitt)=") in new stack [2012-01-02 12:59:35] -- Executing [s@all-hangup:5] Set("Local/6002@default-local-paging-8d10;2", "CDR(peerip)=") in new stack [2012-01-02 12:59:36] == Spawn extension (all-local-extension, paging, 6) exited non-zero on 'Local/6989@default-local-paging-a24d;2' [2012-01-02 12:59:36] -- Executing [h@all-local-extension:1] Goto("Local/6989@default-local-paging-a24d;2", "all-hangup,s,1") in new stack [2012-01-02 12:59:36] -- Executing [s@all-hangup:6] Set("Local/6002@default-local-paging-8d10;2", "CDR(recvip)=") in new stack [2012-01-02 12:59:36] -- Executing [s@all-hangup:14] GotoIf("Local/6007@default-local-paging-72c2;2", "0?all-faxnotify,s,1:15") in new stack [2012-01-02 12:59:36] -- Goto (all-hangup,s,1) [2012-01-02 12:59:36] -- Executing [s@all-hangup:1] Set("Local/6989@default-local-paging-a24d;2", "CDR(hangupside)=") in new stack [2012-01-02 12:59:36] -- Executing [s@all-hangup:7] Set("Local/6002@default-local-paging-8d10;2", "CDR(fromchan)=") in new stack [2012-01-02 12:59:36] -- Executing [s@all-hangup:2] Set("Local/6989@default-local-paging-a24d;2", "CDR(hangupcause)=20") in new stack [2012-01-02 12:59:36] -- Goto (all-hangup,s,15) [2012-01-02 12:59:36] -- Executing [s@all-hangup:15] ResetCDR("Local/6007@default-local-paging-72c2;2", "w") in new stack [2012-01-02 12:59:36] WARNING[29011]: channel.c:1474 __ast_queue_frame: Exceptionally long voice queue length queuing to Local/6055@default-local-d64a;1 [2012-01-02 12:59:36] -- Executing [s@all-hangup:8] Set("Local/6002@default-local-paging-8d10;2", "CDR(uri)=") in new stack [2012-01-02 12:59:36] -- Executing [s@all-hangup:16] NoCDR("Local/6007@default-local-paging-72c2;2", "") in new stack [2012-01-02 12:59:36] -- Executing [s@all-hangup:9] Set("Local/6002@default-local-paging-8d10;2", "CDR(useragent)=") in new stack [2012-01-02 12:59:36] -- Called SIP/6010 [2012-01-02 12:59:36] -- Executing [s@all-hangup:3] Set("Local/6989@default-local-paging-a24d;2", "CDR(codec1)=ulaw") in new stack [2012-01-02 12:59:36] -- Called SIP/6057 [2012-01-02 12:59:36] -- Executing [s@all-hangup:17] Hangup("Local/6007@default-local-paging-72c2;2", "") in new stack [2012-01-02 12:59:37] -- SIP/6057-00000011 is ringing [2012-01-02 12:59:37] == Spawn extension (all-hangup, s, 17) exited non-zero on 'Local/6007@default-local-paging-72c2;2' [2012-01-02 12:59:37] -- Local/6057@default-local-paging-da0f;1 is ringing [2012-01-02 12:59:37] -- Executing [s@all-hangup:4] Set("Local/6989@default-local-paging-a24d;2", "CDR(codec2)=ulaw") in new stack [2012-01-02 12:59:37] -- Executing [s@all-hangup:10] Set("Local/6002@default-local-paging-8d10;2", "CDR(llp)=") in new stack [2012-01-02 12:59:37] -- SIP/6010-00000010 answered Local/6010@default-local-paging-634f;2 [2012-01-02 12:59:37] -- Executing [s@all-hangup:5] Set("Local/6989@default-local-paging-a24d;2", "CDR(peerip)=") in new stack [2012-01-02 12:59:37] -- Executing [s@all-hangup:11] Set("Local/6002@default-local-paging-8d10;2", "CDR(rlp)=") in new stack [2012-01-02 12:59:37] -- Executing [s@all-hangup:6] Set("Local/6989@default-local-paging-a24d;2", "CDR(recvip)=") in new stack [2012-01-02 12:59:37] -- Executing [s@all-hangup:12] Set("Local/6002@default-local-paging-8d10;2", "CDR(ljitt)=") in new stack [2012-01-02 12:59:38] WARNING[29028]: channel.c:1474 __ast_queue_frame: Exceptionally long voice queue length queuing to Local/6006@default-local-paging-0e63;2 [2012-01-02 12:59:38] -- Executing [s@all-hangup:13] Set("Local/6002@default-local-paging-8d10;2", "CDR(rjitt)=") in new stack [2012-01-02 12:59:38] -- Executing [s@all-hangup:7] Set("Local/6989@default-local-paging-a24d;2", "CDR(fromchan)=") in new stack [2012-01-02 12:59:38] -- Executing [s@all-hangup:14] GotoIf("Local/6002@default-local-paging-8d10;2", "0?all-faxnotify,s,1:15") in new stack [2012-01-02 12:59:38] -- Executing [h@all-local-extension:1] Goto("Local/6003@default-local-paging-0db6;2", "all-hangup,s,1") in new stack [2012-01-02 12:59:38] -- Executing [s@all-hangup:8] Set("Local/6989@default-local-paging-a24d;2", "CDR(uri)=") in new stack [2012-01-02 12:59:38] -- Goto (all-hangup,s,15) [2012-01-02 12:59:38] -- Executing [s@all-hangup:15] ResetCDR("Local/6002@default-local-paging-8d10;2", "w") in new stack [2012-01-02 12:59:38] -- Goto (all-hangup,s,1) [2012-01-02 12:59:38] -- Executing [s@all-hangup:1] Set("Local/6003@default-local-paging-0db6;2", "CDR(hangupside)=") in new stack [2012-01-02 12:59:38] -- Executing [s@all-hangup:9] Set("Local/6989@default-local-paging-a24d;2", "CDR(useragent)=") in new stack [2012-01-02 12:59:38] -- Local/6010@default-local-paging-634f;1 answered [2012-01-02 12:59:38] -- Executing [s@all-hangup:16] NoCDR("Local/6002@default-local-paging-8d10;2", "") in new stack [2012-01-02 12:59:39] -- Executing [s@all-hangup:10] Set("Local/6989@default-local-paging-a24d;2", "CDR(llp)=") in new stack [2012-01-02 12:59:39] -- Executing [s@all-hangup:2] Set("Local/6003@default-local-paging-0db6;2", "CDR(hangupcause)=16") in new stack [2012-01-02 12:59:39] -- Executing [s@all-hangup:17] Hangup("Local/6002@default-local-paging-8d10;2", "") in new stack [2012-01-02 12:59:39] WARNING[29011]: channel.c:1474 __ast_queue_frame: Exceptionally long voice queue length queuing to Local/6055@default-local-d64a;1 [2012-01-02 12:59:39] -- Executing [s@all-hangup:11] Set("Local/6989@default-local-paging-a24d;2", "CDR(rlp)=") in new stack [2012-01-02 12:59:39] == Spawn extension (all-hangup, s, 17) exited non-zero on 'Local/6002@default-local-paging-8d10;2' [2012-01-02 12:59:40] -- SIP/6057-00000011 answered Local/6057@default-local-paging-da0f;2 [2012-01-02 12:59:40] -- Executing [s@all-hangup:3] Set("Local/6003@default-local-paging-0db6;2", "CDR(codec1)=ulaw") in new stack [2012-01-02 12:59:40] -- Executing [s@all-hangup:12] Set("Local/6989@default-local-paging-a24d;2", "CDR(ljitt)=") in new stack [2012-01-02 12:59:40] == Extension Changed 6057[default-local] new state InUse for Notify User 6002 [2012-01-02 12:59:40] -- Executing [s@all-hangup:13] Set("Local/6989@default-local-paging-a24d;2", "CDR(rjitt)=") in new stack [2012-01-02 12:59:40] -- Executing [s@all-hangup:4] Set("Local/6003@default-local-paging-0db6;2", "CDR(codec2)=ulaw") in new stack [2012-01-02 12:59:41] -- Executing [s@all-hangup:14] GotoIf("Local/6989@default-local-paging-a24d;2", "0?all-faxnotify,s,1:15") in new stack [2012-01-02 12:59:41] -- Executing [s@all-hangup:5] Set("Local/6003@default-local-paging-0db6;2", "CDR(peerip)=") in new stack [2012-01-02 12:59:41] WARNING[29011]: channel.c:1474 __ast_queue_frame: Exceptionally long voice queue length queuing to Local/6055@default-local-d64a;1 [2012-01-02 12:59:41] WARNING[29027]: channel.c:1474 __ast_queue_frame: Exceptionally long voice queue length queuing to Local/6006@default-local-paging-0e63;1 [2012-01-02 13:00:09] ERROR[20778]: res_musiconhold.c:659 monmp3thread: poll() failed: Interrupted system call [2012-01-02 13:00:10] -- Executing [s@all-hangup:6] Set("Local/6003@default-local-paging-0db6;2", "CDR(recvip)=") in new stack [2012-01-02 13:00:10] WARNING[29011]: channel.c:1474 __ast_queue_frame: Exceptionally long voice queue length queuing to Local/6055@default-local-d64a;1 [2012-01-02 13:00:10] == Spawn extension (all-local-extension, paging, 5) exited non-zero on 'Local/6000@default-local-paging-c665;2' [2012-01-02 13:00:10] -- Local/6057@default-local-paging-da0f;1 answered [2012-01-02 13:00:10] -- Goto (all-hangup,s,15) [2012-01-02 13:00:10] -- Executing [s@all-hangup:15] ResetCDR("Local/6989@default-local-paging-a24d;2", "w") in new stack [2012-01-02 13:00:10] == Spawn extension (all-local-extension, paging, 5) exited non-zero on 'Local/6001@default-local-paging-86d3;2' [2012-01-02 13:00:10] -- Executing [s@all-hangup:16] NoCDR("Local/6989@default-local-paging-a24d;2", "") in new stack [2012-01-02 13:00:10] -- Executing [s@all-hangup:7] Set("Local/6003@default-local-paging-0db6;2", "CDR(fromchan)=") in new stack [2012-01-02 13:00:10] -- Executing [h@all-local-extension:1] Goto("Local/6005@default-local-paging-7791;2", "all-hangup,s,1") in new stack [2012-01-02 13:00:10] -- Executing [s@all-hangup:17] Hangup("Local/6989@default-local-paging-a24d;2", "") in new stack [2012-01-02 13:00:10] -- Goto (all-hangup,s,1) [2012-01-02 13:00:10] -- Executing [s@all-hangup:1] Set("Local/6005@default-local-paging-7791;2", "CDR(hangupside)=") in new stack [2012-01-02 13:00:10] -- Executing [s@all-hangup:8] Set("Local/6003@default-local-paging-0db6;2", "CDR(uri)=") in new stack [2012-01-02 13:00:11] == Spawn extension (all-hangup, s, 17) exited non-zero on 'Local/6989@default-local-paging-a24d;2' [2012-01-02 13:00:11] -- Executing [s@all-hangup:2] Set("Local/6005@default-local-paging-7791;2", "CDR(hangupcause)=16") in new stack [2012-01-02 13:00:11] -- Executing [s@all-hangup:9] Set("Local/6003@default-local-paging-0db6;2", "CDR(useragent)=") in new stack [2012-01-02 13:00:11] WARNING[29011]: channel.c:1474 __ast_queue_frame: Exceptionally long voice queue length queuing to Local/6055@default-local-d64a;1 [2012-01-02 13:00:11] -- Executing [s@all-hangup:3] Set("Local/6005@default-local-paging-7791;2", "CDR(codec1)=ulaw") in new stack [2012-01-02 13:00:11] -- Executing [s@all-hangup:10] Set("Local/6003@default-local-paging-0db6;2", "CDR(llp)=") in new stack [2012-01-02 13:00:11] -- Executing [s@all-hangup:4] Set("Local/6005@default-local-paging-7791;2", "CDR(codec2)=ulaw") in new stack [2012-01-02 13:00:12] -- Executing [s@all-hangup:11] Set("Local/6003@default-local-paging-0db6;2", "CDR(rlp)=") in new stack [2012-01-02 13:00:12] WARNING[29027]: channel.c:1474 __ast_queue_frame: Exceptionally long voice queue length queuing to Local/6006@default-local-paging-0e63;1 [2012-01-02 13:00:12] == Spawn extension (all-local-extension, paging, 5) exited non-zero on 'Local/6002@default-local-paging-8d10;2' [2012-01-02 13:00:12] -- Executing [s@all-hangup:5] Set("Local/6005@default-local-paging-7791;2", "CDR(peerip)=") in new stack [2012-01-02 13:00:12] -- Executing [s@all-hangup:12] Set("Local/6003@default-local-paging-0db6;2", "CDR(ljitt)=") in new stack [2012-01-02 13:00:12] -- Executing [s@all-hangup:6] Set("Local/6005@default-local-paging-7791;2", "CDR(recvip)=") in new stack [2012-01-02 13:00:12] -- Executing [s@all-hangup:13] Set("Local/6003@default-local-paging-0db6;2", "CDR(rjitt)=") in new stack [2012-01-02 13:00:12] -- Executing [s@all-hangup:7] Set("Local/6005@default-local-paging-7791;2", "CDR(fromchan)=") in new stack [2012-01-02 13:00:13] -- Executing [s@all-hangup:14] GotoIf("Local/6003@default-local-paging-0db6;2", "0?all-faxnotify,s,1:15") in new stack [2012-01-02 13:00:13] WARNING[29032]: channel.c:1474 __ast_queue_frame: Exceptionally long voice queue length queuing to Local/6010@default-local-paging-634f;2 [2012-01-02 13:00:13] -- Executing [s@all-hangup:8] Set("Local/6005@default-local-paging-7791;2", "CDR(uri)=") in new stack [2012-01-02 13:00:13] -- Goto (all-hangup,s,15) [2012-01-02 13:00:13] -- Executing [s@all-hangup:15] ResetCDR("Local/6003@default-local-paging-0db6;2", "w") in new stack [2012-01-02 13:00:14] -- Executing [s@all-hangup:9] Set("Local/6005@default-local-paging-7791;2", "CDR(useragent)=") in new stack [2012-01-02 13:00:14] WARNING[29027]: channel.c:1474 __ast_queue_frame: Exceptionally long voice queue length queuing to Local/6006@default-local-paging-0e63;1 [2012-01-02 13:00:15] -- Executing [s@all-hangup:16] NoCDR("Local/6003@default-local-paging-0db6;2", "") in new stack [2012-01-02 13:00:15] WARNING[29032]: channel.c:1474 __ast_queue_frame: Exceptionally long voice queue length queuing to Local/6010@default-local-paging-634f;2 [2012-01-02 13:00:15] WARNING[29011]: channel.c:1474 __ast_queue_frame: Exceptionally long voice queue length queuing to Local/6055@default-local-d64a;1 [2012-01-02 13:00:15] -- Executing [s@all-hangup:10] Set("Local/6005@default-local-paging-7791;2", "CDR(llp)=") in new stack [2012-01-02 13:00:16] WARNING[29028]: channel.c:1474 __ast_queue_frame: Exceptionally long voice queue length queuing to Local/6006@default-local-paging-0e63;2 [2012-01-02 13:00:16] -- Executing [s@all-hangup:17] Hangup("Local/6003@default-local-paging-0db6;2", "") in new stack [2012-01-02 13:00:16] WARNING[29032]: channel.c:1474 __ast_queue_frame: Exceptionally long voice queue length queuing to Local/6010@default-local-paging-634f;2 [2012-01-02 13:00:16] -- Executing [s@all-hangup:11] Set("Local/6005@default-local-paging-7791;2", "CDR(rlp)=") in new stack [2012-01-02 13:00:16] WARNING[29003]: channel.c:1474 __ast_queue_frame: Exceptionally long voice queue length queuing to Local/6055@default-local-d64a;2 [2012-01-02 13:00:16] == Spawn extension (all-hangup, s, 17) exited non-zero on 'Local/6003@default-local-paging-0db6;2' [2012-01-02 13:00:16] -- Executing [s@all-hangup:12] Set("Local/6005@default-local-paging-7791;2", "CDR(ljitt)=") in new stack [2012-01-02 13:00:17] -- Executing [s@all-hangup:13] Set("Local/6005@default-local-paging-7791;2", "CDR(rjitt)=") in new stack [2012-01-02 13:00:17] WARNING[29011]: channel.c:1474 __ast_queue_frame: Exceptionally long voice queue length queuing to Local/6055@default-local-d64a;1 [2012-01-02 13:00:17] WARNING[29053]: channel.c:1474 __ast_queue_frame: Exceptionally long voice queue length queuing to Local/6057@default-local-paging-da0f;2 [2012-01-02 13:00:17] -- Executing [s@all-hangup:14] GotoIf("Local/6005@default-local-paging-7791;2", "0?all-faxnotify,s,1:15") in new stack