In order to find the callback which returns CONFD_ERROR, I compared the two logs of data provider. And found the maapi_commit_upgrade succeeded and its return code is CONFD_OK. But data provider didn’t receive the upgrade event of type 4.
I am sure about this because in the following code snippet, the last log is printed:
log.Info("Commit upgrade")
if err := conn.CommitUpgrade(); err != nil {
log.WithError(err).Error("Failed to commit upgrade")
return err
}
log.Info("Succeeded")
Would you please explain why this happened? And another question: Does the close_trans error cause ConfD crash?
Here is the log of data provider when upgrade is ok:
{"context":"loadYangSchemas","message":"Notify Confd about schema changes","service_id":"com-cm-yang-provider","severity":"info","timestamp":"2021-06-02T08:54:13.493Z","version":"0.2.0"}
{"message":"Waiting for phase 2","service_id":"com-cm-yang-provider","severity":"debug","timestamp":"2021-06-02T08:54:13.493Z","version":"0.2.0"}
{"message":"Load schemas","service_id":"com-cm-yang-provider","severity":"debug","timestamp":"2021-06-02T08:54:13.493Z","version":"0.2.0"}
{"message":"Start user session","service_id":"com-cm-yang-provider","severity":"debug","timestamp":"2021-06-02T08:54:13.519Z","version":"0.2.0"}
{"message":"partial lock lockId 216","service_id":"com-cm-yang-provider","severity":"debug","timestamp":"2021-06-02T08:54:13.52Z","version":"0.2.0"}
{"message":"Initializing upgrade","service_id":"com-cm-yang-provider","severity":"debug","timestamp":"2021-06-02T08:54:13.52Z","version":"0.2.0"}
{"message":"Upgrade event type: 1","notif_fd":23,"service_id":"com-cm-yang-provider","severity":"info","timestamp":"2021-06-02T08:54:13.521Z","version":"0.2.0"}
{"message":"Upgrade event type: 2","notif_fd":23,"service_id":"com-cm-yang-provider","severity":"info","timestamp":"2021-06-02T08:54:13.522Z","version":"0.2.0"}
{"message":"Perform upgrade","service_id":"com-cm-yang-provider","severity":"debug","timestamp":"2021-06-02T08:54:13.522Z","version":"0.2.0"}
{"message":"Upgrade event type: 3","notif_fd":23,"service_id":"com-cm-yang-provider","severity":"info","timestamp":"2021-06-02T08:54:13.655Z","version":"0.2.0"}
{"message":"Commit upgrade","service_id":"com-cm-yang-provider","severity":"info","timestamp":"2021-06-02T08:54:13.655Z","version":"0.2.0"}
{"NewValidatorSession":"tmp log","message":"","service_id":"com-cm-yang-provider","severity":"debug","timestamp":"2021-06-02T08:54:13.699Z","version":"0.2.0"}
{"message":"Validator.txInit","service_id":"com-cm-yang-provider","severity":"debug","timestamp":"2021-06-02T08:54:13.7Z","version":"0.2.0"}
{"db":"running","fd":587,"message":"lockEarly:false","service_id":"com-cm-yang-provider","session_id":1150,"session_type":"system","severity":"debug","timestamp":"2021-06-02T08:54:13.7Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"db":"running","fd":587,"message":"CANDIDATE_ENABLED: false","service_id":"com-cm-yang-provider","session_id":1150,"session_type":"system","severity":"debug","timestamp":"2021-06-02T08:54:13.7Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"db":"running","fd":587,"message":"tx_init Tx worker successfully created/connected","service_id":"com-cm-yang-provider","session_id":1150,"session_type":"system","severity":"debug","timestamp":"2021-06-02T08:54:13.7Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"message":"Validator.validate","service_id":"com-cm-yang-provider","severity":"debug","timestamp":"2021-06-02T08:54:13.7Z","version":"0.2.0"}
{"db":"running","fd":587,"func":"tx_lock","message":"enter write_lock","service_id":"com-cm-yang-provider","session_id":1150,"session_type":"system","severity":"debug","timestamp":"2021-06-02T08:54:13.701Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"db":"running","fd":587,"func":"tx_lock","message":"Lock","service_id":"com-cm-yang-provider","session_id":1150,"session_type":"system","severity":"debug","timestamp":"2021-06-02T08:54:13.701Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"db":"running","fd":587,"func":"tx_lock","message":"enter checkBeginDbSession","service_id":"com-cm-yang-provider","session_id":1150,"session_type":"system","severity":"debug","timestamp":"2021-06-02T08:54:13.701Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"db":"running","error":"no etag header found","fd":587,"func":"tx_lock","message":"Failed to find expected etag","service_id":"com-cm-yang-provider","session_id":1150,"session_type":"system","severity":"debug","timestamp":"2021-06-02T08:54:13.708Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"body":"{\"result\":\"created\",\"id\":\"64450f2b354abdfcf8787557d0803703\"}\n","db":"running","etag":"","fd":587,"func":"tx_lock","message":"POST","service_id":"com-cm-yang-provider","session_id":1150,"session_type":"system","severity":"debug","status":201,"timestamp":"2021-06-02T08:54:13.708Z","tx":-2,"tx_mode":"READ_WRITE","url":"https://com-cm-backend:443/v1/tx","version":"0.2.0"}
{"NewValidatorSession":"tmp log","message":"","service_id":"com-cm-yang-provider","severity":"debug","timestamp":"2021-06-02T08:54:13.708Z","version":"0.2.0"}
{"db":"running","fd":587,"func":"tx_lock","message":"exit checkBeginDbSession, cleared accessors/validators","service_id":"com-cm-yang-provider","session_id":1150,"session_type":"system","severity":"debug","timestamp":"2021-06-02T08:54:13.708Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"db":"running","fd":587,"func":"tx_lock","message":"exit write_lock","service_id":"com-cm-yang-provider","session_id":1150,"session_type":"system","severity":"debug","timestamp":"2021-06-02T08:54:13.708Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"message":"enter go_confd_validation_init","service_id":"com-cm-yang-provider","severity":"debug","timestamp":"2021-06-02T08:54:13.709Z","version":"0.2.0"}
{"message":"exit go_confd_validation_init","service_id":"com-cm-yang-provider","severity":"debug","timestamp":"2021-06-02T08:54:13.709Z","version":"0.2.0"}
{"message":"go_confd_validation_execute","service_id":"com-cm-yang-provider","severity":"debug","timestamp":"2021-06-02T08:54:13.709Z","version":"0.2.0"}
{"db":"running","fd":587,"func":"go_confd_validation_execute","message":"enter","service_id":"com-cm-yang-provider","session_id":1150,"session_type":"system","severity":"debug","timestamp":"2021-06-02T08:54:13.709Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"db":"running","fd":587,"message":"TxChangeIterator.CanApply","service_id":"com-cm-yang-provider","session_id":1150,"session_type":"system","severity":"debug","timestamp":"2021-06-02T08:54:13.709Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"db":"running","fd":587,"message":"TxChangeIterator.CanApply userContext: system, dbname: running","service_id":"com-cm-yang-provider","session_id":1150,"session_type":"system","severity":"debug","timestamp":"2021-06-02T08:54:13.709Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"db":"running","fd":587,"message":"TxChangeIterator.Apply TX not for validation","service_id":"com-cm-yang-provider","session_id":1150,"session_type":"system","severity":"debug","timestamp":"2021-06-02T08:54:13.709Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"db":"running","fd":587,"func":"go_confd_validation_execute","message":"exit","service_id":"com-cm-yang-provider","session_id":1150,"session_type":"system","severity":"debug","timestamp":"2021-06-02T08:54:13.71Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"message":"go_confd_validation_execute","service_id":"com-cm-yang-provider","severity":"debug","timestamp":"2021-06-02T08:54:13.71Z","version":"0.2.0"}
{"db":"running","fd":587,"func":"go_confd_validation_execute","message":"enter","service_id":"com-cm-yang-provider","session_id":1150,"session_type":"system","severity":"debug","timestamp":"2021-06-02T08:54:13.71Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"db":"running","fd":587,"message":"TxChangeIterator.CanApply","service_id":"com-cm-yang-provider","session_id":1150,"session_type":"system","severity":"debug","timestamp":"2021-06-02T08:54:13.71Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"db":"running","fd":587,"message":"TxChangeIterator.CanApply userContext: system, dbname: running","service_id":"com-cm-yang-provider","session_id":1150,"session_type":"system","severity":"debug","timestamp":"2021-06-02T08:54:13.71Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"db":"running","fd":587,"message":"TxChangeIterator.Apply TX not for validation","service_id":"com-cm-yang-provider","session_id":1150,"session_type":"system","severity":"debug","timestamp":"2021-06-02T08:54:13.71Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"db":"running","fd":587,"func":"go_confd_validation_execute","message":"exit","service_id":"com-cm-yang-provider","session_id":1150,"session_type":"system","severity":"debug","timestamp":"2021-06-02T08:54:13.71Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"db":"running","fd":587,"func":"tx_write_start","message":"enter write_start","service_id":"com-cm-yang-provider","session_id":1150,"session_type":"system","severity":"debug","timestamp":"2021-06-02T08:54:13.71Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"db":"running","fd":587,"func":"tx_write_start","message":"exit write_start","service_id":"com-cm-yang-provider","session_id":1150,"session_type":"system","severity":"debug","timestamp":"2021-06-02T08:54:13.71Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"message":"enter-exit go_confd_validation_stop","service_id":"com-cm-yang-provider","severity":"debug","timestamp":"2021-06-02T08:54:13.711Z","version":"0.2.0"}
{"db":"running","fd":587,"func":"tx_commit","message":"enter tx_commit","service_id":"com-cm-yang-provider","session_id":1150,"session_type":"system","severity":"debug","timestamp":"2021-06-02T08:54:13.713Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"db":"running","fd":587,"from":2,"func":"tx_commit","message":"Invalid state change","service_id":"com-cm-yang-provider","session_id":1150,"session_type":"system","severity":"debug","timestamp":"2021-06-02T08:54:13.713Z","to":6,"tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"db":"running","error":"invalid state change","fd":587,"func":"tx_commit","message":"Error in empty transaction commit","service_id":"com-cm-yang-provider","session_id":1150,"session_type":"system","severity":"warning","timestamp":"2021-06-02T08:54:13.713Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"db":"running","fd":587,"func":"tx_commit","message":"exit tx_commit","service_id":"com-cm-yang-provider","session_id":1150,"session_type":"system","severity":"debug","timestamp":"2021-06-02T08:54:13.713Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"db":"running","fd":587,"func":"tx_finish","message":"Tx Finish","service_id":"com-cm-yang-provider","session_id":1150,"session_type":"system","severity":"debug","timestamp":"2021-06-02T08:54:13.714Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"NewValidatorSession":"tmp log","message":"","service_id":"com-cm-yang-provider","severity":"debug","timestamp":"2021-06-02T08:54:13.714Z","version":"0.2.0"}
{"db":"running","error":"no etag header found","fd":587,"func":"tx_lock","message":"Failed to find expected etag","service_id":"com-cm-yang-provider","session_id":1150,"session_type":"system","severity":"debug","timestamp":"2021-06-02T08:54:13.72Z","tx":"64450f2b354abdfcf8787557d0803703","tx_mode":"READ_WRITE","version":"0.2.0"}
{"body":"{\"result\":\"deleted\",\"id\":\"64450f2b354abdfcf8787557d0803703\"}\n","db":"running","etag":"","fd":587,"func":"tx_lock","message":"POST","service_id":"com-cm-yang-provider","session_id":1150,"session_type":"system","severity":"debug","status":200,"timestamp":"2021-06-02T08:54:13.72Z","tx":"64450f2b354abdfcf8787557d0803703","tx_mode":"READ_WRITE","url":"https://com-cm-backend:443/v1/tx/64450f2b354abdfcf8787557d0803703/abort","version":"0.2.0"}
{"db":"running","fd":587,"message":"Closing Tx worker","service_id":"com-cm-yang-provider","session_id":1150,"session_type":"system","severity":"debug","timestamp":"2021-06-02T08:54:13.72Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"NewValidatorSession":"tmp log","message":"","service_id":"com-cm-yang-provider","severity":"debug","timestamp":"2021-06-02T08:54:13.732Z","version":"0.2.0"}
{"message":"Validator.txInit","service_id":"com-cm-yang-provider","severity":"debug","timestamp":"2021-06-02T08:54:13.732Z","version":"0.2.0"}
{"db":"running","fd":677,"message":"lockEarly:false","service_id":"com-cm-yang-provider","session_id":1151,"session_type":"system","severity":"debug","timestamp":"2021-06-02T08:54:13.732Z","tx":2419,"tx_mode":"READ","version":"0.2.0"}
{"db":"running","fd":677,"message":"CANDIDATE_ENABLED: false","service_id":"com-cm-yang-provider","session_id":1151,"session_type":"system","severity":"debug","timestamp":"2021-06-02T08:54:13.732Z","tx":2419,"tx_mode":"READ","version":"0.2.0"}
{"db":"running","fd":677,"message":"tx_init Tx worker successfully created/connected","service_id":"com-cm-yang-provider","session_id":1151,"session_type":"system","severity":"debug","timestamp":"2021-06-02T08:54:13.732Z","tx":2419,"tx_mode":"READ","version":"0.2.0"}
{"message":"Upgrade event type: 4","notif_fd":23,"service_id":"com-cm-yang-provider","severity":"info","timestamp":"2021-06-02T08:54:13.733Z","version":"0.2.0"}
{"message":"Succeeded","service_id":"com-cm-yang-provider","severity":"info","timestamp":"2021-06-02T08:54:13.733Z","version":"0.2.0"}
{"message":"partal unlock lockId 216","service_id":"com-cm-yang-provider","severity":"debug","timestamp":"2021-06-02T08:54:13.733Z","version":"0.2.0"}
{"message":"Reload AAA","service_id":"com-cm-yang-provider","severity":"info","timestamp":"2021-06-02T08:54:13.734Z","version":"0.2.0"}
{"message":"partial lock lockId 217","service_id":"com-cm-yang-provider","severity":"debug","timestamp":"2021-06-02T08:54:13.735Z","version":"0.2.0"}
{"message":"partal unlock lockId 217","service_id":"com-cm-yang-provider","severity":"debug","timestamp":"2021-06-02T08:54:13.735Z","version":"0.2.0"}
{"message":"Reload AAA Succeeded","service_id":"com-cm-yang-provider","severity":"info","timestamp":"2021-06-02T08:54:13.735Z","version":"0.2.0"}
And here is the log of data provider when ConfD crashed:
{"context":"loadYangSchemas","message":"Notify Confd about schema changes","service_id":"com-cm-yang-provider","severity":"info","timestamp":"2021-06-02T11:04:40.335Z","version":"0.2.0"}
{"message":"Waiting for phase 2","service_id":"com-cm-yang-provider","severity":"debug","timestamp":"2021-06-02T11:04:40.336Z","version":"0.2.0"}
{"message":"Load schemas","service_id":"com-cm-yang-provider","severity":"debug","timestamp":"2021-06-02T11:04:40.336Z","version":"0.2.0"}
{"message":"Start user session","service_id":"com-cm-yang-provider","severity":"debug","timestamp":"2021-06-02T11:04:40.405Z","version":"0.2.0"}
{"message":"partial lock lockId 224","service_id":"com-cm-yang-provider","severity":"debug","timestamp":"2021-06-02T11:04:40.407Z","version":"0.2.0"}
{"message":"Initializing upgrade","service_id":"com-cm-yang-provider","severity":"debug","timestamp":"2021-06-02T11:04:40.407Z","version":"0.2.0"}
{"message":"Upgrade event type: 1","notif_fd":23,"service_id":"com-cm-yang-provider","severity":"info","timestamp":"2021-06-02T11:04:40.408Z","version":"0.2.0"}
{"db":"running","fd":25,"func":"tx_finish","message":"Tx Finish","service_id":"com-cm-yang-provider","session_id":1188,"session_type":"cli","severity":"debug","timestamp":"2021-06-02T11:04:40.408Z","tx":2473,"tx_mode":"READ","version":"0.2.0"}
{"NewValidatorSession":"tmp log","message":"","service_id":"com-cm-yang-provider","severity":"debug","timestamp":"2021-06-02T11:04:40.408Z","version":"0.2.0"}
{"db":"running","fd":25,"message":"Closing Tx worker","service_id":"com-cm-yang-provider","session_id":1188,"session_type":"cli","severity":"debug","timestamp":"2021-06-02T11:04:40.408Z","tx":2473,"tx_mode":"READ","version":"0.2.0"}
{"message":"Upgrade event type: 2","notif_fd":23,"service_id":"com-cm-yang-provider","severity":"info","timestamp":"2021-06-02T11:04:40.409Z","version":"0.2.0"}
{"message":"Perform upgrade","service_id":"com-cm-yang-provider","severity":"debug","timestamp":"2021-06-02T11:04:40.409Z","version":"0.2.0"}
{"message":"Upgrade event type: 3","notif_fd":23,"service_id":"com-cm-yang-provider","severity":"info","timestamp":"2021-06-02T11:04:40.541Z","version":"0.2.0"}
{"message":"Commit upgrade","service_id":"com-cm-yang-provider","severity":"info","timestamp":"2021-06-02T11:04:40.541Z","version":"0.2.0"}
{"cmd":"/opt/confd/bin/confdc --yangpath /opt/adp/yang -c /tmp/yangArchive952954455/com-brm-ext-adp.yang --use-description -o /tmp/yangArchive952954455/com-brm-ext-adp.fxs --yangpath /tmp/yangArchive952954455","message":"Command exec succeeded!","service_id":"com-cm-yang-provider","severity":"debug","stderr":"","stdout":"","timestamp":"2021-06-02T11:04:40.602Z","version":"0.2.0"}
{"file":"/tmp/yangArchive952954455/com-brm-ext-adp.yang","message":"Compilation of YANG file successful","service_id":"com-cm-yang-provider","severity":"info","timestamp":"2021-06-02T11:04:40.602Z","version":"0.2.0"}
{"NewValidatorSession":"tmp log","message":"","service_id":"com-cm-yang-provider","severity":"debug","timestamp":"2021-06-02T11:04:40.614Z","version":"0.2.0"}
{"message":"Validator.txInit","service_id":"com-cm-yang-provider","severity":"debug","timestamp":"2021-06-02T11:04:40.614Z","version":"0.2.0"}
{"db":"running","fd":25,"message":"lockEarly:false","service_id":"com-cm-yang-provider","session_id":1200,"session_type":"system","severity":"debug","timestamp":"2021-06-02T11:04:40.614Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"db":"running","fd":25,"message":"CANDIDATE_ENABLED: false","service_id":"com-cm-yang-provider","session_id":1200,"session_type":"system","severity":"debug","timestamp":"2021-06-02T11:04:40.614Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"db":"running","fd":25,"message":"tx_init Tx worker successfully created/connected","service_id":"com-cm-yang-provider","session_id":1200,"session_type":"system","severity":"debug","timestamp":"2021-06-02T11:04:40.614Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"message":"Validator.validate","service_id":"com-cm-yang-provider","severity":"debug","timestamp":"2021-06-02T11:04:40.614Z","version":"0.2.0"}
{"db":"running","fd":25,"func":"tx_lock","message":"enter write_lock","service_id":"com-cm-yang-provider","session_id":1200,"session_type":"system","severity":"debug","timestamp":"2021-06-02T11:04:40.615Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"db":"running","fd":25,"func":"tx_lock","message":"Lock","service_id":"com-cm-yang-provider","session_id":1200,"session_type":"system","severity":"debug","timestamp":"2021-06-02T11:04:40.615Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"db":"running","fd":25,"func":"tx_lock","message":"enter checkBeginDbSession","service_id":"com-cm-yang-provider","session_id":1200,"session_type":"system","severity":"debug","timestamp":"2021-06-02T11:04:40.615Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"db":"running","error":"no etag header found","fd":25,"func":"tx_lock","message":"Failed to find expected etag","service_id":"com-cm-yang-provider","session_id":1200,"session_type":"system","severity":"debug","timestamp":"2021-06-02T11:04:40.622Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"body":"{\"result\":\"created\",\"id\":\"db10724e06daee7f8304e7085fbe1a23\"}\n","db":"running","etag":"","fd":25,"func":"tx_lock","message":"POST","service_id":"com-cm-yang-provider","session_id":1200,"session_type":"system","severity":"debug","status":201,"timestamp":"2021-06-02T11:04:40.622Z","tx":-2,"tx_mode":"READ_WRITE","url":"https://com-cm-backend:443/v1/tx","version":"0.2.0"}
{"NewValidatorSession":"tmp log","message":"","service_id":"com-cm-yang-provider","severity":"debug","timestamp":"2021-06-02T11:04:40.622Z","version":"0.2.0"}
{"db":"running","fd":25,"func":"tx_lock","message":"exit checkBeginDbSession, cleared accessors/validators","service_id":"com-cm-yang-provider","session_id":1200,"session_type":"system","severity":"debug","timestamp":"2021-06-02T11:04:40.622Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"db":"running","fd":25,"func":"tx_lock","message":"exit write_lock","service_id":"com-cm-yang-provider","session_id":1200,"session_type":"system","severity":"debug","timestamp":"2021-06-02T11:04:40.622Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"message":"enter go_confd_validation_init","service_id":"com-cm-yang-provider","severity":"debug","timestamp":"2021-06-02T11:04:40.624Z","version":"0.2.0"}
{"message":"exit go_confd_validation_init","service_id":"com-cm-yang-provider","severity":"debug","timestamp":"2021-06-02T11:04:40.624Z","version":"0.2.0"}
{"message":"go_confd_validation_execute","service_id":"com-cm-yang-provider","severity":"debug","timestamp":"2021-06-02T11:04:40.624Z","version":"0.2.0"}
{"db":"running","fd":25,"func":"go_confd_validation_execute","message":"enter","service_id":"com-cm-yang-provider","session_id":1200,"session_type":"system","severity":"debug","timestamp":"2021-06-02T11:04:40.624Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"db":"running","fd":25,"message":"TxChangeIterator.CanApply","service_id":"com-cm-yang-provider","session_id":1200,"session_type":"system","severity":"debug","timestamp":"2021-06-02T11:04:40.624Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"db":"running","fd":25,"message":"TxChangeIterator.CanApply userContext: system, dbname: running","service_id":"com-cm-yang-provider","session_id":1200,"session_type":"system","severity":"debug","timestamp":"2021-06-02T11:04:40.624Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"db":"running","fd":25,"message":"TxChangeIterator.Apply TX not for validation","service_id":"com-cm-yang-provider","session_id":1200,"session_type":"system","severity":"debug","timestamp":"2021-06-02T11:04:40.624Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"db":"running","fd":25,"func":"go_confd_validation_execute","message":"exit","service_id":"com-cm-yang-provider","session_id":1200,"session_type":"system","severity":"debug","timestamp":"2021-06-02T11:04:40.624Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"message":"go_confd_validation_execute","service_id":"com-cm-yang-provider","severity":"debug","timestamp":"2021-06-02T11:04:40.625Z","version":"0.2.0"}
{"db":"running","fd":25,"func":"go_confd_validation_execute","message":"enter","service_id":"com-cm-yang-provider","session_id":1200,"session_type":"system","severity":"debug","timestamp":"2021-06-02T11:04:40.625Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"db":"running","fd":25,"message":"TxChangeIterator.CanApply","service_id":"com-cm-yang-provider","session_id":1200,"session_type":"system","severity":"debug","timestamp":"2021-06-02T11:04:40.625Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"db":"running","fd":25,"message":"TxChangeIterator.CanApply userContext: system, dbname: running","service_id":"com-cm-yang-provider","session_id":1200,"session_type":"system","severity":"debug","timestamp":"2021-06-02T11:04:40.625Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"db":"running","fd":25,"message":"TxChangeIterator.Apply TX not for validation","service_id":"com-cm-yang-provider","session_id":1200,"session_type":"system","severity":"debug","timestamp":"2021-06-02T11:04:40.625Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"db":"running","fd":25,"func":"go_confd_validation_execute","message":"exit","service_id":"com-cm-yang-provider","session_id":1200,"session_type":"system","severity":"debug","timestamp":"2021-06-02T11:04:40.625Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"db":"running","fd":25,"func":"tx_write_start","message":"enter write_start","service_id":"com-cm-yang-provider","session_id":1200,"session_type":"system","severity":"debug","timestamp":"2021-06-02T11:04:40.625Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"db":"running","fd":25,"func":"tx_write_start","message":"exit write_start","service_id":"com-cm-yang-provider","session_id":1200,"session_type":"system","severity":"debug","timestamp":"2021-06-02T11:04:40.625Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"message":"enter-exit go_confd_validation_stop","service_id":"com-cm-yang-provider","severity":"debug","timestamp":"2021-06-02T11:04:40.626Z","version":"0.2.0"}
{"db":"running","fd":25,"func":"tx_commit","message":"enter tx_commit","service_id":"com-cm-yang-provider","session_id":1200,"session_type":"system","severity":"debug","timestamp":"2021-06-02T11:04:40.63Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"db":"running","fd":25,"from":2,"func":"tx_commit","message":"Invalid state change","service_id":"com-cm-yang-provider","session_id":1200,"session_type":"system","severity":"debug","timestamp":"2021-06-02T11:04:40.63Z","to":6,"tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"db":"running","error":"invalid state change","fd":25,"func":"tx_commit","message":"Error in empty transaction commit","service_id":"com-cm-yang-provider","session_id":1200,"session_type":"system","severity":"warning","timestamp":"2021-06-02T11:04:40.63Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"db":"running","fd":25,"func":"tx_commit","message":"exit tx_commit","service_id":"com-cm-yang-provider","session_id":1200,"session_type":"system","severity":"debug","timestamp":"2021-06-02T11:04:40.63Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"db":"running","fd":25,"func":"tx_finish","message":"Tx Finish","service_id":"com-cm-yang-provider","session_id":1200,"session_type":"system","severity":"debug","timestamp":"2021-06-02T11:04:40.681Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
{"NewValidatorSession":"tmp log","message":"","service_id":"com-cm-yang-provider","severity":"debug","timestamp":"2021-06-02T11:04:40.681Z","version":"0.2.0"}
{"cmd":"/opt/confd/bin/confdc --yangpath /opt/adp/yang -c /tmp/yangArchive952954455/com-brm.yang --use-description -o /tmp/yangArchive952954455/com-brm.fxs --yangpath /tmp/yangArchive952954455 --deviation /tmp/yangArchive952954455/com-brm-ext-adp.yang -F com-brm:housekeeping,scheduler","message":"Command exec succeeded!","service_id":"com-cm-yang-provider","severity":"debug","stderr":"","stdout":"","timestamp":"2021-06-02T11:04:40.69Z","version":"0.2.0"}
{"file":"/tmp/yangArchive952954455/com-brm.yang","message":"Compilation of YANG file successful","service_id":"com-cm-yang-provider","severity":"info","timestamp":"2021-06-02T11:04:40.69Z","version":"0.2.0"}
{"message":"Compilation successful","name":"com-brm","service_id":"com-cm-yang-provider","severity":"debug","timestamp":"2021-06-02T11:04:40.691Z","tx":"afb2ba9a639dbbcda3eed48b2457dce9","url":{"Scheme":"","Opaque":"","User":null,"Host":"","Path":"/v1/yang","RawPath":"","ForceQuery":false,"RawQuery":"tx=afb2ba9a639dbbcda3eed48b2457dce9","Fragment":"","RawFragment":""},"version":"0.2.0"}
{"db":"running","error":"no etag header found","fd":25,"func":"tx_lock","message":"Failed to find expected etag","service_id":"com-cm-yang-provider","session_id":1200,"session_type":"system","severity":"debug","timestamp":"2021-06-02T11:04:40.693Z","tx":"db10724e06daee7f8304e7085fbe1a23","tx_mode":"READ_WRITE","version":"0.2.0"}
{"body":"{\"result\":\"deleted\",\"id\":\"db10724e06daee7f8304e7085fbe1a23\"}\n","db":"running","etag":"","fd":25,"func":"tx_lock","message":"POST","service_id":"com-cm-yang-provider","session_id":1200,"session_type":"system","severity":"debug","status":200,"timestamp":"2021-06-02T11:04:40.693Z","tx":"db10724e06daee7f8304e7085fbe1a23","tx_mode":"READ_WRITE","url":"https://com-cm-backend:443/v1/tx/db10724e06daee7f8304e7085fbe1a23/abort","version":"0.2.0"}
{"db":"running","fd":25,"message":"Closing Tx worker","service_id":"com-cm-yang-provider","session_id":1200,"session_type":"system","severity":"debug","timestamp":"2021-06-02T11:04:40.693Z","tx":-2,"tx_mode":"READ_WRITE","version":"0.2.0"}
DEBUG EOF on socket to ConfD
DEBUG EOF on socket to ConfD
{"message":"Socket closed","ret":-2,"service_id":"com-cm-yang-provider","severity":"error","timestamp":"2021-06-02T11:04:40.705Z","version":"0.2.0"}
{"message":"Trying to connect to Confdvalidation control","service_id":"com-cm-yang-provider","severity":"debug","timestamp":"2021-06-02T11:04:40.705Z","version":"0.2.0"}
{"message":"Succeeded","service_id":"com-cm-yang-provider","severity":"info","timestamp":"2021-06-02T11:04:40.707Z","version":"0.2.0"}
{"message":"partal unlock lockId 224","service_id":"com-cm-yang-provider","severity":"debug","timestamp":"2021-06-02T11:04:40.707Z","version":"0.2.0"}
DEBUG internal error -
{"confd_errno":18,"confd_errno_str":"internal error","confd_lasterror":0,"message":"maapi partial unlock failed","ret":-1,"service_id":"com-cm-yang-provider","severity":"debug","timestamp":"2021-06-02T11:04:40.709Z","version":"0.2.0"}
{"message":"Reload AAA","service_id":"com-cm-yang-provider","severity":"info","timestamp":"2021-06-02T11:04:40.709Z","version":"0.2.0"}
DEBUG internal error -
{"error":"failed to start user session","message":"Failed to reload NACM cache","service_id":"com-cm-yang-provider","severity":"error","timestamp":"2021-06-02T11:04:40.71Z","version":"0.2.0"}
{"error":"failed to start user session","message":"Failed to reload AAA","service_id":"com-cm-yang-provider","severity":"fatal","timestamp":"2021-06-02T11:04:40.71Z","version":"0.2.0"}
Ended with exit code 1.