Keine automatische Installation der Pakete in setup_after_install bei debian13

Antworten
Christian Imhorst
Beiträge: 22
Registriert: 24 Apr 2023, 09:34

Keine automatische Installation der Pakete in setup_after_install bei debian13

Beitrag von Christian Imhorst »

Hallo,

sollte das Problem nur bei mir bestehen, kann ich dazu auch gerne ein Ticket aufmachen: Im Netboot-Produkt "debian13" stehen 2 Pakete in "setup_after_install", die nach der Installation von Debian eigentlich autmatisch installiert werden sollten. Doch nach der Installation des "opsi-linux-client-agent" werden sie zwar auf "setup" gesetzt, aber nach dem Neustart dann nicht automatisch installiert.

Debian wird ohne Desktop installiert (desktop_package = none), "partition_method" ist "lvm" und die "installation_method" ist "reboot".

Woran könnte das liegen, das die Installtion der beiden Localboot-Produkte nach "opsi-linux-client-agent" nicht automatisch erfolgt?

Viele Grüße
Christian
Benutzeravatar
n.doerrer
uib-Team
Beiträge: 516
Registriert: 23 Okt 2020, 16:11

Re: Keine automatische Installation der Pakete in setup_after_install bei debian13

Beitrag von n.doerrer »

Moin,

läuft denn ein opsiclientd_start event beim ersten booten nach der olca-Installation? Sieht man da im log was? Sind vielleicht irgendwelche excludes am Werk?


Vielen Dank für die Nutzung von opsi. Im Forum ist unser Support begrenzt.

Für den professionellen Einsatz und individuelle Beratung empfehlen wir einen Support-Vertrag und eine Schulung.
Gerne informieren wir Sie zu unserem Angebot.

uib GmbH
Telefon: +49 6131 27561 0
E-Mail: sales@uib.de


Christian Imhorst
Beiträge: 22
Registriert: 24 Apr 2023, 09:34

Re: Keine automatische Installation der Pakete in setup_after_install bei debian13

Beitrag von Christian Imhorst »

Moin,

im instlog steht zum Schluss:

Code: Alles auswählen

[5] [2026-03-06 09:39:19.908] [opsi-linux-client-agent] comment: Setup after install
[6] [2026-03-06 09:39:19.908] [opsi-linux-client-agent] The value of the variable "$Finalize$" is now: "reboot"
[6] [2026-03-06 09:39:19.909] [opsi-linux-client-agent] 
[6] [2026-03-06 09:39:19.909] [opsi-linux-client-agent] ~~~~~~ Looping through:  'l-debian-install-firmware', 'l-glpi'
[5] [2026-03-06 09:39:19.909] [opsi-linux-client-agent] Execution of: OpsiServiceCall_setProductActionRequestWithDependencies_setup
[6] [2026-03-06 09:39:19.909] [opsi-linux-client-agent]    "method": "setProductActionRequestWithDependencies"
[6] [2026-03-06 09:39:19.970] [opsi-linux-client-agent] HTTPSender Post succeeded
[6] [2026-03-06 09:39:19.970] [opsi-linux-client-agent] Server-FQDN: 10.10.10.10 Server-IP: 10.10.10.10
[6] [2026-03-06 09:39:19.970] [opsi-linux-client-agent] JSON Bench for setProductActionRequestWithDependencies "params":["l-debian-install-firmware","lx-1234.ex Start: 09:39:19:909 Time: 00:00:00:061
[6] [2026-03-06 09:39:19.970] [opsi-linux-client-agent] JSON result:
[5] [2026-03-06 09:39:19.971] [opsi-linux-client-agent] Execution of: OpsiServiceCall_setProductActionRequestWithDependencies_setup
[6] [2026-03-06 09:39:19.971] [opsi-linux-client-agent]    "method": "setProductActionRequestWithDependencies"
[6] [2026-03-06 09:39:20.020] [opsi-linux-client-agent] HTTPSender Post succeeded
[6] [2026-03-06 09:39:20.020] [opsi-linux-client-agent] Server-FQDN: 10.10.10.10 Server-IP: 10.10.10.10
[6] [2026-03-06 09:39:20.020] [opsi-linux-client-agent] JSON Bench for setProductActionRequestWithDependencies "params":["l-glpi","lx-1234.ex.example.com","setup" Start: 09:39:19:971 Time: 00:00:00:049
[6] [2026-03-06 09:39:20.021] [opsi-linux-client-agent] JSON result:
[6] [2026-03-06 09:39:20.021] [opsi-linux-client-agent] 
[6] [2026-03-06 09:39:20.021] [opsi-linux-client-agent] ~~~~~~ End Loop
[6] [2026-03-06 09:39:20.021] [opsi-linux-client-agent] Section ending since next line is starting with "["
[6] [2026-03-06 09:39:20.021] [opsi-linux-client-agent] expression: [$RunningInServiceContext$ = "false"] <<< is true
[5] [2026-03-06 09:39:20.023] [opsi-linux-client-agent] Execution of: OpsiServiceCall_productOnClient_createObjects_opsiclientagent
[6] [2026-03-06 09:39:20.024] [opsi-linux-client-agent]    "method": "productOnClient_createObjects"
[6] [2026-03-06 09:39:20.037] [opsi-linux-client-agent] HTTPSender Post succeeded
[6] [2026-03-06 09:39:20.037] [opsi-linux-client-agent] Server-FQDN: 10.10.10.10 Server-IP: 10.10.10.10
[6] [2026-03-06 09:39:20.038] [opsi-linux-client-agent] JSON Bench for productOnClient_createObjects "params":[[{"clientId":"lx-1234.ex.example.com","ac Start: 09:39:20:024 Time: 00:00:00:014
[6] [2026-03-06 09:39:20.038] [opsi-linux-client-agent] JSON result:
[7] [2026-03-06 09:39:20.039] [opsi-linux-client-agent] expression: [Contains($InstallationOptions$, "BOOTIMAGE")] <<< is false
[6] [2026-03-06 09:39:20.039] [opsi-linux-client-agent] expression: [Contains($InstallationOptions$, "bootimage") or Contains($InstallationOptions$, "BOOTIMAGE")] <<< is true
[6] [2026-03-06 09:39:20.039] [opsi-linux-client-agent] The value of the variable "$Finalize$" is now: ""
[7] [2026-03-06 09:39:20.043] [opsi-linux-client-agent] expression: [$Finalize$ = "reboot"] <<< is false
[6] [2026-03-06 09:39:20.043] [opsi-linux-client-agent] expression: [($Finalize$ = "reboot")] <<< is false
[7] [2026-03-06 09:39:20.044] [opsi-linux-client-agent] expression: [$Finalize$ = "shutdown"] <<< is false
[6] [2026-03-06 09:39:20.044] [opsi-linux-client-agent] expression: [($Finalize$ = "shutdown")] <<< is false
[7] [2026-03-06 09:39:20.044] [opsi-linux-client-agent] expression: [$Finalize$ = "service_restart"] <<< is false
[7] [2026-03-06 09:39:20.045] [opsi-linux-client-agent] expression: [$Finalize$ = "service_restart_no_skip"] <<< is false
[7] [2026-03-06 09:39:20.045] [opsi-linux-client-agent] expression: [($Finalize$ = "service_restart_no_skip")] <<< is false
[6] [2026-03-06 09:39:20.045] [opsi-linux-client-agent] expression: [($Finalize$ = "service_restart") or ($Finalize$ = "service_restart_no_skip")] <<< is false
[1] [2026-03-06 09:39:20.046] [opsi-linux-client-agent] ___________________
[1] [2026-03-06 09:39:20.046] [opsi-linux-client-agent] script finished: success
[1] [2026-03-06 09:39:20.046] [opsi-linux-client-agent] 0 errors
[1] [2026-03-06 09:39:20.046] [opsi-linux-client-agent] 1 warning
[1] [2026-03-06 09:39:20.047] [opsi-linux-client-agent] Exitcode will be: 0
[1] [2026-03-06 09:39:20.047] [opsi-linux-client-agent] 
[1] [2026-03-06 09:39:20.047] [opsi-linux-client-agent] handled product: opsi-linux-client-agent Version: 4.3.17.7-2
[1] [2026-03-06 09:39:20.047] [opsi-linux-client-agent] 
[6] [2026-03-06 09:39:20.054] [opsi-linux-client-agent] HTTPSender Post succeeded
[6] [2026-03-06 09:39:20.054] [opsi-linux-client-agent] Server-FQDN: 10.10.10.10 Server-IP: 10.10.10.10
[6] [2026-03-06 09:39:20.054] [opsi-linux-client-agent] JSON Bench for backend_getSystemConfiguration "params":[],"id":1} Start: 09:39:20:047 Time: 00:00:00:007
[6] [2026-03-06 09:39:20.054] [opsi-linux-client-agent] Checking if partlog: is bigger than 0 MB :.
[6] [2026-03-06 09:39:20.054] [opsi-linux-client-agent] Checking if partlog: /var/log/opsi-script/opsi-script-part-mx51IF1t1U.log is bigger than 0 MB - found: 0 MB
[5] [2026-03-06 09:39:20.054] [opsi-linux-client-agent] -------- submitted part of log file ends here, see the rest of log file on client ----------
Weiter passiert nichts.

Excludes sehe ich nur:

Code: Alles auswählen

[7] [2026-03-06 09:39:19.441] [opsi-linux-client-agent] [6] [2026-03-06 09:39:17.121] [                                        ] Setting config cache_service.exclude_product_group_ids to []   (Config.py:535)
Ich kann über den "Client-Shell-Zugang (über Messagebus)" sehen, dass der opsiclientd-Dienst läuft:

Code: Alles auswählen

 UNIT                     LOAD   ACTIVE SUB     DESCRIPTION                                   
  anacron.service          loaded active running Run anacron jobs
  bluetooth.service        loaded active running Bluetooth service
  cron.service             loaded active running Regular background program processing daemon
  dbus.service             loaded active running D-Bus System Message Bus
  getty@tty1.service       loaded active running Getty on tty1
  opsiclientd.service      loaded active running Opsi Linux Client Agent
  systemd-journald.service loaded active running Journal Service
  systemd-logind.service   loaded active running User Login Management
  systemd-udevd.service    loaded active running Rule-based Manager for Device Events and Files
  wpa_supplicant.service   loaded active running WPA supplicant
Update: Nach einem Neustart des Laptops passiert nichts, wenn ich aber im "Client-Shell-Zugang (über Messagebus)" ein

Code: Alles auswählen

systemctl restart opsiclientd.service
ausführe, startet die Installation, sobald der Service zurück ist. Kann ich den Aufruf irgendwie an olca anhängen?

Viele Grüße
Christian
Benutzeravatar
n.doerrer
uib-Team
Beiträge: 516
Registriert: 23 Okt 2020, 16:11

Re: Keine automatische Installation der Pakete in setup_after_install bei debian13

Beitrag von n.doerrer »

Interessant. Dann läuft also der opsiclientd und kann beim opsiclientd_start-Event auch die Aktionen abhandeln.
Aber beim booten scheint etwas schief zu gehen. In /var/log/opsi-client-agent/opsiclientd.log ist vielleicht etwas dazu zu finden.


Vielen Dank für die Nutzung von opsi. Im Forum ist unser Support begrenzt.

Für den professionellen Einsatz und individuelle Beratung empfehlen wir einen Support-Vertrag und eine Schulung.
Gerne informieren wir Sie zu unserem Angebot.

uib GmbH
Telefon: +49 6131 27561 0
E-Mail: sales@uib.de


Christian Imhorst
Beiträge: 22
Registriert: 24 Apr 2023, 09:34

Re: Keine automatische Installation der Pakete in setup_after_install bei debian13

Beitrag von Christian Imhorst »

Moin,

erst dachte ich, dass es an der Namensauflösung scheitert, klappt aber auch nicht bzw. selbe Problem mit IP statt FQDN:

Code: Alles auswählen

[6] [2026-03-13 11:19:11.355] [opsiclientd                             ] Event generator 'gui_startup' created   (Generators.py:74)
[6] [2026-03-13 11:19:11.355] [opsiclientd                             ] Event generator 'on_demand' created   (Generators.py:74)
[6] [2026-03-13 11:19:11.355] [opsiclientd                             ] Event 'on_shutdown' of type 'custom' is disabled (main)   (Generators.py:66)
[6] [2026-03-13 11:19:11.356] [opsiclientd                             ] Event generator 'opsiclientd_start' created   (Generators.py:74)
[6] [2026-03-13 11:19:11.356] [opsiclientd                             ] Event generator 'silent_install' created   (Generators.py:74)
[6] [2026-03-13 11:19:11.356] [opsiclientd                             ] Event generator 'software_on_demand' created   (Generators.py:74)
[6] [2026-03-13 11:19:11.356] [opsiclientd                             ] Event generator 'sync_completed' created   (Generators.py:74)
[6] [2026-03-13 11:19:11.356] [opsiclientd                             ] Event 'timer' of type 'timer' is disabled (main)   (Generators.py:66)
[6] [2026-03-13 11:19:11.356] [opsiclientd                             ] Event generator 'timer_silentinstall' created   (Generators.py:74)
[6] [2026-03-13 11:19:11.356] [opsiclientd                             ] Event 'net_connection' of type 'custom' is disabled (main)   (Generators.py:66)
[6] [2026-03-13 11:19:11.356] [opsiclientd                             ] Event config 'gui_startup' added to event generator 'gui_startup'   (Generators.py:110)
[6] [2026-03-13 11:19:11.356] [opsiclientd                             ] Event 'gui_startup{cache_ready}' of type 'gui startup' is disabled (precondition)   (Generators.py:95)
[6] [2026-03-13 11:19:11.356] [opsiclientd                             ] Event 'gui_startup{installation_pending}' of type 'gui startup' is disabled (precondition)   (Generators.py:95)
[6] [2026-03-13 11:19:11.356] [opsiclientd                             ] Event config 'gui_startup{user_logged_in}' added to event generator 'gui_startup'   (Generators.py:110)
[6] [2026-03-13 11:19:11.356] [opsiclientd                             ] Event config 'on_demand' added to event generator 'on_demand'   (Generators.py:110)
[6] [2026-03-13 11:19:11.356] [opsiclientd                             ] Event config 'on_demand{user_logged_in}' added to event generator 'on_demand'   (Generators.py:110)
[6] [2026-03-13 11:19:11.356] [opsiclientd                             ] Event 'on_shutdown' of type 'custom' is disabled (precondition)   (Generators.py:95)
[6] [2026-03-13 11:19:11.356] [opsiclientd                             ] Event 'on_shutdown{installation_pending}' of type 'custom' is disabled (precondition)   (Generators.py:95)
[6] [2026-03-13 11:19:11.356] [opsiclientd                             ] Event config 'opsiclientd_start' added to event generator 'opsiclientd_start'   (Generators.py:110)
[6] [2026-03-13 11:19:11.356] [opsiclientd                             ] Event config 'opsiclientd_start{cache_ready}' added to event generator 'opsiclientd_start'   (Generators.py:110)
[6] [2026-03-13 11:19:11.356] [opsiclientd                             ] Event config 'silent_install' added to event generator 'silent_install'   (Generators.py:110)
[6] [2026-03-13 11:19:11.356] [opsiclientd                             ] Event config 'software_on_demand' added to event generator 'software_on_demand'   (Generators.py:110)
[6] [2026-03-13 11:19:11.356] [opsiclientd                             ] Event config 'sync_completed' added to event generator 'sync_completed'   (Generators.py:110)
[6] [2026-03-13 11:19:11.356] [opsiclientd                             ] Event config 'sync_completed{cache_ready_user_logged_in}' added to event generator 'sync_completed'   (Generators.py:110)
[6] [2026-03-13 11:19:11.356] [opsiclientd                             ] Event config 'sync_completed{cache_ready}' added to event generator 'sync_completed'   (Generators.py:110)
[6] [2026-03-13 11:19:11.356] [opsiclientd                             ] Event 'timer' of type 'timer' is disabled (precondition)   (Generators.py:95)
[6] [2026-03-13 11:19:11.356] [opsiclientd                             ] Event config 'timer_silentinstall' added to event generator 'timer_silentinstall'   (Generators.py:110)
[6] [2026-03-13 11:19:11.356] [opsiclientd                             ] Event 'net_connection' of type 'custom' is disabled (precondition)   (Generators.py:95)
[5] [2026-03-13 11:19:11.356] [opsiclientd                             ] Disabling event 'gui_startup' because 'daemon startup' is enabled   (Generators.py:121)
[5] [2026-03-13 11:19:11.356] [opsiclientd                             ] Disabling event 'gui_startup{user_logged_in}' because 'daemon startup' is enabled   (Generators.py:121)
[5] [2026-03-13 11:19:11.356] [opsiclientd                             ] Configured events: gui_startup, gui_startup{cache_ready}, gui_startup{installation_pending}, gui_startup{user_logged_in}, net_connection, on_demand, on_demand{user_logged_in}, on_shutdown, on_shutdown{installation_pending}, opsiclientd_start, opsiclientd_start{cache_ready}, panic, silent_install, software_on_demand, sync_completed, sync_completed{cache_ready_user_logged_in}, sync_completed{cache_ready}, timer, timer_silentinstall   (Generators.py:126)
[5] [2026-03-13 11:19:11.356] [opsiclientd                             ] Enabled events: on_demand, on_demand{user_logged_in}, opsiclientd_start, opsiclientd_start{cache_ready}, panic, silent_install, software_on_demand, sync_completed, sync_completed{cache_ready_user_logged_in}, sync_completed{cache_ready}, timer_silentinstall   (Generators.py:127)
[6] [2026-03-13 11:19:11.357] [event generator panic                   ] Initializing event generator '<PanicEventGenerator panic>'   (Basic.py:206)
[6] [2026-03-13 11:19:11.357] [opsiclientd                             ] Event generator '<PanicEventGenerator panic>' started   (Opsiclientd.py:507)
[6] [2026-03-13 11:19:11.357] [event generator panic                   ] Activating event generator '<PanicEventGenerator panic>'   (Basic.py:215)
[6] [2026-03-13 11:19:11.357] [event generator panic                   ] Getting next event...   (Basic.py:219)
[6] [2026-03-13 11:19:11.357] [event generator on_demand               ] Initializing event generator '<CustomEventGenerator on_demand>'   (Basic.py:206)
[6] [2026-03-13 11:19:11.357] [event generator on_demand               ] Activating event generator '<CustomEventGenerator on_demand>'   (Basic.py:215)
[6] [2026-03-13 11:19:11.357] [event generator on_demand               ] Getting next event...   (Basic.py:219)
[6] [2026-03-13 11:19:11.357] [opsiclientd                             ] Event generator '<CustomEventGenerator on_demand>' started   (Opsiclientd.py:507)
[6] [2026-03-13 11:19:11.358] [event generator opsiclientd_start       ] Initializing event generator '<DaemonStartupEventGenerator opsiclientd_start>'   (Basic.py:206)
[6] [2026-03-13 11:19:11.359] [opsiclientd                             ] Event generator '<DaemonStartupEventGenerator opsiclientd_start>' started   (Opsiclientd.py:507)
[6] [2026-03-13 11:19:11.359] [event generator silent_install          ] Initializing event generator '<CustomEventGenerator silent_install>'   (Basic.py:206)
[6] [2026-03-13 11:19:11.359] [event generator silent_install          ] Activating event generator '<CustomEventGenerator silent_install>'   (Basic.py:215)
[6] [2026-03-13 11:19:11.359] [event generator silent_install          ] Getting next event...   (Basic.py:219)
[6] [2026-03-13 11:19:11.359] [opsiclientd                             ] Event generator '<CustomEventGenerator silent_install>' started   (Opsiclientd.py:507)
[6] [2026-03-13 11:19:11.359] [event generator software_on_demand      ] Initializing event generator '<SwOnDemandEventGenerator software_on_demand>'   (Basic.py:206)
[6] [2026-03-13 11:19:11.359] [event generator software_on_demand      ] Activating event generator '<SwOnDemandEventGenerator software_on_demand>'   (Basic.py:215)
[6] [2026-03-13 11:19:11.359] [event generator software_on_demand      ] Getting next event...   (Basic.py:219)
[6] [2026-03-13 11:19:11.359] [opsiclientd                             ] Event generator '<SwOnDemandEventGenerator software_on_demand>' started   (Opsiclientd.py:507)
[6] [2026-03-13 11:19:11.359] [event generator sync_completed          ] Initializing event generator '<SyncCompletedEventGenerator sync_completed>'   (Basic.py:206)
[6] [2026-03-13 11:19:11.359] [event generator sync_completed          ] Activating event generator '<SyncCompletedEventGenerator sync_completed>'   (Basic.py:215)
[6] [2026-03-13 11:19:11.359] [event generator sync_completed          ] Getting next event...   (Basic.py:219)
[6] [2026-03-13 11:19:11.360] [opsiclientd                             ] Event generator '<SyncCompletedEventGenerator sync_completed>' started   (Opsiclientd.py:507)
[6] [2026-03-13 11:19:11.360] [event generator timer_silentinstall     ] Initializing event generator '<TimerEventGenerator timer_silentinstall>'   (Basic.py:206)
[6] [2026-03-13 11:19:11.360] [event generator timer_silentinstall     ] Activating event generator '<TimerEventGenerator timer_silentinstall>'   (Basic.py:215)
[6] [2026-03-13 11:19:11.360] [event generator timer_silentinstall     ] Getting next event...   (Basic.py:219)
[6] [2026-03-13 11:19:11.360] [opsiclientd                             ] Event generator '<TimerEventGenerator timer_silentinstall>' started   (Opsiclientd.py:507)
[6] [2026-03-13 11:19:11.360] [opsiclientd                             ] Testing preconditions of configs: [<DaemonStartupEventConfig opsiclientd_start>, <DaemonStartupEventConfig opsiclientd_start{cache_ready}>]   (Basic.py:70)
[6] [2026-03-13 11:19:11.360] [opsiclientd                             ] Preconditions for event config 'opsiclientd_start' fulfilled: {}   (Basic.py:77)
[6] [2026-03-13 11:19:11.360] [opsiclientd                             ] Preconditions for event config 'opsiclientd_start{cache_ready}' not fulfilled: {'config_cached': False, 'products_cached': False}   (Basic.py:86)
[6] [2026-03-13 11:19:11.360] [opsiclientd                             ] Firing event '<opsiclientd.Events.DaemonStartup.DaemonStartupEvent object at 0x7fc0b016d6a0>'   (Basic.py:155)
[6] [2026-03-13 11:19:11.360] [opsiclientd                             ] Event info:   (Basic.py:156)
[6] [2026-03-13 11:19:11.360] [opsiclientd                             ] Starting FireEventThread for listeners: [<OpsiclientdPosix(opsiclientd, started 140465616885440)>]   (Basic.py:182)
[6] [2026-03-13 11:19:11.360] [event generator opsiclientd_start       ] Calling processEvent on listener <OpsiclientdPosix(opsiclientd, started 140465616885440)>   (Basic.py:177)
[5] [2026-03-13 11:19:11.361] [opsiclientd                             ] No events processing, unblocking login   (Opsiclientd.py:710)
[5] [2026-03-13 11:19:11.361] [event generator opsiclientd_start       ] Processing event <opsiclientd.Events.DaemonStartup.DaemonStartupEvent object at 0x7fc0b016d6a0>   (Opsiclientd.py:816)
[5] [2026-03-13 11:19:11.361] [opsiclientd                             ] Block login now set to 'False'   (Opsiclientd.py:357)
[6] [2026-03-13 11:19:11.369] [webserver                               ] Started server process [880]   (server.py:83)
[6] [2026-03-13 11:19:11.369] [webserver                               ] Waiting for application startup.   (on.py:48)
[6] [2026-03-13 11:19:11.371] [opsiclientd                             ] Message of the day is disabled   (Opsiclientd.py:1057)
[5] [2026-03-13 11:19:11.372] [event processing opsiclientd_start      ] ============= EventProcessingThread for occurrcence of event 'opsiclientd_start' started =============   (EventProcessing.py:1942)
[5] [2026-03-13 11:19:11.376] [event processing opsiclientd_start      ] Block login now set to 'False'   (Opsiclientd.py:357)
[5] [2026-03-13 11:19:11.376] [event processing opsiclientd_start      ] Starting notification server   (EventProcessing.py:247)
[6] [2026-03-13 11:19:11.377] [notification server                     ] Notification server serving on ('::1', 44000, 0, 0), ('127.0.0.1', 44000)   (notification_server.py:286)
[5] [2026-03-13 11:19:11.377] [notification server                     ] Notification server started (listening on port 44000)   (EventProcessing.py:276)
[6] [2026-03-13 11:19:11.386] [webserver                               ] Executing: lsb_release -i   (Posix.py:939)
[6] [2026-03-13 11:19:11.387] [webserver                               ] Using encoding 'UTF-8'   (Posix.py:981)
[6] [2026-03-13 11:19:11.400] [webserver                               ] Application startup complete.   (on.py:62)
[6] [2026-03-13 11:19:11.401] [webserver                               ] Uvicorn running on https://['::', '0.0.0.0']:4441 (Press CTRL+C to quit)   (server.py:215)
[5] [2026-03-13 11:19:11.406] [event processing opsiclientd_start      ] Action processor name 'opsi-script', version '4.12.18.8'   (EventProcessing.py:458)
[6] [2026-03-13 11:19:11.411] [event processing opsiclientd_start      ] Using active session id: None   (EventProcessing.py:233)
[5] [2026-03-13 11:19:11.411] [event processing opsiclientd_start      ] Starting notifier application in session 'None' on desktop 'winlogon'   (EventProcessing.py:413)
[6] [2026-03-13 11:19:11.415] [event processing opsiclientd_start      ] Using active session id: None   (EventProcessing.py:233)
[5] [2026-03-13 11:19:11.415] [event processing opsiclientd_start      ] Executing: '['/usr/bin/opsi-notifier', '-l', '6', '-p', '44000', '-i', 'event', '-s', 'notifier/event.ini']'   (Posix.py:4156)
[6] [2026-03-13 11:19:11.416] [event processing opsiclientd_start      ] Process started, pid: 954   (Posix.py:4183)
[6] [2026-03-13 11:19:11.416] [event processing opsiclientd_start      ] User is allowed to cancel connection after 30 seconds   (EventProcessing.py:1858)
[6] [2026-03-13 11:19:13.328] [permanent service connection            ] Trying to connect to service: ['https://10.11.12.13:4447']   (OpsiService.py:283)
[5] [2026-03-13 11:19:13.329] [permanent service connection            ] Opening connection to opsi service ['https://10.11.12.13:4447']   (OpsiService.py:315)
[4] [2026-03-13 11:19:13.330] [permanent service connection            ] Failed to get nameservers from Resolver: no nameservers   (network.py:107)
[6] [2026-03-13 11:19:13.331] [permanent service connection            ] Current network Status:
Interface lo, Address 127.0.0.1, Family 2, Netmask 255.0.0.0
Interface lo, Address ::1, Family 10, Netmask ffff:ffff:ffff:ffff:ffff:ffff:ffff:ffff
Interface enp0s13f0u2u1, Address fe80::ad2e:a08f:d398:c562, Family 10, Netmask ffff:ffff:ffff:ffff::
   (utils.py:140)
[6] [2026-03-13 11:19:13.332] [permanent service connection            ] Using proxy settings: http_proxy=None, https_proxy=None, no_proxy='127.0.0.1,ip6-localhost,::1,localhost,ip6-loopback'   (__init__.py:281)
[6] [2026-03-13 11:19:13.332] [permanent service connection            ] Connecting to service 'https://10.11.12.13:4447' (opsiclientd: False)   (opsiservice.py:1043)
[6] [2026-03-13 11:19:13.334] [permanent service connection            ] Updating UIB OPSI CA in cert file '/etc/opsi-client-agent/tls/opsi-ca-cert.pem' (2 certificates total)   (opsiservice.py:929)
[6] [2026-03-13 11:19:13.336] [permanent service connection            ] CA cert file '/etc/opsi-client-agent/tls/opsi-ca-cert.pem' successfully updated (2 certificates total)   (opsiservice.py:881)
[3] [2026-03-13 11:19:13.339] [permanent service connection            ] Connection to opsi service https://10.11.12.13:4447 failed: Opsi service connection error: HTTPSConnectionPool(host='10.11.12.13', port=4447): Max retries exceeded with url: /rpc (Caused by NewConnectionError('<urllib3.connection.HTTPSConnection object at 0x7fc0987d5590>: Failed to establish a new connection: [Errno 101] Network is unreachable'))   (OpsiService.py:397)
[6] [2026-03-13 11:19:13.339] [permanent service connection            ] Failed to connect: Opsi service connection error: HTTPSConnectionPool(host='10.11.12.13', port=4447): Max retries exceeded with url: /rpc (Caused by NewConnectionError('<urllib3.connection.HTTPSConnection object at 0x7fc0987d5590>: Failed to establish a new connection: [Errno 101] Network is unreachable'))   (OpsiService.py:271)
[6] [2026-03-13 11:19:16.344] [permanent service connection            ] Trying to connect to service: ['https://10.11.12.13:4447']   (OpsiService.py:283)
[5] [2026-03-13 11:19:16.346] [permanent service connection            ] Opening connection to opsi service ['https://10.11.12.13:4447']   (OpsiService.py:315)
[4] [2026-03-13 11:19:16.347] [permanent service connection            ] Failed to get nameservers from Resolver: no nameservers   (network.py:107)
[6] [2026-03-13 11:19:16.348] [permanent service connection            ] Current network Status:
Interface lo, Address 127.0.0.1, Family 2, Netmask 255.0.0.0
Interface lo, Address ::1, Family 10, Netmask ffff:ffff:ffff:ffff:ffff:ffff:ffff:ffff
Interface enp0s13f0u2u1, Address fe80::ad2e:a08f:d398:c562, Family 10, Netmask ffff:ffff:ffff:ffff::
   (utils.py:140)
[6] [2026-03-13 11:19:16.349] [permanent service connection            ] Using proxy settings: http_proxy=None, https_proxy=None, no_proxy='127.0.0.1,ip6-localhost,::1,localhost,ip6-loopback'   (__init__.py:281)
[6] [2026-03-13 11:19:16.350] [permanent service connection            ] Connecting to service 'https://10.11.12.13:4447' (opsiclientd: False)   (opsiservice.py:1043)
[6] [2026-03-13 11:19:16.353] [permanent service connection            ] Updating UIB OPSI CA in cert file '/etc/opsi-client-agent/tls/opsi-ca-cert.pem' (2 certificates total)   (opsiservice.py:929)
[6] [2026-03-13 11:19:16.355] [permanent service connection            ] CA cert file '/etc/opsi-client-agent/tls/opsi-ca-cert.pem' successfully updated (2 certificates total)   (opsiservice.py:881)
[3] [2026-03-13 11:19:16.358] [permanent service connection            ] Connection to opsi service https://10.11.12.13:4447 failed: Opsi service connection error: HTTPSConnectionPool(host='10.11.12.13', port=4447): Max retries exceeded with url: /rpc (Caused by NewConnectionError('<urllib3.connection.HTTPSConnection object at 0x7fc0987d5d10>: Failed to establish a new connection: [Errno 101] Network is unreachable'))   (OpsiService.py:397)
[6] [2026-03-13 11:19:16.359] [permanent service connection            ] Failed to connect: Opsi service connection error: HTTPSConnectionPool(host='10.11.12.13', port=4447): Max retries exceeded with url: /rpc (Caused by NewConnectionError('<urllib3.connection.HTTPSConnection object at 0x7fc0987d5d10>: Failed to establish a new connection: [Errno 101] Network is unreachable'))   (OpsiService.py:271)
[3] [2026-03-13 11:19:18.419] [event processing opsiclientd_start      ] Failed to connect to config service 'https://10.11.12.13:4447': Timed out after 7 seconds   (EventProcessing.py:1886)
[5] [2026-03-13 11:19:18.420] [event processing opsiclientd_start      ] Writing log to service   (EventProcessing.py:326)
[4] [2026-03-13 11:19:18.420] [event processing opsiclientd_start      ] Cannot write log to service: not connected   (EventProcessing.py:329)
[5] [2026-03-13 11:19:18.421] [event processing opsiclientd_start      ] Block login now set to 'False'   (Opsiclientd.py:357)
[3] [2026-03-13 11:19:18.421] [event processing opsiclientd_start      ] Failed to process event <opsiclientd.Events.DaemonStartup.DaemonStartupEvent object at 0x7fc0b016d6a0>: Failed to connect to config service 'https://10.11.12.13:4447': Timed out after 7 seconds   (EventProcessing.py:2101)
Traceback (most recent call last):
  File "opsiclientd/EventProcessing.py", line 2006, in run
  File "opsiclientd/EventProcessing.py", line 1887, in wait_for_service_connection
RuntimeError: Failed to connect to config service 'https://10.11.12.13:4447': Timed out after 7 seconds
[6] [2026-03-13 11:19:18.430] [                                        ] Stopping notification server   (EventProcessing.py:283)
[6] [2026-03-13 11:19:18.891] [notification server                     ] Notification server stopped   (notification_server.py:309)
[6] [2026-03-13 11:19:20.365] [permanent service connection            ] Trying to connect to service: ['https://10.11.12.13:4447']   (OpsiService.py:283)
[5] [2026-03-13 11:19:20.367] [permanent service connection            ] Opening connection to opsi service ['https://10.11.12.13:4447']   (OpsiService.py:315)
[6] [2026-03-13 11:19:20.368] [permanent service connection            ] Current network Status:
Interface lo, Address 127.0.0.1, Family 2, Netmask 255.0.0.0
Interface lo, Address ::1, Family 10, Netmask ffff:ffff:ffff:ffff:ffff:ffff:ffff:ffff
Interface enp0s13f0u2u1, Address 192.168.100.123, Family 2, Netmask 255.255.255.0
Interface enp0s13f0u2u1, Address fe80::ad2e:a08f:d398:c562, Family 10, Netmask ffff:ffff:ffff:ffff::
   (utils.py:140)
[6] [2026-03-13 11:19:20.370] [permanent service connection            ] Using proxy settings: http_proxy=None, https_proxy=None, no_proxy='127.0.0.1,ip6-localhost,::1,localhost,ip6-loopback'   (__init__.py:281)
[6] [2026-03-13 11:19:20.370] [permanent service connection            ] Connecting to service 'https://10.11.12.13:4447' (opsiclientd: False)   (opsiservice.py:1043)
[6] [2026-03-13 11:19:20.374] [permanent service connection            ] Updating UIB OPSI CA in cert file '/etc/opsi-client-agent/tls/opsi-ca-cert.pem' (2 certificates total)   (opsiservice.py:929)
[6] [2026-03-13 11:19:20.376] [permanent service connection            ] CA cert file '/etc/opsi-client-agent/tls/opsi-ca-cert.pem' successfully updated (2 certificates total)   (opsiservice.py:881)
[6] [2026-03-13 11:19:20.435] [permanent service connection            ] Fetching OPSI CA from service (verify=/etc/opsi-client-agent/tls/opsi-ca-cert.pem)   (opsiservice.py:885)
[6] [2026-03-13 11:19:20.467] [permanent service connection            ] CA cert file '/etc/opsi-client-agent/tls/opsi-ca-cert.pem' successfully updated (2 certificates total)   (opsiservice.py:881)
[6] [2026-03-13 11:19:20.467] [permanent service connection            ] JSON-RPC request to https://10.11.12.13:4447: id='6c40ca03-0183-4df7-90ce-43bf2943d9f9', method=backend_getInterface, Content-Type=application/msgpack, Content-Encoding=lz4, timeout=300.0   (opsiservice.py:1649)
[6] [2026-03-13 11:19:20.477] [permanent service connection            ] Got response status=200, id='6c40ca03-0183-4df7-90ce-43bf2943d9f9', method=backend_getInterface, Content-Type=application/msgpack, Content-Encoding=lz4, duration=0.009s   (opsiservice.py:1673)
[5] [2026-03-13 11:19:20.496] [permanent service connection            ] Connected to config server 'https://10.11.12.13:4447' (name=opsiconfd 4.3.50.2 (uvicorn), version=4.3.50.2)   (OpsiService.py:350)
[6] [2026-03-13 11:19:20.496] [permanent service connection            ] Updating os CA cert store   (OpsiService.py:74)
[6] [2026-03-13 11:19:20.498] [permanent service connection            ] Installing CA 'opsi CA' into system store (/usr/local/share/ca-certificates)   (linux.py:93)
[6] [2026-03-13 11:19:20.499] [permanent service connection            ] Executing: ['update-ca-certificates']   (__init__.py:475)
[6] [2026-03-13 11:19:21.359] [event generator opsiclientd_start       ] Activating event generator '<DaemonStartupEventGenerator opsiclientd_start>'   (Basic.py:215)
[6] [2026-03-13 11:19:21.359] [event generator opsiclientd_start       ] Getting next event...   (Basic.py:219)
[6] [2026-03-13 11:19:21.456] [permanent service connection            ] JSON-RPC request to https://10.11.12.13:4447: id='469a983d-acad-408b-b51d-71e595e898db', method=configState_getClientToDepotserver, Content-Type=application/msgpack, Content-Encoding=lz4, timeout=300.0   (opsiservice.py:1649)
[6] [2026-03-13 11:19:21.492] [permanent service connection            ] Got response status=200, id='469a983d-acad-408b-b51d-71e595e898db', method=configState_getClientToDepotserver, Content-Type=application/msgpack, Content-Encoding=, duration=0.036s   (opsiservice.py:1673)
[6] [2026-03-13 11:19:21.492] [permanent service connection            ] Setting config depot_server.master_depot_id to 'opsi.ex.example.com'   (Config.py:535)
[6] [2026-03-13 11:19:21.493] [permanent service connection            ] Updating config file: '/etc/opsi-client-agent/opsiclientd.conf'   (Config.py:598)
[5] [2026-03-13 11:19:21.504] [permanent service connection            ] Config file '/etc/opsi-client-agent/opsiclientd.conf' written   (Config.py:655)
[5] [2026-03-13 11:19:21.504] [permanent service connection            ] Message bus available, connecting   (OpsiService.py:379)
[5] [2026-03-13 11:19:21.531] [event processing opsiclientd_start      ] Block login now set to 'False'   (Opsiclientd.py:357)
[5] [2026-03-13 11:19:21.531] [event processing opsiclientd_start      ] ============= EventProcessingThread for event 'opsiclientd_start' ended =============   (EventProcessing.py:2126)
[5] [2026-03-13 11:19:21.538] [event generator opsiclientd_start       ] Done processing event <opsiclientd.Events.DaemonStartup.DaemonStartupEvent object at 0x7fc0b016d6a0>   (Opsiclientd.py:858)
[5] [2026-03-13 11:19:22.505] [permanent service connection            ] Connecting to OPSI messagebus   (opsiservice.py:2179)
[6] [2026-03-13 11:19:22.532] [permanent service connection            ] Websocket connected   (_logging.py:89)
[5] [2026-03-13 11:19:22.533] [permanent service connection            ] Connected to OPSI messagebus (id='140465617878528')   (opsiservice.py:1940)
[6] [2026-03-13 11:19:22.535] [permanent service connection            ] Current channel subscriptions: ['host:lx-1234.ex.example.com', 'session:d0dfca88-e9c7-4890-9a2d-a33a610bea8a']   (opsiservice.py:2028)
[6] [2026-03-13 11:21:35.033] [                                        ] Starting new pty with shell 'bash', rows 24, cols 80, cwd '/root'   (terminal.py:101)
[6] [2026-03-13 11:21:35.700] [permanent service connection            ] PTY started with pid 2083   (terminal.py:227)

Beim ersten Versuch (11:19:13) hat der Client nur Link-Local fe80:: IPv6 auf enp0s13f0u2u1. "Network is unreachable" [Errno 101] kommt, weil keine IPv4-Adresse/Routing existiert. DHCP hat die IP 192.168.100.123 erst 7 Sekunden später (11:19:20) zugewiesen, vermutlich typisch für verzögerte DHCP-Zuweisung auf USB-Ethernet-Interfaces wie dem Dell 7 in 1 Multiportadapter (hier enp0s13f0u2u1), den ich benutze. :(

Im Prinzip muss ich nur den Start von opsiclientd verzögern, bis das Netzwerk da ist:

Code: Alles auswählen

systemctl edit opsiclientd
Und dann:

Code: Alles auswählen

[Service]
ExecStartPre=/bin/sleep 15
Kann ich das irgendwie bei der Installation des olca einbauen?

Viele Grüße
Christian
Antworten