Univention Bugzilla – Bug 42333
System setup ignores fatal errors
Last modified: 2020-07-02 09:58:03 CEST
./univention/setup.log:__MSG__:univention-server-master (amd64) wird installiert. ./univention/setup.log:__MSG__:univention-server-master (amd64) wird vorbereitet. ./univention/setup.log:__MSG__:univention-server-master (amd64) wird entpackt. ./univention/setup.log:__MSG__:Konfiguration von univention-server-master (amd64) wird vorbereitet. ./univention/setup.log:__ERR__:univention-server-master: Failed to install Very little works afterwards
Package "univention-server-master" is not configured → UCRV "ldap/server/type" is not set → "management/univention-ldap/01univention-ldap-server-init.inst" can setup LDAP → univention-role-server-common is not configured → univention-home-mounter is not configured → nfs-common is not configured → "update-rc.d nfs-common defaults": insserv rejected the script header → Service rpcbind has to be enabled → Running in chroot, ignoring request. → univention-nfs-server is not configured has been fixed, but the issue remains.
For the bugzilla search: univention-server-master: Failed to uninstall univention-server-backup: Failed to install
*** Bug 33418 has been marked as a duplicate of this bug. ***
(In reply to Florian Best from comment #3) > *** Bug 33418 has been marked as a duplicate of this bug. *** This is one example of this bug.
Task #4777: 2016-11-24/25 - UCS-Technikschulung - Bremen /usr/lib/univention-system-setup/scripts/setup-join.sh: >219 run-parts -v /usr/lib/univention-system-setup/scripts/50_software /var/log/installer/syslog: >=== 50_software/10software (2016-11-25 18:26:19) === >__NAME__:50_software/10software Einrichten der Software-Komponenten >__STEPS__:900 >File: /etc/apt/sources.list.d/15_ucs-online-version.list ># An error occurred during the repository check. The error message: >__MSG__:Es wurden 0 B in 0 s geholt (0 B/s) >__ERR__:Fetching failed >__ERR__: >Further information regarding this error: >Error: Problem executing scripts APT::Update::Pre-Invoke 'grep -Fqs '# An error occurred during the repository check.' /etc/apt/sources.list.d/15_ucs-online-version.list && ucr commit /etc/apt/sources.list.d/15_ucs-online-version.list ; ! grep -F '# An error occurred during the repository check.' /etc/apt/sources.list.d/15_ucs-online-version.list'. >__ERR__:Error: Sub-process returned an error code. >run-parts: /usr/lib/univention-system-setup/scripts/50_software/10software exited with return code 1 As the script does not "set -e", it ignores all errors. After the installation /etc/apt/sources.list.d/15_ucs-online-version.list looks sane, but all component packages were NOT installed. I was able to reproduce this behavior after the training: 3/6 failed, after that 2/3. Around 18:26:19 several daemons were restarted: >Nov 25 18:26:10 logger: /etc/init.d/slapd restart (pid: 13068, ppid:13051 invoke-rc.d) >Nov 25 18:26:10 logger: /etc/init.d/slapd stop (pid: 13076, ppid:13068 slapd) >Nov 25 18:26:10 slapd[8458]: daemon: shutdown requested and initiated. >Nov 25 18:26:10 slapd[8458]: slapd shutdown: waiting for 0 operations/tasks to finish >Nov 25 18:26:10 slapd[8458]: DIGEST-MD5 common mech free >Nov 25 18:26:10 slapd[8458]: slapd stopped. >Nov 25 18:26:10 logger: /etc/init.d/slapd start (pid: 13089, ppid:13068 slapd) ... >Nov 25 18:26:18 postfix/master[13319]: daemon started -- version 2.9.6, configuration /etc/postfix ... >Nov 25 18:26:20 slapd[13101]: daemon: shutdown requested and initiated. >Nov 25 18:26:20 slapd[13101]: slapd shutdown: waiting for 0 operations/tasks to finish >Nov 25 18:26:20 slapd[13101]: DIGEST-MD5 common mech free >Nov 25 18:26:20 slapd[13101]: slapd stopped. ... Th first restart was triggered by /usr/lib/univention-system-setup/scripts/40_ssl/10ssl, which alt least restarts "slapd apache2 cyrus postfix". I also see DNS requests for: > Nov 25 18:26:18 named[31433]: error (network unreachable) resolving 'univention-repository.knut.univention.de.schulung7.ucs/A/IN': 2001:500:2d::d#53 (Yes I used out internal repository for installation while the PCs were still connected to KNUT)
# An error occurred during the repository check. The error message: # Traceback (most recent call last): # File "<stdin>", line 13, in <module> # File "/usr/lib/pymodules/python2.7/univention/updater/tools.py", line 579, in __init__ # self.ucr_reinit() # File "/usr/lib/pymodules/python2.7/univention/updater/tools.py", line 651, in ucr_reinit # assert self.server.access(None, '/univention-repository/') # File "/usr/lib/pymodules/python2.7/univention/updater/tools.py", line 488, in access # raise ConfigurationError(uri, reason) # ConfigurationError: Configuration error: host is unresolvable # This was caused by one "named" running from Debians /etc/init.d/bind9, which does not get terminated when the UCS ones try to start; that one has no forwarders set and thus resolves "univention-repository.knut.univention.de" by appending its DNS domain name, which fails. Maybe that (BIND started by Debian's init.d before the switch-over to UCS-BIND-{ldap,proxy,samba}) should be checked too.
Still with UCS 5.0: [master090] 2020-07-01T23:40:31.907963 __ERR__:Traceback (most recent call last): [master090] 2020-07-01T23:40:31.907963 __ERR__: File "/usr/lib/python2.7/dist-packages/univention/management/console/modules/setup/setup_script.py", line 313, in run [master090] 2020-07-01T23:40:31.907963 __ERR__: success = self.inner_run() [master090] 2020-07-01T23:40:31.907963 __ERR__: File "/usr/lib/univention-system-setup/scripts/50_software/10software", line 76, in inner_run [master090] 2020-07-01T23:40:31.907963 __ERR__: self.autoremove() [master090] 2020-07-01T23:40:31.907963 __ERR__: File "/usr/lib/python2.7/dist-packages/univention/management/console/modules/setup/setup_script.py", line 443, in autoremove [master090] 2020-07-01T23:40:31.907963 __ERR__: self.package_manager.autoremove() [master090] 2020-07-01T23:40:31.907963 __ERR__: File "/usr/lib/python2.7/dist-packages/univention/lib/package_manager.py", line 1111, in autoremove [master090] 2020-07-01T23:40:31.907963 __ERR__: return self.commit(msg_if_failed=failed_msg) [master090] 2020-07-01T23:40:31.907963 __ERR__: File "/usr/lib/python2.7/dist-packages/univention/lib/package_manager.py", line 945, in commit [master090] 2020-07-01T23:40:31.907963 __ERR__: result = self.cache.commit(**kwargs) [master090] 2020-07-01T23:40:31.907963 __ERR__: File "/usr/lib/python2.7/dist-packages/apt/cache.py", line 549, in commit [master090] 2020-07-01T23:40:31.907963 __ERR__: res = self.install_archives(pm, install_progress) [master090] 2020-07-01T23:40:31.907963 __ERR__: File "/usr/lib/python2.7/dist-packages/apt/cache.py", line 508, in install_archives [master090] 2020-07-01T23:40:31.907963 __ERR__: res = install_progress.run(pm) [master090] 2020-07-01T23:40:31.907963 __ERR__: File "/usr/lib/python2.7/dist-packages/apt/progress/base.py", line 208, in run [master090] 2020-07-01T23:40:31.907963 __ERR__: res = self.wait_child() [master090] 2020-07-01T23:40:31.907963 __ERR__: File "/usr/lib/python2.7/dist-packages/apt/progress/base.py", line 279, in wait_child [master090] 2020-07-01T23:40:31.907963 __ERR__: self.update_interface() [master090] 2020-07-01T23:40:31.907963 __ERR__: File "/usr/lib/python2.7/dist-packages/apt/progress/base.py", line 256, in update_interface [master090] 2020-07-01T23:40:31.907963 __ERR__: self.status_change(pkgname, float(percent), status_str.strip()) [master090] 2020-07-01T23:40:31.907963 __ERR__: File "/usr/lib/python2.7/dist-packages/univention/lib/package_manager.py", line 349, in status_change [master090] 2020-07-01T23:40:31.907963 __ERR__: self.progress_state.percentage(str(percent)) [master090] 2020-07-01T23:40:31.907963 __ERR__: File "/usr/lib/python2.7/dist-packages/univention/lib/package_manager.py", line 143, in percentage [master090] 2020-07-01T23:40:31.907963 __ERR__: self.get_logger(logger_name).info(percentage) [master090] 2020-07-01T23:40:31.907963 __ERR__: File "/usr/lib/python2.7/logging/__init__.py", line 1167, in info [master090] 2020-07-01T23:40:31.907963 __ERR__: self._log(INFO, msg, args, **kwargs) [master090] 2020-07-01T23:40:31.907963 __ERR__: File "/usr/lib/python2.7/logging/__init__.py", line 1286, in _log [master090] 2020-07-01T23:40:31.907963 __ERR__: self.handle(record) [master090] 2020-07-01T23:40:31.907963 __ERR__: File "/usr/lib/python2.7/logging/__init__.py", line 1296, in handle [master090] 2020-07-01T23:40:31.907963 __ERR__: self.callHandlers(record) [master090] 2020-07-01T23:40:31.907963 __ERR__: File "/usr/lib/python2.7/logging/__init__.py", line 1336, in callHandlers [master090] 2020-07-01T23:40:31.907963 __ERR__: hdlr.handle(record) [master090] 2020-07-01T23:40:31.907963 __ERR__: File "/usr/lib/python2.7/logging/__init__.py", line 759, in handle [master090] 2020-07-01T23:40:31.907963 __ERR__: self.emit(record) [master090] 2020-07-01T23:40:31.907963 __ERR__: File "/usr/lib/python2.7/dist-packages/univention/management/console/modules/setup/setup_script.py", line 357, in emit [master090] 2020-07-01T23:40:31.907963 __ERR__: super(_PackageManagerLoggerHandlerWithoutProcess, self).emit(record) [master090] 2020-07-01T23:40:31.907963 __ERR__: File "/usr/lib/python2.7/dist-packages/univention/lib/package_manager.py", line 403, in emit [master090] 2020-07-01T23:40:31.907963 __ERR__: self.step_handler(record.msg) [master090] 2020-07-01T23:40:31.907963 __ERR__: File "/usr/lib/python2.7/dist-packages/univention/management/console/modules/setup/setup_script.py", line 285, in step [master090] 2020-07-01T23:40:31.907963 __ERR__: self._step += 1 [master090] 2020-07-01T23:40:31.907963 __ERR__:TypeError: cannot concatenate 'str' and 'int' objects [master090] 2020-07-01T23:40:31.908478 Traceback (most recent call last): [master090] 2020-07-01T23:40:31.908478 File "/usr/lib/python2.7/dist-packages/univention/management/console/modules/setup/setup_script.py", line 313, in run [master090] 2020-07-01T23:40:31.908478 success = self.inner_run() [master090] 2020-07-01T23:40:31.908478 File "/usr/lib/univention-system-setup/scripts/50_software/10software", line 76, in inner_run [master090] 2020-07-01T23:40:31.908478 self.autoremove() [master090] 2020-07-01T23:40:31.908478 File "/usr/lib/python2.7/dist-packages/univention/management/console/modules/setup/setup_script.py", line 443, in autoremove [master090] 2020-07-01T23:40:31.908478 self.package_manager.autoremove() [master090] 2020-07-01T23:40:31.908478 File "/usr/lib/python2.7/dist-packages/univention/lib/package_manager.py", line 1111, in autoremove [master090] 2020-07-01T23:40:31.908478 return self.commit(msg_if_failed=failed_msg) [master090] 2020-07-01T23:40:31.908478 File "/usr/lib/python2.7/dist-packages/univention/lib/package_manager.py", line 945, in commit [master090] 2020-07-01T23:40:31.908478 result = self.cache.commit(**kwargs) [master090] 2020-07-01T23:40:31.908478 File "/usr/lib/python2.7/dist-packages/apt/cache.py", line 549, in commit [master090] 2020-07-01T23:40:31.908478 res = self.install_archives(pm, install_progress) [master090] 2020-07-01T23:40:31.908478 File "/usr/lib/python2.7/dist-packages/apt/cache.py", line 508, in install_archives [master090] 2020-07-01T23:40:31.908478 res = install_progress.run(pm) [master090] 2020-07-01T23:40:31.908478 File "/usr/lib/python2.7/dist-packages/apt/progress/base.py", line 208, in run [master090] 2020-07-01T23:40:31.908478 res = self.wait_child() [master090] 2020-07-01T23:40:31.908478 File "/usr/lib/python2.7/dist-packages/apt/progress/base.py", line 279, in wait_child [master090] 2020-07-01T23:40:31.908478 self.update_interface() [master090] 2020-07-01T23:40:31.908478 File "/usr/lib/python2.7/dist-packages/apt/progress/base.py", line 256, in update_interface [master090] 2020-07-01T23:40:31.908478 self.status_change(pkgname, float(percent), status_str.strip()) [master090] 2020-07-01T23:40:31.908478 File "/usr/lib/python2.7/dist-packages/univention/lib/package_manager.py", line 349, in status_change [master090] 2020-07-01T23:40:31.908478 self.progress_state.percentage(str(percent)) [master090] 2020-07-01T23:40:31.908478 File "/usr/lib/python2.7/dist-packages/univention/lib/package_manager.py", line 143, in percentage [master090] 2020-07-01T23:40:31.908478 self.get_logger(logger_name).info(percentage) [master090] 2020-07-01T23:40:31.908478 File "/usr/lib/python2.7/logging/__init__.py", line 1167, in info [master090] 2020-07-01T23:40:31.908478 self._log(INFO, msg, args, **kwargs) [master090] 2020-07-01T23:40:31.908478 File "/usr/lib/python2.7/logging/__init__.py", line 1286, in _log [master090] 2020-07-01T23:40:31.908478 self.handle(record) [master090] 2020-07-01T23:40:31.908478 File "/usr/lib/python2.7/logging/__init__.py", line 1296, in handle [master090] 2020-07-01T23:40:31.908478 self.callHandlers(record) [master090] 2020-07-01T23:40:31.908478 File "/usr/lib/python2.7/logging/__init__.py", line 1336, in callHandlers [master090] 2020-07-01T23:40:31.908478 hdlr.handle(record) [master090] 2020-07-01T23:40:31.908478 File "/usr/lib/python2.7/logging/__init__.py", line 759, in handle [master090] 2020-07-01T23:40:31.908478 self.emit(record) [master090] 2020-07-01T23:40:31.908478 File "/usr/lib/python2.7/dist-packages/univention/management/console/modules/setup/setup_script.py", line 357, in emit [master090] 2020-07-01T23:40:31.908478 super(_PackageManagerLoggerHandlerWithoutProcess, self).emit(record) [master090] 2020-07-01T23:40:31.908478 File "/usr/lib/python2.7/dist-packages/univention/lib/package_manager.py", line 403, in emit [master090] 2020-07-01T23:40:31.908478 self.step_handler(record.msg) [master090] 2020-07-01T23:40:31.908478 File "/usr/lib/python2.7/dist-packages/univention/management/console/modules/setup/setup_script.py", line 285, in step [master090] 2020-07-01T23:40:31.908478 self._step += 1 [master090] 2020-07-01T23:40:31.908478 TypeError: cannot concatenate 'str' and 'int' objects [master090] 2020-07-01T23:40:31.908478 [master090] 2020-07-01T23:40:32.043522 Exception in thread Thread-1 (most likely raised during interpreter shutdown): [master090] 2020-07-01T23:40:32.043522 Traceback (most recent call last): [master090] 2020-07-01T23:40:32.043522 File "/usr/lib/python2.7/threading.py", line 801, in __bootstrap_inner [master090] 2020-07-01T23:40:32.043522 File "/usr/lib/python2.7/threading.py", line 754, in run [master090] 2020-07-01T23:40:32.043522 File "/usr/lib/python2.7/dist-packages/univention/lib/package_manager.py", line 331, in check_pipe [master090] 2020-07-01T23:40:32.043522 File "/usr/lib/python2.7/dist-packages/univention/lib/package_manager.py", line 131, in info [master090] 2020-07-01T23:40:32.043522 File "/usr/lib/python2.7/dist-packages/univention/lib/package_manager.py", line 120, in get_logger [master090] 2020-07-01T23:40:32.043522 File "/usr/lib/python2.7/logging/__init__.py", line 1385, in getChild [master090] 2020-07-01T23:40:32.043522 File "/usr/lib/python2.7/logging/__init__.py", line 1037, in getLogger [master090] 2020-07-01T23:40:32.043522 <type 'exceptions.TypeError'>: 'NoneType' object is not callable [master090] 2020-07-01T23:40:32.061880 run-parts: /usr/lib/univention-system-setup/scripts/50_software/10software exited with return code 1 Installation of univention-server-* did not succeed and the Jenkins tests still continue so that the test takes ages and every test fails with some traceback about invalid credentials.