Vicidial 8.0.1
VERSION: 2.14-761a
BUILD: 200708-1033
Have installed this server couple of weeks ago, everything was running smoothly. Suddenly we've started getting this weird issue. When we login to admin and Monitor a call, it accepts the session but if we click on any other user "Listen" button we get SIP 486. If we refresh the page and then again press "Listen" again first time it works fine.
Logs for first call
- Code: Select all
[Jul 27 12:49:01] == Manager 'sendcron' logged on from 127.0.0.1
[Jul 27 12:49:01] -- Executing [176*009*xxx*xxx*08600057@default:1] Goto("Local/176*009*xxx*xxx*08600057@default-00000280;2", "default,08600057,1") in new stack
[Jul 27 12:49:01] -- Goto (default,08600057,1)
[Jul 27 12:49:01] -- Executing [08600057@default:1] Dial("Local/176*009*xxx*xxx*08600057@default-00000280;2", "IAX2/ASTblind:sHMpuxoZs6jS7cU@127.0.0.1:41569/68600057,55,To") in new stack
[Jul 27 12:49:01] -- Called IAX2/ASTblind:sHMpuxoZs6jS7cU@127.0.0.1:41569/68600057
[Jul 27 12:49:01] -- Accepting AUTHENTICATED call from 127.0.0.1:
[Jul 27 12:49:01] -- > requested format = gsm,
[Jul 27 12:49:01] -- > requested prefs = (gsm|ulaw),
[Jul 27 12:49:01] -- > actual format = ulaw,
[Jul 27 12:49:01] -- > host prefs = (ulaw),
[Jul 27 12:49:01] -- > priority = mine
[Jul 27 12:49:01] -- Call accepted by 127.0.0.1 (format ulaw)
[Jul 27 12:49:01] -- Format for call is (ulaw)
[Jul 27 12:49:01] -- Executing [68600057@default:1] MeetMe("IAX2/ASTblind-14066", "8600057,Fmq") in new stack
[Jul 27 12:49:01] -- IAX2/127.0.0.1:41569-9170 answered Local/176*009*xxx*xxx*08600057@default-00000280;2
[Jul 27 12:49:01] > Channel Local/176*009*xxx*xxx*08600057@default-00000280;1 was answered
[Jul 27 12:49:01] -- Executing [7001@default:1] Dial("IAX2/127.0.0.1:41569-9170", "SIP/7001,60,") in new stack
[Jul 27 12:49:01] -- Executing [h@default:1] AGI("Local/176*009*xxx*xxx*08600057@default-00000280;2", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----0-----0") in new stack
[Jul 27 12:49:01] == Using SIP RTP CoS mark 5
[Jul 27 12:49:01] -- Called SIP/7001
[Jul 27 12:49:01] -- <Local/176*009*xxx*xxx*08600057@default-00000280;2>AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----0-----0 completed, returning 0
Logs when pressed "Listen" button for another user
- Code: Select all
[Jul 27 12:49:43] -- Executing [176*009*xxx*xxx*08600055@default:1] Goto("Local/176*009*xxx*xxx*08600055@default-00000284;2", "default,08600055,1") in new stack
[Jul 27 12:49:43] -- Goto (default,08600055,1)
[Jul 27 12:49:43] -- Executing [08600055@default:1] Dial("Local/176*009*xxx*xxx*08600055@default-00000284;2", "IAX2/ASTblind:sHMpuxoZs6jS7cU@127.0.0.1:41569/68600055,55,To") in new stack
[Jul 27 12:49:43] -- Called IAX2/ASTblind:sHMpuxoZs6jS7cU@127.0.0.1:41569/68600055
[Jul 27 12:49:43] -- Accepting AUTHENTICATED call from 127.0.0.1:
[Jul 27 12:49:43] -- > requested format = gsm,
[Jul 27 12:49:43] -- > requested prefs = (gsm|ulaw),
[Jul 27 12:49:43] -- > actual format = ulaw,
[Jul 27 12:49:43] -- > host prefs = (ulaw),
[Jul 27 12:49:43] -- > priority = mine
[Jul 27 12:49:43] -- Call accepted by 127.0.0.1 (format ulaw)
[Jul 27 12:49:43] -- Format for call is (ulaw)
[Jul 27 12:49:43] -- Executing [68600055@default:1] MeetMe("IAX2/ASTblind-1898", "8600055,Fmq") in new stack
[Jul 27 12:49:43] -- IAX2/127.0.0.1:41569-876 answered Local/176*009*xxx*xxx*08600055@default-00000284;2
[Jul 27 12:49:43] > Channel Local/176*009*xxx*xxx*08600055@default-00000284;1 was answered
[Jul 27 12:49:43] -- Executing [7001@default:1] Dial("IAX2/127.0.0.1:41569-876", "SIP/7001,60,") in new stack
[Jul 27 12:49:43] -- Executing [h@default:1] AGI("Local/176*009*xxx*xxx*08600055@default-00000284;2", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----0-----0") in new stack
[Jul 27 12:49:43] == Using SIP RTP CoS mark 5
[Jul 27 12:49:43] -- Called SIP/7001
[Jul 27 12:49:43] -- <Local/176*009*xxx*xxx*08600055@default-00000284;2>AGI Script agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16-----ANSWER-----0-----0 completed, returning 0
[Jul 27 12:49:43] == Spawn extension (default, 08600055, 1) exited non-zero on 'Local/176*009*xxx*xxx*08600055@default-00000284;2'
[Jul 27 12:49:44] == Manager 'sendcron' logged off from 127.0.0.1
[Jul 27 12:49:45] -- SIP/7001-000001b3 is ringing
[Jul 27 12:49:45] -- Got SIP response 486 "Busy Here" back from 182.176.xxx.xxx:58821
[Jul 27 12:49:45] -- SIP/7001-000001b3 is busy
[Jul 27 12:49:45] == Everyone is busy/congested at this time (1:1/0/0)
[Jul 27 12:49:45] -- Executing [7001@default:2] Goto("IAX2/127.0.0.1:41569-876", "default,850266666666667001,1") in new stack
[Jul 27 12:49:45] -- Goto (default,850266666666667001,1)
[Jul 27 12:49:45] -- Executing [850266666666667001@default:1] Wait("IAX2/127.0.0.1:41569-876", "1") in new stack
[Jul 27 12:49:46] -- Executing [850266666666667001@default:2] VoiceMail("IAX2/127.0.0.1:41569-876", "7001,u") in new stack
[Jul 27 12:49:46] -- <IAX2/127.0.0.1:41569-876> Playing 'vm-theperson.gsm' (language 'en')