XiVO Community

dans l'interface d'administration, vérifier que dans IPBX/extensions/général/Renvois (http://ip/service/ipbx/index.php/pbx_services/extenfeatures/#forward)
les renvois soient bien activé et correspondent bien à ces codes (avec * en option).

sur la fiche utilisateurs, vérifier que Services/activer les transfert soit actif.

si tout est ok, mais que ça ne marche toujours pas, merci de fournir des logs.

C'est le 1er truc que j'ai regardé, oui les extensions sont bien activé, avec les *.
Le transfert est bien autorisé est bien coché sur les fiches tout les utilisateurs.

Voici le CLI :
Using SIP RTP CoS mark 5
[May 29 10:57:04] -- Executing [*210631494429@default:1] Set("SIP/c640q6xk-00000042", "XIVO_BASE_CONTEXT=default") in new stack
[May 29 10:57:04] -- Executing [*210631494429@default:2] Set("SIP/c640q6xk-00000042", "XIVO_BASE_EXTEN=*210631494429") in new stack
[May 29 10:57:04] -- Executing [*210631494429@default:3] Gosub("SIP/c640q6xk-00000042", "feature_forward,s,1(unc,0631494429)") in new stack
[May 29 10:57:04] -- Executing [s@feature_forward:1] Gosub("SIP/c640q6xk-00000042", "xivo-chk_feature_access,s,1") in new stack
[May 29 10:57:04] -- Executing [s@xivo-chk_feature_access:1] GotoIf("SIP/c640q6xk-00000042", "0?3") in new stack
[May 29 10:57:04] -- Executing [s@xivo-chk_feature_access:2] Return("SIP/c640q6xk-00000042", "") in new stack
[May 29 10:57:04] -- Executing [s@feature_forward:2] Set("SIP/c640q6xk-00000042", "XIVO_SRCNUM=202") in new stack
[May 29 10:57:04] -- Executing [s@feature_forward:3] Set("SIP/c640q6xk-00000042", "XIVO_CONTEXT=default") in new stack
[May 29 10:57:04] -- Executing [s@feature_forward:4] Set("SIP/c640q6xk-00000042", "XIVO_FEATURE_FORWARD_DEST=0631494429") in new stack
[May 29 10:57:04] -- Executing [s@feature_forward:5] Goto("SIP/c640q6xk-00000042", "unc,1") in new stack
[May 29 10:57:04] -- Goto (feature_forward,unc,1)
[May 29 10:57:04] -- Executing [unc@feature_forward:1] Set("SIP/c640q6xk-00000042", "XIVO_FEATURE_FORWARD_LNAME=unc") in new stack
[May 29 10:57:04] -- Executing [unc@feature_forward:2] Set("SIP/c640q6xk-00000042", "XIVO_FEATURE_FORWARD_UNAME=UNC") in new stack
[May 29 10:57:04] -- Executing [unc@feature_forward:3] Goto("SIP/c640q6xk-00000042", "feature,1") in new stack
[May 29 10:57:04] -- Goto (feature_forward,feature,1)
[May 29 10:57:04] -- Executing [feature@feature_forward:1] Gosub("SIP/c640q6xk-00000042", "xivo-pickup,0,1") in new stack
[May 29 10:57:04] -- Executing [0@xivo-pickup:1] Goto("SIP/c640q6xk-00000042", "s,1") in new stack
[May 29 10:57:04] -- Goto (xivo-pickup,s,1)
[May 29 10:57:04] -- Executing [s@xivo-pickup:1] Set("SIP/c640q6xk-00000042", "WAITSEC=1") in new stack
[May 29 10:57:04] -- Executing [s@xivo-pickup:2] Goto("SIP/c640q6xk-00000042", "pickup,1") in new stack
[May 29 10:57:04] -- Goto (xivo-pickup,pickup,1)
[May 29 10:57:04] -- Executing [pickup@xivo-pickup:1] GotoIf("SIP/c640q6xk-00000042", "?return") in new stack
[May 29 10:57:04] -- Executing [pickup@xivo-pickup:2] Answer("SIP/c640q6xk-00000042", "") in new stack
[May 29 10:57:05] -- Executing [pickup@xivo-pickup:3] Wait("SIP/c640q6xk-00000042", "1") in new stack
[May 29 10:57:05] > 0xb39dcb90 -- Probation passed - setting RTP source address to 192.168.2.105:63632
[May 29 10:57:06] -- Executing [pickup@xivo-pickup:4] Set("SIP/c640q6xk-00000042", "XIVO_PICKEDUP=1") in new stack
[May 29 10:57:06] -- Executing [pickup@xivo-pickup:5] Return("SIP/c640q6xk-00000042", "") in new stack
[May 29 10:57:06] -- Executing [feature@feature_forward:2] AGI("SIP/c640q6xk-00000042", "agi://127.0.0.1/phone_get_features") in new stack
[May 29 10:57:06] agi://127.0.0.1/phone_get_features: AGI handler 'phone_get_features' successfully executed
[May 29 10:57:06] -- AGI Script agi://127.0.0.1/phone_get_features completed, returning 0
[May 29 10:57:06] -- Executing [feature@feature_forward:3] Set("SIP/c640q6xk-00000042", "ENABLED=0") in new stack
[May 29 10:57:06] -- Executing [feature@feature_forward:4] GosubIf("SIP/c640q6xk-00000042", "0?readdigits,1") in new stack
[May 29 10:57:06] -- Executing [feature@feature_forward:5] Set("SIP/c640q6xk-00000042", "TOGGLE=1") in new stack
[May 29 10:57:06] -- Executing [feature@feature_forward:6] AGI("SIP/c640q6xk-00000042", "agi://127.0.0.1/phone_set_feature,unc,1,0631494429") in new stack
[May 29 10:57:06] agi://127.0.0.1/phone_set_feature,unc,1,0631494429: AGI handler 'phone_set_feature' successfully executed
[May 29 10:57:06] -- AGI Script agi://127.0.0.1/phone_set_feature completed, returning 0
[May 29 10:57:06] -- Executing [feature@feature_forward:7] GotoIf("SIP/c640q6xk-00000042", "?enabled,1:disabled,1") in new stack
[May 29 10:57:06] -- Goto (feature_forward,disabled,1)
[May 29 10:57:06] -- Executing [disabled@feature_forward:1] Playback("SIP/c640q6xk-00000042", "forward-off") in new stack
[May 29 10:57:06] -- Playing 'forward-off.slin' (language 'fr_FR')
[May 29 10:57:08] -- Executing [disabled@feature_forward:2] Hangup("SIP/c640q6xk-00000042", "") in new stack
[May 29 10:57:08] == Spawn extension (feature_forward, disabled, 2) exited non-zero on 'SIP/c640q6xk-00000042'
[May 29 10:57:08] -- SIP/c640q6xk-00000042 Internal Gosub(hangup_handlers,userevent,1) start
[May 29 10:57:08] -- Executing [userevent@hangup_handlers:1] NoOp("SIP/c640q6xk-00000042", "Sending Hangup userevent") in new stack
[May 29 10:57:08] -- Executing [userevent@hangup_handlers:2] UserEvent("SIP/c640q6xk-00000042", "Hangup,XIVO_USERUUID: c494fe8d-59e6-49ef-a34a-2b2e2df9f883")

la différence avec un xivo qui marche :

Xivo qui marche :
[May 29 11:06:11] -- Executing [feature@feature_forward:7] GotoIf("SIP/lq4rfitq-00000005", "1?enabled,1:disabled,1") in new stack
[May 29 11:06:11] -- Goto (feature_forward,enabled,1)
[May 29 11:06:11] -- Executing [enabled@feature_forward:1] Playback("SIP/lq4rfitq-00000005", "forward-on") in new stack
[May 29 11:06:11] -- Playing 'forward-on.slin' (language 'fr_FR')

Le Xivo qui ne marche pas :
[May 29 11:03:25] -- Executing [feature@feature_forward:7] GotoIf("SIP/c640q6xk-00000047", "?enabled,1:disabled,1") in new stack
[May 29 11:03:25] -- Goto (feature_forward,disabled,1)
[May 29 11:03:25] -- Executing [disabled@feature_forward:1] Playback("SIP/c640q6xk-00000047", "forward-off") in new stack
[May 29 11:03:25] -- Playing 'forward-off.slin' (language 'fr_FR')

Il désactive le renvoi alors que je lui demande de l'activer.

Sinon j'ai trouvé une piste mais cela date : https://projects.wazo.community/issues/6192

J'ai le service consul et xivo-ctid qui ne démarre pas.

Quand je le lance via :
systemctl start consul

Le log de journalctl -xn :
-- Logs begin at lun. 2017-05-29 12:44:35 CEST, end at lun. 2017-05-29 15:48:20 CEST. --
mai 29 15:47:27 xivo consul[28600]: serf: EventMemberJoin: xivo.unassigned 127.0.0.1
mai 29 15:47:27 xivo consul[28600]: ==> Error starting agent: failed decoding service file "/var/lib/consul/services/df3862e1b64d047be42cf289ebe168a9
mai 29 15:47:27 xivo systemd[1]: consul.service: main process exited, code=exited, status=1/FAILURE
mai 29 15:47:58 xivo systemd[1]: consul.service: control process exited, code=exited status=1
mai 29 15:47:58 xivo systemd[1]: Failed to start Consul agent.
-- Subject: L'unité (unit) consul.service a échoué
-- Defined-By: systemd

-- Support: http://lists.freedesktop.org/mailman/listinfo/systemd-devel¶

-- L'unité (unit) consul.service a échoué, avec le résultat failed.
mai 29 15:47:58 xivo systemd[1]: Unit consul.service entered failed state.
mai 29 15:48:01 xivo CRON[28771]: pam_unix(cron:session): session opened for user root by (uid=0)
mai 29 15:48:01 xivo CRON[28772]: (root) CMD (/root/check-trunk.sh > /dev/null)
mai 29 15:48:01 xivo CRON[28771]: pam_unix(cron:session): session closed for user root
mai 29 15:48:20 xivo sshd[28794]: Received disconnect from 221.194.44.212: 11: [preauth]

Cela serait il mon problème?

yop,

ha ben ça peut poser quelques soucis ...

tu peux vérifier les log ?
/var/log/xivo-.log
/var/log/pf-.log
/var/log/syslog
/var/log/daemon.log

et aussi voir un peu en détails:

ari show status
ari show users
http show status
ps -ef | grep nginx
netstat -tanpu | grep LISTEN

y'a bien un truc dans tout ça qui montrera pourquoi consul et ctid ne veulent pas tourner.

Bizarre pour une installation fraiche ... tu as modifié des fichiers de conf à la main ??

++

Dans les logs xivo j'ai très souvent cela :

RegistererError: ('Connection aborted.', error(111, 'Connection refused'))
2017-05-29 06:25:10,320 1724 (service_discovery): registration failed, retrying in 2 seconds
2017-05-29 06:25:10,453 1724 (xivo-auth): (127.0.0.1) HEAD https://localhost:9497/0.1/token/?scope=agentd.agents.read 404
2017-05-29 06:25:10,466 1724 (xivo-auth): (127.0.0.1) HEAD https://localhost:9497/0.1/token/?scope=dird.directories.lookup.foobar.headers.read 404
2017-05-29 06:25:12,354 1724 (xivo-auth): (127.0.0.1) GET https://localhost:9497/0.1/backends 200
2017-05-29 06:25:12,356 1724 (service_discovery): Registering xivo-auth on Consul as 7cefbd22-5694-4789-b12a-c6bc2319e9d0 with 192.168.2.99:9497
2017-05-29 06:25:12,357 1724 (service_discovery): failed to register service
Traceback (most recent call last):
File "/usr/lib/python2.7/dist-packages/xivo/consul_helpers.py", line 121, in _register
self._registerer.register()
File "/usr/lib/python2.7/dist-packages/xivo/consul_helpers.py", line 226, in register
super(NotifyingRegisterer, self).register()
File "/usr/lib/python2.7/dist-packages/xivo/consul_helpers.py", line 170, in register
raise RegistererError(str(e))
RegistererError: ('Connection aborted.', error(111, 'Connection refused'))

Je n'ai pas de log pf-.log

dans le syslog j'ai en rapport avec consul :

May 29 16:05:48 xivo systemd[1]: Starting Consul agent...
May 29 16:05:48 xivo consul[32392]: ==> WARNING: BootstrapExpect Mode is specified as 1; this is the same as Bootstrap mode.
May 29 16:05:48 xivo consul[32392]: ==> WARNING: Bootstrap mode enabled! Do not enable unless necessary
May 29 16:05:48 xivo consul[32392]: consul: shutting down server
May 29 16:05:48 xivo consul[32392]: ==> Starting Consul agent...
May 29 16:05:48 xivo consul[32392]: ==> Error starting agent: Failed to start Consul server: Failed to start RPC layer: RPC advertise address is not advertisable: 0.0.0.0:8300
May 29 16:05:48 xivo systemd[1]: consul.service: main process exited, code=exited, status=1/FAILURE
May 29 16:06:01 xivo CRON[32465]: (root) CMD (/root/check-trunk.sh > /dev/null)
May 29 16:06:19 xivo systemd[1]: consul.service: control process exited, code=exited status=1
May 29 16:06:19 xivo systemd[1]: Failed to start Consul agent.
May 29 16:06:19 xivo systemd[1]: Unit consul.service entered failed state.
May 29 16:06:24 xivo dhcpd: DHCPDISCOVER from 00:1d:72:a8:53:4b via eth0: network 192.168.2.0/24: no free leases
May 29 16:06:28 xivo dhcpd: DHCPDISCOVER from 00:1d:72:a8:53:4b via eth0: network 192.168.2.0/24: no free leases
May 29 16:06:37 xivo dhcpd: DHCPDISCOVER from 00:1d:72:a8:53:4b via eth0: network 192.168.2.0/24: no free leases
May 29 16:06:54 xivo dhcpd: DHCPDISCOVER from 00:1d:72:a8:53:4b via eth0: network 192.168.2.0/24: no free leases
May 29 16:07:01 xivo CRON[32568]: (root) CMD (/root/check-trunk.sh > /dev/null)
May 29 16:07:30 xivo systemd[1]: Starting Consul agent...
May 29 16:07:30 xivo consul[32593]: ==> WARNING: BootstrapExpect Mode is specified as 1; this is the same as Bootstrap mode.
May 29 16:07:30 xivo consul[32593]: ==> WARNING: Bootstrap mode enabled! Do not enable unless necessary
May 29 16:07:30 xivo consul[32593]: ==> Starting Consul agent...
May 29 16:07:30 xivo consul[32593]: raft: Initial configuration (index=1): [{Suffrage:Voter ID:127.0.0.1:8300 Address:127.0.0.1:8300}]
May 29 16:07:30 xivo consul[32593]: serf: EventMemberJoin: xivo 127.0.0.1
May 29 16:07:30 xivo consul[32593]: serf: EventMemberJoin: xivo.unassigned 127.0.0.1
May 29 16:07:30 xivo consul[32593]: ==> Error starting agent: failed decoding service file "/var/lib/consul/services/df3862e1b64d047be42cf289ebe168a9": unexpected end of JSON input
May 29 16:07:30 xivo systemd[1]: consul.service: main process exited, code=exited, status=1/FAILURE
May 29 16:08:00 xivo systemd[1]: consul.service: control process exited, code=exited status=1
May 29 16:08:00 xivo systemd[1]: Failed to start Consul agent.
May 29 16:08:00 xivo systemd[1]: Unit consul.service entered failed state.
May 29 16:08:01 xivo CRON[32741]: (root) CMD (/root/check-trunk.sh > /dev/null)
May 29 16:08:45 xivo consul[302]: raft: Initial configuration (index=1): [{Suffrage:Voter ID:127.0.0.1:8300 Address:127.0.0.1:8300}]
May 29 16:08:45 xivo consul[302]: raft: Node at 127.0.0.1:8300 [Follower] entering Follower state (Leader: "")
May 29 16:08:45 xivo consul[302]: serf: EventMemberJoin: xivo 127.0.0.1
May 29 16:08:45 xivo consul[302]: serf: EventMemberJoin: xivo.unassigned 127.0.0.1

je n'ai pas deamon.log

ari show status :

ARI Status:
Enabled: Yes
Output format: compact
Auth realm: Asterisk REST Interface
Allowed Origins: *
User count: 1

ari show users

r/o? Username

---

No xivo

http show status

/httpstatus => Asterisk HTTP General Status
/amanager => HTML Manager Event Interface w/Digest authentication
/arawman => Raw HTTP Manager Event Interface w/Digest authentication
/manager => HTML Manager Event Interface
/rawman => Raw HTTP Manager Event Interface
/static/... => Asterisk HTTP Static Delivery
/amxml => XML Manager Event Interface w/Digest authentication
/mxml => XML Manager Event Interface
/ari/... => Asterisk RESTful API
/ws => Asterisk HTTP WebSocket

Enabled Redirects:
None.

ps -ef | grep nginx

root 620 1 0 12:44 ? 00:00:00 nginx: master process /usr/sbin/nginx -g daemon on; master_process on;
www-data 622 620 0 12:44 ? 00:00:04 nginx: worker process
www-data 623 620 0 12:44 ? 00:00:01 nginx: worker process
www-data 624 620 0 12:44 ? 00:00:02 nginx: worker process
www-data 625 620 0 12:44 ? 00:00:00 nginx: worker process
root 7038 2246 0 17:04 pts/1 00:00:00 grep nginx

netstat -tanpu | grep LISTEN

tcp 0 0 0.0.0.0:2000 0.0.0.0:* LISTEN 25669/asterisk
tcp 0 0 127.0.0.1:5040 0.0.0.0:* LISTEN 25669/asterisk
tcp 0 0 0.0.0.0:80 0.0.0.0:* LISTEN 620/nginx -g daemon
tcp 0 0 0.0.0.0:9489 0.0.0.0:* LISTEN 26138/python
tcp 0 0 0.0.0.0:4369 0.0.0.0:* LISTEN 644/epmd
tcp 0 0 0.0.0.0:9491 0.0.0.0:* LISTEN 25876/python
tcp 0 0 0.0.0.0:9493 0.0.0.0:* LISTEN 25920/python
tcp 0 0 127.0.0.1:4949 0.0.0.0:* LISTEN 686/perl
tcp 0 0 0.0.0.0:22 0.0.0.0:* LISTEN 520/sshd
tcp 0 0 127.0.0.1:5432 0.0.0.0:* LISTEN 685/postgres
tcp 0 0 0.0.0.0:9497 0.0.0.0:* LISTEN 25608/python
tcp 0 0 0.0.0.0:25 0.0.0.0:* LISTEN 1067/master
tcp 0 0 0.0.0.0:9498 0.0.0.0:* LISTEN 26167/python
tcp 0 0 127.0.0.1:8666 0.0.0.0:* LISTEN 25647/python
tcp 0 0 0.0.0.0:9499 0.0.0.0:* LISTEN 26167/python
tcp 0 0 0.0.0.0:8667 0.0.0.0:* LISTEN 25647/python
tcp 0 0 0.0.0.0:443 0.0.0.0:* LISTEN 620/nginx -g daemon
tcp 0 0 127.0.0.1:2812 0.0.0.0:* LISTEN 26274/monit
tcp 0 0 0.0.0.0:9500 0.0.0.0:* LISTEN 26212/python
tcp 0 0 127.0.0.1:8668 0.0.0.0:* LISTEN 25371/python
tcp 0 0 127.0.0.1:4573 0.0.0.0:* LISTEN 25659/python
tcp 0 0 127.0.0.1:8669 0.0.0.0:* LISTEN 25393/confgend
tcp 0 0 0.0.0.0:9502 0.0.0.0:* LISTEN 26245/python3
tcp 0 0 0.0.0.0:5672 0.0.0.0:* LISTEN 748/beam
tcp 0 0 0.0.0.0:25672 0.0.0.0:* LISTEN 748/beam
tcp 0 0 127.0.0.1:9000 0.0.0.0:* LISTEN 589/php5-cgi
tcp 0 0 0.0.0.0:5038 0.0.0.0:* LISTEN 25669/asterisk
tcp 0 0 0.0.0.0:9486 0.0.0.0:* LISTEN 25410/python
tcp 0 0 127.0.0.1:5039 0.0.0.0:* LISTEN 25669/asterisk
tcp 0 0 127.0.0.1:9487 0.0.0.0:* LISTEN 25410/python
tcp6 0 0 :::22 :::* LISTEN 520/sshd

yop,

il vaut mieux attendre l'avis d'une personne plus avisé,
mais je tilt là dessus:
May 29 16:07:30 xivo consul[32593]: raft: Initial configuration (index=1): [{Suffrage:Voter ID:127.0.0.1:8300 Address:127.0.0.1:8300}]

or, tu n'as rien sur le port 8300,
et je pense qu'il faut que ça tape sur asterisk, donc le port 5038 (un membre du staff pour répondre ??)

dans http show status, tu devrais avoir également ces lignes en réponse de la commande:
HTTP Server Status:
Prefix: /asterisk
Server: XiVO PBX
Server Enabled and Bound to 0.0.0.0:5039

HTTPS Server Enabled and Bound to 0.0.0.0:5040

c'est bien le cas ?

Que donne:
systemctl status xivo-ctid-ng.service
et
journalctl -xn
??

perso, à part le fait d'écouter un port inactif, je ne vois pas d'autres raison de la panne.

mais vu que je ne suis pas sûr, je te conseil d'attendre d'autres avis pour le debug et sa résolution.

++

Bon j'ai trouvé, le prob viens de là :
May 29 16:07:30 xivo consul[32593]: ==> Error starting agent: failed decoding service file "/var/lib/consul/services/df3862e1b64d047be42cf289ebe168a9": unexpected end of JSON input

J'ai suivi une manip d'un bug pour xivo 15 et 16 : https://projects.wazo.community/issues/6110

J'ai eu des erreurs lors de l'exécutions des lignes de commande, j'ai fais un petit xivi-update-config à la fin.
J'ai eu des erreurs surtout de dossier introuvable.

Tout a l'air de fonctionner et surtout les *XX.

Merci de ton aide Julien ;)

ha ben de rien.

c'est toi qui as pointé sur la bonne erreur.

content de lire que c'est reparti correctement !

++