-- Logs begin at Wed 2021-05-05 18:17:50 EDT, end at Wed 2021-06-30 11:09:35 EDT. -- Jun 14 12:07:10 nas-kvm systemd[1]: Starting TinyPilot updater... Jun 14 12:07:11 nas-kvm tinypilot-update-svc[24809]: 2021-06-14 12:07:11 __main__ INFO Starting TinyPilot update Jun 14 12:07:11 nas-kvm tinypilot-update-svc[24809]: 2021-06-14 12:07:11 __main__ INFO Launching update script: /opt/tinypilot-privileged/update Jun 14 12:07:11 nas-kvm sudo[24810]: tinypilot : TTY=unknown ; PWD=/opt/tinypilot ; USER=root ; COMMAND=/opt/tinypilot-privileged/update Jun 14 12:07:11 nas-kvm sudo[24810]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 12:07:11 nas-kvm tinypilot-update-svc[24809]: + set -u Jun 14 12:07:11 nas-kvm tinypilot-update-svc[24809]: + set -e Jun 14 12:07:11 nas-kvm tinypilot-update-svc[24809]: ++ mktemp -d Jun 14 12:07:11 nas-kvm tinypilot-update-svc[24809]: + cd /tmp/tmp.kZxN8n2dua Jun 14 12:07:11 nas-kvm tinypilot-update-svc[24809]: + git clone https://dev.azure.com/tinypilot/tinypilot-pro/_git/tinypilot-pro . Jun 14 12:07:11 nas-kvm tinypilot-update-svc[24809]: Cloning into '.'... Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + ./quick-install Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + readonly DEFAULT_TINYPILOT_SETTINGS_FILE=/home/tinypilot/settings.yml Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + DEFAULT_TINYPILOT_SETTINGS_FILE=/home/tinypilot/settings.yml Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + [[ -n '' ]] Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + set -u Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: ++ mktemp --tmpdir=/var/tmp --suffix .yml Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + readonly TINYPILOT_SETTINGS_FILE=/var/tmp/tmp.xSHyUmECfR.yml Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + TINYPILOT_SETTINGS_FILE=/var/tmp/tmp.xSHyUmECfR.yml Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + [[ -f /home/tinypilot/settings.yml ]] Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + echo 'Using settings file at: /home/tinypilot/settings.yml' Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: Using settings file at: /home/tinypilot/settings.yml Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + sudo cp /home/tinypilot/settings.yml /var/tmp/tmp.xSHyUmECfR.yml Jun 14 12:07:16 nas-kvm sudo[24830]: root : TTY=unknown ; PWD=/tmp/tmp.kZxN8n2dua ; USER=root ; COMMAND=/usr/bin/cp /home/tinypilot/settings.yml /var/tmp/tmp.xSHyUmECfR.yml Jun 14 12:07:16 nas-kvm sudo[24830]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 12:07:16 nas-kvm sudo[24830]: pam_unix(sudo:session): session closed for user root Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + readonly EXTRA_VARS_PATH=@/var/tmp/tmp.xSHyUmECfR.yml Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + EXTRA_VARS_PATH=@/var/tmp/tmp.xSHyUmECfR.yml Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + add_setting_if_undefined ustreamer_port 8001 Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + local key=ustreamer_port Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + local value=8001 Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + grep --silent '^ustreamer_port:' /var/tmp/tmp.xSHyUmECfR.yml Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + add_setting_if_undefined ustreamer_persistent true Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + local key=ustreamer_persistent Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + local value=true Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + grep --silent '^ustreamer_persistent:' /var/tmp/tmp.xSHyUmECfR.yml Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + USE_TC358743_DEFAULTS= Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + grep --silent '^ustreamer_capture_device:' /var/tmp/tmp.xSHyUmECfR.yml Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + '[' -f /home/ustreamer/config.yml ']' Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + grep --silent 'capture_device: "tc358743"' /home/ustreamer/config.yml Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + USE_TC358743_DEFAULTS=y Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + [[ y == \y ]] Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + add_setting_if_undefined ustreamer_encoder omx Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + local key=ustreamer_encoder Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + local value=omx Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + grep --silent '^ustreamer_encoder:' /var/tmp/tmp.xSHyUmECfR.yml Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + add_setting_if_undefined ustreamer_format uyvy Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + local key=ustreamer_format Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + local value=uyvy Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + grep --silent '^ustreamer_format:' /var/tmp/tmp.xSHyUmECfR.yml Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + add_setting_if_undefined ustreamer_workers 3 Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + local key=ustreamer_workers Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + local value=3 Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + grep --silent '^ustreamer_workers:' /var/tmp/tmp.xSHyUmECfR.yml Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + add_setting_if_undefined ustreamer_use_dv_timings true Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + local key=ustreamer_use_dv_timings Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + local value=true Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + grep --silent '^ustreamer_use_dv_timings:' /var/tmp/tmp.xSHyUmECfR.yml Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + add_setting_if_undefined ustreamer_drop_same_frames 30 Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + local key=ustreamer_drop_same_frames Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + local value=30 Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + grep --silent '^ustreamer_drop_same_frames:' /var/tmp/tmp.xSHyUmECfR.yml Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + echo 'Final install settings:' Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: Final install settings: Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + cat /var/tmp/tmp.xSHyUmECfR.yml Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: tinypilot_manage_tls_keys: false Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: tinypilot_repo_branch: 2.2.2 Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: ustreamer_drop_same_frames: 30 Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: ustreamer_encoder: omx Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: ustreamer_format: uyvy Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: ustreamer_persistent: true Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: ustreamer_port: 8001 Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: ustreamer_use_dv_timings: true Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: ustreamer_workers: 3 Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: + sudo apt-get update Jun 14 12:07:16 nas-kvm sudo[24842]: root : TTY=unknown ; PWD=/tmp/tmp.kZxN8n2dua ; USER=root ; COMMAND=/usr/bin/apt-get update Jun 14 12:07:16 nas-kvm sudo[24842]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: Get:1 http://archive.raspberrypi.org/debian buster InRelease [32.6 kB] Jun 14 12:07:16 nas-kvm tinypilot-update-svc[24809]: Get:2 http://raspbian.raspberrypi.org/raspbian buster InRelease [15.0 kB] Jun 14 12:07:17 nas-kvm tinypilot-update-svc[24809]: Get:3 http://raspbian.raspberrypi.org/raspbian buster/main armhf Packages [13.0 MB] Jun 14 12:07:18 nas-kvm tinypilot-update-svc[24809]: Get:4 http://archive.raspberrypi.org/debian buster/main armhf Packages [376 kB] Jun 14 12:07:26 nas-kvm tinypilot-update-svc[24809]: Fetched 13.4 MB in 10s (1,406 kB/s) Jun 14 12:07:29 nas-kvm tinypilot-update-svc[24809]: Reading package lists... Jun 14 12:07:30 nas-kvm sudo[24842]: pam_unix(sudo:session): session closed for user root Jun 14 12:07:30 nas-kvm tinypilot-update-svc[24809]: + sudo apt-get install -y git libffi-dev libssl-dev python3-dev python3-venv Jun 14 12:07:30 nas-kvm sudo[24963]: root : TTY=unknown ; PWD=/tmp/tmp.kZxN8n2dua ; USER=root ; COMMAND=/usr/bin/apt-get install -y git libffi-dev libssl-dev python3-dev python3-venv Jun 14 12:07:30 nas-kvm sudo[24963]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 12:07:33 nas-kvm tinypilot-update-svc[24809]: Reading package lists... Jun 14 12:07:33 nas-kvm tinypilot-update-svc[24809]: Building dependency tree... Jun 14 12:07:33 nas-kvm tinypilot-update-svc[24809]: Reading state information... Jun 14 12:07:33 nas-kvm tinypilot-update-svc[24809]: git is already the newest version (1:2.20.1-2+deb10u3). Jun 14 12:07:33 nas-kvm tinypilot-update-svc[24809]: libffi-dev is already the newest version (3.2.1-9). Jun 14 12:07:33 nas-kvm tinypilot-update-svc[24809]: python3-dev is already the newest version (3.7.3-1). Jun 14 12:07:33 nas-kvm tinypilot-update-svc[24809]: python3-venv is already the newest version (3.7.3-1). Jun 14 12:07:33 nas-kvm tinypilot-update-svc[24809]: libssl-dev is already the newest version (1.1.1d-0+deb10u6+rpt1). Jun 14 12:07:33 nas-kvm tinypilot-update-svc[24809]: 0 upgraded, 0 newly installed, 0 to remove and 61 not upgraded. Jun 14 12:07:33 nas-kvm sudo[24963]: pam_unix(sudo:session): session closed for user root Jun 14 12:07:33 nas-kvm tinypilot-update-svc[24809]: + INSTALLER_DIR=/opt/tinypilot-updater Jun 14 12:07:33 nas-kvm tinypilot-update-svc[24809]: + sudo mkdir -p /opt/tinypilot-updater Jun 14 12:07:33 nas-kvm sudo[24969]: root : TTY=unknown ; PWD=/tmp/tmp.kZxN8n2dua ; USER=root ; COMMAND=/usr/bin/mkdir -p /opt/tinypilot-updater Jun 14 12:07:33 nas-kvm sudo[24969]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 12:07:33 nas-kvm sudo[24969]: pam_unix(sudo:session): session closed for user root Jun 14 12:07:33 nas-kvm tinypilot-update-svc[24809]: ++ whoami Jun 14 12:07:36 nas-kvm tinypilot-update-svc[24809]: ++ whoami Jun 14 12:07:36 nas-kvm tinypilot-update-svc[24809]: + sudo chown root:root --recursive /opt/tinypilot-updater Jun 14 12:07:36 nas-kvm sudo[24974]: root : TTY=unknown ; PWD=/tmp/tmp.kZxN8n2dua ; USER=root ; COMMAND=/usr/bin/chown root:root --recursive /opt/tinypilot-updater Jun 14 12:07:36 nas-kvm sudo[24974]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 12:07:36 nas-kvm sudo[24974]: pam_unix(sudo:session): session closed for user root Jun 14 12:07:36 nas-kvm tinypilot-update-svc[24809]: + pushd /opt/tinypilot-updater Jun 14 12:07:36 nas-kvm tinypilot-update-svc[24809]: /opt/tinypilot-updater /tmp/tmp.kZxN8n2dua Jun 14 12:07:36 nas-kvm tinypilot-update-svc[24809]: + python3 -m venv venv Jun 14 12:07:44 nas-kvm tinypilot-update-svc[24809]: + . venv/bin/activate Jun 14 12:07:44 nas-kvm tinypilot-update-svc[24809]: ++ deactivate nondestructive Jun 14 12:07:44 nas-kvm tinypilot-update-svc[24809]: ++ '[' -n '' ']' Jun 14 12:07:44 nas-kvm tinypilot-update-svc[24809]: ++ '[' -n /bin/bash -o -n '' ']' Jun 14 12:07:44 nas-kvm tinypilot-update-svc[24809]: ++ hash -r Jun 14 12:07:44 nas-kvm tinypilot-update-svc[24809]: ++ '[' -n '' ']' Jun 14 12:07:44 nas-kvm tinypilot-update-svc[24809]: ++ unset VIRTUAL_ENV Jun 14 12:07:44 nas-kvm tinypilot-update-svc[24809]: ++ '[' '!' nondestructive = nondestructive ']' Jun 14 12:07:44 nas-kvm tinypilot-update-svc[24809]: ++ VIRTUAL_ENV=/opt/tinypilot-updater/venv Jun 14 12:07:44 nas-kvm tinypilot-update-svc[24809]: ++ export VIRTUAL_ENV Jun 14 12:07:44 nas-kvm tinypilot-update-svc[24809]: ++ _OLD_VIRTUAL_PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin Jun 14 12:07:44 nas-kvm tinypilot-update-svc[24809]: ++ PATH=/opt/tinypilot-updater/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin Jun 14 12:07:44 nas-kvm tinypilot-update-svc[24809]: ++ export PATH Jun 14 12:07:44 nas-kvm tinypilot-update-svc[24809]: ++ '[' -n '' ']' Jun 14 12:07:44 nas-kvm tinypilot-update-svc[24809]: ++ '[' -z '' ']' Jun 14 12:07:44 nas-kvm tinypilot-update-svc[24809]: ++ _OLD_VIRTUAL_PS1= Jun 14 12:07:44 nas-kvm tinypilot-update-svc[24809]: ++ '[' 'x(venv) ' '!=' x ']' Jun 14 12:07:44 nas-kvm tinypilot-update-svc[24809]: ++ PS1='(venv) ' Jun 14 12:07:44 nas-kvm tinypilot-update-svc[24809]: ++ export PS1 Jun 14 12:07:44 nas-kvm tinypilot-update-svc[24809]: ++ '[' -n /bin/bash -o -n '' ']' Jun 14 12:07:44 nas-kvm tinypilot-update-svc[24809]: ++ hash -r Jun 14 12:07:44 nas-kvm tinypilot-update-svc[24809]: + pip install wheel==0.34.2 Jun 14 12:07:48 nas-kvm tinypilot-update-svc[24809]: Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple Jun 14 12:07:48 nas-kvm tinypilot-update-svc[24809]: Requirement already satisfied: wheel==0.34.2 in ./venv/lib/python3.7/site-packages (0.34.2) Jun 14 12:07:49 nas-kvm tinypilot-update-svc[24809]: + echo 'ansible==2.9.10 Jun 14 12:07:49 nas-kvm tinypilot-update-svc[24809]: cffi==1.14.4 Jun 14 12:07:49 nas-kvm tinypilot-update-svc[24809]: cryptography==3.3.2 Jun 14 12:07:49 nas-kvm tinypilot-update-svc[24809]: Jinja2==2.11.2 Jun 14 12:07:49 nas-kvm tinypilot-update-svc[24809]: MarkupSafe==1.1.1 Jun 14 12:07:49 nas-kvm tinypilot-update-svc[24809]: pkg-resources==0.0.0 Jun 14 12:07:49 nas-kvm tinypilot-update-svc[24809]: pycparser==2.20 Jun 14 12:07:49 nas-kvm tinypilot-update-svc[24809]: pyOpenSSL==20.0.1 Jun 14 12:07:49 nas-kvm tinypilot-update-svc[24809]: PyYAML==5.3.1 Jun 14 12:07:49 nas-kvm tinypilot-update-svc[24809]: six==1.15.0' Jun 14 12:07:49 nas-kvm tinypilot-update-svc[24809]: + pip install -r requirements.txt Jun 14 12:07:52 nas-kvm tinypilot-update-svc[24809]: Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple Jun 14 12:07:52 nas-kvm tinypilot-update-svc[24809]: Requirement already satisfied: ansible==2.9.10 in ./venv/lib/python3.7/site-packages (from -r requirements.txt (line 1)) (2.9.10) Jun 14 12:07:52 nas-kvm tinypilot-update-svc[24809]: Requirement already satisfied: cffi==1.14.4 in ./venv/lib/python3.7/site-packages (from -r requirements.txt (line 2)) (1.14.4) Jun 14 12:07:52 nas-kvm tinypilot-update-svc[24809]: Requirement already satisfied: cryptography==3.3.2 in ./venv/lib/python3.7/site-packages (from -r requirements.txt (line 3)) (3.3.2) Jun 14 12:07:52 nas-kvm tinypilot-update-svc[24809]: Requirement already satisfied: Jinja2==2.11.2 in ./venv/lib/python3.7/site-packages (from -r requirements.txt (line 4)) (2.11.2) Jun 14 12:07:52 nas-kvm tinypilot-update-svc[24809]: Requirement already satisfied: MarkupSafe==1.1.1 in ./venv/lib/python3.7/site-packages (from -r requirements.txt (line 5)) (1.1.1) Jun 14 12:07:52 nas-kvm tinypilot-update-svc[24809]: Requirement already satisfied: pkg-resources==0.0.0 in ./venv/lib/python3.7/site-packages (from -r requirements.txt (line 6)) (0.0.0) Jun 14 12:07:52 nas-kvm tinypilot-update-svc[24809]: Requirement already satisfied: pycparser==2.20 in ./venv/lib/python3.7/site-packages (from -r requirements.txt (line 7)) (2.20) Jun 14 12:07:52 nas-kvm tinypilot-update-svc[24809]: Requirement already satisfied: pyOpenSSL==20.0.1 in ./venv/lib/python3.7/site-packages (from -r requirements.txt (line 8)) (20.0.1) Jun 14 12:07:52 nas-kvm tinypilot-update-svc[24809]: Requirement already satisfied: PyYAML==5.3.1 in ./venv/lib/python3.7/site-packages (from -r requirements.txt (line 9)) (5.3.1) Jun 14 12:07:53 nas-kvm tinypilot-update-svc[24809]: Requirement already satisfied: six==1.15.0 in ./venv/lib/python3.7/site-packages (from -r requirements.txt (line 10)) (1.15.0) Jun 14 12:07:53 nas-kvm tinypilot-update-svc[24809]: + echo '[defaults] Jun 14 12:07:53 nas-kvm tinypilot-update-svc[24809]: roles_path = /opt/tinypilot-updater Jun 14 12:07:53 nas-kvm tinypilot-update-svc[24809]: interpreter_python = /usr/bin/python3 Jun 14 12:07:53 nas-kvm tinypilot-update-svc[24809]: ' Jun 14 12:07:53 nas-kvm tinypilot-update-svc[24809]: + readonly TINYPILOT_ROLE_NAME=tinypilot.tinypilot-pro Jun 14 12:07:53 nas-kvm tinypilot-update-svc[24809]: + TINYPILOT_ROLE_NAME=tinypilot.tinypilot-pro Jun 14 12:07:53 nas-kvm tinypilot-update-svc[24809]: + readonly TINYPILOT_ROLE_VERSION=1.1.3 Jun 14 12:07:53 nas-kvm tinypilot-update-svc[24809]: + TINYPILOT_ROLE_VERSION=1.1.3 Jun 14 12:07:53 nas-kvm tinypilot-update-svc[24809]: + [[ ! -d tinypilot.tinypilot-pro ]] Jun 14 12:07:53 nas-kvm tinypilot-update-svc[24809]: + pushd tinypilot.tinypilot-pro Jun 14 12:07:53 nas-kvm tinypilot-update-svc[24809]: /opt/tinypilot-updater/tinypilot.tinypilot-pro /opt/tinypilot-updater /tmp/tmp.kZxN8n2dua Jun 14 12:07:53 nas-kvm tinypilot-update-svc[24809]: + git fetch --tags --force Jun 14 12:07:53 nas-kvm tinypilot-update-svc[24809]: From https://dev.azure.com/tinypilot/ansible-role-tinypilot-pro/_git/ansible-role-tinypilot-pro Jun 14 12:07:53 nas-kvm tinypilot-update-svc[24809]: d85b96c..a354135 master -> origin/master Jun 14 12:07:53 nas-kvm tinypilot-update-svc[24809]: * [new tag] 1.1.3 -> 1.1.3 Jun 14 12:07:53 nas-kvm tinypilot-update-svc[24809]: + git checkout 1.1.3 Jun 14 12:07:53 nas-kvm tinypilot-update-svc[24809]: Previous HEAD position was d85b96c Merge pull request #51 from tiny-pilot/ustreamer-role-1.0.2 Jun 14 12:07:53 nas-kvm tinypilot-update-svc[24809]: HEAD is now at a354135 Merge pull request #55 from tiny-pilot/upstream-6-11 Jun 14 12:07:53 nas-kvm tinypilot-update-svc[24809]: + popd Jun 14 12:07:53 nas-kvm tinypilot-update-svc[24809]: /opt/tinypilot-updater /tmp/tmp.kZxN8n2dua Jun 14 12:07:53 nas-kvm tinypilot-update-svc[24809]: + ansible-galaxy install --force --role-file tinypilot.tinypilot-pro/requirements.yml Jun 14 12:07:57 nas-kvm tinypilot-update-svc[24809]: - extracting ansible-role-ustreamer to /opt/tinypilot-updater/ansible-role-ustreamer Jun 14 12:07:57 nas-kvm tinypilot-update-svc[24809]: - ansible-role-ustreamer (1.0.2) was installed successfully Jun 14 12:07:57 nas-kvm tinypilot-update-svc[24809]: - changing role ansible-role-nginx from 2.8.2 to 2.8.2 Jun 14 12:07:58 nas-kvm tinypilot-update-svc[24809]: - extracting ansible-role-nginx to /opt/tinypilot-updater/ansible-role-nginx Jun 14 12:07:58 nas-kvm tinypilot-update-svc[24809]: - ansible-role-nginx (2.8.2) was installed successfully Jun 14 12:07:58 nas-kvm tinypilot-update-svc[24809]: + echo '- hosts: localhost Jun 14 12:07:58 nas-kvm tinypilot-update-svc[24809]: connection: local Jun 14 12:07:58 nas-kvm tinypilot-update-svc[24809]: become: true Jun 14 12:07:58 nas-kvm tinypilot-update-svc[24809]: become_method: sudo Jun 14 12:07:58 nas-kvm tinypilot-update-svc[24809]: roles: Jun 14 12:07:58 nas-kvm tinypilot-update-svc[24809]: - role: tinypilot.tinypilot-pro' Jun 14 12:07:58 nas-kvm tinypilot-update-svc[24809]: + ansible-playbook -i localhost, install.yml --extra-vars @/var/tmp/tmp.xSHyUmECfR.yml Jun 14 12:08:04 nas-kvm tinypilot-update-svc[24809]: PLAY [localhost] *************************************************************** Jun 14 12:08:04 nas-kvm tinypilot-update-svc[24809]: TASK [Gathering Facts] ********************************************************* Jun 14 12:08:06 nas-kvm ansible-setup[25064]: Invoked with gather_subset=['all'] gather_timeout=10 filter=* fact_path=/etc/ansible/facts.d Jun 14 12:08:07 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:08:07 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-ustreamer : create ustreamer group] ************************* Jun 14 12:08:08 nas-kvm ansible-group[25133]: Invoked with name=ustreamer state=present system=False local=False non_unique=False gid=None Jun 14 12:08:08 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:08:08 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-ustreamer : create ustreamer user] ************************** Jun 14 12:08:10 nas-kvm ansible-user[25160]: Invoked with name=ustreamer group=ustreamer groups=['video'] system=True create_home=True state=present non_unique=False force=False remove=False move_home=False append=False ssh_key_bits=0 ssh_key_type=rsa ssh_key_comment=ansible-generated on nas-kvm update_password=always uid=None comment=None home=None shell=None password=NOT_LOGGING_PARAMETER login_class=None hidden=None seuser=None skeleton=None generate_ssh_key=None ssh_key_file=None ssh_key_passphrase=NOT_LOGGING_PARAMETER expires=None password_lock=None local=None profile=None authorization=None role=None Jun 14 12:08:10 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:08:10 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-ustreamer : check for a boot config file] ******************* Jun 14 12:08:11 nas-kvm ansible-stat[25189]: Invoked with path=/boot/config.txt follow=False get_md5=False get_checksum=True get_mime=True get_attributes=True checksum_algorithm=sha1 Jun 14 12:08:11 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:08:11 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-ustreamer : save whether boot config file exists] *********** Jun 14 12:08:11 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:08:11 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-ustreamer : check whether this machine has a uStreamer settings file] *** Jun 14 12:08:12 nas-kvm ansible-stat[25218]: Invoked with path=/home/ustreamer/config.yml follow=False get_md5=False get_checksum=True get_mime=True get_attributes=True checksum_algorithm=sha1 Jun 14 12:08:12 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:08:12 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-ustreamer : read uStreamer settings file] ******************* Jun 14 12:08:14 nas-kvm ansible-slurp[25246]: Invoked with src=/home/ustreamer/config.yml Jun 14 12:08:14 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:08:14 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-ustreamer : decode settings file] *************************** Jun 14 12:08:14 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:08:14 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-ustreamer : read ustreamer_capture_device from config file if it's not already defined] *** Jun 14 12:08:14 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:08:14 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-ustreamer : enable TC358743 overlay in /boot/config.txt] **** Jun 14 12:08:15 nas-kvm ansible-lineinfile[25276]: Invoked with path=/boot/config.txt line=dtoverlay=tc358743 insertafter=EOF state=present backrefs=False create=False backup=False firstmatch=False follow=False regexp=None insertbefore=None validate=None mode=None owner=None group=None seuser=None serole=None selevel=None setype=None attributes=None src=None force=None content=NOT_LOGGING_PARAMETER remote_src=None delimiter=None directory_mode=None unsafe_writes=None Jun 14 12:08:15 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:08:15 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-ustreamer : set GPU memory to 256MB in /boot/config.txt] **** Jun 14 12:08:16 nas-kvm ansible-lineinfile[25301]: Invoked with path=/boot/config.txt line=gpu_mem=256 regexp=gpu_mem= insertafter=EOF state=present backrefs=False create=False backup=False firstmatch=False follow=False insertbefore=None validate=None mode=None owner=None group=None seuser=None serole=None selevel=None setype=None attributes=None src=None force=None content=NOT_LOGGING_PARAMETER remote_src=None delimiter=None directory_mode=None unsafe_writes=None Jun 14 12:08:16 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:08:16 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-ustreamer : check for a boot cmdline file] ****************** Jun 14 12:08:17 nas-kvm ansible-stat[25327]: Invoked with path=/boot/cmdline.txt follow=False get_md5=False get_checksum=True get_mime=True get_attributes=True checksum_algorithm=sha1 Jun 14 12:08:17 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:08:17 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-ustreamer : read /boot/cmdline.txt] ************************* Jun 14 12:08:18 nas-kvm ansible-slurp[25354]: Invoked with src=/boot/cmdline.txt Jun 14 12:08:18 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:08:18 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-ustreamer : decode command-line string] ********************* Jun 14 12:08:18 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:08:18 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-ustreamer : change cma to 128M if it's set to a different value] *** Jun 14 12:08:18 nas-kvm tinypilot-update-svc[24809]: skipping: [localhost] Jun 14 12:08:18 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-ustreamer : add cma=128M to cmdline.txt if it's missing] **** Jun 14 12:08:18 nas-kvm tinypilot-update-svc[24809]: skipping: [localhost] Jun 14 12:08:18 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-ustreamer : create EDIDs folder] **************************** Jun 14 12:08:20 nas-kvm ansible-file[25386]: Invoked with path=/home/ustreamer/edids state=directory owner=root group=root recurse=False force=False follow=True modification_time_format=%Y%m%d%H%M.%S access_time_format=%Y%m%d%H%M.%S _original_basename=None _diff_peek=None src=None modification_time=None access_time=None mode=None seuser=None serole=None selevel=None setype=None attributes=None content=NOT_LOGGING_PARAMETER backup=None remote_src=None regexp=None delimiter=None directory_mode=None unsafe_writes=None Jun 14 12:08:20 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:08:20 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-ustreamer : copy TC358743 EDID file] ************************ Jun 14 12:08:20 nas-kvm ansible-stat[25411]: Invoked with path=/home/ustreamer/edids/tc358743-edid.hex follow=False get_checksum=True checksum_algorithm=sha1 get_md5=False get_mime=True get_attributes=True Jun 14 12:08:21 nas-kvm ansible-file[25422]: Invoked with owner=ustreamer group=ustreamer mode=0644 dest=/home/ustreamer/edids/tc358743-edid.hex _original_basename=tmp86tjz37i recurse=False state=file path=/home/ustreamer/edids/tc358743-edid.hex force=False follow=True modification_time_format=%Y%m%d%H%M.%S access_time_format=%Y%m%d%H%M.%S _diff_peek=None src=None modification_time=None access_time=None seuser=None serole=None selevel=None setype=None attributes=None content=NOT_LOGGING_PARAMETER backup=None remote_src=None regexp=None delimiter=None directory_mode=None unsafe_writes=None Jun 14 12:08:21 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:08:21 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-ustreamer : install TC358743 initializer service] *********** Jun 14 12:08:22 nas-kvm ansible-stat[25447]: Invoked with path=/lib/systemd/system/load-tc358743-edid.service follow=False get_checksum=True checksum_algorithm=sha1 get_md5=False get_mime=True get_attributes=True Jun 14 12:08:22 nas-kvm ansible-file[25457]: Invoked with owner=root group=root mode=0644 follow=False dest=/lib/systemd/system/load-tc358743-edid.service _original_basename=load-tc358743-edid.systemd.j2 recurse=False state=file path=/lib/systemd/system/load-tc358743-edid.service force=False modification_time_format=%Y%m%d%H%M.%S access_time_format=%Y%m%d%H%M.%S _diff_peek=None src=None modification_time=None access_time=None seuser=None serole=None selevel=None setype=None attributes=None content=NOT_LOGGING_PARAMETER backup=None remote_src=None regexp=None delimiter=None directory_mode=None unsafe_writes=None Jun 14 12:08:23 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:08:23 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-ustreamer : use custom settings for TC358743 chip for any facts not already defined] *** Jun 14 12:08:23 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:08:23 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-ustreamer : remove TC358743 initializer service file] ******* Jun 14 12:08:23 nas-kvm tinypilot-update-svc[24809]: skipping: [localhost] Jun 14 12:08:23 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-ustreamer : disable TC358743 overlay in /boot/config.txt] *** Jun 14 12:08:23 nas-kvm tinypilot-update-svc[24809]: skipping: [localhost] Jun 14 12:08:23 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-ustreamer : save whether boot config file exists] *********** Jun 14 12:08:23 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:08:23 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-ustreamer : enable OpenMax IL acceleration on Pi OS] ******** Jun 14 12:08:23 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:08:23 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-ustreamer : collect universal required apt packages] ******** Jun 14 12:08:24 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:08:24 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-ustreamer : collect Raspberry Pi OS specific required apt packages] *** Jun 14 12:08:24 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:08:24 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-ustreamer : install libraspberrypi-dev if we're using OpenMax IL acceleration] *** Jun 14 12:08:24 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:08:24 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-ustreamer : collect Debian-specific required apt packages] *** Jun 14 12:08:24 nas-kvm tinypilot-update-svc[24809]: skipping: [localhost] Jun 14 12:08:24 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-ustreamer : collect Ubuntu-specific required apt packages] *** Jun 14 12:08:24 nas-kvm tinypilot-update-svc[24809]: skipping: [localhost] Jun 14 12:08:24 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-ustreamer : install uStreamer pre-requisite packages] ******* Jun 14 12:08:26 nas-kvm ansible-apt[25504]: Invoked with name=['build-essential', 'git', 'libevent-dev', 'libbsd-dev', 'uuid-dev', 'libjpeg8-dev', 'libraspberrypi-dev'] state=present package=['build-essential', 'git', 'libevent-dev', 'libbsd-dev', 'uuid-dev', 'libjpeg8-dev', 'libraspberrypi-dev'] cache_valid_time=0 purge=False force=False dpkg_options=force-confdef,force-confold autoremove=False autoclean=False only_upgrade=False force_apt_get=False allow_unauthenticated=False update_cache=None deb=None default_release=None install_recommends=None upgrade=None policy_rc_d=None Jun 14 12:08:28 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:08:28 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-ustreamer : create uStreamer folder] ************************ Jun 14 12:08:29 nas-kvm ansible-file[25535]: Invoked with path=/opt/ustreamer state=directory owner=ustreamer group=ustreamer recurse=False force=False follow=True modification_time_format=%Y%m%d%H%M.%S access_time_format=%Y%m%d%H%M.%S _original_basename=None _diff_peek=None src=None modification_time=None access_time=None mode=None seuser=None serole=None selevel=None setype=None attributes=None content=NOT_LOGGING_PARAMETER backup=None remote_src=None regexp=None delimiter=None directory_mode=None unsafe_writes=None Jun 14 12:08:29 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:08:29 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-ustreamer : get uStreamer repo] ***************************** Jun 14 12:08:30 nas-kvm ansible-git[25561]: Invoked with repo=https://github.com/tiny-pilot/ustreamer.git dest=/opt/ustreamer version=v3.26 remote=origin force=False clone=True update=True verify_commit=False gpg_whitelist=[] accept_hostkey=False bare=False recursive=True track_submodules=False refspec=None reference=None depth=None key_file=None ssh_opts=None executable=None umask=None archive=None separate_git_dir=None Jun 14 12:08:31 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:08:31 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-ustreamer : cache build settings] *************************** Jun 14 12:08:32 nas-kvm ansible-stat[25604]: Invoked with path=/home/ustreamer/build-settings.cache follow=False get_checksum=True checksum_algorithm=sha1 get_md5=False get_mime=True get_attributes=True Jun 14 12:08:33 nas-kvm ansible-file[25614]: Invoked with owner=ustreamer group=ustreamer mode=0644 follow=False dest=/home/ustreamer/build-settings.cache _original_basename=build-settings.j2 recurse=False state=file path=/home/ustreamer/build-settings.cache force=False modification_time_format=%Y%m%d%H%M.%S access_time_format=%Y%m%d%H%M.%S _diff_peek=None src=None modification_time=None access_time=None seuser=None serole=None selevel=None setype=None attributes=None content=NOT_LOGGING_PARAMETER backup=None remote_src=None regexp=None delimiter=None directory_mode=None unsafe_writes=None Jun 14 12:08:33 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:08:33 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-ustreamer : clean repository if needed] ********************* Jun 14 12:08:33 nas-kvm tinypilot-update-svc[24809]: skipping: [localhost] Jun 14 12:08:33 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-ustreamer : build uStreamer] ******************************** Jun 14 12:08:33 nas-kvm tinypilot-update-svc[24809]: skipping: [localhost] Jun 14 12:08:33 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-ustreamer : fix uStreamer folder permissions] *************** Jun 14 12:08:34 nas-kvm ansible-file[25644]: Invoked with path=/opt/ustreamer state=directory owner=ustreamer group=ustreamer recurse=True force=False follow=True modification_time_format=%Y%m%d%H%M.%S access_time_format=%Y%m%d%H%M.%S _original_basename=None _diff_peek=None src=None modification_time=None access_time=None mode=None seuser=None serole=None selevel=None setype=None attributes=None content=NOT_LOGGING_PARAMETER backup=None remote_src=None regexp=None delimiter=None directory_mode=None unsafe_writes=None Jun 14 12:08:34 nas-kvm tinypilot-update-svc[24809]: changed: [localhost] Jun 14 12:08:34 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-ustreamer : install uStreamer as a service] ***************** Jun 14 12:08:35 nas-kvm ansible-stat[25669]: Invoked with path=/lib/systemd/system/ustreamer.service follow=False get_checksum=True checksum_algorithm=sha1 get_md5=False get_mime=True get_attributes=True Jun 14 12:08:35 nas-kvm ansible-file[25679]: Invoked with owner=root group=root mode=0644 follow=False dest=/lib/systemd/system/ustreamer.service _original_basename=ustreamer.systemd.j2 recurse=False state=file path=/lib/systemd/system/ustreamer.service force=False modification_time_format=%Y%m%d%H%M.%S access_time_format=%Y%m%d%H%M.%S _diff_peek=None src=None modification_time=None access_time=None seuser=None serole=None selevel=None setype=None attributes=None content=NOT_LOGGING_PARAMETER backup=None remote_src=None regexp=None delimiter=None directory_mode=None unsafe_writes=None Jun 14 12:08:36 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:08:36 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-ustreamer : enable systemd uStreamer service file] ********** Jun 14 12:08:38 nas-kvm ansible-systemd[25705]: Invoked with name=ustreamer enabled=True daemon_reload=False daemon_reexec=False no_block=False state=None force=None masked=None user=None scope=None Jun 14 12:08:38 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:08:38 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-ustreamer : save uStreamer settings file] ******************* Jun 14 12:08:39 nas-kvm ansible-stat[25735]: Invoked with path=/home/ustreamer/config.yml follow=False get_checksum=True checksum_algorithm=sha1 get_md5=False get_mime=True get_attributes=True Jun 14 12:08:39 nas-kvm ansible-file[25745]: Invoked with owner=ustreamer group=ustreamer mode=0644 follow=False dest=/home/ustreamer/config.yml _original_basename=config.yml.j2 recurse=False state=file path=/home/ustreamer/config.yml force=False modification_time_format=%Y%m%d%H%M.%S access_time_format=%Y%m%d%H%M.%S _diff_peek=None src=None modification_time=None access_time=None seuser=None serole=None selevel=None setype=None attributes=None content=NOT_LOGGING_PARAMETER backup=None remote_src=None regexp=None delimiter=None directory_mode=None unsafe_writes=None Jun 14 12:08:39 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:08:39 nas-kvm tinypilot-update-svc[24809]: TASK [tinypilot.tinypilot-pro : (legacy cleanup) check for broken cycle-tls-keys script] *** Jun 14 12:08:40 nas-kvm ansible-stat[25771]: Invoked with path=/opt/cycle-tls-keys follow=False get_md5=False get_checksum=True get_mime=True get_attributes=True checksum_algorithm=sha1 Jun 14 12:08:40 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:08:40 nas-kvm tinypilot-update-svc[24809]: TASK [tinypilot.tinypilot-pro : (legacy cleanup) disable cycle-tls-keys systemd task] *** Jun 14 12:08:40 nas-kvm tinypilot-update-svc[24809]: skipping: [localhost] Jun 14 12:08:40 nas-kvm tinypilot-update-svc[24809]: TASK [tinypilot.tinypilot-pro : (legacy cleanup) remove cycle-tls-keys systemd task] *** Jun 14 12:08:40 nas-kvm tinypilot-update-svc[24809]: skipping: [localhost] Jun 14 12:08:40 nas-kvm tinypilot-update-svc[24809]: TASK [tinypilot.tinypilot-pro : (legacy cleanup) remove stale key material] **** Jun 14 12:08:40 nas-kvm tinypilot-update-svc[24809]: skipping: [localhost] => (item=/etc/ssl/certs/tinypilot-ca.crt) Jun 14 12:08:40 nas-kvm tinypilot-update-svc[24809]: skipping: [localhost] => (item=/etc/ssl/private/tinypilot-ca.key) Jun 14 12:08:40 nas-kvm tinypilot-update-svc[24809]: skipping: [localhost] => (item=/etc/ssl/csr/tinypilot-ca.csr) Jun 14 12:08:41 nas-kvm tinypilot-update-svc[24809]: skipping: [localhost] => (item=/etc/ssl/certs/tinypilot-nginx.crt) Jun 14 12:08:41 nas-kvm tinypilot-update-svc[24809]: skipping: [localhost] => (item=/etc/ssl/private/tinypilot-nginx.key) Jun 14 12:08:41 nas-kvm tinypilot-update-svc[24809]: skipping: [localhost] => (item=/etc/ssl/csr/tinypilot-nginx.csr) Jun 14 12:08:41 nas-kvm tinypilot-update-svc[24809]: TASK [tinypilot.tinypilot-pro : (legacy cleanup) remove broken cycle-tls-keys script] *** Jun 14 12:08:41 nas-kvm tinypilot-update-svc[24809]: skipping: [localhost] Jun 14 12:08:41 nas-kvm tinypilot-update-svc[24809]: TASK [tinypilot.tinypilot-pro : install pip3] ********************************** Jun 14 12:08:41 nas-kvm tinypilot-update-svc[24809]: skipping: [localhost] Jun 14 12:08:41 nas-kvm tinypilot-update-svc[24809]: TASK [tinypilot.tinypilot-pro : install PyOpenSSL] ***************************** Jun 14 12:08:41 nas-kvm tinypilot-update-svc[24809]: skipping: [localhost] Jun 14 12:08:41 nas-kvm tinypilot-update-svc[24809]: TASK [tinypilot.tinypilot-pro : ensure CSR directory exists] ******************* Jun 14 12:08:41 nas-kvm tinypilot-update-svc[24809]: skipping: [localhost] Jun 14 12:08:41 nas-kvm tinypilot-update-svc[24809]: TASK [tinypilot.tinypilot-pro : create CA private key] ************************* Jun 14 12:08:41 nas-kvm tinypilot-update-svc[24809]: skipping: [localhost] Jun 14 12:08:41 nas-kvm tinypilot-update-svc[24809]: TASK [tinypilot.tinypilot-pro : create the CA CSR] ***************************** Jun 14 12:08:41 nas-kvm tinypilot-update-svc[24809]: skipping: [localhost] Jun 14 12:08:41 nas-kvm tinypilot-update-svc[24809]: TASK [tinypilot.tinypilot-pro : sign the CA CSR] ******************************* Jun 14 12:08:41 nas-kvm tinypilot-update-svc[24809]: skipping: [localhost] Jun 14 12:08:41 nas-kvm tinypilot-update-svc[24809]: TASK [tinypilot.tinypilot-pro : create host CSR signing key] ******************* Jun 14 12:08:41 nas-kvm tinypilot-update-svc[24809]: skipping: [localhost] Jun 14 12:08:41 nas-kvm tinypilot-update-svc[24809]: TASK [tinypilot.tinypilot-pro : create CSR for nginx] ************************** Jun 14 12:08:41 nas-kvm tinypilot-update-svc[24809]: skipping: [localhost] Jun 14 12:08:41 nas-kvm tinypilot-update-svc[24809]: TASK [tinypilot.tinypilot-pro : generate a CA-signed TLS certificate] ********** Jun 14 12:08:41 nas-kvm tinypilot-update-svc[24809]: skipping: [localhost] Jun 14 12:08:41 nas-kvm tinypilot-update-svc[24809]: TASK [tinypilot.tinypilot-pro : install update-tls-cert-common-name as a service] *** Jun 14 12:08:42 nas-kvm tinypilot-update-svc[24809]: skipping: [localhost] Jun 14 12:08:42 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-nginx : Include OS-specific variables.] ********************* Jun 14 12:08:42 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:08:42 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-nginx : Define nginx_user.] ********************************* Jun 14 12:08:42 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:08:42 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-nginx : include_tasks] ************************************** Jun 14 12:08:42 nas-kvm tinypilot-update-svc[24809]: skipping: [localhost] Jun 14 12:08:42 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-nginx : include_tasks] ************************************** Jun 14 12:08:42 nas-kvm tinypilot-update-svc[24809]: skipping: [localhost] Jun 14 12:08:42 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-nginx : include_tasks] ************************************** Jun 14 12:08:42 nas-kvm tinypilot-update-svc[24809]: included: /opt/tinypilot-updater/ansible-role-nginx/tasks/setup-Debian.yml for localhost Jun 14 12:08:42 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-nginx : Update apt cache.] ********************************** Jun 14 12:08:44 nas-kvm ansible-apt[25835]: Invoked with update_cache=True cache_valid_time=86400 state=present purge=False force=False dpkg_options=force-confdef,force-confold autoremove=False autoclean=False only_upgrade=False force_apt_get=False allow_unauthenticated=False package=None deb=None default_release=None install_recommends=None upgrade=None policy_rc_d=None Jun 14 12:08:44 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:08:45 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-nginx : Ensure nginx is installed.] ************************* Jun 14 12:08:46 nas-kvm ansible-apt[25863]: Invoked with name=nginx state=present default_release= package=['nginx'] cache_valid_time=0 purge=False force=False dpkg_options=force-confdef,force-confold autoremove=False autoclean=False only_upgrade=False force_apt_get=False allow_unauthenticated=False update_cache=None deb=None install_recommends=None upgrade=None policy_rc_d=None Jun 14 12:08:47 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:08:47 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-nginx : include_tasks] ************************************** Jun 14 12:08:48 nas-kvm tinypilot-update-svc[24809]: skipping: [localhost] Jun 14 12:08:48 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-nginx : include_tasks] ************************************** Jun 14 12:08:48 nas-kvm tinypilot-update-svc[24809]: skipping: [localhost] Jun 14 12:08:48 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-nginx : include_tasks] ************************************** Jun 14 12:08:48 nas-kvm tinypilot-update-svc[24809]: skipping: [localhost] Jun 14 12:08:48 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-nginx : Remove default nginx vhost config file (if configured).] *** Jun 14 12:08:49 nas-kvm ansible-file[25901]: Invoked with path=/etc/nginx/sites-enabled/default state=absent recurse=False force=False follow=True modification_time_format=%Y%m%d%H%M.%S access_time_format=%Y%m%d%H%M.%S _original_basename=None _diff_peek=None src=None modification_time=None access_time=None mode=None owner=None group=None seuser=None serole=None selevel=None setype=None attributes=None content=NOT_LOGGING_PARAMETER backup=None remote_src=None regexp=None delimiter=None directory_mode=None unsafe_writes=None Jun 14 12:08:49 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:08:49 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-nginx : Ensure nginx_vhost_path exists.] ******************** Jun 14 12:08:49 nas-kvm ansible-file[25926]: Invoked with path=/etc/nginx/sites-enabled state=directory mode=493 recurse=False force=False follow=True modification_time_format=%Y%m%d%H%M.%S access_time_format=%Y%m%d%H%M.%S _original_basename=None _diff_peek=None src=None modification_time=None access_time=None owner=None group=None seuser=None serole=None selevel=None setype=None attributes=None content=NOT_LOGGING_PARAMETER backup=None remote_src=None regexp=None delimiter=None directory_mode=None unsafe_writes=None Jun 14 12:08:50 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:08:50 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-nginx : Add managed vhost config files.] ******************** Jun 14 12:08:50 nas-kvm ansible-stat[25952]: Invoked with path=/etc/nginx/sites-enabled/tinypilot.http.conf follow=False get_checksum=True checksum_algorithm=sha1 get_md5=False get_mime=True get_attributes=True Jun 14 12:08:51 nas-kvm ansible-file[25962]: Invoked with force=True owner=root group=root mode=420 follow=False dest=/etc/nginx/sites-enabled/tinypilot.http.conf _original_basename=vhost.j2 recurse=False state=file path=/etc/nginx/sites-enabled/tinypilot.http.conf modification_time_format=%Y%m%d%H%M.%S access_time_format=%Y%m%d%H%M.%S _diff_peek=None src=None modification_time=None access_time=None seuser=None serole=None selevel=None setype=None attributes=None content=NOT_LOGGING_PARAMETER backup=None remote_src=None regexp=None delimiter=None directory_mode=None unsafe_writes=None Jun 14 12:08:51 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] => (item={'listen': '80 default_server', 'server_name': 'tinypilot', 'filename': 'tinypilot.http.conf', 'return': '307 https://$http_host$request_uri'}) Jun 14 12:08:52 nas-kvm ansible-stat[25986]: Invoked with path=/etc/nginx/sites-enabled/tinypilot.conf follow=False get_checksum=True checksum_algorithm=sha1 get_md5=False get_mime=True get_attributes=True Jun 14 12:08:52 nas-kvm ansible-file[25997]: Invoked with force=True owner=root group=root mode=420 follow=False dest=/etc/nginx/sites-enabled/tinypilot.conf _original_basename=vhost.j2 recurse=False state=file path=/etc/nginx/sites-enabled/tinypilot.conf modification_time_format=%Y%m%d%H%M.%S access_time_format=%Y%m%d%H%M.%S _diff_peek=None src=None modification_time=None access_time=None seuser=None serole=None selevel=None setype=None attributes=None content=NOT_LOGGING_PARAMETER backup=None remote_src=None regexp=None delimiter=None directory_mode=None unsafe_writes=None Jun 14 12:08:52 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] => (item={'listen': '443 ssl http2', 'server_name': 'tinypilot', 'filename': 'tinypilot.conf', 'root': '/opt/tinypilot', 'index': 'index.html', 'error_page': '497 =307 https://$http_host$request_uri', 'extra_parameters': 'ssl_certificate "/etc/ssl/certs/tinypilot-nginx.crt";\nssl_certificate_key "/etc/ssl/private/tinypilot-nginx.key";\nssl_protocols TLSv1.2;\nssl_prefer_server_ciphers on;\nssl_ciphers ECDHE-RSA-AES256-GCM-SHA512:DHE-RSA-AES256-GCM-SHA512:ECDHE-RSA-AES256-GCM-SHA384:DHE-RSA-AES256-GCM-SHA384:ECDHE-RSA-AES256-SHA384;\nssl_ecdh_curve secp384r1;\nssl_session_timeout 10m;\nssl_session_cache shared:SSL:10m;\nssl_session_tickets off;\nproxy_buffers 16 16k;\nproxy_buffer_size 16k;\nproxy_set_header Host $http_host;\nproxy_set_header X-Forwarded-For $proxy_add_x_forwarded_for;\nproxy_http_version 1.1;\nlocation /socket.io {\n proxy_pass http://tinypilot;\n proxy_set_header Upgrade $http_upgrade;\n proxy_set_header Connection "Upgrade";\n # Since this is a connection upgrade, we don\'t inherit the settings from\n # above. We need these so that nginx forwards requests properly to\n # Flask-SocketIO.\n # See: https://github.com/miguelgrinberg/Flask-SocketIO/issues/1501#issuecomment-802082048\n proxy_set_header Host $http_host;\n proxy_set_header X-Forwarded-Host $http_host;\n proxy_set_header X-Forwarded-Proto $scheme;\n}\nlocation /state {\n auth_request /auth;\n auth_request_set $auth_status $upstream_status;\n proxy_pass http://ustreamer;\n}\nlocation /stream {\n auth_request /auth;\n auth_request_set $auth_status $upstream_status;\n proxy_pass http://ustreamer;\n}\nlocation /snapshot {\n auth_request /auth;\n auth_request_set $auth_status $upstream_status;\n proxy_pass http://ustreamer;\n}\nlocation /ca.crt {\n alias "/etc/ssl/certs/tinypilot-ca.crt";\n}\nlocation / {\n proxy_pass http://tinypilot;\n}\nlocation /api/massStorage/backingFiles {\n # Allow large file transfers without buffering them.\n client_max_body_size 0;\n proxy_request_buffering off;\n proxy_pass http://tinypilot;\n}\nlocation ~* ^/.+\\.(html|js|js.map|css)$ {\n root "/opt/tinypilot/app/static";\n # Disable caching\n add_header Last-Modified $date_gmt;\n add_header Cache-Control \'no-store, no-cache, must-revalidate, proxy-revalidate, max-age=0\';\n if_modified_since off;\n expires off;\n etag off;\n}\nlocation ~* ^/.+\\.(jpg|jpeg|png|ico)$ {\n root "/opt/tinypilot/app/static";\n}\n# Authenticate any protected routes that are outside of the core\n# TinyPilot web app.\nlocation = /auth {\n internal;\n proxy_pass http://tinypilot/api/auth;\n proxy_pass_request_body off;\n proxy_set_header Content-Length "";\n proxy_set_header X-Original-URI $request_uri;\n}\n'}) Jun 14 12:08:52 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-nginx : Remove managed vhost config files.] ***************** Jun 14 12:08:53 nas-kvm tinypilot-update-svc[24809]: skipping: [localhost] => (item={'listen': '80 default_server', 'server_name': 'tinypilot', 'filename': 'tinypilot.http.conf', 'return': '307 https://$http_host$request_uri'}) Jun 14 12:08:53 nas-kvm tinypilot-update-svc[24809]: skipping: [localhost] => (item={'listen': '443 ssl http2', 'server_name': 'tinypilot', 'filename': 'tinypilot.conf', 'root': '/opt/tinypilot', 'index': 'index.html', 'error_page': '497 =307 https://$http_host$request_uri', 'extra_parameters': 'ssl_certificate "/etc/ssl/certs/tinypilot-nginx.crt";\nssl_certificate_key "/etc/ssl/private/tinypilot-nginx.key";\nssl_protocols TLSv1.2;\nssl_prefer_server_ciphers on;\nssl_ciphers ECDHE-RSA-AES256-GCM-SHA512:DHE-RSA-AES256-GCM-SHA512:ECDHE-RSA-AES256-GCM-SHA384:DHE-RSA-AES256-GCM-SHA384:ECDHE-RSA-AES256-SHA384;\nssl_ecdh_curve secp384r1;\nssl_session_timeout 10m;\nssl_session_cache shared:SSL:10m;\nssl_session_tickets off;\nproxy_buffers 16 16k;\nproxy_buffer_size 16k;\nproxy_set_header Host $http_host;\nproxy_set_header X-Forwarded-For $proxy_add_x_forwarded_for;\nproxy_http_version 1.1;\nlocation /socket.io {\n proxy_pass http://tinypilot;\n proxy_set_header Upgrade $http_upgrade;\n proxy_set_header Connection "Upgrade";\n # Since this is a connection upgrade, we don\'t inherit the settings from\n # above. We need these so that nginx forwards requests properly to\n # Flask-SocketIO.\n # See: https://github.com/miguelgrinberg/Flask-SocketIO/issues/1501#issuecomment-802082048\n proxy_set_header Host $http_host;\n proxy_set_header X-Forwarded-Host $http_host;\n proxy_set_header X-Forwarded-Proto $scheme;\n}\nlocation /state {\n auth_request /auth;\n auth_request_set $auth_status $upstream_status;\n proxy_pass http://ustreamer;\n}\nlocation /stream {\n auth_request /auth;\n auth_request_set $auth_status $upstream_status;\n proxy_pass http://ustreamer;\n}\nlocation /snapshot {\n auth_request /auth;\n auth_request_set $auth_status $upstream_status;\n proxy_pass http://ustreamer;\n}\nlocation /ca.crt {\n alias "/etc/ssl/certs/tinypilot-ca.crt";\n}\nlocation / {\n proxy_pass http://tinypilot;\n}\nlocation /api/massStorage/backingFiles {\n # Allow large file transfers without buffering them.\n client_max_body_size 0;\n proxy_request_buffering off;\n proxy_pass http://tinypilot;\n}\nlocation ~* ^/.+\\.(html|js|js.map|css)$ {\n root "/opt/tinypilot/app/static";\n # Disable caching\n add_header Last-Modified $date_gmt;\n add_header Cache-Control \'no-store, no-cache, must-revalidate, proxy-revalidate, max-age=0\';\n if_modified_since off;\n expires off;\n etag off;\n}\nlocation ~* ^/.+\\.(jpg|jpeg|png|ico)$ {\n root "/opt/tinypilot/app/static";\n}\n# Authenticate any protected routes that are outside of the core\n# TinyPilot web app.\nlocation = /auth {\n internal;\n proxy_pass http://tinypilot/api/auth;\n proxy_pass_request_body off;\n proxy_set_header Content-Length "";\n proxy_set_header X-Original-URI $request_uri;\n}\n'}) Jun 14 12:08:53 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-nginx : Remove legacy vhosts.conf file.] ******************** Jun 14 12:08:53 nas-kvm ansible-file[26023]: Invoked with path=/etc/nginx/sites-enabled/vhosts.conf state=absent recurse=False force=False follow=True modification_time_format=%Y%m%d%H%M.%S access_time_format=%Y%m%d%H%M.%S _original_basename=None _diff_peek=None src=None modification_time=None access_time=None mode=None owner=None group=None seuser=None serole=None selevel=None setype=None attributes=None content=NOT_LOGGING_PARAMETER backup=None remote_src=None regexp=None delimiter=None directory_mode=None unsafe_writes=None Jun 14 12:08:53 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:08:54 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-nginx : Copy nginx configuration in place.] ***************** Jun 14 12:08:54 nas-kvm ansible-stat[26049]: Invoked with path=/etc/nginx/nginx.conf follow=False get_checksum=True checksum_algorithm=sha1 get_md5=False get_mime=True get_attributes=True Jun 14 12:08:55 nas-kvm ansible-file[26059]: Invoked with owner=root group=root mode=420 follow=False dest=/etc/nginx/nginx.conf _original_basename=nginx.conf.j2 recurse=False state=file path=/etc/nginx/nginx.conf force=False modification_time_format=%Y%m%d%H%M.%S access_time_format=%Y%m%d%H%M.%S _diff_peek=None src=None modification_time=None access_time=None seuser=None serole=None selevel=None setype=None attributes=None content=NOT_LOGGING_PARAMETER backup=None remote_src=None regexp=None delimiter=None directory_mode=None unsafe_writes=None Jun 14 12:08:55 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:08:55 nas-kvm tinypilot-update-svc[24809]: TASK [ansible-role-nginx : Ensure nginx service is running as configured.] ***** Jun 14 12:08:56 nas-kvm ansible-systemd[26084]: Invoked with name=nginx state=started enabled=True daemon_reload=False daemon_reexec=False no_block=False force=None masked=None user=None scope=None Jun 14 12:08:56 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:08:56 nas-kvm tinypilot-update-svc[24809]: TASK [tinypilot.tinypilot-pro : set the path to config.txt on non-Ubuntu systems] *** Jun 14 12:08:56 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:08:56 nas-kvm tinypilot-update-svc[24809]: TASK [tinypilot.tinypilot-pro : set the path to config.txt for Ubuntu] ********* Jun 14 12:08:57 nas-kvm tinypilot-update-svc[24809]: skipping: [localhost] Jun 14 12:08:57 nas-kvm tinypilot-update-svc[24809]: TASK [tinypilot.tinypilot-pro : check for a boot config file] ****************** Jun 14 12:08:57 nas-kvm ansible-stat[26118]: Invoked with path=/boot/config.txt follow=False get_md5=False get_checksum=True get_mime=True get_attributes=True checksum_algorithm=sha1 Jun 14 12:08:57 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:08:57 nas-kvm tinypilot-update-svc[24809]: TASK [tinypilot.tinypilot-pro : enable dwc2 driver in boot config] ************* Jun 14 12:08:58 nas-kvm ansible-lineinfile[26145]: Invoked with path=/boot/config.txt create=False line=dtoverlay=dwc2 state=present backrefs=False backup=False firstmatch=False follow=False regexp=None insertafter=None insertbefore=None validate=None mode=None owner=None group=None seuser=None serole=None selevel=None setype=None attributes=None src=None force=None content=NOT_LOGGING_PARAMETER remote_src=None delimiter=None directory_mode=None unsafe_writes=None Jun 14 12:08:58 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:08:58 nas-kvm tinypilot-update-svc[24809]: TASK [tinypilot.tinypilot-pro : check for an /etc/modules file] **************** Jun 14 12:08:59 nas-kvm ansible-stat[26171]: Invoked with path=/etc/modules follow=False get_md5=False get_checksum=True get_mime=True get_attributes=True checksum_algorithm=sha1 Jun 14 12:08:59 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:08:59 nas-kvm tinypilot-update-svc[24809]: TASK [tinypilot.tinypilot-pro : enable dwc2 driver in modules] ***************** Jun 14 12:09:00 nas-kvm ansible-lineinfile[26198]: Invoked with path=/etc/modules create=False line=dwc2 state=present backrefs=False backup=False firstmatch=False follow=False regexp=None insertafter=None insertbefore=None validate=None mode=None owner=None group=None seuser=None serole=None selevel=None setype=None attributes=None src=None force=None content=NOT_LOGGING_PARAMETER remote_src=None delimiter=None directory_mode=None unsafe_writes=None Jun 14 12:09:00 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:09:00 nas-kvm tinypilot-update-svc[24809]: TASK [tinypilot.tinypilot-pro : create TinyPilot privileged folder] ************ Jun 14 12:09:01 nas-kvm ansible-file[26224]: Invoked with path=/opt/tinypilot-privileged state=directory owner=root group=root recurse=False force=False follow=True modification_time_format=%Y%m%d%H%M.%S access_time_format=%Y%m%d%H%M.%S _original_basename=None _diff_peek=None src=None modification_time=None access_time=None mode=None seuser=None serole=None selevel=None setype=None attributes=None content=NOT_LOGGING_PARAMETER backup=None remote_src=None regexp=None delimiter=None directory_mode=None unsafe_writes=None Jun 14 12:09:01 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:09:01 nas-kvm tinypilot-update-svc[24809]: TASK [tinypilot.tinypilot-pro : copy usb-gadget initializer] ******************* Jun 14 12:09:01 nas-kvm ansible-stat[26249]: Invoked with path=/opt/tinypilot-privileged/init-usb-gadget follow=False get_checksum=True checksum_algorithm=sha1 get_md5=False get_mime=True get_attributes=True Jun 14 12:09:02 nas-kvm ansible-copy[26264]: Invoked with src=/root/.ansible/tmp/ansible-tmp-1623686941.27841-26231-227350720983841/source dest=/opt/tinypilot-privileged/init-usb-gadget owner=root group=root mode=0700 _original_basename=init-usb-gadget follow=False checksum=2a3080120e87195910987e7a5215027f273ee900 backup=False force=True content=NOT_LOGGING_PARAMETER validate=None directory_mode=None remote_src=None local_follow=None seuser=None serole=None selevel=None setype=None attributes=None regexp=None delimiter=None unsafe_writes=None Jun 14 12:09:03 nas-kvm tinypilot-update-svc[24809]: changed: [localhost] Jun 14 12:09:03 nas-kvm tinypilot-update-svc[24809]: TASK [tinypilot.tinypilot-pro : copy usb-gadget de-initializer] **************** Jun 14 12:09:03 nas-kvm ansible-stat[26291]: Invoked with path=/opt/tinypilot-privileged/remove-usb-gadget follow=False get_checksum=True checksum_algorithm=sha1 get_md5=False get_mime=True get_attributes=True Jun 14 12:09:04 nas-kvm ansible-file[26301]: Invoked with owner=root group=root mode=0700 dest=/opt/tinypilot-privileged/remove-usb-gadget _original_basename=remove-usb-gadget recurse=False state=file path=/opt/tinypilot-privileged/remove-usb-gadget force=False follow=True modification_time_format=%Y%m%d%H%M.%S access_time_format=%Y%m%d%H%M.%S _diff_peek=None src=None modification_time=None access_time=None seuser=None serole=None selevel=None setype=None attributes=None content=NOT_LOGGING_PARAMETER backup=None remote_src=None regexp=None delimiter=None directory_mode=None unsafe_writes=None Jun 14 12:09:04 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:09:04 nas-kvm tinypilot-update-svc[24809]: TASK [tinypilot.tinypilot-pro : install usb-gadget initializer as a service] *** Jun 14 12:09:05 nas-kvm ansible-stat[26327]: Invoked with path=/lib/systemd/system/usb-gadget.service follow=False get_checksum=True checksum_algorithm=sha1 get_md5=False get_mime=True get_attributes=True Jun 14 12:09:05 nas-kvm ansible-file[26337]: Invoked with owner=root group=root mode=0644 follow=False dest=/lib/systemd/system/usb-gadget.service _original_basename=usb-gadget.systemd.j2 recurse=False state=file path=/lib/systemd/system/usb-gadget.service force=False modification_time_format=%Y%m%d%H%M.%S access_time_format=%Y%m%d%H%M.%S _diff_peek=None src=None modification_time=None access_time=None seuser=None serole=None selevel=None setype=None attributes=None content=NOT_LOGGING_PARAMETER backup=None remote_src=None regexp=None delimiter=None directory_mode=None unsafe_writes=None Jun 14 12:09:05 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:09:05 nas-kvm tinypilot-update-svc[24809]: TASK [tinypilot.tinypilot-pro : enable systemd usb-gadget initializer service file] *** Jun 14 12:09:07 nas-kvm ansible-systemd[26362]: Invoked with name=usb-gadget enabled=True daemon_reload=False daemon_reexec=False no_block=False state=None force=None masked=None user=None scope=None Jun 14 12:09:07 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:09:07 nas-kvm tinypilot-update-svc[24809]: TASK [tinypilot.tinypilot-pro : collect TinyPilot required apt packages on all systems] *** Jun 14 12:09:07 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:09:07 nas-kvm tinypilot-update-svc[24809]: TASK [tinypilot.tinypilot-pro : collect Debian and Ubuntu specific TinyPilot required apt packages] *** Jun 14 12:09:07 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:09:07 nas-kvm tinypilot-update-svc[24809]: TASK [tinypilot.tinypilot-pro : collect Ubuntu 20.04 specific TinyPilot required apt packages] *** Jun 14 12:09:07 nas-kvm tinypilot-update-svc[24809]: skipping: [localhost] Jun 14 12:09:07 nas-kvm tinypilot-update-svc[24809]: TASK [tinypilot.tinypilot-pro : install TinyPilot pre-requisite packages] ****** Jun 14 12:09:08 nas-kvm ansible-apt[26398]: Invoked with name=['git', 'python3-venv', 'sudo', 'python-pip'] state=present package=['git', 'python3-venv', 'sudo', 'python-pip'] cache_valid_time=0 purge=False force=False dpkg_options=force-confdef,force-confold autoremove=False autoclean=False only_upgrade=False force_apt_get=False allow_unauthenticated=False update_cache=None deb=None default_release=None install_recommends=None upgrade=None policy_rc_d=None Jun 14 12:09:10 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:09:10 nas-kvm tinypilot-update-svc[24809]: TASK [tinypilot.tinypilot-pro : create tinypilot group] ************************ Jun 14 12:09:11 nas-kvm ansible-group[26430]: Invoked with name=tinypilot state=present system=False local=False non_unique=False gid=None Jun 14 12:09:11 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:09:11 nas-kvm tinypilot-update-svc[24809]: TASK [tinypilot.tinypilot-pro : create tinypilot user] ************************* Jun 14 12:09:12 nas-kvm ansible-user[26457]: Invoked with name=tinypilot group=tinypilot system=True create_home=True state=present non_unique=False force=False remove=False move_home=False append=False ssh_key_bits=0 ssh_key_type=rsa ssh_key_comment=ansible-generated on nas-kvm update_password=always uid=None groups=None comment=None home=None shell=None password=NOT_LOGGING_PARAMETER login_class=None hidden=None seuser=None skeleton=None generate_ssh_key=None ssh_key_file=None ssh_key_passphrase=NOT_LOGGING_PARAMETER expires=None password_lock=None local=None profile=None authorization=None role=None Jun 14 12:09:12 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:09:12 nas-kvm tinypilot-update-svc[24809]: TASK [tinypilot.tinypilot-pro : copy admin scripts] **************************** Jun 14 12:09:13 nas-kvm ansible-stat[26485]: Invoked with path=/opt/tinypilot-privileged/change-hostname follow=False get_checksum=True checksum_algorithm=sha1 get_md5=False get_mime=True get_attributes=True Jun 14 12:09:13 nas-kvm ansible-file[26496]: Invoked with owner=root group=root mode=0755 dest=/opt/tinypilot-privileged/change-hostname _original_basename=change-hostname recurse=False state=file path=/opt/tinypilot-privileged/change-hostname force=False follow=True modification_time_format=%Y%m%d%H%M.%S access_time_format=%Y%m%d%H%M.%S _diff_peek=None src=None modification_time=None access_time=None seuser=None serole=None selevel=None setype=None attributes=None content=NOT_LOGGING_PARAMETER backup=None remote_src=None regexp=None delimiter=None directory_mode=None unsafe_writes=None Jun 14 12:09:13 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] => (item=change-hostname) Jun 14 12:09:14 nas-kvm ansible-stat[26520]: Invoked with path=/opt/tinypilot-privileged/collect-debug-logs follow=False get_checksum=True checksum_algorithm=sha1 get_md5=False get_mime=True get_attributes=True Jun 14 12:09:15 nas-kvm ansible-copy[26534]: Invoked with src=/root/.ansible/tmp/ansible-tmp-1623686953.8747852-26467-211445899179636/source dest=/opt/tinypilot-privileged/collect-debug-logs owner=root group=root mode=0755 _original_basename=collect-debug-logs follow=False checksum=2f92b5bfbdb06287e24f4655d01e573b12249fa9 backup=False force=True content=NOT_LOGGING_PARAMETER validate=None directory_mode=None remote_src=None local_follow=None seuser=None serole=None selevel=None setype=None attributes=None regexp=None delimiter=None unsafe_writes=None Jun 14 12:09:15 nas-kvm tinypilot-update-svc[24809]: changed: [localhost] => (item=collect-debug-logs) Jun 14 12:09:15 nas-kvm ansible-stat[26560]: Invoked with path=/opt/tinypilot-privileged/eject-mass-storage follow=False get_checksum=True checksum_algorithm=sha1 get_md5=False get_mime=True get_attributes=True Jun 14 12:09:16 nas-kvm ansible-file[26570]: Invoked with owner=root group=root mode=0755 dest=/opt/tinypilot-privileged/eject-mass-storage _original_basename=eject-mass-storage recurse=False state=file path=/opt/tinypilot-privileged/eject-mass-storage force=False follow=True modification_time_format=%Y%m%d%H%M.%S access_time_format=%Y%m%d%H%M.%S _diff_peek=None src=None modification_time=None access_time=None seuser=None serole=None selevel=None setype=None attributes=None content=NOT_LOGGING_PARAMETER backup=None remote_src=None regexp=None delimiter=None directory_mode=None unsafe_writes=None Jun 14 12:09:16 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] => (item=eject-mass-storage) Jun 14 12:09:16 nas-kvm ansible-stat[26593]: Invoked with path=/opt/tinypilot-privileged/mount-mass-storage follow=False get_checksum=True checksum_algorithm=sha1 get_md5=False get_mime=True get_attributes=True Jun 14 12:09:17 nas-kvm ansible-file[26604]: Invoked with owner=root group=root mode=0755 dest=/opt/tinypilot-privileged/mount-mass-storage _original_basename=mount-mass-storage recurse=False state=file path=/opt/tinypilot-privileged/mount-mass-storage force=False follow=True modification_time_format=%Y%m%d%H%M.%S access_time_format=%Y%m%d%H%M.%S _diff_peek=None src=None modification_time=None access_time=None seuser=None serole=None selevel=None setype=None attributes=None content=NOT_LOGGING_PARAMETER backup=None remote_src=None regexp=None delimiter=None directory_mode=None unsafe_writes=None Jun 14 12:09:17 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] => (item=mount-mass-storage) Jun 14 12:09:18 nas-kvm ansible-stat[26627]: Invoked with path=/opt/tinypilot-privileged/read-update-log follow=False get_checksum=True checksum_algorithm=sha1 get_md5=False get_mime=True get_attributes=True Jun 14 12:09:18 nas-kvm ansible-file[26637]: Invoked with owner=root group=root mode=0755 dest=/opt/tinypilot-privileged/read-update-log _original_basename=read-update-log recurse=False state=file path=/opt/tinypilot-privileged/read-update-log force=False follow=True modification_time_format=%Y%m%d%H%M.%S access_time_format=%Y%m%d%H%M.%S _diff_peek=None src=None modification_time=None access_time=None seuser=None serole=None selevel=None setype=None attributes=None content=NOT_LOGGING_PARAMETER backup=None remote_src=None regexp=None delimiter=None directory_mode=None unsafe_writes=None Jun 14 12:09:18 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] => (item=read-update-log) Jun 14 12:09:19 nas-kvm ansible-stat[26660]: Invoked with path=/opt/tinypilot-privileged/update follow=False get_checksum=True checksum_algorithm=sha1 get_md5=False get_mime=True get_attributes=True Jun 14 12:09:20 nas-kvm ansible-file[26671]: Invoked with owner=root group=root mode=0755 dest=/opt/tinypilot-privileged/update _original_basename=update recurse=False state=file path=/opt/tinypilot-privileged/update force=False follow=True modification_time_format=%Y%m%d%H%M.%S access_time_format=%Y%m%d%H%M.%S _diff_peek=None src=None modification_time=None access_time=None seuser=None serole=None selevel=None setype=None attributes=None content=NOT_LOGGING_PARAMETER backup=None remote_src=None regexp=None delimiter=None directory_mode=None unsafe_writes=None Jun 14 12:09:20 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] => (item=update) Jun 14 12:09:20 nas-kvm ansible-stat[26694]: Invoked with path=/opt/tinypilot-privileged/update-tls-cert-common-name follow=False get_checksum=True checksum_algorithm=sha1 get_md5=False get_mime=True get_attributes=True Jun 14 12:09:21 nas-kvm ansible-file[26704]: Invoked with owner=root group=root mode=0755 dest=/opt/tinypilot-privileged/update-tls-cert-common-name _original_basename=update-tls-cert-common-name recurse=False state=file path=/opt/tinypilot-privileged/update-tls-cert-common-name force=False follow=True modification_time_format=%Y%m%d%H%M.%S access_time_format=%Y%m%d%H%M.%S _diff_peek=None src=None modification_time=None access_time=None seuser=None serole=None selevel=None setype=None attributes=None content=NOT_LOGGING_PARAMETER backup=None remote_src=None regexp=None delimiter=None directory_mode=None unsafe_writes=None Jun 14 12:09:21 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] => (item=update-tls-cert-common-name) Jun 14 12:09:21 nas-kvm ansible-stat[26728]: Invoked with path=/opt/tinypilot-privileged/update-video-settings follow=False get_checksum=True checksum_algorithm=sha1 get_md5=False get_mime=True get_attributes=True Jun 14 12:09:22 nas-kvm ansible-copy[26742]: Invoked with src=/root/.ansible/tmp/ansible-tmp-1623686961.4343145-26467-22619726164987/source dest=/opt/tinypilot-privileged/update-video-settings owner=root group=root mode=0755 _original_basename=update-video-settings follow=False checksum=a2d1145f54d0aee789e03b959014320f3f10f78c backup=False force=True content=NOT_LOGGING_PARAMETER validate=None directory_mode=None remote_src=None local_follow=None seuser=None serole=None selevel=None setype=None attributes=None regexp=None delimiter=None unsafe_writes=None Jun 14 12:09:22 nas-kvm tinypilot-update-svc[24809]: changed: [localhost] => (item=update-video-settings) Jun 14 12:09:22 nas-kvm tinypilot-update-svc[24809]: TASK [tinypilot.tinypilot-pro : store passwordless sudo paths] ***************** Jun 14 12:09:22 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:09:22 nas-kvm tinypilot-update-svc[24809]: TASK [tinypilot.tinypilot-pro : enable tinypilot to execute a whitelist of commands as sudo] *** Jun 14 12:09:23 nas-kvm ansible-lineinfile[26770]: Invoked with dest=/etc/sudoers state=present line=tinypilot ALL=(ALL) NOPASSWD: /sbin/shutdown, /usr/sbin/service tinypilot-updater start, /opt/tinypilot-privileged/change-hostname, /opt/tinypilot-privileged/collect-debug-logs, /opt/tinypilot-privileged/eject-mass-storage, /opt/tinypilot-privileged/mount-mass-storage, /opt/tinypilot-privileged/read-update-log, /opt/tinypilot-privileged/update, /opt/tinypilot-privileged/update-tls-cert-common-name, /opt/tinypilot-privileged/update-video-settings regexp=^tinypilot validate=sudo /usr/sbin/visudo -cf %s path=/etc/sudoers backrefs=False create=False backup=False firstmatch=False follow=False insertafter=None insertbefore=None mode=None owner=None group=None seuser=None serole=None selevel=None setype=None attributes=None src=None force=None content=NOT_LOGGING_PARAMETER remote_src=None delimiter=None directory_mode=None unsafe_writes=None Jun 14 12:09:23 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:09:23 nas-kvm tinypilot-update-svc[24809]: TASK [tinypilot.tinypilot-pro : create TinyPilot folder] *********************** Jun 14 12:09:24 nas-kvm ansible-file[26796]: Invoked with path=/opt/tinypilot state=directory owner=tinypilot group=tinypilot recurse=False force=False follow=True modification_time_format=%Y%m%d%H%M.%S access_time_format=%Y%m%d%H%M.%S _original_basename=None _diff_peek=None src=None modification_time=None access_time=None mode=None seuser=None serole=None selevel=None setype=None attributes=None content=NOT_LOGGING_PARAMETER backup=None remote_src=None regexp=None delimiter=None directory_mode=None unsafe_writes=None Jun 14 12:09:24 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:09:24 nas-kvm tinypilot-update-svc[24809]: TASK [tinypilot.tinypilot-pro : get TinyPilot repo] **************************** Jun 14 12:09:25 nas-kvm ansible-git[26821]: Invoked with repo=https://dev.azure.com/tinypilot/tinypilot-pro/_git/tinypilot-pro dest=/opt/tinypilot version=2.2.2 accept_hostkey=True remote=origin force=False clone=True update=True verify_commit=False gpg_whitelist=[] bare=False recursive=True track_submodules=False refspec=None reference=None depth=None key_file=None ssh_opts=None executable=None umask=None archive=None separate_git_dir=None Jun 14 12:09:27 nas-kvm tinypilot-update-svc[24809]: changed: [localhost] Jun 14 12:09:27 nas-kvm tinypilot-update-svc[24809]: TASK [tinypilot.tinypilot-pro : find absolute path to python3] ***************** Jun 14 12:09:28 nas-kvm ansible-command[26870]: Invoked with _raw_params=realpath $(which python3) _uses_shell=True warn=True stdin_add_newline=True strip_empty_ends=True argv=None chdir=None executable=None creates=None removes=None stdin=None Jun 14 12:09:28 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:09:28 nas-kvm tinypilot-update-svc[24809]: TASK [tinypilot.tinypilot-pro : save absolute path to python3] ***************** Jun 14 12:09:28 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:09:28 nas-kvm tinypilot-update-svc[24809]: TASK [tinypilot.tinypilot-pro : create TinyPilot virtualenv] ******************* Jun 14 12:09:30 nas-kvm ansible-pip[26900]: Invoked with virtualenv=/opt/tinypilot/venv virtualenv_command=/usr/bin/python3.7 -m venv venv requirements=/opt/tinypilot/requirements.txt extra_args= state=present virtualenv_site_packages=False editable=False name=None version=None virtualenv_python=None chdir=None executable=None umask=None Jun 14 12:09:44 nas-kvm tinypilot-update-svc[24809]: changed: [localhost] Jun 14 12:09:44 nas-kvm tinypilot-update-svc[24809]: TASK [tinypilot.tinypilot-pro : fix TinyPilot folder permissions] ************** Jun 14 12:09:44 nas-kvm ansible-file[26940]: Invoked with path=/opt/tinypilot state=directory owner=tinypilot group=tinypilot recurse=True force=False follow=True modification_time_format=%Y%m%d%H%M.%S access_time_format=%Y%m%d%H%M.%S _original_basename=None _diff_peek=None src=None modification_time=None access_time=None mode=None seuser=None serole=None selevel=None setype=None attributes=None content=NOT_LOGGING_PARAMETER backup=None remote_src=None regexp=None delimiter=None directory_mode=None unsafe_writes=None Jun 14 12:09:45 nas-kvm tinypilot-update-svc[24809]: changed: [localhost] Jun 14 12:09:45 nas-kvm tinypilot-update-svc[24809]: TASK [tinypilot.tinypilot-pro : install TinyPilot as a service] **************** Jun 14 12:09:46 nas-kvm ansible-stat[26966]: Invoked with path=/lib/systemd/system/tinypilot.service follow=False get_checksum=True checksum_algorithm=sha1 get_md5=False get_mime=True get_attributes=True Jun 14 12:09:47 nas-kvm ansible-file[26976]: Invoked with owner=root group=root mode=0644 follow=False dest=/lib/systemd/system/tinypilot.service _original_basename=tinypilot.systemd.j2 recurse=False state=file path=/lib/systemd/system/tinypilot.service force=False modification_time_format=%Y%m%d%H%M.%S access_time_format=%Y%m%d%H%M.%S _diff_peek=None src=None modification_time=None access_time=None seuser=None serole=None selevel=None setype=None attributes=None content=NOT_LOGGING_PARAMETER backup=None remote_src=None regexp=None delimiter=None directory_mode=None unsafe_writes=None Jun 14 12:09:47 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:09:47 nas-kvm tinypilot-update-svc[24809]: TASK [tinypilot.tinypilot-pro : enable systemd TinyPilot service file] ********* Jun 14 12:09:48 nas-kvm ansible-systemd[27001]: Invoked with name=tinypilot enabled=True daemon_reload=False daemon_reexec=False no_block=False state=None force=None masked=None user=None scope=None Jun 14 12:09:48 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:09:48 nas-kvm tinypilot-update-svc[24809]: TASK [tinypilot.tinypilot-pro : install tinypilot-updater as a service] ******** Jun 14 12:09:49 nas-kvm ansible-stat[27031]: Invoked with path=/lib/systemd/system/tinypilot-updater.service follow=False get_checksum=True checksum_algorithm=sha1 get_md5=False get_mime=True get_attributes=True Jun 14 12:09:50 nas-kvm ansible-copy[27045]: Invoked with src=/root/.ansible/tmp/ansible-tmp-1623686988.7545733-27013-110235594333638/source dest=/lib/systemd/system/tinypilot-updater.service owner=root group=root mode=0644 follow=False _original_basename=tinypilot-updater.systemd.j2 checksum=74c8108a6d1f2e398c413b789a48db3c395b8889 backup=False force=True content=NOT_LOGGING_PARAMETER validate=None directory_mode=None remote_src=None local_follow=None seuser=None serole=None selevel=None setype=None attributes=None regexp=None delimiter=None unsafe_writes=None Jun 14 12:09:50 nas-kvm tinypilot-update-svc[24809]: changed: [localhost] Jun 14 12:09:50 nas-kvm tinypilot-update-svc[24809]: RUNNING HANDLER [tinypilot.tinypilot-pro : restart TinyPilot service] ********** Jun 14 12:09:51 nas-kvm ansible-systemd[27074]: Invoked with name=tinypilot state=restarted daemon_reload=False daemon_reexec=False no_block=False enabled=None force=None masked=None user=None scope=None Jun 14 12:09:51 nas-kvm tinypilot-update-svc[24809]: changed: [localhost] Jun 14 12:09:51 nas-kvm tinypilot-update-svc[24809]: RUNNING HANDLER [tinypilot.tinypilot-pro : reload tinypilot updater systemd config] *** Jun 14 12:09:52 nas-kvm ansible-systemd[27105]: Invoked with name=tinypilot-updater daemon_reload=True enabled=False daemon_reexec=False no_block=False state=None force=None masked=None user=None scope=None Jun 14 12:09:53 nas-kvm tinypilot-update-svc[24809]: ok: [localhost] Jun 14 12:09:53 nas-kvm tinypilot-update-svc[24809]: PLAY RECAP ********************************************************************* Jun 14 12:09:53 nas-kvm tinypilot-update-svc[24809]: localhost : ok=72 changed=8 unreachable=0 failed=0 skipped=30 rescued=0 ignored=0 Jun 14 12:09:53 nas-kvm tinypilot-update-svc[24809]: + chmod +r /var/tmp/tmp.xSHyUmECfR.yml Jun 14 12:09:53 nas-kvm tinypilot-update-svc[24809]: + sudo cp /var/tmp/tmp.xSHyUmECfR.yml /home/tinypilot/settings.yml Jun 14 12:09:53 nas-kvm sudo[27132]: root : TTY=unknown ; PWD=/opt/tinypilot-updater ; USER=root ; COMMAND=/usr/bin/cp /var/tmp/tmp.xSHyUmECfR.yml /home/tinypilot/settings.yml Jun 14 12:09:53 nas-kvm sudo[27132]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 12:09:53 nas-kvm sudo[27132]: pam_unix(sudo:session): session closed for user root Jun 14 12:09:53 nas-kvm tinypilot-update-svc[24809]: + sudo chown tinypilot:tinypilot /home/tinypilot/settings.yml Jun 14 12:09:53 nas-kvm sudo[27134]: root : TTY=unknown ; PWD=/opt/tinypilot-updater ; USER=root ; COMMAND=/usr/bin/chown tinypilot:tinypilot /home/tinypilot/settings.yml Jun 14 12:09:53 nas-kvm sudo[27134]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 12:09:53 nas-kvm sudo[27134]: pam_unix(sudo:session): session closed for user root Jun 14 12:09:53 nas-kvm sudo[24810]: pam_unix(sudo:session): session closed for user root Jun 14 12:09:53 nas-kvm tinypilot-update-svc[24809]: 2021-06-14 12:09:53 __main__ INFO Update completed successfully Jun 14 12:09:53 nas-kvm tinypilot-update-svc[24809]: 2021-06-14 12:09:53 update.result_store INFO Writing result file to /home/tinypilot/logs/latest-update-result.json Jun 14 12:09:53 nas-kvm systemd[1]: tinypilot-updater.service: Succeeded. Jun 14 12:09:53 nas-kvm systemd[1]: Started TinyPilot updater.