Skip to content

Clixon_cli fails to find YANG spec of XML node (config) of the connected device #244

@v1shnya

Description

@v1shnya

I'm testing the latest Clixon 7.7.0 and Clixon-controller 1.7.0 releases.
Clixon-controller is running in a docker container.
After controller starts I connect to the device.

controller> show connections
Name                    State      Time                   Logmsg
====================================================================
test-dev                OPEN       2026-02-28T09:14:17

Immediately after neither tab command expansion after config mount-point works, nor the command below. This issue is floating and somehow (I didn't catch it ) the correct controller behaviour is restored. Usually issue pops up after a controller restart.

controller> show devices test-dev yang
Netconf error: Get configuration: application operation-failed Failed to find YANG spec of XML node: contexts with parent: config in namespace: http://finance/yang/fw. Internal error, backend returned invalid XML. <bad-element>contexts</bad-element>

Please see the logs from the clixon_cli process collected after the above command is triggered. It's an Event+Msg+Detail log-level.

Feb 28 09:27:11.111671: clixon_rpc11:709:
Feb 28 09:27:11.111746: clixon_msg_send:374: Send [/usr/local/var/run/controller/controller.sock]
#365
<rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="sysadmin" xmlns:cl="http://clicon.org/lib" message-id="42"><config-path-info xmlns="http://clicon.org/lib"><api-path>/clixon-controller:devices/device/name</api-path><strict>false</strict><leafref-refer>true</leafref-refer></config-path-info></rpc>
##
Feb 28 09:27:11.112529: clixon_msg_rcv11:656: Recv [/usr/local/var/run/controller/controller.sock]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><xml xmlns="http://clicon.org/lib"><devices xmlns="http://clicon.org/controller"><device><name></name></device></devices></xml><api-path xmlns="http://clicon.org/lib">/clixon-controller:devices/device/name</api-path><xpath xmlns="http://clicon.org/lib" xmlns:ctrl="http://clicon.org/controller">/ctrl:devices/ctrl:device/ctrl:name</xpath><namespace-context xmlns="http://clicon.org/lib"><namespace><prefix>ctrl</prefix><ns>http://clicon.org/controller</ns></namespace></namespace-context><symbol xmlns="http://clicon.org/lib">name</symbol><prefix xmlns="http://clicon.org/lib">ctrl</prefix><ns xmlns="http://clicon.org/lib">http://clicon.org/controller</ns><module xmlns="http://clicon.org/lib">clixon-controller</module><filename xmlns="http://clicon.org/lib">/usr/local/share/controller/main/clixon-controller@2025-12-01.yang</filename></rpc-reply>
Feb 28 09:27:11.112549: clixon_msg_rcv11:674: clixon_msg_rcv11 done
Feb 28 09:27:11.112554: clixon_rpc11:716: retval:0
Feb 28 09:27:11.112756: clixon_rpc11:709:
Feb 28 09:27:11.112764: clixon_msg_send:374: Send [/usr/local/var/run/controller/controller.sock]
#352
<rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="sysadmin" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><running/></source><nc:filter nc:type="xpath" nc:select="/ctrl:devices/ctrl:device/ctrl:name" xmlns:ctrl="http://clicon.org/controller"/></get-config></rpc>
##
Feb 28 09:27:11.113279: clixon_msg_rcv11:656: Recv [/usr/local/var/run/controller/controller.sock]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data><devices xmlns="http://clicon.org/controller"><device><name>test-dev</name></device><device><name>fw-133.10</name></device></devices></data></rpc-reply>
Feb 28 09:27:11.113318: clixon_msg_rcv11:674: clixon_msg_rcv11 done
Feb 28 09:27:11.113323: clixon_rpc11:716: retval:0
Feb 28 09:27:11.113624: clixon_rpc11:709:
Feb 28 09:27:11.113636: clixon_msg_send:374: Send [/usr/local/var/run/controller/controller.sock]
#534
<rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="sysadmin" xmlns:cl="http://clicon.org/lib" message-id="50"><get cl:content="all" xmlns:cl="http://clicon.org/lib"><nc:filter nc:type="xpath" nc:select="/devices/device[name=&apos;test-dev&apos;]/config" xmlns="http://clicon.org/controller" xmlns:yanglib="urn:ietf:params:xml:ns:yang:ietf-yang-library"/><with-defaults xmlns="urn:ietf:params:xml:ns:yang:ietf-netconf-with-defaults">explicit</with-defaults></get></rpc>
##
Feb 28 09:27:11.117941: clixon_msg_rcv11:656: Recv [/usr/local/var/run/controller/controller.sock]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data><devices xmlns="http://clicon.org/controller"><device><name>test-dev</name><config><contexts xmlns="http://finance/yang/fw"><context><name>test</name><interface><ethernet><name>eth0</name><layer3><config><enabled>true</enabled><ipv4><addresses><addr
Feb 28 09:27:11.117979: clixon_msg_rcv11:674: clixon_msg_rcv11 done
Feb 28 09:27:11.117986: clixon_rpc11:716: retval:0
Feb 28 09:27:11.119232: show_yang_revisions: 2428: Netconf error: Get configuration: application operation-failed Failed to find YANG spec of XML node: contexts with parent: config in namespace: http://finance/yang/fw. Internal error, backend returned invalid XML. <bad-element>contexts</bad-element>

Corresponding logs from the clixon_backend process

controller  | Feb 28 09:27:11.111838: event_handle_fds:504: fd local netconf client socket
controller  | Feb 28 09:27:11.111943: clixon_msg_rcv11:656: Recv [t:cli s:1]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="sysadmin" xmlns:cl="http://clicon.org/lib" message-id="42"><config-path-info xmlns="http://clicon.org/lib"><api-path>/clixon-controller:devices/device/name</api-path><strict>false</strict><leafref-refer>true</leafref-refer></config-path-info></rpc>
controller  | Feb 28 09:27:11.111946: clixon_msg_rcv11:674: clixon_msg_rcv11 done
controller  | Feb 28 09:27:11.112427: clixon_msg_send:374: Send [t:cli s:1 r:config-path-info m:42]
controller  | #909
controller  | <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><xml xmlns="http://clicon.org/lib"><devices xmlns="http://clicon.org/controller"><device><name></name></device></devices></xml><api-path xmlns="http://clicon.org/lib">/clixon-controller:devices/device/name</api-path><xpath xmlns="http://clicon.org/lib" xmlns:ctrl="http://clicon.org/controller">/ctrl:devices/ctrl:device/ctrl:name</xpath><namespace-context xmlns="http://clicon.org/lib"><namespace><prefix>ctrl</prefix><ns>http://clicon.org/controller</ns></namespace></namespace-context><symbol xmlns="http://clicon.org/lib">name</symbol><prefix xmlns="http://clicon.org/lib">ctrl</prefix><ns xmlns="http://clicon.org/lib">http://clicon.org/controller</ns><module xmlns="http://clicon.org/lib">clixon-controller</module><filename xmlns="http://clicon.org/lib">/usr/local/share/controller/main/clixon-controller@2025-12-01.yang</filename></rpc-reply>
controller  | ##
controller  | Feb 28 09:27:11.112443: event_handle_fds:499: check s:7 prio:0 fd Netconf ssh 172.17.133.10
controller  | Feb 28 09:27:11.112445: event_handle_fds:499: check s:6 prio:0 fd Netconf ssh 172.17.100.4
controller  | Feb 28 09:27:11.112447: event_handle_fds:499: check s:3 prio:0 fd server socket
controller  | Feb 28 09:27:11.112449: clixon_event_loop:573: register prio
controller  | Feb 28 09:27:11.112451: clixon_event_loop:580: register fd prio local netconf client socket nr:0
controller  | Feb 28 09:27:11.112452: clixon_event_loop:580: register fd prio local netconf client socket nr:1
controller  | Feb 28 09:27:11.112454: clixon_event_loop:585: register unprio
controller  | Feb 28 09:27:11.112456: clixon_event_loop:592: register fd Netconf ssh 172.17.133.10 nr:2
controller  | Feb 28 09:27:11.112457: clixon_event_loop:592: register fd Netconf ssh 172.17.100.4 nr:3
controller  | Feb 28 09:27:11.112459: clixon_event_loop:592: register fd server socket nr:4
controller  | Feb 28 09:27:11.112460: clixon_event_loop:602: timeout
controller  | Feb 28 09:27:11.112462: clixon_event_loop:612: poll timeout: 1972
controller  | Feb 28 09:27:11.112785: event_handle_fds:499: check s:5 prio:1 fd local netconf client socket
controller  | Feb 28 09:27:11.112787: event_handle_fds:499: check s:4 prio:1 fd local netconf client socket
controller  | Feb 28 09:27:11.112789: event_handle_fds:504: fd local netconf client socket
controller  | Feb 28 09:27:11.112820: clixon_msg_rcv11:656: Recv [t:cli s:1]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="sysadmin" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><running/></source><nc:filter nc:type="xpath" nc:select="/ctrl:devices/ctrl:device/ctrl:name" xmlns:ctrl="http://clicon.org/controller"/></get-config></rpc>
controller  | Feb 28 09:27:11.112821: clixon_msg_rcv11:674: clixon_msg_rcv11 done
controller  | Feb 28 09:27:11.113219: clixon_msg_send:374: Send [t:cli s:1 r:get-config m:42]
controller  | #217
controller  | <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data><devices xmlns="http://clicon.org/controller"><device><name>test-dev</name></device><device><name>fw-133.10</name></device></devices></data></rpc-reply>
controller  | ##
controller  | Feb 28 09:27:11.113232: event_handle_fds:499: check s:7 prio:0 fd Netconf ssh 172.17.133.10
controller  | Feb 28 09:27:11.113233: event_handle_fds:499: check s:6 prio:0 fd Netconf ssh 172.17.100.4
controller  | Feb 28 09:27:11.113235: event_handle_fds:499: check s:3 prio:0 fd server socket
controller  | Feb 28 09:27:11.113236: clixon_event_loop:573: register prio
controller  | Feb 28 09:27:11.113238: clixon_event_loop:580: register fd prio local netconf client socket nr:0
controller  | Feb 28 09:27:11.113239: clixon_event_loop:580: register fd prio local netconf client socket nr:1
controller  | Feb 28 09:27:11.113240: clixon_event_loop:585: register unprio
controller  | Feb 28 09:27:11.113242: clixon_event_loop:592: register fd Netconf ssh 172.17.133.10 nr:2
controller  | Feb 28 09:27:11.113243: clixon_event_loop:592: register fd Netconf ssh 172.17.100.4 nr:3
controller  | Feb 28 09:27:11.113244: clixon_event_loop:592: register fd server socket nr:4
controller  | Feb 28 09:27:11.113245: clixon_event_loop:602: timeout
controller  | Feb 28 09:27:11.113247: clixon_event_loop:612: poll timeout: 1972
controller  | Feb 28 09:27:11.113661: event_handle_fds:499: check s:5 prio:1 fd local netconf client socket
controller  | Feb 28 09:27:11.113663: event_handle_fds:499: check s:4 prio:1 fd local netconf client socket
controller  | Feb 28 09:27:11.113665: event_handle_fds:504: fd local netconf client socket
controller  | Feb 28 09:27:11.113723: clixon_msg_rcv11:656: Recv [t:cli s:1]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="sysadmin" xmlns:cl="http://clicon.org/lib" message-id="50"><get cl:content="all" xmlns:cl="http://clicon.org/lib"><nc:filter nc:type="xpath" nc:select="/devices/device[name=&apos;test-dev&apos;]/config" xmlns="http://clicon.org/controller" xmlns:yanglib="urn:ietf:params:xml:ns:yang:ietf-yang-library"/><with-defaults xmlns="urn:ietf:params:xml:ns:yang:ietf-netconf-with-defaults">explicit</with-defaults></get></rpc>
controller  | Feb 28 09:27:11.113725: clixon_msg_rcv11:674: clixon_msg_rcv11 done
controller  | Feb 28 09:27:11.116957: clixon_msg_send:374: Send [t:cli s:1 r:get m:50]
controller  | #13551
controller  | <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data><devices xmlns="http://clicon.org/controller"><device><name>test-dev</name><config><contexts xmlns="http://finance/yang/fw"><context><name>test</name><interface><ethernet><name>eth0</name><layer3><config><enabled>true</enabled><ipv4><addresses><add

Metadata

Metadata

Assignees

No one assigned

    Labels

    No labels
    No labels

    Type

    Projects

    No projects

    Milestone

    No milestone

    Relationships

    None yet

    Development

    No branches or pull requests

    Issue actions