Sophomorix Value error

Hallo,

nachdem ich meinen 7.1-Server gestern mal wieder „auf Stand gebracht“ habe, bekomme ich heute folgende Fehlermeldung, wenn ich mich als global-admin an der Schulkonsole einlogge:

grafik

Im Traceback steht:

Traceback (most recent call last):
  File "/usr/lib/linuxmuster-webui/plugins/lmn_common/api.py", line 130, in lmn_getSophomorixValue
    f"Sophomorix stdout :\n {t.stdout.decode('utf-8')}"
  File "/usr/local/lib/python3.6/dist-packages/dpath/util.py", line 179, in get
    raise KeyError(glob)
KeyError: 'USER/user/global-admin'

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "/usr/local/lib/python3.6/dist-packages/aj/api/endpoint.py", line 75, in wrapper
    result = fx(self, context, *args, **kwargs)
  File "/usr/lib/linuxmuster-webui/plugins/lmn_landingpage/views.py", line 36, in handle_api_quota
  File "/usr/lib/linuxmuster-webui/plugins/lmn_common/api.py", line 133, in lmn_getSophomorixValue
Exception: Sophomorix Value error !

Either sophomorix field does not exist or user does not have sufficient permissions:
Error Message: 'USER/user/global-admin'
Dictionary we looked for information:
{'COUNTERS': {'ROOM': 0, 'ALL': 0, 'USER': 0, 'COMPUTER': 0, 'GROUP': 0, 'SCHOOL': 0}, 'LISTS': {'GROUP': [], 'COMPUTER': [], 'USER': [], 'ALL': [], 'ROOM': []}}

Ausführung von sophomorix-check, sophomorix-update sowie sophomorix-quota auf der Console hat keine Verbesserung gebracht.

Ausgabe von sophomorix-check:

root@server:~# sophomorix-check
Command line::
Option verbose is a modifier option
Option json is a modifier option
Hmmh. do not know what to do with option info
* forcing info mode
Option combinations successfully checked
OK: SophomorixSchemaVersion 1 matches required Version 1
#### Reading /usr/share/sophomorix/devel/sophomorix.ini                       ####
#### Distro-check: Ubuntu 18.04 is OK                                         ####
#### Reading /etc/samba/smb.conf                                              ####
#### Reading /usr/lib/linuxmuster-webui/etc/default-ui-permissions.ini        ####
#### Parsing: net conf list                                                   ####
#### Asking domain passwordsettings from samba                                ####
#### Reading /etc/linuxmuster/sophomorix/sophomorix.conf                      ####
#### Reading /etc/linuxmuster/sophomorix/default-school/school.conf           ####
#### 0 ERRORS, 0 WARNINGS -> let's go                                         ####
#### Creating lock in /var/lib/sophomorix/lock/sophomorix.lock                ####
#### /usr/sbin/sophomorix-check started ...                                   ####
#### Cleaning up last check                                                   ####
Encoding extrastudents.csv: UTF8 (ENCODING=auto,*_FORCE=FALSE, *_CHECKED=UTF8)
Encoding students.csv: UTF8 (ENCODING=auto,*_FORCE=FALSE, *_CHECKED=UTF8)
Encoding teachers.csv: UTF8 (ENCODING=auto,*_FORCE=FALSE, *_CHECKED=UTF8)
#### Reading injected lines ...                                               ####
#### 0 ERRORS, 0 WARNINGS -> let's go                                         ####
#### Searching AD for users ...                                               ####
#### Query AD (begin)                                                         ####
#### Query AD (end)                                                           ####

#### ### School default-school: Matching lines in files to users in AD ...    ####
#### unidMATCH: 44 CHECKED in default-school, MATCH: 1, NOMATCH: 43, NOunid: 0####
#### exactMATCH: 43 CHECKED in default-school, MATCH: 43, NOMATCH: 0          ####
#### approxMATCH: 0 CHECKED in default-school, MATCH: 0 (Edit distance: 1)    ####
#### ## School default-school ... Done!                                       ####
#### Removing lock in /var/lib/sophomorix/lock/sophomorix.lock                ####
#### /usr/sbin/sophomorix-check terminated regularly                          ####
Calling console printout
LOG       : /usr/sbin/sophomorix-check terminated regularly
##### Overview of what can be done:
     0 users can be added in sophomorix.add
     0 users can be updated in sophomorix.update
     0 users can be killed in sophomorix.kill
    48 users are not to be changed in sophomorix.nochange
     0 users with errors in sophomorix.error

Installiert sind

linuxmuster-base7/unbekannt,now 7.1.21-0 all  [installiert]
linuxmuster-linbo-gui7/unbekannt,now 7.0.6 all  [Installiert,automatisch]
linuxmuster-linbo7/unbekannt,now 4.0.44-0 all  [Installiert,automatisch]
linuxmuster-prepare/unbekannt,now 7.2.0-0 all  [installiert]
linuxmuster-webui7/unbekannt,now 7.1.51 all  [Installiert,automatisch]

Weiß jemand Abhilfe?

Beste Grüße,
Jens

Hallo Jens,

sophomorix-check überprüft, ob man User hinzufügen oder löschen sollte.
In deinem Fall liegt das Problem beim Quotabefehl.

Was ergibt :

sophomorix-query --sam global-admin --user-full --quota-usage -j

? ( bitte nicht hier posten, nur die Fehlermeldungen, oder bei mir als PM )

Gruß

Arnaud

Hallo Jens,

Danke für den Output ( als PM gegeben ), ich sehe drin keinerlei Fehlermeldung.
Aber ich bin sehr erstaunt, dass die Ursache in die Datei /usr/lib/linuxmuster-webui/plugins/lmn_landingpage/views.py Zeile 36 angezeigt wird.
Diese Datei sollte leer sein !

Falls es leer ist, bitte die Webui neu starten. Ansonstens müssen wir weiterforschen.

Gruß

Arnaud

Hallo Arnaud,

Du hast Recht: usr/lib/linuxmuster-webui/plugins/lmn_landingpage/views.py ist leer.

Ich habe jetzt die WebUI neu gestartet. Jetzt bekomme ich beim neuen Laden des WebUI die Fehlermeldung

Warning! The following plugin has failed to load: lmn_samba_shares. Please fix or uninstall it.

Logge ich mich ein, kommt diese Fehlermeldung:

Vielen Dank für Deine Hilfe!
Jens

Hallo Jens,

Da ist etwas während das Update schief gegangen, weil normalerweise startet die Webui automatisch neu am Ende.
Man kann es reparieren, da es nicht um Daten geht.

Was gibt es als Fehlermeldung in /var/log/ajenti/ajenti.log ?

Eventuell hilft ein :

apt install --reinstall linuxmuster-webui7

Gruß

Arnaud

1 „Gefällt mir“

Hallo Arnaud,

im ajenti.log steht für einen Login-Vorgang des global-admin:

2023-03-26 18:04:12,810 INFO    : 10.32.1.1 - - [2023-03-26 18:04:12] "POST /api/core/logout HTTP/1.1" 200 166 0.055530
2023-03-26 18:04:13,765 INFO    : 10.32.1.1 - - [2023-03-26 18:04:13] "GET /view/login/normal//view/lmn/landingpage HTTP/1.1" 200 12090 0.011092
2023-03-26 18:04:14,026 INFO    : 10.32.1.1 - - [2023-03-26 18:04:14] "GET /api/core/web-manifest HTTP/1.1" 200 442 0.007961
2023-03-26 18:04:14,033 INFO    : 10.32.1.1 - - [2023-03-26 18:04:14] "GET /resources/all.css HTTP/1.1" 200 29257 0.013249
2023-03-26 18:04:14,035 INFO    : 10.32.1.1 - - [2023-03-26 18:04:14] "GET /resources/all.vendor.css HTTP/1.1" 200 17201 0.014566
2023-03-26 18:04:14,058 INFO    : 10.32.1.1 - - [2023-03-26 18:04:14] "GET /resources/all.js HTTP/1.1" 200 78393 0.036189
2023-03-26 18:04:14,059 INFO    : 10.32.1.1 - - [2023-03-26 18:04:14] "GET /resources/all.init.js HTTP/1.1" 200 614 0.035393
2023-03-26 18:04:14,213 INFO    : 10.32.1.1 - - [2023-03-26 18:04:14] "GET /resources/all.vendor.js HTTP/1.1" 200 655459 0.188597
2023-03-26 18:04:14,380 INFO    : 10.32.1.1 - - [2023-03-26 18:04:14] "GET /resources/all.partials.js HTTP/1.1" 200 71160 0.019339
2023-03-26 18:04:14,712 INFO    : 10.32.1.1 - - [2023-03-26 18:04:14] "GET /resources/all.locale.js?lang=de HTTP/1.1" 200 20835 0.007151
2023-03-26 18:04:14,713 INFO    : 10.32.1.1 - - [2023-03-26 18:04:14] "GET /api/core/identity HTTP/1.1" 200 420 0.007114
2023-03-26 18:04:14,714 INFO    : 10.32.1.1 - - [2023-03-26 18:04:14] "GET /api/core/session-time HTTP/1.1" 401 127 0.006593
2023-03-26 18:04:14,714 INFO    : 10.32.1.1 - - [2023-03-26 18:04:14] "GET /api/core/sidebar HTTP/1.1" 401 127 0.005912
2023-03-26 18:04:33,506 INFO    : 10.32.1.1 - - [2023-03-26 18:04:33] "GET /view/login/normal//view/lmn/landingpage HTTP/1.1" 200 12090 0.002678
2023-03-26 18:04:33,840 INFO    : 10.32.1.1 - - [2023-03-26 18:04:33] "GET /resources/all.vendor.css HTTP/1.1" 200 17201 0.003994
2023-03-26 18:04:33,841 INFO    : 10.32.1.1 - - [2023-03-26 18:04:33] "GET /api/core/web-manifest HTTP/1.1" 200 442 0.004102
2023-03-26 18:04:33,848 INFO    : 10.32.1.1 - - [2023-03-26 18:04:33] "GET /resources/all.css HTTP/1.1" 200 29257 0.009475
2023-03-26 18:04:33,997 INFO    : 10.32.1.1 - - [2023-03-26 18:04:33] "GET /resources/all.vendor.js HTTP/1.1" 200 655459 0.158070
2023-03-26 18:04:34,001 INFO    : 10.32.1.1 - - [2023-03-26 18:04:34] "GET /resources/all.js HTTP/1.1" 200 78393 0.156041
2023-03-26 18:04:34,001 INFO    : 10.32.1.1 - - [2023-03-26 18:04:34] "GET /resources/all.init.js HTTP/1.1" 200 614 0.155720
2023-03-26 18:04:34,224 INFO    : 10.32.1.1 - - [2023-03-26 18:04:34] "GET /resources/all.partials.js HTTP/1.1" 200 71160 0.019378
2023-03-26 18:04:34,554 INFO    : 10.32.1.1 - - [2023-03-26 18:04:34] "GET /resources/all.locale.js?lang=de HTTP/1.1" 200 20835 0.006342
2023-03-26 18:04:34,556 INFO    : 10.32.1.1 - - [2023-03-26 18:04:34] "GET /api/core/session-time HTTP/1.1" 401 127 0.006922
2023-03-26 18:04:34,556 INFO    : 10.32.1.1 - - [2023-03-26 18:04:34] "GET /api/core/sidebar HTTP/1.1" 401 127 0.006519
2023-03-26 18:04:34,557 INFO    : 10.32.1.1 - - [2023-03-26 18:04:34] "GET /api/core/identity HTTP/1.1" 200 420 0.006271
2023-03-26 18:04:43,582 WARNING : Initializing Kerberos ticket for global-admin
2023-03-26 18:04:43,926 INFO    : Opening a session for user global-admin
2023-03-26 18:04:43,926 INFO    : Opening a new worker gate for session 3, client 10.32.1.1
2023-03-26 18:04:43,936 INFO    : 10.32.1.1 - - [2023-03-26 18:04:43] "POST /api/core/auth HTTP/1.1" 200 3030 0.501914
2023-03-26 18:04:43,940 INFO    : New worker "session 3" PID 26503, EUID 0, EGID 0
2023-03-26 18:04:43,940 INFO    : Authenticating session as global-admin
2023-03-26 18:04:44,626 WARNING : Changing kerberos ticket rights for global-admin
2023-03-26 18:04:44,730 INFO    : Detected encoding for /var/lib/linuxmuster/setup.ini : ascii, but using utf-8
2023-03-26 18:04:44,736 INFO    : Detected encoding for /var/lib/linuxmuster/setup.ini : ascii, but using utf-8
2023-03-26 18:04:44,744 INFO    : Detected encoding for /etc/linuxmuster/sophomorix/default-school/devices.csv : ascii, but using utf-8
2023-03-26 18:04:44,750 INFO    : Detected encoding for /etc/linuxmuster/sophomorix/default-school/devices.csv : ascii, but using utf-8
2023-03-26 18:04:44,753 INFO    : 10.32.1.1 - - [2023-03-26 18:04:44] "GET / HTTP/1.1" 302 153 0.553030
2023-03-26 18:04:45,002 INFO    : 10.32.1.1 - - [2023-03-26 18:04:45] "GET /view/ HTTP/1.1" 200 12093 0.003123
2023-03-26 18:04:45,262 INFO    : 10.32.1.1 - - [2023-03-26 18:04:45] "GET /api/core/web-manifest HTTP/1.1" 200 445 0.008620
2023-03-26 18:04:45,272 INFO    : 10.32.1.1 - - [2023-03-26 18:04:45] "GET /resources/all.css HTTP/1.1" 200 29260 0.016591
2023-03-26 18:04:45,278 INFO    : 10.32.1.1 - - [2023-03-26 18:04:45] "GET /resources/all.vendor.css HTTP/1.1" 200 17204 0.021437
2023-03-26 18:04:45,306 INFO    : 10.32.1.1 - - [2023-03-26 18:04:45] "GET /resources/all.js HTTP/1.1" 200 78396 0.048052
2023-03-26 18:04:45,307 INFO    : 10.32.1.1 - - [2023-03-26 18:04:45] "GET /resources/all.init.js HTTP/1.1" 200 617 0.047419
2023-03-26 18:04:45,472 INFO    : 10.32.1.1 - - [2023-03-26 18:04:45] "GET /resources/all.vendor.js HTTP/1.1" 200 655462 0.211888
2023-03-26 18:04:45,603 INFO    : 10.32.1.1 - - [2023-03-26 18:04:45] "GET /resources/all.partials.js HTTP/1.1" 200 71163 0.036455
2023-03-26 18:04:45,968 INFO    : 10.32.1.1 - - [2023-03-26 18:04:45] "GET /api/core/identity HTTP/1.1" 200 1497 0.046417
2023-03-26 18:04:45,982 INFO    : 10.32.1.1 - - [2023-03-26 18:04:45] "GET /resources/all.locale.js?lang=de HTTP/1.1" 200 20838 0.059302
2023-03-26 18:04:45,987 INFO    : 10.32.1.1 - - [2023-03-26 18:04:45] "GET /api/core/sidebar HTTP/1.1" 200 4012 0.061875
2023-03-26 18:04:45,992 INFO    : 10.32.1.1 - - [2023-03-26 18:04:45] "GET /api/core/session-time HTTP/1.1" 200 166 0.067495
2023-03-26 18:04:46,213 INFO    : 10.32.1.1 - - [2023-03-26 18:04:46] "GET /api/lmn/setup-wizard/is-configured HTTP/1.1" 200 166 0.003239
2023-03-26 18:04:46,217 INFO    : 10.32.1.1 - - [2023-03-26 18:04:46] "GET /api/lmn/users/global-admin/customfields HTTP/1.1" 500 6294 0.004660
2023-03-26 18:04:46,977 INFO    : 10.32.1.1 - - [2023-03-26 18:04:46] "GET /api/lmn/quota/user/global-admin HTTP/1.1" 200 5407 0.765651

Das Problem ist aber gelöst: Du hattest vollkommen Recht, dass wohl was mit meinem Update nicht richtig durchgelaufen ist … ein apt-Prozess hing noch (36h später). Den habe ich nun gekillt und anschließend ein

dpkg --configure -a

durchlaufen lassen. Dabei wurde u.a. das WebUI noch konfiguriert und neu gestartet. Anschließend funktioniert nun wieder alles.

Vielen Dank für Deine tolle Hilfe selbst am Sonntagnachmittag. Ich bin (mal wieder) begeistert!

Beste Grüße,
Jens