[Bug 2056570] [NEW] Installation failed when Subiquity installs SSH server on noble

Olivier Gayot 2056570 at bugs.launchpad.net
Fri Mar 8 15:20:39 UTC 2024 

Public bug reported:

I'm trying to install Ubuntu Server 24.04 using today's daily + changes
related to deb822. I'm using the following curtin revision:

https://git.launchpad.net/~ogayot/curtin/commit/?id=2ac55b7f594c5e73891e04a11ebcf9b1f7ec9e3e

Subiquity fails when installing openssh-server. Unfortunately, the logs
do not help much to understand what's going on:

Mar 08 13:39:08 ubuntu-server subiquity_log.1547[11562]: system install failed for ['openssh-server']: Unexpected error while running comma>
Mar 08 13:39:08 ubuntu-server subiquity_log.1547[11562]: Command: ['unshare', '--fork', '--pid', '--mount-proc=/target/proc', '--', 'chroot>
Mar 08 13:39:08 ubuntu-server subiquity_log.1547[11562]: Exit code: 100
Mar 08 13:39:08 ubuntu-server subiquity_log.1547[11562]: Reason: -
Mar 08 13:39:08 ubuntu-server subiquity_log.1547[11562]: Stdout: ''
Mar 08 13:39:08 ubuntu-server subiquity_log.1547[11562]: Stderr: ''

I've added more logs to see what happens (see
https://code.launchpad.net/~ogayot/curtin/+git/curtin/+merge/462051) and
now I can see that dpkg fails during the postinst script:

Mar 08 14:51:10 ubuntu-server subiquity_log.1547[10961]: Stderr: perl: warning: Setting locale failed.
[...]
Mar 08 14:51:10 ubuntu-server subiquity_log.1547[10961]:         Creating config file /etc/ssh/sshd_config with new version
Mar 08 14:51:10 ubuntu-server subiquity_log.1547[10961]:         Creating SSH2 RSA key; this may take some time ...
Mar 08 14:51:10 ubuntu-server subiquity_log.1547[10961]:         3072 SHA256:tXx12vlm+iJZZUZzitch0ZdmXdYpmjw2eFG+vBmizWo root at ubuntu-server>
Mar 08 14:51:10 ubuntu-server subiquity_log.1547[10961]:         Creating SSH2 ECDSA key; this may take some time ...
Mar 08 14:51:10 ubuntu-server subiquity_log.1547[10961]:         256 SHA256:aTGgNLJcS/gjoXyDbZGGw8Bksjm/ENHOcWwER6hZOYQ root at ubuntu-server >
Mar 08 14:51:10 ubuntu-server subiquity_log.1547[10961]:         Creating SSH2 ED25519 key; this may take some time ...
Mar 08 14:51:10 ubuntu-server subiquity_log.1547[10961]:         256 SHA256:MZmITjwhkmfqHyu/U3x68Y9yw48UgJTfLAriavFznv4 root at ubuntu-server >
Mar 08 14:51:10 ubuntu-server subiquity_log.1547[10961]:         Failed to connect to bus: No data available
Mar 08 14:51:10 ubuntu-server subiquity_log.1547[10961]:         dpkg: error processing package openssh-server (--configure):
Mar 08 14:51:10 ubuntu-server subiquity_log.1547[10961]:          installed openssh-server package post-installation script subprocess retu>
Mar 08 14:51:10 ubuntu-server subiquity_log.1547[10961]:         Errors were encountered while processing:
Mar 08 14:51:10 ubuntu-server subiquity_log.1547[10961]:          openssh-server
Mar 08 14:51:10 ubuntu-server subiquity_log.1547[10961]:         E: Sub-process /usr/bin/dpkg returned an error code (1)

After adding set -x to the postinst script, we see that is is the call
to systemctl daemon-reload which causes the failure:

        + [ -d /run/systemd/system ]
        + systemctl daemon-reload
        Failed to connect to bus: No data available
        + cleanup
        + [ /tmp/tmp.iebuhpLhg7 ]
        + rm -f /tmp/tmp.iebuhpLhg7
        + [  ]
        dpkg: error processing package openssh-server (--configure):
         installed openssh-server package post-installation script subprocess returned error exit status 1
        Errors were encountered while processing:
         openssh-server
        E: Sub-process /usr/bin/dpkg returned an error code (1)

I think it is a regression introduced by
https://code.launchpad.net/~mitchellaugustin/curtin/+git/curtin-1/+merge/461730
but I have to confirm.

** Affects: curtin
     Importance: Undecided
         Status: New

** Affects: subiquity
     Importance: Undecided
         Status: New

** Description changed:

  I'm trying to install Ubuntu Server 24.04 using today's daily + changes
  related to deb822. I'm using the following curtin revision:
  
  https://git.launchpad.net/~ogayot/curtin/commit/?id=2ac55b7f594c5e73891e04a11ebcf9b1f7ec9e3e
  
  Subiquity fails when installing openssh-server. Unfortunately, the logs
  do not help much to understand what's going on:
  
  Mar 08 13:39:08 ubuntu-server subiquity_log.1547[11562]: system install failed for ['openssh-server']: Unexpected error while running comma>
  Mar 08 13:39:08 ubuntu-server subiquity_log.1547[11562]: Command: ['unshare', '--fork', '--pid', '--mount-proc=/target/proc', '--', 'chroot>
  Mar 08 13:39:08 ubuntu-server subiquity_log.1547[11562]: Exit code: 100
  Mar 08 13:39:08 ubuntu-server subiquity_log.1547[11562]: Reason: -
  Mar 08 13:39:08 ubuntu-server subiquity_log.1547[11562]: Stdout: ''
  Mar 08 13:39:08 ubuntu-server subiquity_log.1547[11562]: Stderr: ''
  
  I've added more logs to see what happens (see
  https://code.launchpad.net/~ogayot/curtin/+git/curtin/+merge/462051) and
  now I can see that dpkg fails during the postinst script:
- 
  
  Mar 08 14:51:10 ubuntu-server subiquity_log.1547[10961]: Stderr: perl: warning: Setting locale failed.
  [...]
  Mar 08 14:51:10 ubuntu-server subiquity_log.1547[10961]:         Creating config file /etc/ssh/sshd_config with new version
  Mar 08 14:51:10 ubuntu-server subiquity_log.1547[10961]:         Creating SSH2 RSA key; this may take some time ...
  Mar 08 14:51:10 ubuntu-server subiquity_log.1547[10961]:         3072 SHA256:tXx12vlm+iJZZUZzitch0ZdmXdYpmjw2eFG+vBmizWo root at ubuntu-server>
  Mar 08 14:51:10 ubuntu-server subiquity_log.1547[10961]:         Creating SSH2 ECDSA key; this may take some time ...
  Mar 08 14:51:10 ubuntu-server subiquity_log.1547[10961]:         256 SHA256:aTGgNLJcS/gjoXyDbZGGw8Bksjm/ENHOcWwER6hZOYQ root at ubuntu-server >
  Mar 08 14:51:10 ubuntu-server subiquity_log.1547[10961]:         Creating SSH2 ED25519 key; this may take some time ...
  Mar 08 14:51:10 ubuntu-server subiquity_log.1547[10961]:         256 SHA256:MZmITjwhkmfqHyu/U3x68Y9yw48UgJTfLAriavFznv4 root at ubuntu-server >
  Mar 08 14:51:10 ubuntu-server subiquity_log.1547[10961]:         Failed to connect to bus: No data available
  Mar 08 14:51:10 ubuntu-server subiquity_log.1547[10961]:         dpkg: error processing package openssh-server (--configure):
  Mar 08 14:51:10 ubuntu-server subiquity_log.1547[10961]:          installed openssh-server package post-installation script subprocess retu>
  Mar 08 14:51:10 ubuntu-server subiquity_log.1547[10961]:         Errors were encountered while processing:
  Mar 08 14:51:10 ubuntu-server subiquity_log.1547[10961]:          openssh-server
  Mar 08 14:51:10 ubuntu-server subiquity_log.1547[10961]:         E: Sub-process /usr/bin/dpkg returned an error code (1)
  
  After adding set -x to the postinst script, we see that is is the call
  to systemctl daemon-reload which causes the failure:
  
+         + [ -d /run/systemd/system ]
+         + systemctl daemon-reload
+         Failed to connect to bus: No data available
+         + cleanup
+         + [ /tmp/tmp.iebuhpLhg7 ]
+         + rm -f /tmp/tmp.iebuhpLhg7
+         + [  ]
+         dpkg: error processing package openssh-server (--configure):
+          installed openssh-server package post-installation script subprocess returned error exit status 1
+         Errors were encountered while processing:
+          openssh-server
+         E: Sub-process /usr/bin/dpkg returned an error code (1)
  
-         + [ -d /run/systemd/system ]
-         + systemctl daemon-reload
-         Failed to connect to bus: No data available
-         + cleanup
-         + [ /tmp/tmp.iebuhpLhg7 ]
-         + rm -f /tmp/tmp.iebuhpLhg7
-         + [  ]
-         dpkg: error processing package openssh-server (--configure):
-          installed openssh-server package post-installation script subprocess returned error exit status 1
-         Errors were encountered while processing:
-          openssh-server
-         E: Sub-process /usr/bin/dpkg returned an error code (1)
- 
- 
- I think it is a regression introduced by https://code.launchpad.net/~mitchellaugustin/curtin/+git/curtin-1/+merge/461730 by I have to confirm.
+ I think it is a regression introduced by
+ https://code.launchpad.net/~mitchellaugustin/curtin/+git/curtin-1/+merge/461730
+ but I have to confirm.

** Also affects: curtin
   Importance: Undecided
       Status: New

-- 
You received this bug notification because you are a member of Ubuntu
Foundations Bugs, which is subscribed to curtin.
https://bugs.launchpad.net/bugs/2056570

Title:
  Installation failed when Subiquity installs SSH server on noble

Status in curtin:
  New
Status in subiquity:
  New

Bug description:
  I'm trying to install Ubuntu Server 24.04 using today's daily +
  changes related to deb822. I'm using the following curtin revision:

  https://git.launchpad.net/~ogayot/curtin/commit/?id=2ac55b7f594c5e73891e04a11ebcf9b1f7ec9e3e

  Subiquity fails when installing openssh-server. Unfortunately, the
  logs do not help much to understand what's going on:

  Mar 08 13:39:08 ubuntu-server subiquity_log.1547[11562]: system install failed for ['openssh-server']: Unexpected error while running comma>
  Mar 08 13:39:08 ubuntu-server subiquity_log.1547[11562]: Command: ['unshare', '--fork', '--pid', '--mount-proc=/target/proc', '--', 'chroot>
  Mar 08 13:39:08 ubuntu-server subiquity_log.1547[11562]: Exit code: 100
  Mar 08 13:39:08 ubuntu-server subiquity_log.1547[11562]: Reason: -
  Mar 08 13:39:08 ubuntu-server subiquity_log.1547[11562]: Stdout: ''
  Mar 08 13:39:08 ubuntu-server subiquity_log.1547[11562]: Stderr: ''

  I've added more logs to see what happens (see
  https://code.launchpad.net/~ogayot/curtin/+git/curtin/+merge/462051)
  and now I can see that dpkg fails during the postinst script:

  Mar 08 14:51:10 ubuntu-server subiquity_log.1547[10961]: Stderr: perl: warning: Setting locale failed.
  [...]
  Mar 08 14:51:10 ubuntu-server subiquity_log.1547[10961]:         Creating config file /etc/ssh/sshd_config with new version
  Mar 08 14:51:10 ubuntu-server subiquity_log.1547[10961]:         Creating SSH2 RSA key; this may take some time ...
  Mar 08 14:51:10 ubuntu-server subiquity_log.1547[10961]:         3072 SHA256:tXx12vlm+iJZZUZzitch0ZdmXdYpmjw2eFG+vBmizWo root at ubuntu-server>
  Mar 08 14:51:10 ubuntu-server subiquity_log.1547[10961]:         Creating SSH2 ECDSA key; this may take some time ...
  Mar 08 14:51:10 ubuntu-server subiquity_log.1547[10961]:         256 SHA256:aTGgNLJcS/gjoXyDbZGGw8Bksjm/ENHOcWwER6hZOYQ root at ubuntu-server >
  Mar 08 14:51:10 ubuntu-server subiquity_log.1547[10961]:         Creating SSH2 ED25519 key; this may take some time ...
  Mar 08 14:51:10 ubuntu-server subiquity_log.1547[10961]:         256 SHA256:MZmITjwhkmfqHyu/U3x68Y9yw48UgJTfLAriavFznv4 root at ubuntu-server >
  Mar 08 14:51:10 ubuntu-server subiquity_log.1547[10961]:         Failed to connect to bus: No data available
  Mar 08 14:51:10 ubuntu-server subiquity_log.1547[10961]:         dpkg: error processing package openssh-server (--configure):
  Mar 08 14:51:10 ubuntu-server subiquity_log.1547[10961]:          installed openssh-server package post-installation script subprocess retu>
  Mar 08 14:51:10 ubuntu-server subiquity_log.1547[10961]:         Errors were encountered while processing:
  Mar 08 14:51:10 ubuntu-server subiquity_log.1547[10961]:          openssh-server
  Mar 08 14:51:10 ubuntu-server subiquity_log.1547[10961]:         E: Sub-process /usr/bin/dpkg returned an error code (1)

  After adding set -x to the postinst script, we see that is is the call
  to systemctl daemon-reload which causes the failure:

          + [ -d /run/systemd/system ]
          + systemctl daemon-reload
          Failed to connect to bus: No data available
          + cleanup
          + [ /tmp/tmp.iebuhpLhg7 ]
          + rm -f /tmp/tmp.iebuhpLhg7
          + [  ]
          dpkg: error processing package openssh-server (--configure):
           installed openssh-server package post-installation script subprocess returned error exit status 1
          Errors were encountered while processing:
           openssh-server
          E: Sub-process /usr/bin/dpkg returned an error code (1)

  I think it is a regression introduced by
  https://code.launchpad.net/~mitchellaugustin/curtin/+git/curtin-1/+merge/461730
  but I have to confirm.

To manage notifications about this bug go to:
https://bugs.launchpad.net/curtin/+bug/2056570/+subscriptions

More information about the foundations-bugs mailing list