syslog --------------------------------------- Apr 3 09:08:55 ubuntu-server subiquity_log.2004[2479]: Copying curtin install log from /var/log/curtin/install.log to target//var/log/installer/curtin-install.log Apr 3 09:08:55 ubuntu-server subiquity_log.2004[2479]: Skipping unmount: config disabled target unmounting Apr 3 09:08:55 ubuntu-server subiquity_log.2004[2479]: TIMED INSTALL_COMMAND: 74.749 Apr 3 09:08:55 ubuntu-server subiquity_log.2004[2479]: finish: cmd-install: SUCCESS: curtin command install Apr 3 09:08:55 ubuntu-server curtin_event.2004.3[2479]: finish: cmd-install: SUCCESS: curtin command install Apr 3 09:08:55 ubuntu-server subiquity_event.2004[2004]: subiquity/Install/install/curtin_install/cmd-install/stage-hook/builtin: running 'curtin hook' Apr 3 09:08:55 ubuntu-server subiquity_event.2004[2004]: subiquity/Install/install/curtin_install/cmd-install/stage-hook: finalizing installation Apr 3 09:08:55 ubuntu-server subiquity_event.2004[2004]: subiquity/Install/install/curtin_install/cmd-install/stage-late: executing late commands Apr 3 09:08:55 ubuntu-server subiquity_event.2004[2004]: subiquity/Install/install/curtin_install/cmd-install/stage-late: executing late commands Apr 3 09:08:55 ubuntu-server subiquity_event.2004[2004]: subiquity/Install/install/curtin_install/cmd-install: curtin command install Apr 3 09:08:55 ubuntu-server subiquity_event.2004[2004]: subiquity/Install/install/curtin_install: installing system Apr 3 09:08:55 ubuntu-server subiquity_event.2004[2004]: subiquity/Install/install/postinstall: final system configuration Apr 3 09:08:55 ubuntu-server subiquity_event.2004[2004]: subiquity/Install/install/postinstall/configure_cloud_init: configuring cloud-init Apr 3 09:08:55 ubuntu-server subiquity_event.2004[2004]: subiquity/Meta/status_GET Apr 3 09:08:55 ubuntu-server subiquity_event.2004[2004]: subiquity/Install/install/postinstall/configure_cloud_init: configuring cloud-init Apr 3 09:08:55 ubuntu-server subiquity_event.2004[2004]: subiquity/Install/install/postinstall/get_target_packages: calculating extra packages to install Apr 3 09:08:55 ubuntu-server subiquity_event.2004[2004]: subiquity/Install/install/postinstall/get_target_packages: calculating extra packages to install Apr 3 09:08:55 ubuntu-server subiquity_event.2004[2004]: subiquity/Install/install/postinstall/install_bridge-utils: installing bridge-utils Apr 3 09:08:55 ubuntu-server subiquity_log.2004[15974]: start: cmd-system-install: curtin command system-install Apr 3 09:08:55 ubuntu-server curtin_event.2004.4[15974]: start: cmd-system-install: curtin command system-install Apr 3 09:08:55 ubuntu-server subiquity_log.2004[15974]: Running command ['mount', '--bind', '/dev', '/target/dev'] with allowed return codes [0] (capture=False) Apr 3 09:08:55 ubuntu-server subiquity_log.2004[15974]: Running command ['mount', '--bind', '/proc', '/target/proc'] with allowed return codes [0] (capture=False) Apr 3 09:08:55 ubuntu-server subiquity_log.2004[15974]: Running command ['mount', '--bind', '/run', '/target/run'] with allowed return codes [0] (capture=False) Apr 3 09:08:56 ubuntu-server subiquity_log.2004[15974]: Running command ['mount', '--bind', '/sys', '/target/sys'] with allowed return codes [0] (capture=False) Apr 3 09:08:56 ubuntu-server subiquity_log.2004[15974]: Running command ['mount', '--bind', '/sys/firmware/efi/efivars', '/target/sys/firmware/efi/efivars'] with allowed return codes [0] (capture=False) Apr 3 09:08:56 ubuntu-server subiquity_log.2004[15974]: Running command ['unshare', '--help'] with allowed return codes [0] (capture=True) Apr 3 09:08:56 ubuntu-server subiquity_log.2004[15974]: Running command ['unshare', '--fork', '--pid', '--', 'chroot', '/target', 'eatmydata', 'apt-get', '--quiet', '--assume-yes', '--option=Dpkg::options::=--force-unsafe-io', '--option=Dpkg::Options::=--force-confold', 'install', 'bridge-utils'] with allowed return codes [0] (capture=False) Apr 3 09:08:56 ubuntu-server subiquity_log.2004[15986]: Reading package lists... Apr 3 09:08:56 ubuntu-server subiquity_log.2004[15986]: Building dependency tree... Apr 3 09:08:56 ubuntu-server subiquity_log.2004[15986]: Reading state information... Apr 3 09:08:56 ubuntu-server subiquity_log.2004[15986]: E: Unable to locate package bridge-utils Apr 3 09:08:56 ubuntu-server subiquity_log.2004[15974]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False) Apr 3 09:08:56 ubuntu-server subiquity_log.2004[15974]: TIMED subp(['udevadm', 'settle']): 0.020 Apr 3 09:08:56 ubuntu-server subiquity_log.2004[15974]: Running command ['mount', '--make-private', '/target/sys/firmware/efi/efivars'] with allowed return codes [0] (capture=False) Apr 3 09:08:56 ubuntu-server subiquity_log.2004[15974]: Running command ['umount', '/target/sys/firmware/efi/efivars'] with allowed return codes [0] (capture=False) Apr 3 09:08:56 ubuntu-server systemd[1]: target-sys-firmware-efi-efivars.mount: Succeeded. Apr 3 09:08:56 ubuntu-server subiquity_log.2004[15974]: Running command ['mount', '--make-private', '/target/sys'] with allowed return codes [0] (capture=False) Apr 3 09:08:56 ubuntu-server subiquity_log.2004[15974]: Running command ['umount', '/target/sys'] with allowed return codes [0] (capture=False) Apr 3 09:08:56 ubuntu-server systemd[1]: target-sys.mount: Succeeded. Apr 3 09:08:56 ubuntu-server subiquity_log.2004[15974]: Running command ['mount', '--make-private', '/target/run'] with allowed return codes [0] (capture=False) Apr 3 09:08:56 ubuntu-server subiquity_log.2004[15974]: Running command ['umount', '/target/run'] with allowed return codes [0] (capture=False) Apr 3 09:08:56 ubuntu-server systemd[1]: target-run.mount: Succeeded. Apr 3 09:08:56 ubuntu-server subiquity_log.2004[15974]: Running command ['mount', '--make-private', '/target/proc'] with allowed return codes [0] (capture=False) Apr 3 09:08:56 ubuntu-server subiquity_log.2004[15974]: Running command ['umount', '/target/proc'] with allowed return codes [0] (capture=False) Apr 3 09:08:56 ubuntu-server systemd[1]: target-proc.mount: Succeeded. Apr 3 09:08:56 ubuntu-server subiquity_log.2004[15974]: Running command ['mount', '--make-private', '/target/dev'] with allowed return codes [0] (capture=False) Apr 3 09:08:56 ubuntu-server subiquity_log.2004[15974]: Running command ['umount', '/target/dev'] with allowed return codes [0] (capture=False) Apr 3 09:08:56 ubuntu-server systemd[1]: target-dev.mount: Succeeded. Apr 3 09:08:56 ubuntu-server subiquity_log.2004[15974]: system install failed for ['bridge-utils']: Unexpected error while running command. Apr 3 09:08:56 ubuntu-server subiquity_log.2004[15974]: Command: ['unshare', '--fork', '--pid', '--', 'chroot', '/target', 'eatmydata', 'apt-get', '--quiet', '--assume-yes', '--option=Dpkg::options::=--force-unsafe-io', '--option=Dpkg::Options::=--force-confold', 'install', 'bridge-utils'] Apr 3 09:08:56 ubuntu-server subiquity_log.2004[15974]: Exit code: 100 Apr 3 09:08:56 ubuntu-server subiquity_log.2004[15974]: Reason: - Apr 3 09:08:56 ubuntu-server subiquity_log.2004[15974]: Stdout: '' Apr 3 09:08:56 ubuntu-server subiquity_log.2004[15974]: Stderr: '' Apr 3 09:08:56 ubuntu-server subiquity_log.2004[15974]: finish: cmd-system-install: FAIL: curtin command system-install Apr 3 09:08:56 ubuntu-server curtin_event.2004.4[15974]: finish: cmd-system-install: FAIL: curtin command system-install Apr 3 09:08:56 ubuntu-server subiquity_event.2004[2004]: subiquity/Install/install/postinstall/install_bridge-utils: Command '['/snap/subiquity/3119/usr/bin/python3.8', '-m', 'curtin', '--showtrace', '-vvv', '--set', 'json:reporting={"subiquity": {"type": "journald", "identifier": "curtin_event.2004.4"}}', 'system-install', '-t', '/target', '--', 'bridge-utils']' returned non-zero exit status 100. Apr 3 09:08:56 ubuntu-server subiquity_event.2004[2004]: subiquity/Install/install/postinstall: Command '['/snap/subiquity/3119/usr/bin/python3.8', '-m', 'curtin', '--showtrace', '-vvv', '--set', 'json:reporting={"subiquity": {"type": "journald", "identifier": "curtin_event.2004.4"}}', 'system-install', '-t', '/target', '--', 'bridge-utils']' returned non-zero exit status 100. Apr 3 09:08:56 ubuntu-server subiquity_event.2004[2004]: subiquity/Install/install: Command '['/snap/subiquity/3119/usr/bin/python3.8', '-m', 'curtin', '--showtrace', '-vvv', '--set', 'json:reporting={"subiquity": {"type": "journald", "identifier": "curtin_event.2004.4"}}', 'system-install', '-t', '/target', '--', 'bridge-utils']' returned non-zero exit status 100. Apr 3 09:08:56 ubuntu-server subiquity_event.2004[2004]: subiquity/ErrorReporter/1648976936.147035599.install_fail/add_info Apr 3 09:08:56 ubuntu-server subiquity_event.2004[2004]: subiquity/Install/install/postinstall/install_bridge-utils/cmd-system-install: curtin command system-install Apr 3 09:08:56 ubuntu-server subiquity_event.2004[2004]: subiquity/Install/install/postinstall/install_bridge-utils/cmd-system-install: curtin command system-install Apr 3 09:08:56 ubuntu-server subiquity_event.2004[2004]: subiquity/ErrorReporter/1648976936.147035599.install_fail/add_info: written to /var/crash/1648976936.147035599.install_fail.crash ---------------------------------------
subiquity-server-debug.log --------------------------------------- 2022-04-03 09:08:55,508 INFO root:39 finish: subiquity/Install/install/curtin_install: SUCCESS: installing system 2022-04-03 09:08:55,509 INFO root:39 start: subiquity/Install/install/postinstall: final system configuration 2022-04-03 09:08:55,510 DEBUG subiquity.models.filesystem:1229 mountpoints {'/': 'mount-3', '/boot': 'mount-2', '/boot/efi': 'mount-1'} 2022-04-03 09:08:55,515 DEBUG root:39 start: subiquity/Install/install/postinstall/configure_cloud_init: configuring cloud-init 2022-04-03 09:08:55,530 INFO root:39 finish: subiquity/Meta/status_GET: SUCCESS: 200 {"state": "POST_RUNNING", "confirming_tty": "", "error": null, "cloud_init_ok... 2022-04-03 09:08:55,545 INFO aiohttp.access:233 [03/Apr/2022:09:07:38 +0000] "GET /meta/status?cur=%22RUNNING%22 HTTP/1.1" 200 417 "-" "Python/3.8 aiohttp/3.6.2" 2022-04-03 09:08:55,552 DEBUG subiquitycore.utils:48 run_command called: ['chroot', '/target', 'getent', 'group'] 2022-04-03 09:08:55,553 INFO root:39 start: subiquity/Meta/status_GET: 2022-04-03 09:08:55,557 DEBUG subiquitycore.utils:61 run_command ['chroot', '/target', 'getent', 'group'] exited with code 0 2022-04-03 09:08:55,563 DEBUG root:39 finish: subiquity/Install/install/postinstall/configure_cloud_init: SUCCESS: configuring cloud-init 2022-04-03 09:08:55,563 DEBUG root:39 start: subiquity/Install/install/postinstall/get_target_packages: calculating extra packages to install 2022-04-03 09:08:55,564 DEBUG root:39 finish: subiquity/Install/install/postinstall/get_target_packages: SUCCESS: calculating extra packages to install 2022-04-03 09:08:55,564 DEBUG root:39 start: subiquity/Install/install/postinstall/install_bridge-utils: installing bridge-utils 2022-04-03 09:08:55,568 DEBUG subiquitycore.utils:94 astart_command called: ['systemd-cat', '--level-prefix=false', '--identifier=subiquity_log.2004', '/snap/subiquity/3119/usr/bin/python3.8', '-m', 'curtin', '--showtrace', '-vvv', '--set', 'json:reporting={"subiquity": {"type": "journald", "identifier": "curtin_event.2004.4"}}', 'system-install', '-t', '/target', '--', 'bridge-utils'] 2022-04-03 09:08:56,146 ERROR root:39 finish: subiquity/Install/install/postinstall/install_bridge-utils: FAIL: Command '['/snap/subiquity/3119/usr/bin/python3.8', '-m', 'curtin', '--showtrace', '-vvv', '--set', 'json:reporting={"subiquity": {"type": "journald", "identifier": "curtin_event.2004.4"}}', 'system-install', '-t', '/target', '--', 'bridge-utils']' returned non-zero exit status 100. 2022-04-03 09:08:56,146 ERROR root:39 finish: subiquity/Install/install/postinstall: FAIL: Command '['/snap/subiquity/3119/usr/bin/python3.8', '-m', 'curtin', '--showtrace', '-vvv', '--set', 'json:reporting={"subiquity": {"type": "journald", "identifier": "curtin_event.2004.4"}}', 'system-install', '-t', '/target', '--', 'bridge-utils']' returned non-zero exit status 100. 2022-04-03 09:08:56,146 DEBUG subiquitycore.common.errorreport:384 generating crash report 2022-04-03 09:08:56,169 INFO subiquitycore.common.errorreport:406 saving crash report 'install failed crashed with CalledProcessError' to /var/crash/1648976936.147035599.install_fail.crash 2022-04-03 09:08:56,169 ERROR root:39 finish: subiquity/Install/install: FAIL: Command '['/snap/subiquity/3119/usr/bin/python3.8', '-m', 'curtin', '--showtrace', '-vvv', '--set', 'json:reporting={"subiquity": {"type": "journald", "identifier": "curtin_event.2004.4"}}', 'system-install', '-t', '/target', '--', 'bridge-utils']' returned non-zero exit status 100. 2022-04-03 09:08:56,169 INFO root:39 start: subiquity/ErrorReporter/1648976936.147035599.install_fail/add_info: 2022-04-03 09:08:56,170 ERROR subiquity.server.server:414 top level error Traceback (most recent call last): File "/snap/subiquity/3119/lib/python3.8/site-packages/subiquity/server/controllers/cmdlist.py", line 104, in _run await Install.install_task File "/snap/subiquity/3119/lib/python3.8/site-packages/subiquitycore/context.py", line 148, in decorated_async return await meth(self, **kw) File "/snap/subiquity/3119/lib/python3.8/site-packages/subiquity/server/controllers/install.py", line 169, in install await self.postinstall(context=context) File "/snap/subiquity/3119/lib/python3.8/site-packages/subiquitycore/context.py", line 148, in decorated_async return await meth(self, **kw) File "/snap/subiquity/3119/lib/python3.8/site-packages/subiquity/server/controllers/install.py", line 192, in postinstall await self.install_package(context=context, package=package) File "/snap/subiquity/3119/lib/python3.8/site-packages/subiquitycore/context.py", line 148, in decorated_async return await meth(self, **kw) File "/snap/subiquity/3119/lib/python3.8/site-packages/subiquity/server/controllers/install.py", line 212, in install_package await run_curtin_command( File "/snap/subiquity/3119/lib/python3.8/site-packages/subiquity/server/curtin.py", line 166, in run_curtin_command await cmd.wait() File "/snap/subiquity/3119/lib/python3.8/site-packages/subiquity/server/curtin.py", line 113, in wait await self.runner.wait(self.proc) File "/snap/subiquity/3119/lib/python3.8/site-packages/subiquity/server/runner.py", line 37, in wait raise subprocess.CalledProcessError(proc.returncode, proc.args) subprocess.CalledProcessError: Command '['/snap/subiquity/3119/usr/bin/python3.8', '-m', 'curtin', '--showtrace', '-vvv', '--set', 'json:reporting={"subiquity": {"type": "journald", "identifier": "curtin_event.2004.4"}}', 'system-install', '-t', '/target', '--', 'bridge-utils']' returned non-zero exit status 100. 2022-04-03 09:08:56,171 ERROR subiquity.server.server:414 top level error Traceback (most recent call last): File "/snap/subiquity/3119/lib/python3.8/site-packages/subiquity/server/controllers/shutdown.py", line 77, in _wait_install await self.app.controllers.Install.install_task File "/snap/subiquity/3119/lib/python3.8/site-packages/subiquity/server/controllers/cmdlist.py", line 104, in _run await Install.install_task File "/snap/subiquity/3119/lib/python3.8/site-packages/subiquitycore/context.py", line 148, in decorated_async return await meth(self, **kw) File "/snap/subiquity/3119/lib/python3.8/site-packages/subiquity/server/controllers/install.py", line 169, in install await self.postinstall(context=context) File "/snap/subiquity/3119/lib/python3.8/site-packages/subiquitycore/context.py", line 148, in decorated_async return await meth(self, **kw) File "/snap/subiquity/3119/lib/python3.8/site-packages/subiquity/server/controllers/install.py", line 192, in postinstall await self.install_package(context=context, package=package) File "/snap/subiquity/3119/lib/python3.8/site-packages/subiquitycore/context.py", line 148, in decorated_async return await meth(self, **kw) File "/snap/subiquity/3119/lib/python3.8/site-packages/subiquity/server/controllers/install.py", line 212, in install_package await run_curtin_command( File "/snap/subiquity/3119/lib/python3.8/site-packages/subiquity/server/curtin.py", line 166, in run_curtin_command await cmd.wait() File "/snap/subiquity/3119/lib/python3.8/site-packages/subiquity/server/curtin.py", line 113, in wait await self.runner.wait(self.proc) File "/snap/subiquity/3119/lib/python3.8/site-packages/subiquity/server/runner.py", line 37, in wait raise subprocess.CalledProcessError(proc.returncode, proc.args) subprocess.CalledProcessError: Command '['/snap/subiquity/3119/usr/bin/python3.8', '-m', 'curtin', '--showtrace', '-vvv', '--set', 'json:reporting={"subiquity": {"type": "journald", "identifier": "curtin_event.2004.4"}}', 'system-install', '-t', '/target', '--', 'bridge-utils']' returned non-zero exit status 100. 2022-04-03 09:08:56,419 DEBUG root:39 start: subiquity/Install/install/postinstall/install_bridge-utils/cmd-system-install: curtin command system-install 2022-04-03 09:08:56,423 ERROR root:39 finish: subiquity/Install/install/postinstall/install_bridge-utils/cmd-system-install: FAIL: curtin command system-install 2022-04-03 09:08:56,657 INFO root:39 finish: subiquity/ErrorReporter/1648976936.147035599.install_fail/add_info: SUCCESS: written to /var/crash/1648976936.147035599.install_fail.crash 2022-04-03 09:08:56,658 INFO root:39 finish: subiquity/Meta/status_GET: SUCCESS: 200 {"state": "ERROR", "confirming_tty": "", "error": {"state": "DONE", "base": "... 2022-04-03 09:08:56,660 INFO aiohttp.access:233 [03/Apr/2022:09:08:55 +0000] "GET /meta/status?cur=%22POST_RUNNING%22 HTTP/1.1" 200 524 "-" "Python/3.8 aiohttp/3.6.2" --------------------------------------- -- You received this bug notification because you are a member of Ubuntu Bugs, which is subscribed to Ubuntu. https://bugs.launchpad.net/bugs/1967458 Title: ubuntu 20.4.4 Server Autoinstall Error To manage notifications about this bug go to: https://bugs.launchpad.net/ubuntu/+source/subiquity/+bug/1967458/+subscriptions -- ubuntu-bugs mailing list ubuntu-bugs@lists.ubuntu.com https://lists.ubuntu.com/mailman/listinfo/ubuntu-bugs