I am having trouble completing the AAA extension setup. It fails at the end when testing
the login flow, if I test the search that part works.
I can confirm that I am able to login to my system using the admin account so there is not
a password issue.
I have listed my results below to include log level=finest. I have also attached a log.
Sugeestions on troubleshooting are appreciated. I am not sure where to start. Thanks!
Please provide credentials to test login flow:
Enter user name: admin
Enter user password:
[ INFO ] Executing login sequence...
Login output:
2018-10-23 16:43:46,432-05 INFO ===================================
=====================================
2018-10-23 16:43:46,452-05 INFO ============================ Initia
lization
============================
2018-10-23 16:43:46,452-05 INFO ===================================
=====================================
2018-10-23 16:43:46,565-05 INFO Loading extension 'ldap.cyber-range
.lan-authn'
2018-10-23 16:43:46,668-05 INFO Extension 'ldap.cyber-range.lan-aut
hn'
loaded
2018-10-23 16:43:46,672-05 INFO Loading extension 'ldap.cyber-range
.lan'
2018-10-23 16:43:46,681-05 INFO Extension 'ldap.cyber-range.lan' lo
aded
2018-10-23 16:43:46,682-05 INFO Initializing extension 'ldap.cyber-
range.lan-authn'
2018-10-23 16:43:46,682-05 INFO [ovirt-engine-extension-aaa-ldap.au
thn::ldap.cyber-range.lan-authn] Creating LDAP pool 'authz'
2018-10-23 16:43:47,236-05 INFO [ovirt-engine-extension-aaa-ldap.au
thn::ldap.cyber-range.lan-authn] LDAP pool 'authz' information: vendor='389
Proj
ect' version='389-Directory/1.3.7.5 B2018.269.1826'
2018-10-23 16:43:47,237-05 INFO [ovirt-engine-extension-aaa-ldap.au
thn::ldap.cyber-range.lan-authn] Creating LDAP pool 'authn'
2018-10-23 16:43:47,518-05 INFO [ovirt-engine-extension-aaa-ldap.au
thn::ldap.cyber-range.lan-authn] LDAP pool 'authn' information: vendor='389
Proj
ect' version='389-Directory/1.3.7.5 B2018.269.1826'
2018-10-23 16:43:47,518-05 INFO Extension 'ldap.cyber-range.lan-aut
hn'
initialized
2018-10-23 16:43:47,519-05 INFO Initializing extension 'ldap.cyber-
range.lan'
2018-10-23 16:43:47,520-05 INFO [ovirt-engine-extension-aaa-ldap.au
thz::ldap.cyber-range.lan] Creating LDAP pool 'authz'
2018-10-23 16:43:47,759-05 INFO [ovirt-engine-extension-aaa-ldap.au
thz::ldap.cyber-range.lan] LDAP pool 'authz' information: vendor='389
Project' v
ersion='389-Directory/1.3.7.5 B2018.269.1826'
2018-10-23 16:43:47,760-05 INFO [ovirt-engine-extension-aaa-ldap.au
thz::ldap.cyber-range.lan] Available Namespaces: [dc=cyber-range,dc=lan]
2018-10-23 16:43:47,760-05 INFO Extension 'ldap.cyber-range.lan' in
itialized
2018-10-23 16:43:47,761-05 INFO Start of enabled extensions list
2018-10-23 16:43:47,761-05 INFO Instance name: 'ldap.cyber-range.la
n-authn', Extension name: 'ovirt-engine-extension-aaa-ldap.authn', Version:
'1.3
.7', Notes: 'Display name:
ovirt-engine-extension-aaa-ldap-1.3.7-1.el7.centos',
License: 'ASL 2.0', Home:
'http://www.ovirt.org', Author 'The oVirt Project', Bu
ild interface Version:
'0', File: '/tmp/tmprnxgRZ/extensions.d/ldap.cyber-range
.lan-authn.properties', Initialized: 'true'
2018-10-23 16:43:47,761-05 INFO Instance name: 'ldap.cyber-range.la
n',
Extension name: 'ovirt-engine-extension-aaa-ldap.authz', Version: '1.3.7',
N
otes: 'Display name: ovirt-engine-extension-aaa-ldap-1.3.7-1.el7.centos', Licens
e:
'ASL 2.0', Home: 'http://www.ovirt.org', Author 'The oVirt
Project', Build in
terface Version: '0', File:
'/tmp/tmprnxgRZ/extensions.d/ldap.cyber-range.lan.p
roperties', Initialized:
'true'
2018-10-23 16:43:47,761-05 INFO End of enabled extensions list
2018-10-23 16:43:47,762-05 INFO ===================================
=====================================
2018-10-23 16:43:47,762-05 INFO ============================== Exec
ution
===============================
2018-10-23 16:43:47,762-05 INFO ===================================
=====================================
2018-10-23 16:43:47,762-05 INFO Iteration: 0
2018-10-23 16:43:47,763-05 INFO Profile='ldap.cyber-range.lan' auth
n='ldap.cyber-range.lan-authn' authz='ldap.cyber-range.lan'
mapping='null'
2018-10-23 16:43:47,763-05 INFO API: -->Authn.InvokeCommands.AUTHEN
TICATE_CREDENTIALS profile='ldap.cyber-range.lan' user='admin'
2018-10-23 16:43:47,771-05 INFO API: <--Authn.InvokeCommands.AUTHEN
TICATE_CREDENTIALS profile='ldap.cyber-range.lan' result=CREDENTIALS_INVALID
2018-10-23 16:43:47,775-05 SEVERE Authn.Result code is: CREDENTIALS_I
NVALID
[ ERROR ] Login sequence failed
Please investigate details of the failure (search for lines containing
SEVERE log
level).
Select test sequence to execute (Done, Abort, Login, Search) [Abort]:Login
Please provide credentials to test login flow:
Enter user name: admin
Enter user password:
[ INFO ] Executing login sequence...
Login output:
2018-10-23 16:44:08,301-05 INFO
========================================================================
2018-10-23 16:44:08,320-05 INFO ============================ Initialization
============================
2018-10-23 16:44:08,320-05 INFO
========================================================================
2018-10-23 16:44:08,346-05 INFO Loading extension
'ldap.cyber-range.lan-authn'
2018-10-23 16:44:08,397-05 INFO Extension
'ldap.cyber-range.lan-authn' loaded
2018-10-23 16:44:08,401-05 INFO Loading extension
'ldap.cyber-range.lan'
2018-10-23 16:44:08,409-05 INFO Extension 'ldap.cyber-range.lan'
loaded
2018-10-23 16:44:08,409-05 INFO Initializing extension
'ldap.cyber-range.lan-authn'
2018-10-23 16:44:08,410-05 INFO
[ovirt-engine-extension-aaa-ldap.authn::ldap.cyber-range.lan-authn] Creating LDAP pool
'authz'
2018-10-23 16:44:08,914-05 INFO
[ovirt-engine-extension-aaa-ldap.authn::ldap.cyber-range.lan-authn] LDAP pool
'authz' information: vendor='389 Project'
version='389-Directory/1.3.7.5 B2018.269.1826'
2018-10-23 16:44:08,915-05 INFO
[ovirt-engine-extension-aaa-ldap.authn::ldap.cyber-range.lan-authn] Creating LDAP pool
'authn'
2018-10-23 16:44:09,192-05 INFO
[ovirt-engine-extension-aaa-ldap.authn::ldap.cyber-range.lan-authn] LDAP pool
'authn' information: vendor='389 Project'
version='389-Directory/1.3.7.5 B2018.269.1826'
2018-10-23 16:44:09,193-05 INFO Extension
'ldap.cyber-range.lan-authn' initialized
2018-10-23 16:44:09,194-05 INFO Initializing extension
'ldap.cyber-range.lan'
2018-10-23 16:44:09,194-05 INFO
[ovirt-engine-extension-aaa-ldap.authz::ldap.cyber-range.lan] Creating LDAP pool
'authz'
2018-10-23 16:44:09,430-05 INFO
[ovirt-engine-extension-aaa-ldap.authz::ldap.cyber-range.lan] LDAP pool 'authz'
information: vendor='389 Project' version='389-Directory/1.3.7.5
B2018.269.1826'
2018-10-23 16:44:09,431-05 INFO
[ovirt-engine-extension-aaa-ldap.authz::ldap.cyber-range.lan] Available Namespaces:
[dc=cyber-range,dc=lan]
2018-10-23 16:44:09,432-05 INFO Extension 'ldap.cyber-range.lan'
initialized
2018-10-23 16:44:09,432-05 INFO Start of enabled extensions list
2018-10-23 16:44:09,432-05 INFO Instance name:
'ldap.cyber-range.lan-authn', Extension name:
'ovirt-engine-extension-aaa-ldap.authn', Version: '1.3.7', Notes:
'Display name: ovirt-engine-extension-aaa-ldap-1.3.7-1.el7.centos', License:
'ASL 2.0', Home: 'http://www.ovirt.org', Author 'The oVirt
Project', Build interface Version: '0', File:
'/tmp/tmprnxgRZ/extensions.d/ldap.cyber-range.lan-authn.properties', Initialized:
'true'
2018-10-23 16:44:09,433-05 INFO Instance name:
'ldap.cyber-range.lan', Extension name:
'ovirt-engine-extension-aaa-ldap.authz', Version: '1.3.7', Notes:
'Display name: ovirt-engine-extension-aaa-ldap-1.3.7-1.el7.centos', License:
'ASL 2.0', Home: 'http://www.ovirt.org', Author 'The oVirt
Project', Build interface Version: '0', File:
'/tmp/tmprnxgRZ/extensions.d/ldap.cyber-range.lan.properties', Initialized:
'true'
2018-10-23 16:44:09,433-05 INFO End of enabled extensions list
2018-10-23 16:44:09,433-05 INFO
========================================================================
2018-10-23 16:44:09,433-05 INFO ============================== Execution
===============================
2018-10-23 16:44:09,433-05 INFO
========================================================================
2018-10-23 16:44:09,433-05 INFO Iteration: 0
2018-10-23 16:44:09,434-05 INFO Profile='ldap.cyber-range.lan'
authn='ldap.cyber-range.lan-authn' authz='ldap.cyber-range.lan'
mapping='null'
2018-10-23 16:44:09,434-05 INFO API:
-->Authn.InvokeCommands.AUTHENTICATE_CREDENTIALS profile='ldap.cyber-range.lan'
user='admin'
2018-10-23 16:44:09,443-05 INFO API:
<--Authn.InvokeCommands.AUTHENTICATE_CREDENTIALS profile='ldap.cyber-range.lan'
result=CREDENTIALS_INVALID
2018-10-23 16:44:09,447-05 SEVERE Authn.Result code is: CREDENTIALS_INVALID
[ ERROR ] Login sequence failed
Please investigate details of the failure (search for lines containing SEVERE
log level).
Select test sequence to execute (Done, Abort, Login, Search) [Abort]: Abort
[ ERROR ] Failed to execute stage 'Setup validation': Aborted by user
[ INFO ] Stage: Clean up
Log file is available at
/tmp/ovirt-engine-extension-aaa-ldap-setup-20181023164215-uvjiii.log:
[ INFO ] Stage: Pre-termination
[ INFO ] Stage: Termination
[root@engine ~]# ovirt-engine-extensions-tool --log-level=FINEST aaa login-user
--user-name=admin --profile=ldap.cyber-range.lan
2018-10-23 17:28:53,690-05 FINE Version: ovirt-engine-4.2.6.4 ()
2018-10-23 17:28:53,720-05 INFO
========================================================================
2018-10-23 17:28:53,720-05 INFO ============================ Initialization
============================
2018-10-23 17:28:53,721-05 INFO
========================================================================
2018-10-23 17:28:53,722-05 FINE Loading extension file
'internal-authz.properties'
2018-10-23 17:28:53,751-05 INFO Loading extension 'internal-authz'
2018-10-23 17:28:53,752-05 FINEST Invoke Input BEGIN
2018-10-23 17:28:53,754-05 FINEST {Extkey[name=EXTENSION_INVOKE_COMMAND;type=class
org.ovirt.engine.api.extensions.ExtUUID;uuid=EXTENSION_INVOKE_COMMAND[485778ab-bede-4f1a-b823-77b262a2f28d];]=EXTENSION_LOAD[b0f2460e-7971-4a9c-b4e1-c1db1362a47a],
Extkey[name=EXTENSION_INVOKE_CONTEXT;type=class
org.ovirt.engine.api.extensions.ExtMap;uuid=EXTENSION_INVOKE_CONTEXT[886d2ebb-312a-49ae-9cc3-e1f849834b7d];]={Extkey[name=EXTENSION_GLOBAL_CONTEXT;type=class
org.ovirt.engine.api.extensions.ExtMap;uuid=EXTENSION_GLOBAL_CONTEXT[9799e72f-7af6-4cf1-bf08-297bc8903676];]=*skip*,
Extkey[name=EXTENSION_MANAGER_TRACE_LOG;type=interface
org.slf4j.Logger;uuid=EXTENSION_MANAGER_TRACE_LOG[863db666-3ea7-4751-9695-918a3197ad83];]=org.slf4j.impl.JDK14LoggerAdapter(org.ovirt.engine.core.extensions.mgr.ExtensionsManager.trace),
Extkey[name=EXTENSION_CONFIGURATION_SENSITIVE_KEYS;type=interface
java.util.Collection;uuid=EXTENSION_CONFIGURATION_SENSITIVE_KEYS[a456efa1-73ff-4204-9f9b-ebff01e35263];]=[],
Extkey[name=EXTENSION_PROVIDES;type=interface
java.util.Collection;uuid=EXTENSION_PROVIDES[8cf373a6-65b5-4594-b828-0e275087de91];]=[org.ovirt.engine.api.extensions.aaa.Authz],
Extkey[name=EXTENSION_LOCALE;type=class
java.lang.String;uuid=EXTENSION_LOCALE[0780b112-0ce0-404a-b85e-8765d778bb29];]=en_US,
Extkey[name=EXTENSION_CONFIGURATION_FILE;type=class
java.lang.String;uuid=EXTENSION_CONFIGURATION_FILE[4fb0ffd3-983c-4f3f-98ff-9660bd67af6a];]=/etc/ovirt-engine/extensions.d/internal-authz.properties,
Extkey[name=EXTENSION_CONFIGURATION;type=class
java.util.Properties;uuid=EXTENSION_CONFIGURATION[2d48ab72-f0a1-4312-b4ae-5068a226b0fc];]=***,
Extkey[name=EXTENSION_INTERFACE_VERSION_MAX;type=class
java.lang.Integer;uuid=EXTENSION_INTERFACE_VERSION_MAX[f4cff49f-2717-4901-8ee9-df362446e3e7];]=0,
Extkey[name=EXTENSION_INTERFACE_VERSION_MIN;type=class
java.lang.Integer;uuid=EXTENSION_INTERFACE_VERSION_MIN[2b84fc91-305b-497b-a1d7-d961b9d2ce0b];]=0,
Extkey[name=EXTENSION_INSTANCE_NAME;type=class
java.lang.String;uuid=EXTENSION_INSTANCE_NAME[65c67ff6-aeca-4bd5-a245-8674327f011b];]=internal-authz}}
2018-10-23 17:28:53,755-05 FINEST Invoke Input END
2018-10-23 17:28:53,759-05 FINEST Invoke Output BEGIN
2018-10-23 17:28:53,759-05 FINEST {Extkey[name=AAA_AUTHZ_STATUS;type=class
java.lang.Integer;uuid=AAA_AUTHZ_STATUS[566f0ba5-8329-4de1-952a-7a81e4bedd3e];]=0,
Extkey[name=EXTENSION_INVOKE_RESULT;type=class
java.lang.Integer;uuid=EXTENSION_INVOKE_RESULT[0909d91d-8bde-40fb-b6c0-099c772ddd4e];]=0}
2018-10-23 17:28:53,759-05 FINEST Invoke Output END
2018-10-23 17:28:53,760-05 INFO Extension 'internal-authz' loaded
2018-10-23 17:28:53,760-05 FINE Config BEGIN
2018-10-23 17:28:53,760-05 FINE ovirt.engine.extension.provides:
org.ovirt.engine.api.extensions.aaa.Authz
2018-10-23 17:28:53,761-05 FINE ovirt.engine.extension.binding.jbossmodule.class:
org.ovirt.engine.extension.aaa.jdbc.binding.api.AuthzExtension
2018-10-23 17:28:53,761-05 FINE ovirt.engine.extension.bindings.method: jbossmodule
2018-10-23 17:28:53,761-05 FINE config.datasource.file:
/etc/ovirt-engine/aaa/internal.properties
2018-10-23 17:28:53,761-05 FINE ovirt.engine.extension.name: internal-authz
2018-10-23 17:28:53,762-05 FINE ovirt.engine.extension.binding.jbossmodule.module:
org.ovirt.engine.extension.aaa.jdbc
2018-10-23 17:28:53,762-05 FINE Config END
2018-10-23 17:28:53,762-05 FINE Loading extension file
'internal-authn.properties'
2018-10-23 17:28:53,763-05 INFO Loading extension 'internal-authn'
2018-10-23 17:28:53,763-05 FINEST Invoke Input BEGIN
2018-10-23 17:28:53,764-05 FINEST {Extkey[name=EXTENSION_INVOKE_COMMAND;type=class
org.ovirt.engine.api.extensions.ExtUUID;uuid=EXTENSION_INVOKE_COMMAND[485778ab-bede-4f1a-b823-77b262a2f28d];]=EXTENSION_LOAD[b0f2460e-7971-4a9c-b4e1-c1db1362a47a],
Extkey[name=EXTENSION_INVOKE_CONTEXT;type=class
org.ovirt.engine.api.extensions.ExtMap;uuid=EXTENSION_INVOKE_CONTEXT[886d2ebb-312a-49ae-9cc3-e1f849834b7d];]={Extkey[name=EXTENSION_GLOBAL_CONTEXT;type=class
org.ovirt.engine.api.extensions.ExtMap;uuid=EXTENSION_GLOBAL_CONTEXT[9799e72f-7af6-4cf1-bf08-297bc8903676];]=*skip*,
Extkey[name=EXTENSION_MANAGER_TRACE_LOG;type=interface
org.slf4j.Logger;uuid=EXTENSION_MANAGER_TRACE_LOG[863db666-3ea7-4751-9695-918a3197ad83];]=org.slf4j.impl.JDK14LoggerAdapter(org.ovirt.engine.core.extensions.mgr.ExtensionsManager.trace),
Extkey[name=EXTENSION_CONFIGURATION_SENSITIVE_KEYS;type=interface
java.util.Collection;uuid=EXTENSION_CONFIGURATION_SENSITIVE_KEYS[a456efa1-73ff-4204-9f9b-ebff01e35263];]=[],
Extkey[name=EXTENSION_PROVIDES;type=interface
java.util.Collection;uuid=EXTENSION_PROVIDES[8cf373a6-65b5-4594-b828-0e275087de91];]=[org.ovirt.engine.api.extensions.aaa.Authn],
Extkey[name=EXTENSION_LOCALE;type=class
java.lang.String;uuid=EXTENSION_LOCALE[0780b112-0ce0-404a-b85e-8765d778bb29];]=en_US,
Extkey[name=EXTENSION_CONFIGURATION_FILE;type=class
java.lang.String;uuid=EXTENSION_CONFIGURATION_FILE[4fb0ffd3-983c-4f3f-98ff-9660bd67af6a];]=/etc/ovirt-engine/extensions.d/internal-authn.properties,
Extkey[name=EXTENSION_CONFIGURATION;type=class
java.util.Properties;uuid=EXTENSION_CONFIGURATION[2d48ab72-f0a1-4312-b4ae-5068a226b0fc];]=***,
Extkey[name=EXTENSION_INTERFACE_VERSION_MAX;type=class
java.lang.Integer;uuid=EXTENSION_INTERFACE_VERSION_MAX[f4cff49f-2717-4901-8ee9-df362446e3e7];]=0,
Extkey[name=EXTENSION_INTERFACE_VERSION_MIN;type=class
java.lang.Integer;uuid=EXTENSION_INTERFACE_VERSION_MIN[2b84fc91-305b-497b-a1d7-d961b9d2ce0b];]=0,
Extkey[name=EXTENSION_INSTANCE_NAME;type=class
java.lang.String;uuid=EXTENSION_INSTANCE_NAME[65c67ff6-aeca-4bd5-a245-8674327f011b];]=internal-authn}}
2018-10-23 17:28:53,765-05 FINEST Invoke Input END
2018-10-23 17:28:53,766-05 FINEST Invoke Output BEGIN
2018-10-23 17:28:53,766-05 FINEST {Extkey[name=EXTENSION_INVOKE_RESULT;type=class
java.lang.Integer;uuid=EXTENSION_INVOKE_RESULT[0909d91d-8bde-40fb-b6c0-099c772ddd4e];]=0}
2018-10-23 17:28:53,766-05 FINEST Invoke Output END
2018-10-23 17:28:53,766-05 INFO Extension 'internal-authn' loaded
2018-10-23 17:28:53,767-05 FINE Config BEGIN
2018-10-23 17:28:53,767-05 FINE ovirt.engine.aaa.authn.profile.name: internal
2018-10-23 17:28:53,767-05 FINE ovirt.engine.extension.provides:
org.ovirt.engine.api.extensions.aaa.Authn
2018-10-23 17:28:53,767-05 FINE ovirt.engine.extension.binding.jbossmodule.class:
org.ovirt.engine.extension.aaa.jdbc.binding.api.AuthnExtension
2018-10-23 17:28:53,767-05 FINE ovirt.engine.aaa.authn.authz.plugin: internal-authz
2018-10-23 17:28:53,768-05 FINE ovirt.engine.extension.bindings.method: jbossmodule
2018-10-23 17:28:53,768-05 FINE config.datasource.file:
/etc/ovirt-engine/aaa/internal.properties
2018-10-23 17:28:53,768-05 FINE ovirt.engine.extension.name: internal-authn
2018-10-23 17:28:53,768-05 FINE ovirt.engine.extension.binding.jbossmodule.module:
org.ovirt.engine.extension.aaa.jdbc
2018-10-23 17:28:53,768-05 FINE Config END
2018-10-23 17:28:53,769-05 INFO Initializing extension 'internal-authz'
2018-10-23 17:28:53,769-05 FINEST Invoke Input BEGIN
2018-10-23 17:28:53,771-05 FINEST {Extkey[name=EXTENSION_INVOKE_COMMAND;type=class
org.ovirt.engine.api.extensions.ExtUUID;uuid=EXTENSION_INVOKE_COMMAND[485778ab-bede-4f1a-b823-77b262a2f28d];]=EXTENSION_INITIALIZE[e5ae1b7f-9104-4f23-a444-7b9175ff68d2],
Extkey[name=EXTENSION_INVOKE_CONTEXT;type=class
org.ovirt.engine.api.extensions.ExtMap;uuid=EXTENSION_INVOKE_CONTEXT[886d2ebb-312a-49ae-9cc3-e1f849834b7d];]={Extkey[name=AAA_AUTHZ_AVAILABLE_NAMESPACES;type=interface
java.util.Collection;uuid=AAA_AUTHZ_AVAILABLE_NAMESPACES[6dffa34c-955f-486a-bd35-0a272b45a711];]=[*],
Extkey[name=EXTENSION_LICENSE;type=class
java.lang.String;uuid=EXTENSION_LICENSE[8a61ad65-054c-4e31-9c6d-1ca4d60a4c18];]=ASL 2.0,
Extkey[name=EXTENSION_GLOBAL_CONTEXT;type=class
org.ovirt.engine.api.extensions.ExtMap;uuid=EXTENSION_GLOBAL_CONTEXT[9799e72f-7af6-4cf1-bf08-297bc8903676];]=*skip*,
Extkey[name=EXTENSION_NAME;type=class
java.lang.String;uuid=EXTENSION_NAME[651381d3-f54f-4547-bf28-b0b01a103184];]="ovirt-engine-extension-aaa-jdbc".authz,
Extkey[name=EXTENSION_MANAGER_TRACE_LOG;type=interface
org.slf4j.Logger;uuid=EXTENSION_MANAGER_TRACE_LOG[863db666-3ea7-4751-9695-918a3197ad83];]=org.slf4j.impl.JDK14LoggerAdapter(org.ovirt.engine.core.extensions.mgr.ExtensionsManager.trace."ovirt-engine-extension-aaa-jdbc".authz.internal-authz),
Extkey[name=EXTENSION_CONFIGURATION_SENSITIVE_KEYS;type=interface
java.util.Collection;uuid=EXTENSION_CONFIGURATION_SENSITIVE_KEYS[a456efa1-73ff-4204-9f9b-ebff01e35263];]=[],
Extkey[name=EXTENSION_VERSION;type=class
java.lang.String;uuid=EXTENSION_VERSION[fe35f6a8-8239-4bdb-ab1a-af9f779ce68c];]="1.1.7_master",
Extkey[name=EXTENSION_PROVIDES;type=interface
java.util.Collection;uuid=EXTENSION_PROVIDES[8cf373a6-65b5-4594-b828-0e275087de91];]=[org.ovirt.engine.api.extensions.aaa.Authz],
Extkey[name=EXTENSION_AUTHOR;type=class
java.lang.String;uuid=EXTENSION_AUTHOR[ef242f7a-2dad-4bc5-9aad-e07018b7fbcc];]=The oVirt
Project, Extkey[name=EXTENSION_LOCALE;type=class
java.lang.String;uuid=EXTENSION_LOCALE[0780b112-0ce0-404a-b85e-8765d778bb29];]=en_US,
Extkey[name=EXTENSION_CONFIGURATION_FILE;type=class
java.lang.String;uuid=EXTENSION_CONFIGURATION_FILE[4fb0ffd3-983c-4f3f-98ff-9660bd67af6a];]=/etc/ovirt-engine/extensions.d/internal-authz.properties,
Extkey[name=EXTENSION_HOME_URL;type=class
java.lang.String;uuid=EXTENSION_HOME_URL[4ad7a2f4-f969-42d4-b399-72d192e1...,
Extkey[name=EXTENSION_CONFIGURATION;type=class
java.util.Properties;uuid=EXTENSION_CONFIGURATION[2d48ab72-f0a1-4312-b4ae-5068a226b0fc];]=***,
Extkey[name=EXTENSION_INTERFACE_VERSION_MAX;type=class
java.lang.Integer;uuid=EXTENSION_INTERFACE_VERSION_MAX[f4cff49f-2717-4901-8ee9-df362446e3e7];]=0,
Extkey[name=AAA_AUTHZ_QUERY_MAX_FILTER_SIZE;type=class
java.lang.Integer;uuid=AAA_AUTHZ_QUERY_MAX_FILTER_SIZE[2eb1f541-0f65-44a1-a6e3-014e247595f5];]=100,
Extkey[name=EXTENSION_INTERFACE_VERSION_MIN;type=class
java.lang.Integer;uuid=EXTENSION_INTERFACE_VERSION_MIN[2b84fc91-305b-497b-a1d7-d961b9d2ce0b];]=0,
Extkey[name=EXTENSION_INSTANCE_NAME;type=class
java.lang.String;uuid=EXTENSION_INSTANCE_NAME[65c67ff6-aeca-4bd5-a245-8674327f011b];]=internal-authz,
Extkey[name=AAA_AUTHZ_CAPABILITIES;type=class
java.lang.Long;uuid=AAA_AUTHZ_CAPABILITIES[6106d1fb-9291-4351-a947-b897b9540a23];]=1,
Extkey[name=EXTENSION_BUILD_INTERFACE_VERSION;type=class
java.lang.Integer;uuid=EXTENSION_BUILD_INTERFACE_VERSION[cb479e5a-4b23-46f8-aed3-56a4747a8ab7];]=0,
Extkey[name=EXTENSION_NOTES;type=class
java.lang.String;uuid=EXTENSION_NOTES[2da5ad7e-185a-4584-aaff-97f66978e4ea];]=Display
name: "ovirt-engine-extension-aaa-jdbc"}}
2018-10-23 17:28:53,771-05 FINEST Invoke Input END
2018-10-23 17:28:53,832-05 FINEST cursor for: SELECT COUNT(script) AS count FROM
schema_version WHERE script = $JcvsJ$upgrade/01_00_0060_missing_indexes.sql$JcvsJ$
2018-10-23 17:28:53,846-05 FINEST Invoke Output BEGIN
2018-10-23 17:28:53,846-05 FINEST {Extkey[name=AAA_AUTHZ_STATUS;type=class
java.lang.Integer;uuid=AAA_AUTHZ_STATUS[566f0ba5-8329-4de1-952a-7a81e4bedd3e];]=0,
Extkey[name=EXTENSION_INVOKE_RESULT;type=class
java.lang.Integer;uuid=EXTENSION_INVOKE_RESULT[0909d91d-8bde-40fb-b6c0-099c772ddd4e];]=0}
2018-10-23 17:28:53,846-05 FINEST Invoke Output END
2018-10-23 17:28:53,847-05 INFO Extension 'internal-authz' initialized
2018-10-23 17:28:53,847-05 FINE Extension 'internal-authz' initialized
2018-10-23 17:28:53,847-05 INFO Initializing extension 'internal-authn'
2018-10-23 17:28:53,848-05 FINEST Invoke Input BEGIN
2018-10-23 17:28:53,849-05 FINEST {Extkey[name=EXTENSION_INVOKE_COMMAND;type=class
org.ovirt.engine.api.extensions.ExtUUID;uuid=EXTENSION_INVOKE_COMMAND[485778ab-bede-4f1a-b823-77b262a2f28d];]=EXTENSION_INITIALIZE[e5ae1b7f-9104-4f23-a444-7b9175ff68d2],
Extkey[name=EXTENSION_INVOKE_CONTEXT;type=class
org.ovirt.engine.api.extensions.ExtMap;uuid=EXTENSION_INVOKE_CONTEXT[886d2ebb-312a-49ae-9cc3-e1f849834b7d];]={Extkey[name=EXTENSION_LICENSE;type=class
java.lang.String;uuid=EXTENSION_LICENSE[8a61ad65-054c-4e31-9c6d-1ca4d60a4c18];]=ASL 2.0,
Extkey[name=EXTENSION_GLOBAL_CONTEXT;type=class
org.ovirt.engine.api.extensions.ExtMap;uuid=EXTENSION_GLOBAL_CONTEXT[9799e72f-7af6-4cf1-bf08-297bc8903676];]=*skip*,
Extkey[name=EXTENSION_NAME;type=class
java.lang.String;uuid=EXTENSION_NAME[651381d3-f54f-4547-bf28-b0b01a103184];]="ovirt-engine-extension-aaa-jdbc".authn,
Extkey[name=EXTENSION_MANAGER_TRACE_LOG;type=interface
org.slf4j.Logger;uuid=EXTENSION_MANAGER_TRACE_LOG[863db666-3ea7-4751-9695-918a3197ad83];]=org.slf4j.impl.JDK14LoggerAdapter(org.ovirt.engine.core.extensions.mgr.ExtensionsManager.trace."ovirt-engine-extension-aaa-jdbc".authn.internal-authn),
Extkey[name=EXTENSION_CONFIGURATION_SENSITIVE_KEYS;type=interface
java.util.Collection;uuid=EXTENSION_CONFIGURATION_SENSITIVE_KEYS[a456efa1-73ff-4204-9f9b-ebff01e35263];]=[],
Extkey[name=EXTENSION_VERSION;type=class
java.lang.String;uuid=EXTENSION_VERSION[fe35f6a8-8239-4bdb-ab1a-af9f779ce68c];]="1.1.7_master",
Extkey[name=EXTENSION_PROVIDES;type=interface
java.util.Collection;uuid=EXTENSION_PROVIDES[8cf373a6-65b5-4594-b828-0e275087de91];]=[org.ovirt.engine.api.extensions.aaa.Authn],
Extkey[name=EXTENSION_AUTHOR;type=class
java.lang.String;uuid=EXTENSION_AUTHOR[ef242f7a-2dad-4bc5-9aad-e07018b7fbcc];]=The oVirt
Project, Extkey[name=EXTENSION_LOCALE;type=class
java.lang.String;uuid=EXTENSION_LOCALE[0780b112-0ce0-404a-b85e-8765d778bb29];]=en_US,
Extkey[name=EXTENSION_CONFIGURATION_FILE;type=class
java.lang.String;uuid=EXTENSION_CONFIGURATION_FILE[4fb0ffd3-983c-4f3f-98ff-9660bd67af6a];]=/etc/ovirt-engine/extensions.d/internal-authn.properties,
Extkey[name=EXTENSION_HOME_URL;type=class
java.lang.String;uuid=EXTENSION_HOME_URL[4ad7a2f4-f969-42d4-b399-72d192e1...,
Extkey[name=EXTENSION_CONFIGURATION;type=class
java.util.Properties;uuid=EXTENSION_CONFIGURATION[2d48ab72-f0a1-4312-b4ae-5068a226b0fc];]=***,
Extkey[name=EXTENSION_INTERFACE_VERSION_MAX;type=class
java.lang.Integer;uuid=EXTENSION_INTERFACE_VERSION_MAX[f4cff49f-2717-4901-8ee9-df362446e3e7];]=0,
Extkey[name=EXTENSION_INTERFACE_VERSION_MIN;type=class
java.lang.Integer;uuid=EXTENSION_INTERFACE_VERSION_MIN[2b84fc91-305b-497b-a1d7-d961b9d2ce0b];]=0,
Extkey[name=EXTENSION_INSTANCE_NAME;type=class
java.lang.String;uuid=EXTENSION_INSTANCE_NAME[65c67ff6-aeca-4bd5-a245-8674327f011b];]=internal-authn,
Extkey[name=EXTENSION_BUILD_INTERFACE_VERSION;type=class
java.lang.Integer;uuid=EXTENSION_BUILD_INTERFACE_VERSION[cb479e5a-4b23-46f8-aed3-56a4747a8ab7];]=0,
Extkey[name=AAA_AUTHN_CAPABILITIES;type=class
java.lang.Long;uuid=AAA_AUTHN_CAPABILITIES[9d16bee3-10fd-46f2-83f9-3d3c54cf258d];]=44,
Extkey[name=EXTENSION_NOTES;type=class
java.lang.String;uuid=EXTENSION_NOTES[2da5ad7e-185a-4584-aaff-97f66978e4ea];]=Display
name: "ovirt-engine-extension-aaa-jdbc"}}
2018-10-23 17:28:53,849-05 FINEST Invoke Input END
2018-10-23 17:28:53,856-05 FINEST cursor for: SELECT COUNT(script) AS count FROM
schema_version WHERE script = $cnCUr$upgrade/01_00_0060_missing_indexes.sql$cnCUr$
2018-10-23 17:28:53,859-05 FINEST Invoke Output BEGIN
2018-10-23 17:28:53,859-05 FINEST {Extkey[name=EXTENSION_INVOKE_RESULT;type=class
java.lang.Integer;uuid=EXTENSION_INVOKE_RESULT[0909d91d-8bde-40fb-b6c0-099c772ddd4e];]=0}
2018-10-23 17:28:53,859-05 FINEST Invoke Output END
2018-10-23 17:28:53,859-05 INFO Extension 'internal-authn' initialized
2018-10-23 17:28:53,860-05 FINE Extension 'internal-authn' initialized
2018-10-23 17:28:53,860-05 INFO Start of enabled extensions list
2018-10-23 17:28:53,860-05 INFO Instance name: 'internal-authn', Extension
name: '"ovirt-engine-extension-aaa-jdbc".authn', Version:
'"1.1.7_master"', Notes: 'Display name:
"ovirt-engine-extension-aaa-jdbc"', License: 'ASL 2.0', Home:
'http://www.ovirt.org', Author 'The oVirt Project', Build interface
Version: '0', File:
'/etc/ovirt-engine/extensions.d/internal-authn.properties', Initialized:
'true'
2018-10-23 17:28:53,860-05 INFO Instance name: 'internal-authz', Extension
name: '"ovirt-engine-extension-aaa-jdbc".authz', Version:
'"1.1.7_master"', Notes: 'Display name:
"ovirt-engine-extension-aaa-jdbc"', License: 'ASL 2.0', Home:
'http://www.ovirt.org', Author 'The oVirt Project', Build interface
Version: '0', File:
'/etc/ovirt-engine/extensions.d/internal-authz.properties', Initialized:
'true'
2018-10-23 17:28:53,861-05 INFO End of enabled extensions list
2018-10-23 17:28:53,861-05 INFO
========================================================================
2018-10-23 17:28:53,861-05 INFO ============================== Execution
===============================
2018-10-23 17:28:53,861-05 INFO
========================================================================
2018-10-23 17:28:53,861-05 INFO Iteration: 0
2018-10-23 17:28:53,863-05 SEVERE Profile 'ldap.cyber-range.lan' not found
2018-10-23 17:28:53,863-05 FINE Exception:
java.lang.IllegalArgumentException: Profile 'ldap.cyber-range.lan' not found
at
org.ovirt.engine.exttool.aaa.AAAServiceImpl.getExtensionByProfile(AAAServiceImpl.java:549)
at
org.ovirt.engine.exttool.aaa.AAAServiceImpl.access$1200(AAAServiceImpl.java:37)
at
org.ovirt.engine.exttool.aaa.AAAServiceImpl$AAAProfile.<init>(AAAServiceImpl.java:838)
at
org.ovirt.engine.exttool.aaa.AAAServiceImpl$Action.lambda$static$3(AAAServiceImpl.java:154)
at
org.ovirt.engine.exttool.aaa.AAAServiceImpl$Action.execute(AAAServiceImpl.java:417)
at org.ovirt.engine.exttool.aaa.AAAServiceImpl.run(AAAServiceImpl.java:686)
at
org.ovirt.engine.exttool.core.ExtensionsToolExecutor.main(ExtensionsToolExecutor.java:120)
at org.jboss.modules.Module.run(Module.java:352)
at org.jboss.modules.Module.run(Module.java:320)
at org.jboss.modules.Main.main(Main.java:593)
2018-10-23 17:28:53,864-05 FINE Exiting with status '1'