[Xivo Skaro] Connexion Cisco 7937G

[crazypaf]

Bonjour à tous,

Je tente de connecter une araignée(pieuvre) Cisco 7937G à notre serveur Asterisk qui fonctionne avec Xivo Skaro 13.11.

Pendant un an, nous avons utilisé la version Gallifrey de Xivo et la connexion de la Cisco 7937 fonctionnait correctement. A présent depuis Skaro ca ne fonctionne plus. J'ai bien compris que depuis cette dernière version le module sccp avait changé.

Concrètement le modèle est bien reconnu par asterisk, mais il ne cesse de se déconnecter. Voici un exemple de CLI :

NOTICE[21248]: sccp.c:2912 thread_accept: A new device has connected from: 10.10.50.200
NOTICE[22681]: sccp.c:519 register_device: Device found [SEP0004F2ED331E]
ERROR[22681]: sccp.c:2849 thread_session: Disconnecting device [SEP0004F2ED331E]

En exécutant la commande sccp show devices le prériphérique apparaît correctement :

Device IP Type Reg.state Proto.Version
=============== =============== ====== ========== ==============
SEP0004F2ED331E 10.10.50.200 7937 Registered 20
Total: 1 device(s), 1 registered

L'araignée est à jour avec le dernier firmware 1.4.4.
Lors des tentatives d'enregistrement, elle se met à clignoter et au bout d'un moment elle redémarre.

Lorsque je tente de recharger la config sccp avec la commande "sccp update config"
voici le message qui m'intrigue aussi :

NOTICE[1733]: main.c:1060 config_load: Configuring sccp from sccp.conf...
== Parsing '/etc/asterisk/sccp.conf': Found
== Parsing '/var/tmp/exec.1371822834125379.-1699275920': Found
WARNING[1733]: main.c:908 parse_config_lines: Line [101] already exist, line ignored

Je ne demande pas forcément la solution, mais aurez-vous des pistes à me donner pour essayer de faire fonctionner cette pieuvre ??

Merci par avance de vos réponses.

Cordialement,

[quintana]

Bonjour,

C'est sûrement parce qu'elle n'est pas supporté dans notre channel. Il va falloir patcher le channel pour la supporter. Nous n'en avons pas dans notre lab malheureusement.

++

[hexanol]

Salut,

qu'est-ce que tu vois dans la console asterisk si tu actives le niveau de log debug (en éditant le fichier /etc/asterisk/logger.conf puis en faisant un "logger reload") puis que tu connectes ta pieuvre ?

Parce que en regardant ton log, on voit que ta pieuvre semble se connecter correctement, puis elle se fait jeter tout de suite après, ce qui est un peu suspect.

[crazypaf]

Bonjour,

Merci de me donner un coup de main.
J'ai suivi ton conseil et j'ai activé le mode debug voici le résultat :

[Jun 26 09:31:55] NOTICE[19193]: sccp.c:2912 thread_accept: A new device has connected from: 10.10.50.200
[Jun 26 09:31:55] DEBUG[28413]: sccp.c:2711 handle_message: Alarm message: 25: Name=SEP0004F2ED331E Load=1.4(4) Last=Initialize
[Jun 26 09:31:55] DEBUG[28413]: sccp.c:2621 handle_message: Register message
[Jun 26 09:31:55] DEBUG[28413]: sccp.c:2277 handle_register_message: name SEP0004F2ED331E
[Jun 26 09:31:55] DEBUG[28413]: sccp.c:2278 handle_register_message: userId 0
[Jun 26 09:31:55] DEBUG[28413]: sccp.c:2279 handle_register_message: lineInstance 1
[Jun 26 09:31:55] DEBUG[28413]: sccp.c:2280 handle_register_message: maxStream 1
[Jun 26 09:31:55] DEBUG[28413]: sccp.c:2281 handle_register_message: activeStreams 1
[Jun 26 09:31:55] DEBUG[28413]: sccp.c:2282 handle_register_message: protoVersion 20
[Jun 26 09:31:55] NOTICE[28413]: sccp.c:519 register_device: Device found [SEP0004F2ED331E]
[Jun 26 09:31:55] DEBUG[28413]: sccp.c:211 mwi_subscribe: no voicemail set
[Jun 26 09:31:55] DEBUG[28413]: sccp.c:2701 handle_message: Button template request message
[Jun 26 09:31:55] DEBUG[28413]: device.c:385 device_get_button_template: Device type 431
[Jun 26 09:31:55] DEBUG[28413]: sccp.c:2671 handle_message: Capabilities message
[Jun 26 09:31:55] DEBUG[28413]: sccp.c:2021 handle_capabilities_res_message: Received 7 capabilities
[Jun 26 09:31:55] DEBUG[28413]: sccp.c:2041 handle_capabilities_res_message: device cap: (ulaw|alaw|g729)
[Jun 26 09:31:55] DEBUG[28413]: sccp.c:2706 handle_message: Softkey template request message
[Jun 26 09:31:55] DEBUG[28413]: sccp.c:2725 handle_message: Softkey set request message
[Jun 26 09:31:55] DEBUG[28413]: sccp.c:2696 handle_message: Time date message
[Jun 26 09:31:55] DEBUG[28413]: sccp.c:2686 handle_message: Line status message
[Jun 26 09:31:55] DEBUG[28413]: sccp.c:2666 handle_message: Forward status message
[Jun 26 09:31:56] DEBUG[28413]: sccp.c:2681 handle_message: Feature status message
[Jun 26 09:31:56] DEBUG[28413]: sccp.c:2185 handle_feature_status_req_message: No speeddial [19] on device [SEP0004F2ED331E]
[Jun 26 09:31:56] ERROR[28413]: sccp.c:2849 thread_session: Disconnecting device [SEP0004F2ED331E]

Quand je recharge la config sccp (sccp update config) tjrs une erreur :

[Jun 26 09:34:52] NOTICE[28654]: main.c:1060 config_load: Configuring sccp from sccp.conf...
[Jun 26 09:34:52] == Parsing '/etc/asterisk/sccp.conf': Found
[Jun 26 09:34:53] == Parsing '/var/tmp/exec.1372232092995283.-1661424784': Found
[Jun 26 09:34:53] WARNING[28654]: main.c:908 parse_config_lines: Line [129] already exist, line ignored
[Jun 26 09:34:53] WARNING[28654]: main.c:775 parse_config_devices: Can't attach invalid line [] to device [SEP]
[Jun 26 09:34:53] DEBUG[28654]: main.c:729 parse_config_devices: Device [SEP0004F2ED331E] already exist, instance ignored

Par ailleurs, je confirme que c'est un problème avec le module car j'ai essayé d'installer une version 4.1.0 du module sccp et ça fonctionne pour l'enregistrement.
Malheureusement l'installation du module rend Asterisk instable.

Merci par avance.

[quintana]

Envoies nous une trace pcap (tcpdump) de ton enregistrement. C'est peut être pas grand chose à rajouter pour le supporter. Mais pas de garanti car on a bcp de choses en cours en ce moment.

[crazypaf]

Merci de vous pencher sur notre problème, j'ai bien conscience que vous n'avez pas que nous

Voici les résultats du tcpdump. 1 en mode verbose et l'autre normal. Ils sont compressé car sinon je ne pouvais pas attacher les fichiers car ils sont volumineux.

capture_tcpdump.zip

Merci par avance

[hexanol]

Salut,

en fait, ta pieuvre envoie un message que le chan aime plus ou moins ("handle_feature_status_req_message: No speeddial [19] on device [SEP0004F2ED331E]"), et alors il rejette/déconnecte la pieuvre.

La solution... à part refaire un nouveau .deb xivo-libsccp avec la fonction handle_feature_status_req_message modifiée... ca serait p-e de créer plein de touche de fonctions "Customized" (i.e. au moins 19) à ton utilisateur, pour que le chan ne rentre pas dans le cas "No speeddial on device".

Aussi, lorsque tu veux reloader la conf du chan, t'es mieux avec un "module reload chan_sccp.so" que d'un "sccp update config", car la derniere fait surtout juste ajouter les nouveaux devices, pas modifier les déjà existants. Par contre, avec un "module reload chan_sccp.so", toutes tes communications SCCP vont être coupées.

[crazypaf]

Bonjour,

Merci à nouveau pour votre aide.
Effectivement, le problème de registering est résolu en ajoutant des touches en custom.

Néanmoins, j'ai un dernier souci. Lorsque l'on effectue un appel tout fonctionne correctement, mais lorsque l'on souhaite raccrocher l'appel. L'appel est bien interrompu par contre la pieuvre continue à émettre une tonalité qui correspond au décrochage du téléphone. (je sais pas si c'est très clair ).

Voici les logs du CLI Asterisk d'un décrocher/raccrocher :

[Jul 3 11:07:30] DEBUG[29348]: sccp.c:2715 handle_message: Softkey event message
[Jul 3 11:07:30] DEBUG[29348]: sccp.c:1697 handle_softkey_event_message: softKeyEvent: 2
[Jul 3 11:07:30] DEBUG[29348]: sccp.c:1698 handle_softkey_event_message: instance: 1
[Jul 3 11:07:30] DEBUG[29348]: sccp.c:1699 handle_softkey_event_message: callid: 0
[Jul 3 11:07:30] DEBUG[29348]: sccp.c:947 do_newcall: line_instance(1) subchan_id(0)
[Jul 3 11:07:31] DEBUG[29348]: sccp.c:2715 handle_message: Softkey event message
[Jul 3 11:07:31] DEBUG[29348]: sccp.c:1697 handle_softkey_event_message: softKeyEvent: 9
[Jul 3 11:07:31] DEBUG[29348]: sccp.c:1698 handle_softkey_event_message: instance: 1
[Jul 3 11:07:31] DEBUG[29348]: sccp.c:1699 handle_softkey_event_message: callid: 1
[Jul 3 11:07:31] DEBUG[29348]: sccp.c:1217 do_hangup: line_instance(1) subchan_id(1)

Et voici les logs CLI de l'enregistrement de la pieuvre :

[Jul 3 11:07:10] NOTICE[29273]: sccp.c:2912 thread_accept: A new device has connected from: 10.10.50.200
[Jul 3 11:07:10] DEBUG[29348]: sccp.c:2711 handle_message: Alarm message: 25: Name=SEP0004F2ED331E Load=1.4(4) Last=Initialize
[Jul 3 11:07:10] DEBUG[29348]: sccp.c:2621 handle_message: Register message
[Jul 3 11:07:10] DEBUG[29348]: sccp.c:2277 handle_register_message: name SEP0004F2ED331E
[Jul 3 11:07:10] DEBUG[29348]: sccp.c:2278 handle_register_message: userId 0
[Jul 3 11:07:10] DEBUG[29348]: sccp.c:2279 handle_register_message: lineInstance 1
[Jul 3 11:07:10] DEBUG[29348]: sccp.c:2280 handle_register_message: maxStream 1
[Jul 3 11:07:10] DEBUG[29348]: sccp.c:2281 handle_register_message: activeStreams 1
[Jul 3 11:07:10] DEBUG[29348]: sccp.c:2282 handle_register_message: protoVersion 20
[Jul 3 11:07:10] NOTICE[29348]: sccp.c:519 register_device: Device found [SEP0004F2ED331E]
[Jul 3 11:07:10] DEBUG[29348]: sccp.c:211 mwi_subscribe: no voicemail set
[Jul 3 11:07:10] DEBUG[29348]: sccp.c:2701 handle_message: Button template request message
[Jul 3 11:07:10] DEBUG[29348]: device.c:385 device_get_button_template: Device type 431
[Jul 3 11:07:10] DEBUG[29348]: sccp.c:2671 handle_message: Capabilities message
[Jul 3 11:07:10] DEBUG[29348]: sccp.c:2021 handle_capabilities_res_message: Received 7 capabilities
[Jul 3 11:07:10] DEBUG[29348]: sccp.c:2041 handle_capabilities_res_message: device cap: (ulaw|alaw|g729)
[Jul 3 11:07:10] DEBUG[29348]: sccp.c:2706 handle_message: Softkey template request message
[Jul 3 11:07:10] DEBUG[29348]: sccp.c:2725 handle_message: Softkey set request message
[Jul 3 11:07:11] DEBUG[29348]: sccp.c:2696 handle_message: Time date message
[Jul 3 11:07:11] DEBUG[29348]: sccp.c:2686 handle_message: Line status message
[Jul 3 11:07:11] DEBUG[29348]: sccp.c:2666 handle_message: Forward status message
[Jul 3 11:07:11] DEBUG[29348]: sccp.c:2681 handle_message: Feature status message
[Jul 3 11:07:11] DEBUG[29348]: sccp.c:2676 handle_message: Speeddial status message
[Jul 3 11:07:11] DEBUG[29348]: sccp.c:2676 handle_message: Speeddial status message
[Jul 3 11:07:11] DEBUG[29348]: sccp.c:2676 handle_message: Speeddial status message
[Jul 3 11:07:11] DEBUG[29348]: sccp.c:2676 handle_message: Speeddial status message
[Jul 3 11:07:11] DEBUG[29348]: sccp.c:2676 handle_message: Speeddial status message
[Jul 3 11:07:11] DEBUG[29348]: sccp.c:2676 handle_message: Speeddial status message
[Jul 3 11:07:12] DEBUG[29348]: sccp.c:2676 handle_message: Speeddial status message
[Jul 3 11:07:12] DEBUG[29348]: sccp.c:2676 handle_message: Speeddial status message
[Jul 3 11:07:12] DEBUG[29348]: sccp.c:2676 handle_message: Speeddial status message
[Jul 3 11:07:12] DEBUG[29348]: sccp.c:2676 handle_message: Speeddial status message
[Jul 3 11:07:12] DEBUG[29348]: sccp.c:2730 handle_message: Register available lines message

Je ne sais pas si vous pouvez m'aider sur ce point ??

Cordialement,

[hexanol]

Malheureusement non.

Bref, tu peux soit:

* attendre que ce modèle soit supporté officiellement par le chan-sccp de xivo (ce qui peut prendre du temps en fonction des priorités)
* faire les modifications toi même sur le chan (voir http://documentation.xivo.fr/product...l#installation), et par la suite, soumettre ton patch sur le issue tracker de xivo (https://projects.xivo.fr/projects/xivo) ou directement via un merge-request sur gitorious.