[Bug 1995128] Re: user-data autoinstall config with apt `geoip: false` not work

Dan Bungert 1995128 at bugs.launchpad.net
Tue Jan 17 17:47:49 UTC 2023


Please ignore the geoip tracebacks, they are a red herring and not
fatal.

In the original description, is the following line:
{"subiquity": {"type": "journald", "identifier": "curtin_event.3786.2"}}', 'in-target', '-t', '/tmp/tmpzrthyaql/mount', '--', 'apt-get', 'update']' returned non-zero exit status 100.

Apt is failing and this bug report doesn't have enough info to say why.

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

Title:
  user-data autoinstall config with apt `geoip: false` not work

Status in subiquity package in Ubuntu:
  New

Bug description:
  Hi, I have tried to install Ubuntu 22.04.1 in a private network
  server.

  autoinstall apt-config stage failed with error log NOT request
  geoip.ubuntu.com.

  I have disabled `geoip: false` in user-data autointall config, but it
  was not worked.

      # grep -A10 apt: /autoinstall.yaml
      apt:
          disable_components:
          - non-free
          - restricted
          geoip: false
          preserve_sources_list: false
          primary:
          -   arches:
              - default
              uri: http://mirrors.private.com/ubuntu
      debug: true

  user-data config `geoip: false` was removed in
  /var/log/installer/subiquity-curtin-apt.conf

      # Autogenerated by Subiquity: 2022-10-28 15:57:27.895920 UTC
      apt:
        disable_components:
        - non-free
        - restricted
        preserve_sources_list: false
        primary:
        - arches:
          - default
          uri: http://mirrors.private.com/ubuntu

  
  ------------------------------------------------------------------
  /var/log/installer/subiquity-server-debug.log ERROR log:
  ------------------------------------------------------------------

  2022-10-28 15:57:36,669 ERROR root:39 finish: subiquity/Install/install/configure_apt: FAIL: Command '['systemd-run', '--wait', '--same-dir', '--property', 'SyslogIdentifier=subiquity_log.3786', '--property', 'PrivateMounts=yes', '--setenv', 'PATH=/snap/subiquity/3698/bin:/snap/subiquity/3698/usr/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/usr/local/games:/snap/bin:/snap/subiquity/3698/bin', '--setenv', 'PYTHONPATH=:/snap/subiquity/3698/lib/python3.8/site-packages', '--setenv', 'PYTHON=/snap/subiquity/3698/usr/bin/python3.8', '--setenv', 'SNAP=/snap/subiquity/3698', '--', '/snap/subiquity/3698/usr/bin/python3.8', '-m', 'curtin', '--showtrace', '-vvv', '--set', 'json:reporting={"subiquity": {"type": "journald", "identifier": "curtin_event.3786.2"}}', 'in-target', '-t', '/tmp/tmpzrthyaql/mount', '--', 'apt-get', 'update']' returned non-zero exit status 100.
  2022-10-28 15:57:36,669 DEBUG subiquitycore.common.errorreport:384 generating crash report
  2022-10-28 15:57:36,678 INFO subiquitycore.common.errorreport:406 saving crash report 'install failed crashed with CalledProcessError' to /var/crash/1666972656.669968843.install_fail.crash
  2022-10-28 15:57:36,678 ERROR root:39 finish: subiquity/Install/install: FAIL: Command '['systemd-run', '--wait', '--same-dir', '--property', 'SyslogIdentifier=subiquity_log.3786', '--property', 'PrivateMounts=yes', '--setenv', 'PATH=/snap/subiquity/3698/bin:/snap/subiquity/3698/usr/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/usr/local/games:/snap/bin:/snap/subiquity/3698/bin', '--setenv', 'PYTHONPATH=:/snap/subiquity/3698/lib/python3.8/site-packages', '--setenv', 'PYTHON=/snap/subiquity/3698/usr/bin/python3.8', '--setenv', 'SNAP=/snap/subiquity/3698', '--', '/snap/subiquity/3698/usr/bin/python3.8', '-m', 'curtin', '--showtrace', '-vvv', '--set', 'json:reporting={"subiquity": {"type": "journald", "identifier": "curtin_event.3786.2"}}', 'in-target', '-t', '/tmp/tmpzrthyaql/mount', '--', 'apt-get', 'update']' returned non-zero exit status 100.
  2022-10-28 15:57:36,679 INFO root:39 start: subiquity/ErrorReporter/1666972656.669968843.install_fail/add_info:
  2022-10-28 15:57:36,680 ERROR subiquity.server.server:416 top level error
  Traceback (most recent call last):
    File "/snap/subiquity/3698/lib/python3.8/site-packages/subiquity/server/controllers/cmdlist.py", line 104, in _run
      await Install.install_task
    File "/snap/subiquity/3698/lib/python3.8/site-packages/subiquitycore/context.py", line 148, in decorated_async
      return await meth(self, **kw)
    File "/snap/subiquity/3698/lib/python3.8/site-packages/subiquity/server/controllers/install.py", line 160, in install
      for_install_path = await self.configure_apt(context=context)
    File "/snap/subiquity/3698/lib/python3.8/site-packages/subiquitycore/context.py", line 148, in decorated_async
      return await meth(self, **kw)
    File "/snap/subiquity/3698/lib/python3.8/site-packages/subiquity/server/controllers/install.py", line 131, in configure_apt
      return await configurer.configure_for_install(context)
    File "/snap/subiquity/3698/lib/python3.8/site-packages/subiquity/server/apt.py", line 225, in configure_for_install
      await run_curtin_command(
    File "/snap/subiquity/3698/lib/python3.8/site-packages/subiquity/server/curtin.py", line 181, in run_curtin_command
      return await cmd.wait()
    File "/snap/subiquity/3698/lib/python3.8/site-packages/subiquity/server/curtin.py", line 118, in wait
      result = await self.runner.wait(self.proc)
    File "/snap/subiquity/3698/lib/python3.8/site-packages/subiquity/server/runner.py", line 81, in wait
      raise subprocess.CalledProcessError(proc.returncode, proc.args)

  ------------------------------------------------------------------
  /var/crash/1666972656.669968843.install_fail.crash more about geoip.ubuntu.com connect failed log:
  ------------------------------------------------------------------

  2022-10-28 15:57:17,607 ERROR subiquity.common.geoip:119 geoip lookup failed
   Traceback (most recent call last):
     File "/snap/subiquity/3698/lib/python3.8/site-packages/urllib3/connection.py", line 174, in _new_conn
       conn = connection.create_connection(
     File "/snap/subiquity/3698/lib/python3.8/site-packages/urllib3/util/connection.py", line 72, in create_connection
       for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM):
     File "/snap/subiquity/3698/usr/lib/python3.8/socket.py", line 918, in getaddrinfo
       for res in _socket.getaddrinfo(host, port, family, type, proto, flags):
   socket.gaierror: [Errno -3] Temporary failure in name resolution

   During handling of the above exception, another exception occurred:

   Traceback (most recent call last):
     File "/snap/subiquity/3698/lib/python3.8/site-packages/urllib3/connectionpool.py", line 703, in urlopen
       httplib_response = self._make_request(
     File "/snap/subiquity/3698/lib/python3.8/site-packages/urllib3/connectionpool.py", line 386, in _make_request
       self._validate_conn(conn)
     File "/snap/subiquity/3698/lib/python3.8/site-packages/urllib3/connectionpool.py", line 1042, in _validate_conn
       conn.connect()
     File "/snap/subiquity/3698/lib/python3.8/site-packages/urllib3/connection.py", line 358, in connect
       self.sock = conn = self._new_conn()
     File "/snap/subiquity/3698/lib/python3.8/site-packages/urllib3/connection.py", line 186, in _new_conn
       raise NewConnectionError(
   urllib3.exceptions.NewConnectionError: <urllib3.connection.HTTPSConnection object at 0x7f8f2c713370>: Failed to establish a new connection: [Errno -3] Temporary failure in name resolution

   During handling of the above exception, another exception occurred:

   Traceback (most recent call last):
     File "/snap/subiquity/3698/lib/python3.8/site-packages/requests/adapters.py", line 489, in send
       resp = conn.urlopen(
     File "/snap/subiquity/3698/lib/python3.8/site-packages/urllib3/connectionpool.py", line 787, in urlopen
       retries = retries.increment(
     File "/snap/subiquity/3698/lib/python3.8/site-packages/urllib3/util/retry.py", line 592, in increment
       raise MaxRetryError(_pool, url, error or ResponseError(cause))
   urllib3.exceptions.MaxRetryError: HTTPSConnectionPool(host='geoip.ubuntu.com', port=443): Max retries exceeded with url: /lookup (Caused by NewConnectionError('<urllib3.connection.HTTPSConnection object at 0x7f8f2c713370>: Failed to establish a new connection: [Errno -3] Temporary failure in name resolution'))

   During handling of the above exception, another exception occurred:

   Traceback (most recent call last):
     File "/snap/subiquity/3698/lib/python3.8/site-packages/subiquity/server/geoip.py", line 80, in get_response
       response = await run_in_thread(
     File "/snap/subiquity/3698/lib/python3.8/site-packages/subiquitycore/async_helpers.py", line 46, in run_in_thread
       return await loop.run_in_executor(None, func, *args)
     File "/snap/subiquity/3698/usr/lib/python3.8/concurrent/futures/thread.py", line 57, in run
       result = self.fn(*self.args, **self.kwargs)
     File "/snap/subiquity/3698/lib/python3.8/site-packages/requests/api.py", line 73, in get
       return request("get", url, params=params, **kwargs)
     File "/snap/subiquity/3698/lib/python3.8/site-packages/requests/api.py", line 59, in request
       return session.request(method=method, url=url, **kwargs)
     File "/snap/subiquity/3698/lib/python3.8/site-packages/requests/sessions.py", line 587, in request
       resp = self.send(prep, **send_kwargs)
     File "/snap/subiquity/3698/lib/python3.8/site-packages/requests/sessions.py", line 701, in send
       r = adapter.send(request, **kwargs)
     File "/snap/subiquity/3698/lib/python3.8/site-packages/requests/adapters.py", line 565, in send
       raise ConnectionError(e, request=request)
   requests.exceptions.ConnectionError: HTTPSConnectionPool(host='geoip.ubuntu.com', port=443): Max retries exceeded with url: /lookup (Caused by NewConnectionError('<urllib3.connection.HTTPSConnection object at 0x7f8f2c713370>: Failed to establish a new connection: [Errno -3] Temporary failure in name resolution'))

   The above exception was the direct cause of the following exception:

   Traceback (most recent call last):
     File "/snap/subiquity/3698/lib/python3.8/site-packages/subiquity/server/geoip.py", line 117, in _lookup
       self.response_text = await self.strategy.get_response()
     File "/snap/subiquity/3698/lib/python3.8/site-packages/subiquity/server/geoip.py", line 84, in get_response
       raise LookupError from e
   subiquity.server.geoip.LookupError

To manage notifications about this bug go to:
https://bugs.launchpad.net/ubuntu/+source/subiquity/+bug/1995128/+subscriptions




More information about the foundations-bugs mailing list