TinyPilot Pro log dump https://tinypilotkvm.com Timestamp: 2023-12-13T01:58:32+00:00 Software versions TinyPilot version: 2.6.2 uStreamer version: 5.43 System information OS version: Linux tinypilot2 6.1.21-v8+ #1642 SMP PREEMPT Mon Apr 3 17:24:16 BST 2023 aarch64 GNU/Linux Kernel architecture: aarch64 Userland architecture: armhf (32-bit) Distribution name: Raspbian Distribution version: 11 Hardware information Hardware: BCM2835 Revision: b03115 Model: Raspberry Pi 4 Model B Rev 1.5 TinyPilot state Read-only filesystem: off SSH access: enabled Network interfaces: eth0 (up) lo (unknown) wlan0 (down) Mouse jiggler: disabled CPU Temperature: 43.8'C CPU throttled since boot: no Voltage issues: no Streaming mode Selected mode: MJPEG Current mode: MJPEG TinyPilot settings.yml tinypilot_external_tls_port: 8444 ustreamer_desired_fps: 25 TinyPilot configuration [Unit] Description=TinyPilot - RPi-based virtual KVM BindsTo=nginx.service After=syslog.target network.target nginx.service StartLimitIntervalSec=0 [Service] Type=simple User=tinypilot WorkingDirectory=/opt/tinypilot ExecStart=/opt/tinypilot/venv/bin/python app/main.py Environment=APP_SETTINGS_FILE=/home/tinypilot/app_settings.cfg Restart=always [Install] WantedBy=multi-user.target TinyPilot logs -- Journal begins at Tue 2023-12-12 17:41:00 GMT, ends at Wed 2023-12-13 01:58:33 GMT. -- Dec 12 17:41:04 tinypilot2 systemd[1]: Started TinyPilot - RPi-based virtual KVM. Dec 12 17:41:06 tinypilot2 python[628]: 2023-12-12 17:41:06.748 __main__ INFO Starting app Dec 12 17:41:14 tinypilot2 python[628]: 2023-12-12 17:41:14.529 db.store INFO Loading database migrations from /opt/tinypilot/app/db/migrations/*.sql Dec 12 17:41:14 tinypilot2 python[628]: 2023-12-12 17:41:14.535 db.store INFO Read 7 database migrations from disk Dec 12 17:41:14 tinypilot2 python[628]: 2023-12-12 17:41:14.557 socket_api INFO Client dP8xsV_xTzEX6Q0EAAAC connected Dec 12 17:41:14 tinypilot2 python[628]: 2023-12-12 17:41:14.906 socket_api INFO Client wyHrbkW0AM7u6ZxxAAAE connected Dec 12 17:42:25 tinypilot2 python[628]: 2023-12-12 17:42:25.984 socket_api INFO Client dP8xsV_xTzEX6Q0EAAAC disconnected Dec 12 18:02:37 tinypilot2 python[628]: 2023-12-12 18:02:37.694 socket_api INFO Client wyHrbkW0AM7u6ZxxAAAE disconnected Dec 12 18:02:39 tinypilot2 python[628]: 2023-12-12 18:02:39.498 socket_api INFO Client rXfekMqmbCZ1RkOBAAAG connected Dec 12 18:05:04 tinypilot2 python[628]: 2023-12-12 18:05:04.689 socket_api INFO Client rXfekMqmbCZ1RkOBAAAG disconnected Dec 12 18:05:06 tinypilot2 python[628]: 2023-12-12 18:05:06.626 socket_api INFO Client 3Etc2iwhacTtQIJpAAAI connected Dec 12 18:05:51 tinypilot2 python[628]: 2023-12-12 18:05:51.733 socket_api INFO Client 3Etc2iwhacTtQIJpAAAI disconnected Dec 12 18:09:36 tinypilot2 python[628]: 2023-12-12 18:09:36.981 socket_api INFO Client BPxW2-4pKQ4odaTSAAAK connected Dec 12 18:10:42 tinypilot2 python[628]: 2023-12-12 18:10:42.721 socket_api INFO Client BPxW2-4pKQ4odaTSAAAK disconnected Dec 12 18:10:45 tinypilot2 python[628]: 2023-12-12 18:10:45.060 socket_api INFO Client 1vyvX2YDxfQWS_7tAAAM connected Dec 12 18:12:42 tinypilot2 python[628]: 2023-12-12 18:12:42.276 socket_api INFO Client 1vyvX2YDxfQWS_7tAAAM disconnected Dec 12 18:12:44 tinypilot2 python[628]: 2023-12-12 18:12:44.089 socket_api INFO Client oPWuO5n3t6zGgOT8AAAO connected Dec 12 18:13:29 tinypilot2 python[628]: 2023-12-12 18:13:29.189 socket_api INFO Client oPWuO5n3t6zGgOT8AAAO disconnected Dec 12 18:17:23 tinypilot2 python[628]: 2023-12-12 18:17:23.527 socket_api INFO Client eWerP9e7-RHkawCOAAAQ connected Dec 12 18:20:14 tinypilot2 python[628]: 2023-12-12 18:20:14.217 socket_api INFO Client eWerP9e7-RHkawCOAAAQ disconnected Dec 12 18:24:56 tinypilot2 python[628]: 2023-12-12 18:24:56.912 socket_api INFO Client 37nDHmWJG2HGuAGqAAAS connected Dec 12 18:25:46 tinypilot2 python[628]: 2023-12-12 18:25:46.697 socket_api INFO Client 37nDHmWJG2HGuAGqAAAS disconnected Dec 12 18:25:47 tinypilot2 python[628]: 2023-12-12 18:25:47.761 socket_api INFO Client lwC9eFng3-gyeUCSAAAU connected Dec 12 18:26:32 tinypilot2 python[628]: 2023-12-12 18:26:32.877 socket_api INFO Client lwC9eFng3-gyeUCSAAAU disconnected Dec 12 18:31:41 tinypilot2 python[628]: 2023-12-12 18:31:41.544 socket_api INFO Client ENvX9TKDndldUWgbAAAW connected Dec 12 18:34:31 tinypilot2 python[628]: 2023-12-12 18:34:31.602 socket_api INFO Client ENvX9TKDndldUWgbAAAW disconnected Dec 12 18:35:06 tinypilot2 python[628]: 2023-12-12 18:35:06.960 socket_api INFO Client L5wfDAvaDRp0Bb6HAAAY connected Dec 12 18:36:24 tinypilot2 python[628]: 2023-12-12 18:36:24.290 socket_api INFO Client L5wfDAvaDRp0Bb6HAAAY disconnected Dec 12 18:36:25 tinypilot2 python[628]: 2023-12-12 18:36:25.841 socket_api INFO Client 10pp-S4JTY19nFuZAAAa connected Dec 12 18:37:10 tinypilot2 python[628]: 2023-12-12 18:37:10.932 socket_api INFO Client 10pp-S4JTY19nFuZAAAa disconnected Dec 12 18:40:21 tinypilot2 python[628]: 2023-12-12 18:40:21.975 socket_api INFO Client 3cvov1qWN-TgEBf4AAAc connected Dec 12 18:43:12 tinypilot2 python[628]: 2023-12-12 18:43:12.029 socket_api INFO Client 3cvov1qWN-TgEBf4AAAc disconnected Dec 12 18:45:16 tinypilot2 python[628]: 2023-12-12 18:45:16.747 socket_api INFO Client Qkzv7YjqxxCuYgfhAAAe connected Dec 12 19:13:12 tinypilot2 python[628]: 2023-12-12 19:13:12.286 socket_api INFO Client Qkzv7YjqxxCuYgfhAAAe disconnected Dec 12 19:13:14 tinypilot2 python[628]: 2023-12-12 19:13:14.710 socket_api INFO Client -dG13CayK4wVeTW1AAAg connected Dec 12 19:26:59 tinypilot2 python[628]: 2023-12-12 19:26:59.965 socket_api INFO Client -dG13CayK4wVeTW1AAAg disconnected Dec 12 19:27:00 tinypilot2 python[628]: 2023-12-12 19:27:00.052 socket_api INFO Client D7I4YRnXrPQJDjq3AAAi connected Dec 12 19:55:12 tinypilot2 python[628]: 2023-12-12 19:55:12.361 socket_api INFO Client D7I4YRnXrPQJDjq3AAAi disconnected Dec 12 19:55:13 tinypilot2 python[628]: 2023-12-12 19:55:13.661 socket_api INFO Client igB7bxsSqIyQBMxMAAAk connected Dec 12 19:55:58 tinypilot2 python[628]: 2023-12-12 19:55:58.752 socket_api INFO Client igB7bxsSqIyQBMxMAAAk disconnected Dec 12 19:58:42 tinypilot2 python[628]: 2023-12-12 19:58:42.835 socket_api INFO Client 2MPZQRoWWFawc7G4AAAm connected Dec 12 20:05:29 tinypilot2 python[628]: 2023-12-12 20:05:29.243 socket_api INFO Client 2MPZQRoWWFawc7G4AAAm disconnected Dec 12 20:05:30 tinypilot2 python[628]: 2023-12-12 20:05:30.945 socket_api INFO Client r9YfKgB2IuXAoOn9AAAo connected Dec 12 20:06:43 tinypilot2 python[628]: 2023-12-12 20:06:43.771 socket_api INFO Client r9YfKgB2IuXAoOn9AAAo disconnected Dec 12 20:06:45 tinypilot2 python[628]: 2023-12-12 20:06:45.344 socket_api INFO Client ApEhg1RsJA53YEFdAAAq connected Dec 12 20:08:37 tinypilot2 python[628]: 2023-12-12 20:08:37.994 socket_api INFO Client ApEhg1RsJA53YEFdAAAq disconnected Dec 12 20:08:39 tinypilot2 python[628]: 2023-12-12 20:08:39.585 socket_api INFO Client sNWwwtqexjxwedldAAAs connected Dec 12 20:09:24 tinypilot2 python[628]: 2023-12-12 20:09:24.677 socket_api INFO Client sNWwwtqexjxwedldAAAs disconnected Dec 12 20:16:22 tinypilot2 python[628]: 2023-12-12 20:16:22.915 socket_api INFO Client 5j0dr8v6R8CCUONdAAAu connected Dec 12 20:22:45 tinypilot2 python[628]: 2023-12-12 20:22:45.362 socket_api INFO Client 5j0dr8v6R8CCUONdAAAu disconnected Dec 12 20:22:48 tinypilot2 python[628]: 2023-12-12 20:22:48.138 socket_api INFO Client J1V0SIyRO61luV9EAAAw connected Dec 12 20:23:58 tinypilot2 python[628]: 2023-12-12 20:23:58.190 socket_api INFO Client J1V0SIyRO61luV9EAAAw disconnected Dec 12 20:24:40 tinypilot2 python[628]: 2023-12-12 20:24:40.671 socket_api INFO Client o7c6YnfehZ9evxJQAAAy connected Dec 12 20:26:45 tinypilot2 python[628]: 2023-12-12 20:26:45.106 socket_api INFO Client o7c6YnfehZ9evxJQAAAy disconnected Dec 12 20:26:47 tinypilot2 python[628]: 2023-12-12 20:26:47.235 socket_api INFO Client vnjJeQDgaDuNIzFxAAA0 connected Dec 12 20:26:55 tinypilot2 python[628]: 2023-12-12 20:26:55.447 socket_api INFO Client vnjJeQDgaDuNIzFxAAA0 disconnected Dec 12 20:26:57 tinypilot2 python[628]: 2023-12-12 20:26:57.035 socket_api INFO Client Ziscq9CwxB48tA6nAAA2 connected Dec 12 20:29:47 tinypilot2 python[628]: 2023-12-12 20:29:47.083 socket_api INFO Client Ziscq9CwxB48tA6nAAA2 disconnected Dec 12 20:43:45 tinypilot2 python[628]: 2023-12-12 20:43:45.019 socket_api INFO Client SLO3MYYh7T7njpOqAAA4 connected Dec 12 20:46:10 tinypilot2 python[628]: 2023-12-12 20:46:10.180 socket_api INFO Client SLO3MYYh7T7njpOqAAA4 disconnected Dec 12 23:39:24 tinypilot2 python[628]: 2023-12-12 23:39:24.643 socket_api INFO Client 8MM3Nb4g_1L-ZcgkAAA6 connected Dec 12 23:41:24 tinypilot2 python[628]: 2023-12-12 23:41:24.679 socket_api INFO Client 8MM3Nb4g_1L-ZcgkAAA6 disconnected Dec 12 23:41:24 tinypilot2 python[628]: 2023-12-12 23:41:24.796 socket_api INFO Client HGUH666ajmHoPqHCAAA8 connected Dec 12 23:50:16 tinypilot2 python[628]: 2023-12-12 23:50:16.400 socket_api INFO Client HGUH666ajmHoPqHCAAA8 disconnected Dec 12 23:50:18 tinypilot2 python[628]: 2023-12-12 23:50:18.681 socket_api INFO Client Cl2qnKIdjK3zqIB_AAA- connected Dec 12 23:51:03 tinypilot2 python[628]: 2023-12-12 23:51:03.781 socket_api INFO Client Cl2qnKIdjK3zqIB_AAA- disconnected Dec 12 23:54:13 tinypilot2 python[628]: 2023-12-12 23:54:13.875 socket_api INFO Client JUv5dBBKqoc6z75RAABA connected Dec 12 23:57:03 tinypilot2 python[628]: 2023-12-12 23:57:03.937 socket_api INFO Client JUv5dBBKqoc6z75RAABA disconnected Dec 13 01:02:35 tinypilot2 python[628]: 2023-12-13 01:02:35.090 socket_api INFO Client lXBMAZeyKP8BGpkyAABC connected Dec 13 01:03:20 tinypilot2 python[628]: 2023-12-13 01:03:20.183 socket_api INFO Client lXBMAZeyKP8BGpkyAABC disconnected Dec 13 01:26:01 tinypilot2 python[628]: 2023-12-13 01:26:01.000 socket_api INFO Client UU85HHgm9U7n6GSNAABE connected Dec 13 01:28:51 tinypilot2 python[628]: 2023-12-13 01:28:51.245 socket_api INFO Client UU85HHgm9U7n6GSNAABE disconnected Dec 13 01:33:14 tinypilot2 python[628]: 2023-12-13 01:33:14.377 socket_api INFO Client faTeR625XvsQQZZGAABG connected Dec 13 01:33:14 tinypilot2 python[628]: 2023-12-13 01:33:14.814 socket_api INFO Client faTeR625XvsQQZZGAABG disconnected Dec 13 01:33:16 tinypilot2 python[628]: 2023-12-13 01:33:16.065 socket_api INFO Client FYcOKrQMCb19sIMKAABI connected Dec 13 01:36:01 tinypilot2 python[628]: 2023-12-13 01:36:01.367 socket_api INFO Client FYcOKrQMCb19sIMKAABI disconnected Dec 13 01:36:03 tinypilot2 python[628]: 2023-12-13 01:36:03.518 socket_api INFO Client AG3mbYnosqpJsYtAAABK connected Dec 13 01:38:44 tinypilot2 python[628]: 2023-12-13 01:38:44.091 socket_api INFO Client AG3mbYnosqpJsYtAAABK disconnected Dec 13 01:38:44 tinypilot2 python[628]: 2023-12-13 01:38:44.210 socket_api INFO Client 4LuE-VbrJM6aKJodAABM connected Dec 13 01:38:49 tinypilot2 python[628]: 2023-12-13 01:38:49.968 local_system INFO Retrieving local system's kernel version Dec 13 01:38:49 tinypilot2 python[628]: 2023-12-13 01:38:49.981 local_system INFO Retrieved local system's kernel version as 6.1.21-v8+ Dec 13 01:38:49 tinypilot2 python[628]: 2023-12-13 01:38:49.983 local_system INFO Retrieving local system's distribution name Dec 13 01:38:50 tinypilot2 python[628]: 2023-12-13 01:38:50.132 local_system INFO Retrieved local system's distribution name as Raspbian Dec 13 01:38:50 tinypilot2 python[628]: 2023-12-13 01:38:50.133 local_system INFO Retrieving local system's distribution version Dec 13 01:38:50 tinypilot2 python[628]: 2023-12-13 01:38:50.226 local_system INFO Retrieved local system's distribution version as 11 Dec 13 01:58:29 tinypilot2 python[628]: 2023-12-13 01:58:29.443 socket_api INFO Client 4LuE-VbrJM6aKJodAABM disconnected Dec 13 01:58:29 tinypilot2 python[628]: 2023-12-13 01:58:29.560 socket_api INFO Client zZQc8U99PjdDMwl6AABO connected Dec 13 01:58:32 tinypilot2 sudo[2482]: tinypilot : PWD=/opt/tinypilot ; USER=root ; COMMAND=/opt/tinypilot-privileged/scripts/collect-debug-logs -q Dec 13 01:58:32 tinypilot2 sudo[2482]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=111) Dec 13 01:58:33 tinypilot2 python[2515]: 2023-12-13 01:58:33.716 app.main INFO Starting app Dec 13 01:58:33 tinypilot2 python[2515]: 2023-12-13 01:58:33.772 db.store INFO Loading database migrations from /opt/tinypilot/app/db/migrations/*.sql Dec 13 01:58:33 tinypilot2 python[2515]: 2023-12-13 01:58:33.774 db.store INFO Read 7 database migrations from disk TinyPilot update logs + tee --append /var/tmp/tmp.RuZccloYBy.yml ustreamer_persistent: true + USE_TC358743_DEFAULTS=false + grep --silent '^ustreamer_capture_device:' /var/tmp/tmp.RuZccloYBy.yml + '[' -f /home/ustreamer/config.yml ']' + false + yaml_set_if_undefined /var/tmp/tmp.RuZccloYBy.yml ustreamer_encoder hw + local file_path=/var/tmp/tmp.RuZccloYBy.yml + local key=ustreamer_encoder + local value=hw + grep --silent '^ustreamer_encoder:' /var/tmp/tmp.RuZccloYBy.yml + echo 'ustreamer_encoder: hw' + tee --append /var/tmp/tmp.RuZccloYBy.yml ustreamer_encoder: hw + yaml_set_if_undefined /var/tmp/tmp.RuZccloYBy.yml ustreamer_format jpeg + local file_path=/var/tmp/tmp.RuZccloYBy.yml + local key=ustreamer_format + local value=jpeg + grep --silent '^ustreamer_format:' /var/tmp/tmp.RuZccloYBy.yml + echo 'ustreamer_format: jpeg' + tee --append /var/tmp/tmp.RuZccloYBy.yml ustreamer_format: jpeg + yaml_set_if_undefined /var/tmp/tmp.RuZccloYBy.yml ustreamer_resolution 1920x1080 + local file_path=/var/tmp/tmp.RuZccloYBy.yml + local key=ustreamer_resolution + local value=1920x1080 + grep --silent '^ustreamer_resolution:' /var/tmp/tmp.RuZccloYBy.yml + echo 'ustreamer_resolution: 1920x1080' + tee --append /var/tmp/tmp.RuZccloYBy.yml ustreamer_resolution: 1920x1080 + echo 'Final install settings:' Final install settings: + cat /var/tmp/tmp.RuZccloYBy.yml tinypilot_external_tls_port: 8444 ustreamer_desired_fps: 25 ustreamer_port: 8001 ustreamer_persistent: true ustreamer_encoder: hw ustreamer_format: jpeg ustreamer_resolution: 1920x1080 + apt-get update --allow-releaseinfo-change-suite Get:1 http://raspbian.raspberrypi.org/raspbian bullseye InRelease [15.0 kB] Get:2 http://archive.raspberrypi.org/debian bullseye InRelease [23.6 kB] Get:3 http://archive.raspberrypi.org/debian bullseye/main armhf Packages [313 kB] Fetched 352 kB in 2s (178 kB/s) Reading package lists... + apt-get install -y git libffi-dev libssl-dev python3-dev python3-venv Reading package lists... Building dependency tree... Reading state information... git is already the newest version (1:2.30.2-1+deb11u2). libffi-dev is already the newest version (3.3-6). python3-dev is already the newest version (3.9.2-3). python3-venv is already the newest version (3.9.2-3). libssl-dev is already the newest version (1.1.1w-0+deb11u1+rpt1). The following package was automatically installed and is no longer required: dos2unix Use 'sudo apt autoremove' to remove it. 0 upgraded, 0 newly installed, 0 to remove and 75 not upgraded. + python3 -m venv venv + . venv/bin/activate ++ deactivate nondestructive ++ '[' -n '' ']' ++ '[' -n '' ']' ++ '[' -n /bin/bash -o -n '' ']' ++ hash -r ++ '[' -n '' ']' ++ unset VIRTUAL_ENV ++ '[' '!' nondestructive = nondestructive ']' ++ VIRTUAL_ENV=/mnt/tinypilot-installer/venv ++ export VIRTUAL_ENV ++ _OLD_VIRTUAL_PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin ++ PATH=/mnt/tinypilot-installer/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin ++ export PATH ++ '[' -n '' ']' ++ '[' -z '' ']' ++ _OLD_VIRTUAL_PS1= ++ PS1='(venv) ' ++ export PS1 ++ '[' -n /bin/bash -o -n '' ']' ++ hash -r + pip install 'pip>=21.3.1' Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple Collecting pip>=21.3.1 Using cached https://www.piwheels.org/simple/pip/pip-23.3.1-py3-none-any.whl (2.1 MB) Installing collected packages: pip Attempting uninstall: pip Found existing installation: pip 20.3.4 Uninstalling pip-20.3.4: Successfully uninstalled pip-20.3.4 Successfully installed pip-23.3.1 + pip install -r requirements.txt Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple Collecting ansible==2.10.7 (from -r requirements.txt (line 5)) Using cached https://www.piwheels.org/simple/ansible/ansible-2.10.7-py3-none-any.whl (48.2 MB) Collecting ansible-base==2.10.17 (from -r requirements.txt (line 8)) Using cached https://www.piwheels.org/simple/ansible-base/ansible_base-2.10.17-py3-none-any.whl (1.9 MB) Collecting cffi==1.15.1 (from -r requirements.txt (line 9)) Using cached https://www.piwheels.org/simple/cffi/cffi-1.15.1-cp39-cp39-linux_armv7l.whl (364 kB) Collecting cryptography==37.0.4 (from -r requirements.txt (line 10)) Using cached https://www.piwheels.org/simple/cryptography/cryptography-37.0.4-cp39-cp39-linux_armv7l.whl (2.5 MB) Collecting Jinja2==3.1.2 (from -r requirements.txt (line 11)) Using cached https://www.piwheels.org/simple/jinja2/Jinja2-3.1.2-py3-none-any.whl (133 kB) Collecting MarkupSafe==2.1.1 (from -r requirements.txt (line 12)) WARNING: Retrying (Retry(total=4, connect=None, read=None, redirect=None, status=None)) after connection broken by 'ProtocolError('Connection aborted.', RemoteDisconnected('Remote end closed connection without response'))': /simple/markupsafe/MarkupSafe-2.1.1-cp39-cp39-linux_armv7l.whl Using cached https://www.piwheels.org/simple/markupsafe/MarkupSafe-2.1.1-cp39-cp39-linux_armv7l.whl (23 kB) Collecting packaging==21.3 (from -r requirements.txt (line 13)) Using cached https://www.piwheels.org/simple/packaging/packaging-21.3-py3-none-any.whl (40 kB) Collecting pycparser==2.21 (from -r requirements.txt (line 14)) Using cached https://www.piwheels.org/simple/pycparser/pycparser-2.21-py2.py3-none-any.whl (119 kB) Collecting pyparsing==3.0.9 (from -r requirements.txt (line 15)) Using cached https://www.piwheels.org/simple/pyparsing/pyparsing-3.0.9-py3-none-any.whl (98 kB) Collecting PyYAML==6.0 (from -r requirements.txt (line 16)) Using cached https://www.piwheels.org/simple/pyyaml/PyYAML-6.0-cp39-cp39-linux_armv7l.whl (45 kB) Installing collected packages: PyYAML, pyparsing, pycparser, MarkupSafe, packaging, Jinja2, cffi, cryptography, ansible-base, ansible Successfully installed Jinja2-3.1.2 MarkupSafe-2.1.1 PyYAML-6.0 ansible-2.10.7 ansible-base-2.10.17 cffi-1.15.1 cryptography-37.0.4 packaging-21.3 pycparser-2.21 pyparsing-3.0.9 + ansible-playbook --inventory localhost, install.yml --extra-vars @/var/tmp/tmp.RuZccloYBy.yml --extra-vars tinypilot_debian_package_path=/mnt/tinypilot-installer/tinypilot-20221003185210-1-armhf.deb PLAY [localhost] *************************************************************** TASK [Gathering Facts] ********************************************************* ok: [localhost] TASK [ansible-role-tinypilot-pro : install Janus Debian package] *************** skipping: [localhost] TASK [ansible-role-ustreamer : check that the H264 variables are in a consistent state] *** skipping: [localhost] TASK [ansible-role-ustreamer : create ustreamer group] ************************* ok: [localhost] TASK [ansible-role-ustreamer : create ustreamer user] ************************** ok: [localhost] TASK [ansible-role-ustreamer : check for a boot config file] ******************* ok: [localhost] TASK [ansible-role-ustreamer : save whether boot config file exists] *********** ok: [localhost] TASK [ansible-role-ustreamer : check whether this machine has a uStreamer settings file] *** ok: [localhost] TASK [ansible-role-ustreamer : read uStreamer settings file] ******************* skipping: [localhost] TASK [ansible-role-ustreamer : decode settings file] *************************** skipping: [localhost] TASK [ansible-role-ustreamer : read ustreamer_capture_device from config file if it's not already defined] *** skipping: [localhost] TASK [ansible-role-ustreamer : enable TC358743 overlay in /boot/config.txt] **** skipping: [localhost] TASK [ansible-role-ustreamer : set GPU memory to 256MB in /boot/config.txt] **** skipping: [localhost] TASK [ansible-role-ustreamer : check for a boot cmdline file] ****************** skipping: [localhost] TASK [ansible-role-ustreamer : read /boot/cmdline.txt] ************************* skipping: [localhost] TASK [ansible-role-ustreamer : decode command-line string] ********************* skipping: [localhost] TASK [ansible-role-ustreamer : change cma to 128M if it's set to a different value] *** skipping: [localhost] TASK [ansible-role-ustreamer : add cma=128M to cmdline.txt if it's missing] **** skipping: [localhost] TASK [ansible-role-ustreamer : create EDIDs folder] **************************** skipping: [localhost] TASK [ansible-role-ustreamer : copy TC358743 EDID file] ************************ skipping: [localhost] TASK [ansible-role-ustreamer : install TC358743 initializer service] *********** skipping: [localhost] TASK [ansible-role-ustreamer : use custom settings for TC358743 chip for any facts not already defined] *** skipping: [localhost] TASK [ansible-role-ustreamer : remove TC358743 initializer service file] ******* ok: [localhost] TASK [ansible-role-ustreamer : disable TC358743 overlay in /boot/config.txt] *** ok: [localhost] TASK [ansible-role-ustreamer : check if OS is Raspberry Pi OS] ***************** ok: [localhost] TASK [ansible-role-ustreamer : enable OpenMax IL acceleration] ***************** ok: [localhost] TASK [ansible-role-ustreamer : check that OpenMax IL acceleration is only compiled on Raspberry Pi OS] *** skipping: [localhost] TASK [ansible-role-ustreamer : collect universal required apt packages] ******** ok: [localhost] TASK [ansible-role-ustreamer : collect Raspberry Pi OS specific required apt packages] *** ok: [localhost] TASK [ansible-role-ustreamer : install libraspberrypi-dev if we're using OpenMax IL acceleration] *** skipping: [localhost] TASK [ansible-role-ustreamer : collect Debian-specific required apt packages] *** skipping: [localhost] TASK [ansible-role-ustreamer : collect Ubuntu-specific required apt packages] *** skipping: [localhost] TASK [ansible-role-ustreamer : collect Janus WebRTC plugin specific required apt packages] *** skipping: [localhost] TASK [ansible-role-ustreamer : install uStreamer pre-requisite packages] ******* ok: [localhost] TASK [ansible-role-ustreamer : create uStreamer folder] ************************ ok: [localhost] TASK [ansible-role-ustreamer : get uStreamer repo] ***************************** fatal: [localhost]: FAILED! => {"changed": false, "cmd": "/usr/bin/git clone --origin origin https://github.com/tiny-pilot/ustreamer.git /opt/ustreamer", "msg": "fatal: destination path '/opt/ustreamer' already exists and is not an empty directory.", "rc": 128, "stderr": "fatal: destination path '/opt/ustreamer' already exists and is not an empty directory.\n", "stderr_lines": ["fatal: destination path '/opt/ustreamer' already exists and is not an empty directory."], "stdout": "", "stdout_lines": []} PLAY RECAP ********************************************************************* localhost : ok=14 changed=0 unreachable=0 failed=1 skipped=21 rescued=0 ignored=0 + clean_up + rm -rf /var/tmp/tmp.RuZccloYBy.yml + clean_up + sudo umount --lazy /mnt/tinypilot-installer + sudo rm -rf /opt/tinypilot-updater /mnt/tinypilot-installer 2023-12-08 02:28:47.866 __main__ ERROR Update process terminated with failing exit code: Command '['sudo', '/opt/tinypilot-privileged/scripts/update']' returned non-zero exit status 2. 2023-12-08 02:28:47.866 update.result_store INFO Writing result file to /home/tinypilot/logs/latest-update-result.json 2023-12-08 02:28:47.867 update.target_version INFO Clearing target version file /home/tinypilot/target-version uStreamer configuration ==> /opt/ustreamer-launcher/configs.d/000-defaults.yml <== # Settings for an HDMI to USB video capture dongle. --- ustreamer_encoder: hw ustreamer_format: jpeg ustreamer_resolution: "1920x1080" ==> /opt/ustreamer-launcher/configs.d/100-tinypilot.yml <== tinypilot_external_tls_port: 8444 ustreamer_desired_fps: 25 uStreamer logs -- Journal begins at Tue 2023-12-12 17:41:00 GMT, ends at Wed 2023-12-13 01:58:33 GMT. -- Dec 12 17:41:03 tinypilot2 systemd[1]: Started uStreamer - Lightweight, optimized video encoder. Dec 12 17:41:04 tinypilot2 launch[477]: + exec /opt/ustreamer/ustreamer --port 48001 --persistent --h264-sink tinypilot::ustreamer::h264 --h264-sink-mode 777 --h264-sink-rm --encoder hw --format jpeg --desired-fps 25 --resolution 1920x1080 Dec 12 17:41:04 tinypilot2 launch[477]: -- INFO [8.487 main] -- Starting PiKVM uStreamer 5.43 ... Dec 12 17:41:04 tinypilot2 launch[477]: -- INFO [8.487 main] -- Using internal blank placeholder Dec 12 17:41:04 tinypilot2 launch[477]: -- INFO [8.487 main] -- Using H264-sink: tinypilot::ustreamer::h264 Dec 12 17:41:04 tinypilot2 launch[477]: -- INFO [8.488 main] -- Listening HTTP on [127.0.0.1]:48001 Dec 12 17:41:04 tinypilot2 launch[477]: -- INFO [8.488 http] -- Starting HTTP eventloop ... Dec 12 17:41:04 tinypilot2 launch[477]: -- INFO [8.489 stream] -- Using V4L2 device: /dev/video0 Dec 12 17:41:04 tinypilot2 launch[477]: -- INFO [8.489 stream] -- Using desired FPS: 25 Dec 12 17:41:04 tinypilot2 launch[477]: -- INFO [8.489 stream] -- H264: Initializing encoder ... Dec 12 17:41:05 tinypilot2 launch[477]: -- INFO [8.502 stream] -- H264: Configuring encoder: DMA=0 ... Dec 12 17:41:05 tinypilot2 launch[477]: ================================================================================ Dec 12 17:41:05 tinypilot2 launch[477]: -- ERROR [8.526 stream] -- Can't access device: No such file or directory Dec 12 17:41:05 tinypilot2 launch[477]: -- INFO [8.526 stream] -- Waiting for the device access ... Dec 12 17:41:14 tinypilot2 launch[477]: -- INFO [18.409 http] -- HTTP: NEW client (now=1): [2600:1700:38c1:3a70:534:6991:4c69:e86a]:57790, id=930e64bb41a6be58 Dec 12 18:02:37 tinypilot2 launch[477]: -- INFO [1289.765 http] -- HTTP: DEL client (now=0): [2600:1700:38c1:3a70:534:6991:4c69:e86a]:57790, id=930e64bb41a6be58, Resource temporarily unavailable (reading,eof) Dec 12 19:27:00 tinypilot2 launch[477]: -- INFO [6352.108 http] -- HTTP: NEW client (now=1): [2600:1700:38c1:3a70:534:6991:4c69:e86a]:52018, id=f2da399f63bf1de2 Dec 12 19:55:12 tinypilot2 launch[477]: -- INFO [8044.409 http] -- HTTP: DEL client (now=0): [2600:1700:38c1:3a70:534:6991:4c69:e86a]:52018, id=f2da399f63bf1de2, Resource temporarily unavailable (reading,eof) Dec 12 23:41:24 tinypilot2 launch[477]: -- INFO [21616.855 http] -- HTTP: NEW client (now=1): [2600:1700:38c1:3a70:e80f:5f6a:4fe4:15f9]:35624, id=714c153e537a56a0 Dec 12 23:50:16 tinypilot2 launch[477]: -- INFO [22148.474 http] -- HTTP: DEL client (now=0): [2600:1700:38c1:3a70:e80f:5f6a:4fe4:15f9]:35624, id=714c153e537a56a0, Resource temporarily unavailable (reading,eof) Dec 13 01:38:44 tinypilot2 launch[477]: -- INFO [28656.262 http] -- HTTP: NEW client (now=1): [2600:1700:38c1:3a70:e80f:5f6a:4fe4:15f9]:56822, id=ae7c507fd5449f28 Dec 13 01:58:29 tinypilot2 launch[477]: -- INFO [29841.506 http] -- HTTP: DEL client (now=0): [2600:1700:38c1:3a70:e80f:5f6a:4fe4:15f9]:56822, id=ae7c507fd5449f28, Resource temporarily unavailable (reading,eof) Dec 13 01:58:29 tinypilot2 launch[477]: -- INFO [29841.618 http] -- HTTP: NEW client (now=1): [2600:1700:38c1:3a70:e80f:5f6a:4fe4:15f9]:44324, id=54b7d1d56a748c59 nginx logs -- Journal begins at Tue 2023-12-12 17:41:00 GMT, ends at Wed 2023-12-13 01:58:33 GMT. -- Dec 12 17:41:03 tinypilot2 systemd[1]: Starting A high performance web server and a reverse proxy server... Dec 12 17:41:04 tinypilot2 systemd[1]: Started A high performance web server and a reverse proxy server. 2600:1700:38c1:3a70:e80f:5f6a:4fe4:15f9 - - [13/Dec/2023:01:58:29 +0000] "GET /js/settings.js HTTP/2.0" 200 1900 "https://tinypilot2.local:8444/" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/120.0.0.0 Safari/537.36" 2600:1700:38c1:3a70:e80f:5f6a:4fe4:15f9 - - [13/Dec/2023:01:58:29 +0000] "GET /js/wake-on-lan.js HTTP/2.0" 200 551 "https://tinypilot2.local:8444/" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/120.0.0.0 Safari/537.36" 2600:1700:38c1:3a70:e80f:5f6a:4fe4:15f9 - - [13/Dec/2023:01:58:29 +0000] "GET /js/logs.js HTTP/2.0" 200 1484 "https://tinypilot2.local:8444/" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/120.0.0.0 Safari/537.36" 2600:1700:38c1:3a70:e80f:5f6a:4fe4:15f9 - - [13/Dec/2023:01:58:29 +0000] "GET /js/clipboard.js HTTP/2.0" 200 889 "https://tinypilot2.local:8444/" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/120.0.0.0 Safari/537.36" 2600:1700:38c1:3a70:e80f:5f6a:4fe4:15f9 - - [13/Dec/2023:01:58:29 +0000] "GET /js/mouse.js HTTP/2.0" 200 8492 "https://tinypilot2.local:8444/" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/120.0.0.0 Safari/537.36" 2600:1700:38c1:3a70:e80f:5f6a:4fe4:15f9 - - [13/Dec/2023:01:58:29 +0000] "GET /js/updatelogs.js HTTP/2.0" 200 861 "https://tinypilot2.local:8444/" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/120.0.0.0 Safari/537.36" 2600:1700:38c1:3a70:e80f:5f6a:4fe4:15f9 - - [13/Dec/2023:01:58:29 +0000] "GET /third-party/fonts/fonts.css HTTP/2.0" 200 1812 "https://tinypilot2.local:8444/css/style.css" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/120.0.0.0 Safari/537.36" 2600:1700:38c1:3a70:e80f:5f6a:4fe4:15f9 - - [13/Dec/2023:01:58:29 +0000] "GET /css/button.css HTTP/2.0" 200 1976 "https://tinypilot2.local:8444/css/style.css" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/120.0.0.0 Safari/537.36" 2600:1700:38c1:3a70:e80f:5f6a:4fe4:15f9 - - [13/Dec/2023:01:58:29 +0000] "GET /css/cursors.css HTTP/2.0" 200 618 "https://tinypilot2.local:8444/css/style.css" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/120.0.0.0 Safari/537.36" 2600:1700:38c1:3a70:e80f:5f6a:4fe4:15f9 - - [13/Dec/2023:01:58:29 +0000] "GET /third-party/fonts/overpass-light.woff2 HTTP/2.0" 200 26568 "https://tinypilot2.local:8444/third-party/fonts/fonts.css" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/120.0.0.0 Safari/537.36" 2600:1700:38c1:3a70:e80f:5f6a:4fe4:15f9 - - [13/Dec/2023:01:58:29 +0000] "GET /third-party/fonts/overpass-mono-light.woff2 HTTP/2.0" 200 50112 "https://tinypilot2.local:8444/third-party/fonts/fonts.css" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/120.0.0.0 Safari/537.36" 2600:1700:38c1:3a70:e80f:5f6a:4fe4:15f9 - - [13/Dec/2023:01:58:29 +0000] "GET /third-party/fonts/overpass-semibold.woff2 HTTP/2.0" 200 25032 "https://tinypilot2.local:8444/third-party/fonts/fonts.css" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/120.0.0.0 Safari/537.36" 2600:1700:38c1:3a70:e80f:5f6a:4fe4:15f9 - - [13/Dec/2023:01:58:29 +0000] "GET /js/keycodes.js HTTP/2.0" 200 822 "https://tinypilot2.local:8444/js/app.js" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/120.0.0.0 Safari/537.36" 2600:1700:38c1:3a70:e80f:5f6a:4fe4:15f9 - - [13/Dec/2023:01:58:29 +0000] "GET /js/keyboardstate.js HTTP/2.0" 200 3164 "https://tinypilot2.local:8444/js/app.js" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/120.0.0.0 Safari/537.36" 2600:1700:38c1:3a70:e80f:5f6a:4fe4:15f9 - - [13/Dec/2023:01:58:29 +0000] "GET /js/keystrokes.js HTTP/2.0" 200 362 "https://tinypilot2.local:8444/js/app.js" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/120.0.0.0 Safari/537.36" 2600:1700:38c1:3a70:e80f:5f6a:4fe4:15f9 - - [13/Dec/2023:01:58:29 +0000] "GET /js/overlays.js HTTP/2.0" 200 495 "https://tinypilot2.local:8444/js/app.js" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/120.0.0.0 Safari/537.36" 2600:1700:38c1:3a70:e80f:5f6a:4fe4:15f9 - - [13/Dec/2023:01:58:29 +0000] "GET /css/icons.css HTTP/2.0" 200 841 "https://tinypilot2.local:8444/" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/120.0.0.0 Safari/537.36" 2600:1700:38c1:3a70:e80f:5f6a:4fe4:15f9 - - [13/Dec/2023:01:58:29 +0000] "GET /css/toggle.css HTTP/2.0" 200 1005 "https://tinypilot2.local:8444/" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/120.0.0.0 Safari/537.36" 2600:1700:38c1:3a70:e80f:5f6a:4fe4:15f9 - - [13/Dec/2023:01:58:29 +0000] "GET /img/warning-icon.svg HTTP/2.0" 304 0 "https://tinypilot2.local:8444/" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/120.0.0.0 Safari/537.36" 2600:1700:38c1:3a70:e80f:5f6a:4fe4:15f9 - - [13/Dec/2023:01:58:29 +0000] "GET /img/video-stream-icon.svg HTTP/2.0" 304 0 "https://tinypilot2.local:8444/" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/120.0.0.0 Safari/537.36" 2600:1700:38c1:3a70:e80f:5f6a:4fe4:15f9 - - [13/Dec/2023:01:58:29 +0000] "GET /img/clipboard-icon.svg HTTP/2.0" 304 0 "https://tinypilot2.local:8444/" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/120.0.0.0 Safari/537.36" 2600:1700:38c1:3a70:e80f:5f6a:4fe4:15f9 - - [13/Dec/2023:01:58:29 +0000] "GET /img/logo.svg HTTP/2.0" 304 0 "https://tinypilot2.local:8444/" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/120.0.0.0 Safari/537.36" 2600:1700:38c1:3a70:e80f:5f6a:4fe4:15f9 - - [13/Dec/2023:01:58:29 +0000] "GET /img/angle-down-icon.svg HTTP/2.0" 304 0 "https://tinypilot2.local:8444/" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/120.0.0.0 Safari/537.36" 2600:1700:38c1:3a70:e80f:5f6a:4fe4:15f9 - - [13/Dec/2023:01:58:29 +0000] "GET /img/external-link-icon.svg HTTP/2.0" 304 0 "https://tinypilot2.local:8444/" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/120.0.0.0 Safari/537.36" 2600:1700:38c1:3a70:e80f:5f6a:4fe4:15f9 - - [13/Dec/2023:01:58:29 +0000] "GET /socket.io/?EIO=4&transport=polling&t=OnWvPji HTTP/2.0" 200 97 "https://tinypilot2.local:8444/" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/120.0.0.0 Safari/537.36" 2600:1700:38c1:3a70:e80f:5f6a:4fe4:15f9 - - [13/Dec/2023:01:58:29 +0000] "POST /socket.io/?EIO=4&transport=polling&t=OnWvPkY&sid=pWDJyrTJC9Zdic0SAABN HTTP/2.0" 200 2 "https://tinypilot2.local:8444/" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/120.0.0.0 Safari/537.36" 2600:1700:38c1:3a70:e80f:5f6a:4fe4:15f9 - - [13/Dec/2023:01:58:29 +0000] "GET /socket.io/?EIO=4&transport=polling&t=OnWvPkZ&sid=pWDJyrTJC9Zdic0SAABN HTTP/2.0" 200 32 "https://tinypilot2.local:8444/" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/120.0.0.0 Safari/537.36" 2600:1700:38c1:3a70:e80f:5f6a:4fe4:15f9 - - [13/Dec/2023:01:58:29 +0000] "GET /favicon.ico HTTP/2.0" 200 1213 "https://tinypilot2.local:8444/" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/120.0.0.0 Safari/537.36" 2600:1700:38c1:3a70:e80f:5f6a:4fe4:15f9 - - [13/Dec/2023:01:58:29 +0000] "GET /favicon-32x32.png HTTP/2.0" 200 833 "https://tinypilot2.local:8444/" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/120.0.0.0 Safari/537.36" 2600:1700:38c1:3a70:e80f:5f6a:4fe4:15f9 - - [13/Dec/2023:01:58:29 +0000] "GET /socket.io/?EIO=4&transport=polling&t=OnWvPlM&sid=pWDJyrTJC9Zdic0SAABN HTTP/2.0" 200 1 "https://tinypilot2.local:8444/" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/120.0.0.0 Safari/537.36"