search

clicon / clixon-controller

Clixon network controller
Apache License 2.0
14 stars 5 forks source link

Backend exited after XML error #49

Closed krihal closed 11 months ago

krihal commented 11 months ago

PyAPI returned an transaction-error which the backend failed to parse and exited. We must figure out if the backend is misbehaving or the PyAPI and whether it's a good idea to exit on XML errors or not.

Oct 19 06:23:36: rpc_controller_commit
Oct 19 06:23:36: controller_transaction_new
Oct 19 06:23:36: candidate: locked by 1677721
Oct 19 06:23:36: xmldb_copy candidate actions
Oct 19 06:23:36: controller_commit_actions stream_notify: services-commit: 1
Oct 19 06:23:36: ce_event_cb op:0
Oct 19 06:23:36: Send: <notification xmlns="urn:ietf:params:xml:ns:netconf:notification:1.0"><eventTime>2023-10-19T06:23:36.448464Z</eventTime><services-commit xmlns="http://clicon.org/controller"><tid>1</tid><source>actions</source><target>actions</target><service>bgp-peer[service-name='test']</service></services-commit></notification>
Oct 19 06:23:36: ce_event_cb op:0
Oct 19 06:23:36: Send: <notification xmlns="urn:ietf:params:xml:ns:netconf:notification:1.0"><eventTime>2023-10-19T06:23:36.448464Z</eventTime><services-commit xmlns="http://clicon.org/controller"><tid>1</tid><source>actions</source><target>actions</target><service>bgp-peer[service-name='test']</service></services-commit></notification>
Oct 19 06:23:36: controller_transaction_state_set 1 : INIT -> ACTIONS
Oct 19 06:23:36: actions_timeout_register
Oct 19 06:23:36: actions_timeout_register timeout:60 s
Oct 19 06:23:36: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><tid xmlns="http://clicon.org/controller">1</tid></rpc-reply>
Oct 19 06:23:36: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" message-id="42"><close-session/></rpc>
Oct 19 06:23:36: from_client_msg module:ietf-netconf rpc:close-session ce_id:3 s:7
Oct 19 06:23:36: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:36: backend_client_rm
Oct 19 06:23:36: Recv [4]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" username="actions" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><actions xmlns="http://clicon.org/controller"/></source><nc:filter nc:type="xpath" nc:select="/"/></get-config></rpc>
Oct 19 06:23:36: from_client_msg Warning: incoming session-id:42 does not match ce_id:4 on socket: 7
Oct 19 06:23:36: from_client_msg module:ietf-netconf rpc:get-config ce_id:4 s:7
Oct 19 06:23:36: Send [4]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data><services xmlns="http://clicon.org/controller"><properties><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><exchange-points><name>test</name><routing-instance>test</routing-instance><router><name>juniper1</name></router><router><name>juniper2</name></router><aliases>foo</aliases><import-rules>rule-in</import-rules></exchange-points><teardown-limit-threshold>20</teardown-limit-threshold><teardown-idle-timeout>10</teardown-idle-timeout><irr-database>rr.ntt.org</irr-database><as-filter-delta-limit>40</as-filter-delta-limit></bgp-peer></properties><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><service-name>test</service-name><as-number>1111</as-number><irr-sources>rr.ntt.org</irr-sources><import-rules>rule-import</import-rules><export-rules>rule-export</export-rules><description>Foo</description><as-macro4>4444</as-macro4><md5-sum>asdasasdasdasdasdasd</md5-sum><prefix-limit>10</prefix-limit><exchange-points><exchange-point>test</exchange-point><as-number>1111</as-number><import-rules>test-in</import-rules><export-rules>test-out</export-rules><peering><ip>1.1.1.1</ip><md5-sum>asd</md5-sum><as-number>33333</as-number><import-rules>asd</import-rules><export-rules>export-out</export-rules></peering></exchange-points></bgp-peer></services></data></rpc-reply>
Oct 19 06:23:36: Recv [1]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" username="root" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><transaction-actions-done xmlns="http://clicon.org/controller"><tid>1</tid><service>bgp-peer</service></transaction-actions-done></rpc>
Oct 19 06:23:36: from_client_msg Warning: incoming session-id:42 does not match ce_id:1 on socket: 5
Oct 19 06:23:36: from_client_msg module:clixon-controller rpc:transaction-actions-done ce_id:1 s:5
Oct 19 06:23:36: rpc_transactions_actions_done
Oct 19 06:23:36: controller_transaction_state_set 1 : ACTIONS -> INIT
Oct 19 06:23:36: controller_transaction_state_set 1 : INIT -> DONE result: SUCCESS
Oct 19 06:23:36: controller_transaction_notify 1
Oct 19 06:23:36: ce_event_cb op:0
Oct 19 06:23:36: Send: <notification xmlns="urn:ietf:params:xml:ns:netconf:notification:1.0"><eventTime>2023-10-19T06:23:36.451242Z</eventTime><controller-transaction xmlns="http://clicon.org/controller"><tid>1</tid><result>SUCCESS</result></controller-transaction></notification>
Oct 19 06:23:36: ce_event_cb op:0
Oct 19 06:23:36: Send: <notification xmlns="urn:ietf:params:xml:ns:netconf:notification:1.0"><eventTime>2023-10-19T06:23:36.451242Z</eventTime><controller-transaction xmlns="http://clicon.org/controller"><tid>1</tid><result>SUCCESS</result></controller-transaction></notification>
Oct 19 06:23:36: Send [1]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:36: backend_client_rm
Oct 19 06:23:36: Recv [2]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" username="root" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><transaction-error xmlns="http://clicon.org/controller"><tid>1</tid><origin>pyapi</origin><reason>No BGP configuration found for juniper1</reason></transaction-error></rpc>
Oct 19 06:23:36: from_client_msg Warning: incoming session-id:42 does not match ce_id:2 on socket: 6
Oct 19 06:23:36: from_client_msg module:clixon-controller rpc:transaction-error ce_id:2 s:6
Oct 19 06:23:36: rpc_transaction_error
Oct 19 06:23:36: controller_transaction_failed
Oct 19 06:23:36: controller_transaction_failed: 552: XML error: Sanity: may not be in resolved OK state
Oct 19 06:23:36: controller_transaction_failed retval:0
clixon_backend: controller_transaction.c:142: controller_transaction_state_set: Assertion `state != ct->ct_state' failed.
Aborted
debian@khn-dev:~$
krihal commented 11 months ago

Full debug:

debian@khn-dev:~$ sudo clixon_backend -f /usr/local/etc/controller.xml -D3 -F
Oct 19 06:23:31: CLICON_CONFIGFILE=/usr/local/etc/controller.xml
Oct 19 06:23:31: yang_parse_filename /usr/local/share/clixon/clixon-controller-config@2023-01-01.yang
Oct 19 06:23:31: yang_parse_filename /usr/local/share/clixon/clixon-config@2023-05-01.yang
Oct 19 06:23:31: yang_parse_filename /usr/local/share/clixon/clixon-restconf@2022-08-01.yang
Oct 19 06:23:31: yang_parse_filename /usr/local/share/clixon/ietf-inet-types@2021-02-22.yang
Oct 19 06:23:31: yang_parse_filename /usr/local/share/clixon/clixon-autocli@2023-09-01.yang
Oct 19 06:23:31: yang_parse_filename /usr/local/share/clixon/clixon-lib@2023-05-01.yang
Oct 19 06:23:31: yang_parse_filename /usr/local/share/clixon/ietf-yang-types@2013-07-15.yang
Oct 19 06:23:31: yang_parse_filename /usr/local/share/clixon/ietf-netconf-monitoring@2010-10-04.yang
Oct 19 06:23:31: yang_parse_filename /usr/local/share/clixon/ietf-yang-metadata@2016-08-05.yang
Oct 19 06:23:31: ys_populate_feature clixon-restconf:allow-auth-none
Oct 19 06:23:31: clixon_pseudo_plugin pseudo yang metadata
Oct 19 06:23:31: Loading plugin '/usr/local/lib/controller/backend/controller_backend.so'
Oct 19 06:23:31: plugin_load_one file:/usr/local/lib/controller/backend/controller_backend.so function:clixon_plugin_init
Oct 19 06:23:31: rpc_callback_register config-pull
Oct 19 06:23:31: rpc_callback_register controller-commit
Oct 19 06:23:31: rpc_callback_register connection-change
Oct 19 06:23:31: rpc_callback_register get-device-config
Oct 19 06:23:31: rpc_callback_register transaction-error
Oct 19 06:23:31: rpc_callback_register transaction-actions-done
Oct 19 06:23:31: rpc_callback_register datastore-diff
Oct 19 06:23:31: rpc_callback_register create-subscription
Oct 19 06:23:31: action_daemon_register
Oct 19 06:23:31: clixon_process_register Action process ----> stopped
Oct 19 06:23:31: plugin_load_one retval:1
Oct 19 06:23:31: yang_parse_filename /usr/local/share/clixon/controller/as-path-filter@2023-08-07.yang
Oct 19 06:23:31: yang_parse_filename /usr/local/share/clixon/controller/as-path@2023-10-12.yang
Oct 19 06:23:31: yang_parse_filename /usr/local/share/clixon/controller/bgp-common.yang
Oct 19 06:23:31: yang_parse_filename /usr/local/share/clixon/controller/bgp-customer.yang
Oct 19 06:23:31: yang_parse_filename /usr/local/share/clixon/controller/bgp-peer-properties@2023-10-12.yang
Oct 19 06:23:31: yang_parse_filename /usr/local/share/clixon/controller/bgp-peer.yang
Oct 19 06:23:31: yang_parse_filename /usr/local/share/clixon/controller/bgp.yang
Oct 19 06:23:31: yang_parse_filename /usr/local/share/clixon/controller/clixon-controller@2023-11-01.yang
Oct 19 06:23:31: yang_parse_filename /usr/local/share/clixon/controller/hostname@2023-05-22.yang
Oct 19 06:23:31: yang_parse_filename /usr/local/share/clixon/controller/ibgp@2023-10-03.yang
Oct 19 06:23:31: yang_parse_filename /usr/local/share/clixon/controller/prefix-filter@2023-08-03.yang
Oct 19 06:23:31: yang_parse_filename /usr/local/share/clixon/controller/ssh-users.yang
Oct 19 06:23:31: yang_parse_filename /usr/local/share/clixon/controller/test@2023-03-22.yang
Oct 19 06:23:31: yang_parse_filename /usr/local/share/clixon/ietf-inet-types@2021-02-22.yang
Oct 19 06:23:31: yang_parse_filename /usr/local/share/clixon/ietf-yang-types@2013-07-15.yang
Oct 19 06:23:31: yang_parse_filename /usr/local/share/clixon/ietf-netconf@2011-06-01.yang
Oct 19 06:23:31: yang_parse_filename /usr/local/share/clixon/ietf-yang-schema-mount@2019-01-14.yang
Oct 19 06:23:31: yang_parse_filename /usr/local/share/clixon/ietf-datastores@2018-02-14.yang
Oct 19 06:23:31: yang_parse_filename /usr/local/share/clixon/clixon-lib@2023-05-01.yang
Oct 19 06:23:31: yang_parse_filename /usr/local/share/clixon/ietf-netconf-monitoring@2010-10-04.yang
Oct 19 06:23:31: yang_parse_filename /usr/local/share/clixon/ietf-yang-metadata@2016-08-05.yang
Oct 19 06:23:31: ys_populate_feature ietf-netconf:candidate
Oct 19 06:23:31: ys_populate_feature ietf-netconf:validate
Oct 19 06:23:31: ys_populate_feature ietf-netconf:startup
Oct 19 06:23:31: ys_populate_feature ietf-netconf:xpath
Oct 19 06:23:31: ietf_yang_metadata_extension_cb Enabled extension:ietf-yang-metadata:annotation:creator
Oct 19 06:23:31: yang_parse_filename /usr/local/share/clixon/ietf-yang-library@2019-01-04.yang
Oct 19 06:23:31: yang_parse_filename /usr/local/share/clixon/clixon-rfc5277@2008-07-01.yang
Oct 19 06:23:31: yang_parse_filename /usr/local/share/clixon/ietf-list-pagination@2022-07-24.yang
Oct 19 06:23:31: ietf_yang_metadata_extension_cb Enabled extension:ietf-yang-metadata:annotation:remaining
Oct 19 06:23:31: yang_parse_filename /usr/local/share/clixon/ietf-list-pagination-nc@2022-07-24.yang
Oct 19 06:23:31: yang_parse_filename /usr/local/share/clixon/ietf-netconf-nmda@2019-01-07.yang
Oct 19 06:23:31: yang_parse_filename /usr/local/share/clixon/ietf-origin@2018-02-14.yang
Oct 19 06:23:31: yang_parse_filename /usr/local/share/clixon/ietf-netconf-with-defaults@2011-06-01.yang
Oct 19 06:23:31: ietf_yang_metadata_extension_cb Enabled extension:ietf-yang-metadata:annotation:origin
Oct 19 06:23:31: yang_parse_filename /usr/local/share/clixon/ietf-restconf@2017-01-26.yang
Oct 19 06:23:31: rpc_callback_register get-config
Oct 19 06:23:31: rpc_callback_register edit-config
Oct 19 06:23:31: rpc_callback_register copy-config
Oct 19 06:23:31: rpc_callback_register delete-config
Oct 19 06:23:31: rpc_callback_register lock
Oct 19 06:23:31: rpc_callback_register unlock
Oct 19 06:23:31: rpc_callback_register get
Oct 19 06:23:31: rpc_callback_register close-session
Oct 19 06:23:31: rpc_callback_register kill-session
Oct 19 06:23:31: rpc_callback_register action
Oct 19 06:23:31: rpc_callback_register commit
Oct 19 06:23:31: rpc_callback_register discard-changes
Oct 19 06:23:31: rpc_callback_register cancel-commit
Oct 19 06:23:31: rpc_callback_register validate
Oct 19 06:23:31: rpc_callback_register create-subscription
Oct 19 06:23:31: rpc_callback_register get-schema
Oct 19 06:23:31: rpc_callback_register debug
Oct 19 06:23:31: rpc_callback_register ping
Oct 19 06:23:31: rpc_callback_register stats
Oct 19 06:23:31: rpc_callback_register restart-plugin
Oct 19 06:23:31: rpc_callback_register process-control
Oct 19 06:23:31: Reading datastore /usr/local/var/controller/running_db using xml
Oct 19 06:23:31: clixon_process_operation name:Action process op:start
Oct 19 06:23:31: clixon_process_operation scheduling name: Action process pid:0 op: start
Oct 19 06:23:31: clixon_process_operation retval:0
Oct 19 06:23:31: Reading datastore /usr/local/var/controller/tmp_db using xml
Oct 19 06:23:31: clixon_process_operation name:Action process op:start
Oct 19 06:23:31: clixon_process_operation scheduling name: Action process pid:0 op: start
Oct 19 06:23:31: clixon_process_operation retval:0
Oct 19 06:23:31: Reading datastore /usr/local/var/controller/tmp_db using xml
Oct 19 06:23:31: xmldb_copy running candidate
Oct 19 06:23:31: CLICON_PLUGIN_DLOPEN_GLOBAL =   "false"
Oct 19 06:23:31: CLICON_RESTCONF_HTTP2_PLAIN =   "false"
Oct 19 06:23:31: CLICON_CLI_HELPSTRING_LINES =   "1"
Oct 19 06:23:31: CLICON_PLUGIN_CALLBACK_CHECK =  "0"
Oct 19 06:23:31: CLICON_CLI_DIR =    "/usr/local/lib/controller/cli"
Oct 19 06:23:31: CLICON_YANG_UNKNOWN_ANYDATA =   "false"
Oct 19 06:23:31: CLICON_CLI_MODE =   "operation"
Oct 19 06:23:31: CLICON_CLI_UTF8 =   "0"
Oct 19 06:23:31: CLICON_XMLDB_UPGRADE_CHECKOLD =     "true"
Oct 19 06:23:31: CONTROLLER_PYAPI_MODULE_PATH =  "/usr/local/share/clixon/controller/modules/"
Oct 19 06:23:31: CLICON_NACM_DISABLED_ON_EMPTY =     "false"
Oct 19 06:23:31: CLICON_NETCONF_HELLO_OPTIONAL =     "false"
Oct 19 06:23:31: CLICON_NACM_MODE =  "disabled"
Oct 19 06:23:31: CLICON_XMLDB_DIR =  "/usr/local/var/controller"
Oct 19 06:23:31: CLICON_NETCONF_BASE_CAPABILITY =    "1"
Oct 19 06:23:31: CLICON_SOCK_PORT =  "4535"
Oct 19 06:23:31: CLICON_CONFIGFILE =     "/usr/local/etc/controller.xml"
Oct 19 06:23:31: CLICON_STREAM_DISCOVERY_RFC8040 =   "false"
Oct 19 06:23:31: CLICON_STREAM_DISCOVERY_RFC5277 =   "true"
Oct 19 06:23:31: CLICON_CLI_HELPSTRING_TRUNCATE =    "true"
Oct 19 06:23:31: CLICON_AUTOCOMMIT =     "0"
Oct 19 06:23:31: CLICON_SOCK_GROUP =     "clicon"
Oct 19 06:23:31: CLICON_STREAM_URL =     "https://localhost"
Oct 19 06:23:31: CLICON_BACKEND_RESTCONF_PROCESS =   "false"
Oct 19 06:23:31: CLICON_BACKEND_DIR =    "/usr/local/lib/controller/backend"
Oct 19 06:23:31: CLICON_CLISPEC_DIR =    "/usr/local/lib/controller/clispec"
Oct 19 06:23:31: CLICON_SOCK_FAMILY =    "UNIX"
Oct 19 06:23:31: CLICON_NAMESPACE_NETCONF_DEFAULT =  "false"
Oct 19 06:23:31: CLICON_STREAM_PATH =    "streams"
Oct 19 06:23:31: CLICON_YANG_REGEXP =    "posix"
Oct 19 06:23:31: CLICON_CLI_VARONLY =    "1"
Oct 19 06:23:31: CLICON_BACKEND_USER =   "clicon"
Oct 19 06:23:31: CLICON_CLI_TAB_MODE =   "0"
Oct 19 06:23:31: CLICON_XMLDB_FORMAT =   "xml"
Oct 19 06:23:31: CLICON_YANG_LIBRARY =   "true"
Oct 19 06:23:31: CLICON_STARTUP_MODE =   "init"
Oct 19 06:23:31: CLICON_XMLDB_PRETTY =   "true"
Oct 19 06:23:31: CLICON_YANG_AUGMENT_ACCEPT_BROKEN =     "false"
Oct 19 06:23:31: CLICON_XML_CHANGELOG =  "false"
Oct 19 06:23:31: CLICON_CONFIG_EXTEND =  "clixon-controller-config"
Oct 19 06:23:31: CLICON_CLI_HIST_FILE =  "~/.clixon_cli_history"
Oct 19 06:23:31: CLICON_YANG_MAIN_DIR =  "/usr/local/share/clixon/controller"
Oct 19 06:23:31: CLICON_MODULE_SET_ID =  "0"
Oct 19 06:23:31: CLICON_CLI_BUF_START =  "256"
Oct 19 06:23:31: CLICON_RESTCONF_USER =  "www-data"
Oct 19 06:23:31: CLICON_CLI_HIST_SIZE =  "300"
Oct 19 06:23:31: CLICON_BACKEND_REGEXP =     "(.so)$"
Oct 19 06:23:31: CLICON_NETCONF_MESSAGE_ID_OPTIONAL =    "false"
Oct 19 06:23:31: CLICON_XMLDB_MODSTATE =     "false"
Oct 19 06:23:31: CLICON_BACKEND_PIDFILE =    "/usr/local/var/controller.pidfile"
Oct 19 06:23:31: CLICON_RESTCONF_STARTUP_DONTUPDATE =    "false"
Oct 19 06:23:31: CLICON_DATASTORE_CACHE =    "cache"
Oct 19 06:23:31: CLICON_ANONYMOUS_USER =     "anonymous"
Oct 19 06:23:31: CLICON_SNMP_AGENT_SOCK =    "unix:/tmp/clixon_snmp.sock"
Oct 19 06:23:31: CLICON_NACM_CREDENTIALS =   "except"
Oct 19 06:23:31: CLICON_STREAM_RETENTION =   "3600"
Oct 19 06:23:31: CLICON_LOG_STRING_LIMIT =   "0"
Oct 19 06:23:31: CLICON_CLI_LINESCROLLING =  "1"
Oct 19 06:23:31: CLICON_CLI_LINES_DEFAULT =  "24"
Oct 19 06:23:31: CLICON_CLI_BUF_THRESHOLD =  "65536"
Oct 19 06:23:31: CONTROLLER_PYAPI_PIDFILE =  "/tmp/clixon_server.pid"
Oct 19 06:23:31: CLICON_YANG_SCHEMA_MOUNT =  "true"
Oct 19 06:23:31: CLICON_SOCK =   "/usr/local/var/controller.sock"
Oct 19 06:23:31: CLICON_RESTCONF_API_ROOT =  "/restconf"
Oct 19 06:23:31: CLICON_BACKEND_PRIVILEGES =     "none"
Oct 19 06:23:31: CLICON_CLI_EXPAND_LEAFREF =     "false"
Oct 19 06:23:31: CONTROLLER_ACTION_COMMAND =     "/usr/local/bin/clixon_server.py -f /usr/local/etc/controller.xml -F"
Oct 19 06:23:31: CLICON_NETCONF_MONITORING =     "true"
Oct 19 06:23:31: CLICON_VALIDATE_STATE_XML =     "true"
Oct 19 06:23:31: CLICON_RESTCONF_INSTALLDIR =    "/usr/local/sbin"
Oct 19 06:23:31: CLICON_RESTCONF_PRIVILEGES =    "drop_perm"
Oct 19 06:23:31: CLICON_YANG_DIR =   "/usr/local/share/clixon"
Oct 19 06:23:31: CLICON_FEATURE =    "clixon-restconf:allow-auth-none"
Oct 19 06:23:31: CLICON_FEATURE =    "ietf-netconf:candidate"
Oct 19 06:23:31: CLICON_FEATURE =    "ietf-netconf:startup"
Oct 19 06:23:31: CLICON_FEATURE =    "ietf-netconf:validate"
Oct 19 06:23:31: CLICON_FEATURE =    "ietf-netconf:xpath"
Oct 19 06:23:31: Opened pidfile /usr/local/var/controller.pidfile with pid 133373
Oct 19 06:23:31: Listen on server socket at /usr/local/var/controller.sock
Oct 19 06:23:31: clixon_backend: 133373 Started
Oct 19 06:23:31: clixon_process_sched
Oct 19 06:23:31: clixon_process_sched name: Action process pid:0 stopped --op:start-->
Oct 19 06:23:31: clixon_proc_background
Oct 19 06:23:31: clixon_proc_background argv[0]:/usr/local/bin/clixon_server.py
Oct 19 06:23:31: clixon_proc_background argv[1]:-f
Oct 19 06:23:31: clixon_proc_background argv[2]:/usr/local/etc/controller.xml
Oct 19 06:23:31: clixon_proc_background argv[3]:-F
Oct 19 06:23:31: clixon_proc_background retval:0 child:133394
Oct 19 06:23:31: clixon_process_sched Action process(133394) stopped --start--> running
Oct 19 06:23:31: clixon_process_sched retval:0
Oct 19 06:23:31: clixon_process_sched
Oct 19 06:23:31: clixon_process_sched name: Action process pid:133394 running --op:none-->
Oct 19 06:23:31: clixon_process_sched retval:0
Oct 19 06:23:31: clixon_proc_background child
Oct 19 06:23:31: Recv [1]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><create-subscription xmlns="urn:ietf:params:xml:ns:netmod:notification"><stream>services-commit</stream><filter type="xpath" select=""/></create-subscription></rpc>
Oct 19 06:23:31: from_client_msg Warning: incoming session-id:42 does not match ce_id:1 on socket: 5
Oct 19 06:23:31: from_client_msg module:clixon-rfc5277 rpc:create-subscription ce_id:1 s:5
Oct 19 06:23:31: check_services_commit_subscription
Oct 19 06:23:31: stream_ss_add
Oct 19 06:23:31: Send [1]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:31: Recv [1]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><create-subscription xmlns="urn:ietf:params:xml:ns:netmod:notification"><stream>controller-transaction</stream><filter type="xpath" select=""/></create-subscription></rpc>
Oct 19 06:23:31: from_client_msg Warning: incoming session-id:42 does not match ce_id:1 on socket: 5
Oct 19 06:23:31: from_client_msg module:clixon-rfc5277 rpc:create-subscription ce_id:1 s:5
Oct 19 06:23:31: check_services_commit_subscription
Oct 19 06:23:31: stream_ss_add
Oct 19 06:23:31: Send [1]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:33: Recv [2]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><create-subscription xmlns="urn:ietf:params:xml:ns:netmod:notification"><stream>services-commit</stream><filter type="xpath" select=""/></create-subscription></rpc>
Oct 19 06:23:33: from_client_msg Warning: incoming session-id:42 does not match ce_id:2 on socket: 6
Oct 19 06:23:33: from_client_msg module:clixon-rfc5277 rpc:create-subscription ce_id:2 s:6
Oct 19 06:23:33: check_services_commit_subscription
check_services_commit_subscription 0
Oct 19 06:23:33: stream_ss_add
Oct 19 06:23:33: Send [2]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><rpc-error><error-type>application</error-type><error-tag>operation-failed</error-tag><error-severity>error</error-severity><error-message>services-commit client already registered</error-message></rpc-error></rpc-reply><rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:33: Recv [2]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><create-subscription xmlns="urn:ietf:params:xml:ns:netmod:notification"><stream>controller-transaction</stream><filter type="xpath" select=""/></create-subscription></rpc>
Oct 19 06:23:33: from_client_msg Warning: incoming session-id:42 does not match ce_id:2 on socket: 6
Oct 19 06:23:33: from_client_msg module:clixon-rfc5277 rpc:create-subscription ce_id:2 s:6
Oct 19 06:23:33: check_services_commit_subscription
Oct 19 06:23:33: stream_ss_add
Oct 19 06:23:33: Send [2]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Recv [3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/ctrl:properties/bgp:bgp-peer/bgp:irr-database" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg Warning: incoming session-id:2 does not match ce_id:3 on socket: 7
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data/></rpc-reply>
Oct 19 06:23:34: Recv [3]: <hello xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" cl:transport="cl:cli" xmlns:cl="http://clicon.org/lib"><capabilities><capability>urn:ietf:params:netconf:base:1.1</capability></capabilities></hello>
Oct 19 06:23:34: Send [cli3]: <hello xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><session-id>3</session-id></hello>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" message-id="42"><edit-config><target><candidate/></target><default-operation>none</default-operation><config><services xmlns="http://clicon.org/controller"><properties><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><irr-database nc:operation="merge">rr.ntt.org</irr-database></bgp-peer></properties></services></config></edit-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:edit-config ce_id:3 s:7
Oct 19 06:23:34: from_client_edit_config done cbret:<rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/ctrl:properties/bgp:bgp-peer/bgp:teardown-idle-timeout" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" message-id="42"><edit-config><target><candidate/></target><default-operation>none</default-operation><config><services xmlns="http://clicon.org/controller"><properties><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><teardown-idle-timeout nc:operation="merge">10</teardown-idle-timeout></bgp-peer></properties></services></config></edit-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:edit-config ce_id:3 s:7
Oct 19 06:23:34: from_client_edit_config done cbret:<rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/ctrl:properties/bgp:bgp-peer/bgp:teardown-limit-threshold" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" message-id="42"><edit-config><target><candidate/></target><default-operation>none</default-operation><config><services xmlns="http://clicon.org/controller"><properties><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><teardown-limit-threshold nc:operation="merge">20</teardown-limit-threshold></bgp-peer></properties></services></config></edit-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:edit-config ce_id:3 s:7
Oct 19 06:23:34: from_client_edit_config done cbret:<rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/ctrl:properties/bgp:bgp-peer/bgp:as-filter-delta-limit" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" message-id="42"><edit-config><target><candidate/></target><default-operation>none</default-operation><config><services xmlns="http://clicon.org/controller"><properties><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><as-filter-delta-limit nc:operation="merge">40</as-filter-delta-limit></bgp-peer></properties></services></config></edit-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:edit-config ce_id:3 s:7
Oct 19 06:23:34: from_client_edit_config done cbret:<rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/ctrl:properties/bgp:bgp-peer/bgp:exchange-points/bgp:name" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/ctrl:properties/bgp:bgp-peer/bgp:exchange-points[bgp:name='test']/bgp:aliases" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" message-id="42"><edit-config><target><candidate/></target><default-operation>none</default-operation><config><services xmlns="http://clicon.org/controller"><properties><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><exchange-points><name>test</name><aliases nc:operation="merge">foo</aliases></exchange-points></bgp-peer></properties></services></config></edit-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:edit-config ce_id:3 s:7
Oct 19 06:23:34: from_client_edit_config done cbret:<rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/ctrl:properties/bgp:bgp-peer/bgp:exchange-points/bgp:name" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data><services xmlns="http://clicon.org/controller"><properties><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><exchange-points><name>test</name></exchange-points></bgp-peer></properties></services></data></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/ctrl:properties/bgp:bgp-peer/bgp:exchange-points[bgp:name='test']/bgp:import-rules" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" message-id="42"><edit-config><target><candidate/></target><default-operation>none</default-operation><config><services xmlns="http://clicon.org/controller"><properties><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><exchange-points><name>test</name><import-rules nc:operation="merge">rule-in</import-rules></exchange-points></bgp-peer></properties></services></config></edit-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:edit-config ce_id:3 s:7
Oct 19 06:23:34: from_client_edit_config done cbret:<rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/ctrl:properties/bgp:bgp-peer/bgp:exchange-points/bgp:name" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data><services xmlns="http://clicon.org/controller"><properties><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><exchange-points><name>test</name></exchange-points></bgp-peer></properties></services></data></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/ctrl:properties/bgp:bgp-peer/bgp:exchange-points[bgp:name='test']/bgp:routing-instance" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" message-id="42"><edit-config><target><candidate/></target><default-operation>none</default-operation><config><services xmlns="http://clicon.org/controller"><properties><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><exchange-points><name>test</name><routing-instance nc:operation="merge">test</routing-instance></exchange-points></bgp-peer></properties></services></config></edit-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:edit-config ce_id:3 s:7
Oct 19 06:23:34: from_client_edit_config done cbret:<rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/ctrl:properties/bgp:bgp-peer/bgp:exchange-points/bgp:name" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data><services xmlns="http://clicon.org/controller"><properties><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><exchange-points><name>test</name></exchange-points></bgp-peer></properties></services></data></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/ctrl:properties/bgp:bgp-peer/bgp:exchange-points[bgp:name='test']/bgp:router/bgp:name" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" message-id="42"><edit-config><target><candidate/></target><default-operation>none</default-operation><config><services xmlns="http://clicon.org/controller"><properties><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><exchange-points><name>test</name><router nc:operation="merge"><name>juniper1</name></router></exchange-points></bgp-peer></properties></services></config></edit-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:edit-config ce_id:3 s:7
Oct 19 06:23:34: from_client_edit_config done cbret:<rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/ctrl:properties/bgp:bgp-peer/bgp:exchange-points/bgp:name" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data><services xmlns="http://clicon.org/controller"><properties><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><exchange-points><name>test</name></exchange-points></bgp-peer></properties></services></data></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/ctrl:properties/bgp:bgp-peer/bgp:exchange-points[bgp:name='test']/bgp:router/bgp:name" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data><services xmlns="http://clicon.org/controller"><properties><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><exchange-points><name>test</name><router><name>juniper1</name></router></exchange-points></bgp-peer></properties></services></data></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" message-id="42"><edit-config><target><candidate/></target><default-operation>none</default-operation><config><services xmlns="http://clicon.org/controller"><properties><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><exchange-points><name>test</name><router nc:operation="merge"><name>juniper2</name></router></exchange-points></bgp-peer></properties></services></config></edit-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:edit-config ce_id:3 s:7
Oct 19 06:23:34: from_client_edit_config done cbret:<rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/bgp:bgp-peer/bgp:service-name" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/bgp:bgp-peer[bgp:service-name='test']/bgp:as-macro4" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" message-id="42"><edit-config><target><candidate/></target><default-operation>none</default-operation><config><services xmlns="http://clicon.org/controller"><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><service-name>test</service-name><as-macro4 nc:operation="merge">4444</as-macro4></bgp-peer></services></config></edit-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:edit-config ce_id:3 s:7
Oct 19 06:23:34: from_client_edit_config done cbret:<rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/bgp:bgp-peer/bgp:service-name" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data><services xmlns="http://clicon.org/controller"><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><service-name>test</service-name></bgp-peer></services></data></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/bgp:bgp-peer[bgp:service-name='test']/bgp:as-number" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" message-id="42"><edit-config><target><candidate/></target><default-operation>none</default-operation><config><services xmlns="http://clicon.org/controller"><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><service-name>test</service-name><as-number nc:operation="merge">1111</as-number></bgp-peer></services></config></edit-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:edit-config ce_id:3 s:7
Oct 19 06:23:34: from_client_edit_config done cbret:<rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/bgp:bgp-peer/bgp:service-name" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data><services xmlns="http://clicon.org/controller"><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><service-name>test</service-name></bgp-peer></services></data></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/bgp:bgp-peer[bgp:service-name='test']/bgp:description" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" message-id="42"><edit-config><target><candidate/></target><default-operation>none</default-operation><config><services xmlns="http://clicon.org/controller"><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><service-name>test</service-name><description nc:operation="merge">Foo</description></bgp-peer></services></config></edit-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:edit-config ce_id:3 s:7
Oct 19 06:23:34: from_client_edit_config done cbret:<rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/bgp:bgp-peer/bgp:service-name" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data><services xmlns="http://clicon.org/controller"><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><service-name>test</service-name></bgp-peer></services></data></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/bgp:bgp-peer[bgp:service-name='test']/bgp:export-rules" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" message-id="42"><edit-config><target><candidate/></target><default-operation>none</default-operation><config><services xmlns="http://clicon.org/controller"><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><service-name>test</service-name><export-rules nc:operation="merge">rule-export</export-rules></bgp-peer></services></config></edit-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:edit-config ce_id:3 s:7
Oct 19 06:23:34: from_client_edit_config done cbret:<rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/bgp:bgp-peer/bgp:service-name" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data><services xmlns="http://clicon.org/controller"><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><service-name>test</service-name></bgp-peer></services></data></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/bgp:bgp-peer[bgp:service-name='test']/bgp:import-rules" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" message-id="42"><edit-config><target><candidate/></target><default-operation>none</default-operation><config><services xmlns="http://clicon.org/controller"><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><service-name>test</service-name><import-rules nc:operation="merge">rule-import</import-rules></bgp-peer></services></config></edit-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:edit-config ce_id:3 s:7
Oct 19 06:23:34: from_client_edit_config done cbret:<rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/bgp:bgp-peer/bgp:service-name" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data><services xmlns="http://clicon.org/controller"><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><service-name>test</service-name></bgp-peer></services></data></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/bgp:bgp-peer[bgp:service-name='test']/bgp:irr-sources" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" message-id="42"><edit-config><target><candidate/></target><default-operation>none</default-operation><config><services xmlns="http://clicon.org/controller"><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><service-name>test</service-name><irr-sources nc:operation="merge">rr.ntt.org</irr-sources></bgp-peer></services></config></edit-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:edit-config ce_id:3 s:7
Oct 19 06:23:34: from_client_edit_config done cbret:<rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/bgp:bgp-peer/bgp:service-name" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data><services xmlns="http://clicon.org/controller"><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><service-name>test</service-name></bgp-peer></services></data></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/bgp:bgp-peer[bgp:service-name='test']/bgp:md5-sum" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" message-id="42"><edit-config><target><candidate/></target><default-operation>none</default-operation><config><services xmlns="http://clicon.org/controller"><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><service-name>test</service-name><md5-sum nc:operation="merge">asdasasdasdasdasdasd</md5-sum></bgp-peer></services></config></edit-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:edit-config ce_id:3 s:7
Oct 19 06:23:34: from_client_edit_config done cbret:<rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/bgp:bgp-peer/bgp:service-name" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data><services xmlns="http://clicon.org/controller"><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><service-name>test</service-name></bgp-peer></services></data></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/bgp:bgp-peer[bgp:service-name='test']/bgp:prefix-limit" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" message-id="42"><edit-config><target><candidate/></target><default-operation>none</default-operation><config><services xmlns="http://clicon.org/controller"><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><service-name>test</service-name><prefix-limit nc:operation="merge">10</prefix-limit></bgp-peer></services></config></edit-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:edit-config ce_id:3 s:7
Oct 19 06:23:34: from_client_edit_config done cbret:<rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/bgp:bgp-peer/bgp:service-name" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data><services xmlns="http://clicon.org/controller"><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><service-name>test</service-name></bgp-peer></services></data></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/bgp:bgp-peer[bgp:service-name='test']/bgp:exchange-points/bgp:exchange-point" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" message-id="42"><edit-config><target><candidate/></target><default-operation>none</default-operation><config><services xmlns="http://clicon.org/controller"><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><service-name>test</service-name><exchange-points nc:operation="merge"><exchange-point>test</exchange-point></exchange-points></bgp-peer></services></config></edit-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:edit-config ce_id:3 s:7
Oct 19 06:23:34: from_client_edit_config done cbret:<rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/bgp:bgp-peer/bgp:service-name" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data><services xmlns="http://clicon.org/controller"><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><service-name>test</service-name></bgp-peer></services></data></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/bgp:bgp-peer[bgp:service-name='test']/bgp:exchange-points/bgp:exchange-point" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data><services xmlns="http://clicon.org/controller"><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><service-name>test</service-name><exchange-points><exchange-point>test</exchange-point></exchange-points></bgp-peer></services></data></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/bgp:bgp-peer[bgp:service-name='test']/bgp:exchange-points[bgp:exchange-point='test']/bgp:as-number" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" message-id="42"><edit-config><target><candidate/></target><default-operation>none</default-operation><config><services xmlns="http://clicon.org/controller"><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><service-name>test</service-name><exchange-points><exchange-point>test</exchange-point><as-number nc:operation="merge">1111</as-number></exchange-points></bgp-peer></services></config></edit-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:edit-config ce_id:3 s:7
Oct 19 06:23:34: from_client_edit_config done cbret:<rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/bgp:bgp-peer/bgp:service-name" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data><services xmlns="http://clicon.org/controller"><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><service-name>test</service-name></bgp-peer></services></data></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/bgp:bgp-peer[bgp:service-name='test']/bgp:exchange-points/bgp:exchange-point" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data><services xmlns="http://clicon.org/controller"><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><service-name>test</service-name><exchange-points><exchange-point>test</exchange-point></exchange-points></bgp-peer></services></data></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/bgp:bgp-peer[bgp:service-name='test']/bgp:exchange-points[bgp:exchange-point='test']/bgp:export-rules" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" message-id="42"><edit-config><target><candidate/></target><default-operation>none</default-operation><config><services xmlns="http://clicon.org/controller"><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><service-name>test</service-name><exchange-points><exchange-point>test</exchange-point><export-rules nc:operation="merge">test-out</export-rules></exchange-points></bgp-peer></services></config></edit-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:edit-config ce_id:3 s:7
Oct 19 06:23:34: from_client_edit_config done cbret:<rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/bgp:bgp-peer/bgp:service-name" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data><services xmlns="http://clicon.org/controller"><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><service-name>test</service-name></bgp-peer></services></data></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/bgp:bgp-peer[bgp:service-name='test']/bgp:exchange-points/bgp:exchange-point" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data><services xmlns="http://clicon.org/controller"><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><service-name>test</service-name><exchange-points><exchange-point>test</exchange-point></exchange-points></bgp-peer></services></data></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/bgp:bgp-peer[bgp:service-name='test']/bgp:exchange-points[bgp:exchange-point='test']/bgp:import-rules" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" message-id="42"><edit-config><target><candidate/></target><default-operation>none</default-operation><config><services xmlns="http://clicon.org/controller"><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><service-name>test</service-name><exchange-points><exchange-point>test</exchange-point><import-rules nc:operation="merge">test-in</import-rules></exchange-points></bgp-peer></services></config></edit-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:edit-config ce_id:3 s:7
Oct 19 06:23:34: from_client_edit_config done cbret:<rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/bgp:bgp-peer/bgp:service-name" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data><services xmlns="http://clicon.org/controller"><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><service-name>test</service-name></bgp-peer></services></data></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/bgp:bgp-peer[bgp:service-name='test']/bgp:exchange-points/bgp:exchange-point" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data><services xmlns="http://clicon.org/controller"><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><service-name>test</service-name><exchange-points><exchange-point>test</exchange-point></exchange-points></bgp-peer></services></data></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/bgp:bgp-peer[bgp:service-name='test']/bgp:exchange-points[bgp:exchange-point='test']/bgp:peering/bgp:ip" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/bgp:bgp-peer[bgp:service-name='test']/bgp:exchange-points[bgp:exchange-point='test']/bgp:peering[bgp:ip='1.1.1.1']/bgp:as-number" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" message-id="42"><edit-config><target><candidate/></target><default-operation>none</default-operation><config><services xmlns="http://clicon.org/controller"><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><service-name>test</service-name><exchange-points><exchange-point>test</exchange-point><peering><ip>1.1.1.1</ip><as-number nc:operation="merge">33333</as-number></peering></exchange-points></bgp-peer></services></config></edit-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:edit-config ce_id:3 s:7
Oct 19 06:23:34: from_client_edit_config done cbret:<rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/bgp:bgp-peer/bgp:service-name" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data><services xmlns="http://clicon.org/controller"><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><service-name>test</service-name></bgp-peer></services></data></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/bgp:bgp-peer[bgp:service-name='test']/bgp:exchange-points/bgp:exchange-point" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data><services xmlns="http://clicon.org/controller"><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><service-name>test</service-name><exchange-points><exchange-point>test</exchange-point></exchange-points></bgp-peer></services></data></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/bgp:bgp-peer[bgp:service-name='test']/bgp:exchange-points[bgp:exchange-point='test']/bgp:peering/bgp:ip" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data><services xmlns="http://clicon.org/controller"><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><service-name>test</service-name><exchange-points><exchange-point>test</exchange-point><peering><ip>1.1.1.1</ip></peering></exchange-points></bgp-peer></services></data></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/bgp:bgp-peer[bgp:service-name='test']/bgp:exchange-points[bgp:exchange-point='test']/bgp:peering[bgp:ip='1.1.1.1']/bgp:export-rules" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" message-id="42"><edit-config><target><candidate/></target><default-operation>none</default-operation><config><services xmlns="http://clicon.org/controller"><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><service-name>test</service-name><exchange-points><exchange-point>test</exchange-point><peering><ip>1.1.1.1</ip><export-rules nc:operation="merge">export-out</export-rules></peering></exchange-points></bgp-peer></services></config></edit-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:edit-config ce_id:3 s:7
Oct 19 06:23:34: from_client_edit_config done cbret:<rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/bgp:bgp-peer/bgp:service-name" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data><services xmlns="http://clicon.org/controller"><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><service-name>test</service-name></bgp-peer></services></data></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/bgp:bgp-peer[bgp:service-name='test']/bgp:exchange-points/bgp:exchange-point" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data><services xmlns="http://clicon.org/controller"><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><service-name>test</service-name><exchange-points><exchange-point>test</exchange-point></exchange-points></bgp-peer></services></data></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/bgp:bgp-peer[bgp:service-name='test']/bgp:exchange-points[bgp:exchange-point='test']/bgp:peering/bgp:ip" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data><services xmlns="http://clicon.org/controller"><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><service-name>test</service-name><exchange-points><exchange-point>test</exchange-point><peering><ip>1.1.1.1</ip></peering></exchange-points></bgp-peer></services></data></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/bgp:bgp-peer[bgp:service-name='test']/bgp:exchange-points[bgp:exchange-point='test']/bgp:peering[bgp:ip='1.1.1.1']/bgp:import-rules" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" message-id="42"><edit-config><target><candidate/></target><default-operation>none</default-operation><config><services xmlns="http://clicon.org/controller"><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><service-name>test</service-name><exchange-points><exchange-point>test</exchange-point><peering><ip>1.1.1.1</ip><import-rules nc:operation="merge">asd</import-rules></peering></exchange-points></bgp-peer></services></config></edit-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:edit-config ce_id:3 s:7
Oct 19 06:23:34: from_client_edit_config done cbret:<rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/bgp:bgp-peer/bgp:service-name" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data><services xmlns="http://clicon.org/controller"><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><service-name>test</service-name></bgp-peer></services></data></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/bgp:bgp-peer[bgp:service-name='test']/bgp:exchange-points/bgp:exchange-point" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data><services xmlns="http://clicon.org/controller"><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><service-name>test</service-name><exchange-points><exchange-point>test</exchange-point></exchange-points></bgp-peer></services></data></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/bgp:bgp-peer[bgp:service-name='test']/bgp:exchange-points[bgp:exchange-point='test']/bgp:peering/bgp:ip" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data><services xmlns="http://clicon.org/controller"><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><service-name>test</service-name><exchange-points><exchange-point>test</exchange-point><peering><ip>1.1.1.1</ip></peering></exchange-points></bgp-peer></services></data></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><candidate/></source><nc:filter nc:type="xpath" nc:select="/ctrl:services/bgp:bgp-peer[bgp:service-name='test']/bgp:exchange-points[bgp:exchange-point='test']/bgp:peering[bgp:ip='1.1.1.1']/bgp:md5-sum" xmlns:ctrl="http://clicon.org/controller" xmlns:bgp="http://nordu.net/ns/ncs/bgp"/></get-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:get-config ce_id:3 s:7
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data/></rpc-reply>
Oct 19 06:23:34: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" message-id="42"><edit-config><target><candidate/></target><default-operation>none</default-operation><config><services xmlns="http://clicon.org/controller"><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><service-name>test</service-name><exchange-points><exchange-point>test</exchange-point><peering><ip>1.1.1.1</ip><md5-sum nc:operation="merge">asd</md5-sum></peering></exchange-points></bgp-peer></services></config></edit-config></rpc>
Oct 19 06:23:34: from_client_msg module:ietf-netconf rpc:edit-config ce_id:3 s:7
Oct 19 06:23:34: from_client_edit_config done cbret:<rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:34: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:36: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" username="debian" message-id="42"><controller-commit xmlns="http://clicon.org/controller"><device>*</device><push>NONE</push><actions>CHANGE</actions><source>ds:candidate</source></controller-commit></rpc>
Oct 19 06:23:36: from_client_msg module:clixon-controller rpc:controller-commit ce_id:3 s:7
Oct 19 06:23:36: rpc_controller_commit
Oct 19 06:23:36: controller_transaction_new
Oct 19 06:23:36: candidate: locked by 1677721
Oct 19 06:23:36: xmldb_copy candidate actions
Oct 19 06:23:36: controller_commit_actions stream_notify: services-commit: 1
Oct 19 06:23:36: ce_event_cb op:0
Oct 19 06:23:36: Send: <notification xmlns="urn:ietf:params:xml:ns:netconf:notification:1.0"><eventTime>2023-10-19T06:23:36.448464Z</eventTime><services-commit xmlns="http://clicon.org/controller"><tid>1</tid><source>actions</source><target>actions</target><service>bgp-peer[service-name='test']</service></services-commit></notification>
Oct 19 06:23:36: ce_event_cb op:0
Oct 19 06:23:36: Send: <notification xmlns="urn:ietf:params:xml:ns:netconf:notification:1.0"><eventTime>2023-10-19T06:23:36.448464Z</eventTime><services-commit xmlns="http://clicon.org/controller"><tid>1</tid><source>actions</source><target>actions</target><service>bgp-peer[service-name='test']</service></services-commit></notification>
Oct 19 06:23:36: controller_transaction_state_set 1 : INIT -> ACTIONS
Oct 19 06:23:36: actions_timeout_register
Oct 19 06:23:36: actions_timeout_register timeout:60 s
Oct 19 06:23:36: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><tid xmlns="http://clicon.org/controller">1</tid></rpc-reply>
Oct 19 06:23:36: Recv [cli3]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" cl:username="debian" xmlns:cl="http://clicon.org/lib" message-id="42"><close-session/></rpc>
Oct 19 06:23:36: from_client_msg module:ietf-netconf rpc:close-session ce_id:3 s:7
Oct 19 06:23:36: Send [cli3]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:36: backend_client_rm
Oct 19 06:23:36: Recv [4]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" username="actions" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><get-config><source><actions xmlns="http://clicon.org/controller"/></source><nc:filter nc:type="xpath" nc:select="/"/></get-config></rpc>
Oct 19 06:23:36: from_client_msg Warning: incoming session-id:42 does not match ce_id:4 on socket: 7
Oct 19 06:23:36: from_client_msg module:ietf-netconf rpc:get-config ce_id:4 s:7
Oct 19 06:23:36: Send [4]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><data><services xmlns="http://clicon.org/controller"><properties><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><exchange-points><name>test</name><routing-instance>test</routing-instance><router><name>juniper1</name></router><router><name>juniper2</name></router><aliases>foo</aliases><import-rules>rule-in</import-rules></exchange-points><teardown-limit-threshold>20</teardown-limit-threshold><teardown-idle-timeout>10</teardown-idle-timeout><irr-database>rr.ntt.org</irr-database><as-filter-delta-limit>40</as-filter-delta-limit></bgp-peer></properties><bgp-peer xmlns="http://nordu.net/ns/ncs/bgp"><service-name>test</service-name><as-number>1111</as-number><irr-sources>rr.ntt.org</irr-sources><import-rules>rule-import</import-rules><export-rules>rule-export</export-rules><description>Foo</description><as-macro4>4444</as-macro4><md5-sum>asdasasdasdasdasdasd</md5-sum><prefix-limit>10</prefix-limit><exchange-points><exchange-point>test</exchange-point><as-number>1111</as-number><import-rules>test-in</import-rules><export-rules>test-out</export-rules><peering><ip>1.1.1.1</ip><md5-sum>asd</md5-sum><as-number>33333</as-number><import-rules>asd</import-rules><export-rules>export-out</export-rules></peering></exchange-points></bgp-peer></services></data></rpc-reply>
Oct 19 06:23:36: Recv [1]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" username="root" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><transaction-actions-done xmlns="http://clicon.org/controller"><tid>1</tid><service>bgp-peer</service></transaction-actions-done></rpc>
Oct 19 06:23:36: from_client_msg Warning: incoming session-id:42 does not match ce_id:1 on socket: 5
Oct 19 06:23:36: from_client_msg module:clixon-controller rpc:transaction-actions-done ce_id:1 s:5
Oct 19 06:23:36: rpc_transactions_actions_done
Oct 19 06:23:36: controller_transaction_state_set 1 : ACTIONS -> INIT
Oct 19 06:23:36: controller_transaction_state_set 1 : INIT -> DONE result: SUCCESS
Oct 19 06:23:36: controller_transaction_notify 1
Oct 19 06:23:36: ce_event_cb op:0
Oct 19 06:23:36: Send: <notification xmlns="urn:ietf:params:xml:ns:netconf:notification:1.0"><eventTime>2023-10-19T06:23:36.451242Z</eventTime><controller-transaction xmlns="http://clicon.org/controller"><tid>1</tid><result>SUCCESS</result></controller-transaction></notification>
Oct 19 06:23:36: ce_event_cb op:0
Oct 19 06:23:36: Send: <notification xmlns="urn:ietf:params:xml:ns:netconf:notification:1.0"><eventTime>2023-10-19T06:23:36.451242Z</eventTime><controller-transaction xmlns="http://clicon.org/controller"><tid>1</tid><result>SUCCESS</result></controller-transaction></notification>
Oct 19 06:23:36: Send [1]: <rpc-reply xmlns="urn:ietf:params:xml:ns:netconf:base:1.0"><ok/></rpc-reply>
Oct 19 06:23:36: backend_client_rm
Oct 19 06:23:36: Recv [2]: <rpc xmlns="urn:ietf:params:xml:ns:netconf:base:1.0" username="root" xmlns:nc="urn:ietf:params:xml:ns:netconf:base:1.0" message-id="42"><transaction-error xmlns="http://clicon.org/controller"><tid>1</tid><origin>pyapi</origin><reason>No BGP configuration found for juniper1</reason></transaction-error></rpc>
Oct 19 06:23:36: from_client_msg Warning: incoming session-id:42 does not match ce_id:2 on socket: 6
Oct 19 06:23:36: from_client_msg module:clixon-controller rpc:transaction-error ce_id:2 s:6
Oct 19 06:23:36: rpc_transaction_error
Oct 19 06:23:36: controller_transaction_failed
Oct 19 06:23:36: controller_transaction_failed: 552: XML error: Sanity: may not be in resolved OK state
Oct 19 06:23:36: controller_transaction_failed retval:0
clixon_backend: controller_transaction.c:142: controller_transaction_state_set: Assertion `state != ct->ct_state' failed.
Aborted
debian@khn-dev:~$
krihal commented 11 months ago

Don't know how to verify, let's reopen if this ever happens again.