TinyPilot Pro log dump https://tinypilotkvm.com Timestamp: 2023-10-04T15:57:03+01:00 Software versions TinyPilot version: 2.6.1 uStreamer version: 5.38 System information OS version: Linux tinypilot 5.15.84-v7l+ #1613 SMP Thu Jan 5 12:01:26 GMT 2023 armv7l GNU/Linux Kernel architecture: armv7l Userland architecture: armhf (32-bit) Distribution name: Raspbian Distribution version: 11 Hardware information Hardware: BCM2711 Revision: d03115 Model: Raspberry Pi 4 Model B Rev 1.5 TinyPilot state Read-only filesystem: off SSH access: disabled Network interfaces: eth0 (up) lo (unknown) wlan0 (down) Mouse jiggler: disabled CPU Temperature: 37.4'C CPU throttled since boot: no Voltage issues: no TinyPilot settings.yml 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 Wed 2023-10-04 15:18:44 BST, ends at Wed 2023-10-04 15:57:03 BST. -- Oct 04 15:18:48 tinypilot systemd[1]: Started TinyPilot - RPi-based virtual KVM. Oct 04 15:18:51 tinypilot python[547]: 2023-10-04 15:18:51.897 __main__ INFO Starting app Oct 04 15:19:01 tinypilot python[547]: 2023-10-04 15:19:01.124 db.store INFO Loading database migrations from /opt/tinypilot/app/db/migrations/*.sql Oct 04 15:19:01 tinypilot python[547]: 2023-10-04 15:19:01.130 db.store INFO Read 7 database migrations from disk Oct 04 15:19:01 tinypilot python[547]: 2023-10-04 15:19:01.161 socket_api INFO Client dyYSktnR9wz2bqRLAAAB connected Oct 04 15:19:01 tinypilot python[547]: 2023-10-04 15:19:01.546 socket_api INFO Client QTbSeZsTygI1yLgbAAAD connected Oct 04 15:20:15 tinypilot python[547]: 2023-10-04 15:20:15.656 socket_api INFO Client dyYSktnR9wz2bqRLAAAB disconnected [SENSITIVE DATA REDACTED] Oct 04 15:22:58 tinypilot python[1153]: Process ProcessWithResult-3: Oct 04 15:22:58 tinypilot python[1153]: Traceback (most recent call last): Oct 04 15:22:58 tinypilot python[1153]: File "/usr/lib/python3.9/multiprocessing/process.py", line 315, in _bootstrap Oct 04 15:22:58 tinypilot python[1153]: self.run() Oct 04 15:22:58 tinypilot python[1153]: File "/opt/tinypilot/app/hid/write.py", line 45, in run Oct 04 15:22:58 tinypilot python[1153]: result.return_value = self._target(*self._args, **self._kwargs) Oct 04 15:22:58 tinypilot python[1153]: File "/opt/tinypilot/app/hid/write.py", line 65, in _write_to_hid_interface_immediately Oct 04 15:22:58 tinypilot python[1153]: hid_handle.write(bytearray(buffer)) Oct 04 15:22:58 tinypilot python[1153]: BrokenPipeError: [Errno 108] Cannot send after transport endpoint shutdown [SENSITIVE DATA REDACTED] Oct 04 15:22:59 tinypilot python[1157]: Process ProcessWithResult-4: Oct 04 15:22:59 tinypilot python[1157]: Traceback (most recent call last): Oct 04 15:22:59 tinypilot python[1157]: File "/usr/lib/python3.9/multiprocessing/process.py", line 315, in _bootstrap Oct 04 15:22:59 tinypilot python[1157]: self.run() Oct 04 15:22:59 tinypilot python[1157]: File "/opt/tinypilot/app/hid/write.py", line 45, in run Oct 04 15:22:59 tinypilot python[1157]: result.return_value = self._target(*self._args, **self._kwargs) Oct 04 15:22:59 tinypilot python[1157]: File "/opt/tinypilot/app/hid/write.py", line 65, in _write_to_hid_interface_immediately Oct 04 15:22:59 tinypilot python[1157]: hid_handle.write(bytearray(buffer)) Oct 04 15:22:59 tinypilot python[1157]: BrokenPipeError: [Errno 108] Cannot send after transport endpoint shutdown [SENSITIVE DATA REDACTED] Oct 04 15:23:16 tinypilot python[547]: 2023-10-04 15:23:16.869 video_service INFO Triggering ustreamer restart... Oct 04 15:23:16 tinypilot sudo[1190]: tinypilot : PWD=/opt/tinypilot ; USER=root ; COMMAND=/usr/sbin/service ustreamer restart Oct 04 15:23:16 tinypilot sudo[1190]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=110) Oct 04 15:23:17 tinypilot sudo[1190]: pam_unix(sudo:session): session closed for user root Oct 04 15:23:17 tinypilot python[547]: 2023-10-04 15:23:17.581 video_service INFO Successfully restarted ustreamer Oct 04 15:23:18 tinypilot python[547]: 2023-10-04 15:23:18.690 socket_api INFO Client QTbSeZsTygI1yLgbAAAD disconnected Oct 04 15:23:18 tinypilot python[547]: 2023-10-04 15:23:18.773 socket_api INFO Client 2RfcEhDdO4tBJjjQAAAF connected [SENSITIVE DATA REDACTED] [SENSITIVE DATA REDACTED] [SENSITIVE DATA REDACTED] Oct 04 15:25:41 tinypilot python[547]: 2023-10-04 15:25:41.144 socket_api INFO Client 2RfcEhDdO4tBJjjQAAAF disconnected Oct 04 15:52:39 tinypilot python[547]: 2023-10-04 15:52:39.776 socket_api INFO Client csG4LZq31hC6PyoEAAAH connected [SENSITIVE DATA REDACTED] [SENSITIVE DATA REDACTED] Oct 04 15:52:47 tinypilot sudo[3743]: tinypilot : PWD=/opt/tinypilot ; USER=root ; COMMAND=/opt/tinypilot-privileged/scripts/collect-debug-logs -q Oct 04 15:52:47 tinypilot sudo[3743]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=110) Oct 04 15:52:48 tinypilot sudo[3743]: pam_unix(sudo:session): session closed for user root [SENSITIVE DATA REDACTED] [SENSITIVE DATA REDACTED] [SENSITIVE DATA REDACTED] [SENSITIVE DATA REDACTED] Oct 04 15:57:03 tinypilot sudo[4147]: tinypilot : PWD=/opt/tinypilot ; USER=root ; COMMAND=/opt/tinypilot-privileged/scripts/collect-debug-logs -q Oct 04 15:57:03 tinypilot sudo[4147]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=110) TinyPilot update logs 2023-09-26 18:09:02.996 __main__ INFO Starting TinyPilot update 2023-09-26 18:09:02.997 __main__ INFO Launching update script: /opt/tinypilot-privileged/scripts/update + set -u + set -e + readonly VERSION_FILE=/home/tinypilot/target-version + VERSION_FILE=/home/tinypilot/target-version + SCRIPT_ARGS=() + [[ -f /home/tinypilot/target-version ]] ++ cat /home/tinypilot/target-version + VERSION=2.6.1 + SCRIPT_ARGS+=(--version "${VERSION}") + readonly SCRIPT_ARGS + curl --silent --show-error https://gk.tinypilotkvm.com/get-tinypilot-pro.sh + bash -s -- --version 2.6.1 + TARGET_VERSION= + ALLOW_REINSTALL=false + [[ 2 -gt 0 ]] + case "$1" in + TARGET_VERSION=2.6.1 + shift + shift + [[ 0 -gt 0 ]] + readonly ALLOW_REINSTALL + readonly LEGACY_INSTALLER_DIR=/opt/tinypilot-updater + LEGACY_INSTALLER_DIR=/opt/tinypilot-updater + readonly RAMDISK_SIZE_MIB=560 + RAMDISK_SIZE_MIB=560 ++ free --mebi ++ tr --squeeze-repeats ' ' ++ grep --fixed-strings Mem: ++ cut --delimiter ' ' --fields 7 + AVAILABLE_MEMORY_MIB=7367 + readonly AVAILABLE_MEMORY_MIB + INSTALLER_DIR=/mnt/tinypilot-installer + trap clean_up EXIT + (( 7367 >= 560 )) + sudo mkdir /mnt/tinypilot-installer + sudo mount --types tmpfs --options size=560m --source tmpfs --target /mnt/tinypilot-installer --verbose mount: tmpfs mounted on /mnt/tinypilot-installer. + readonly INSTALLER_DIR + readonly TMPDIR=/mnt/tinypilot-installer/tmp + TMPDIR=/mnt/tinypilot-installer/tmp + export TMPDIR + sudo mkdir /mnt/tinypilot-installer/tmp + readonly BUNDLE_FILE=/mnt/tinypilot-installer/bundle.tgz + BUNDLE_FILE=/mnt/tinypilot-installer/bundle.tgz + readonly TARGET_VERSION_FILE=/mnt/tinypilot-installer/target_version.json + TARGET_VERSION_FILE=/mnt/tinypilot-installer/target_version.json + readonly TINYPILOT_VERSION_FILE=/opt/tinypilot/VERSION + TINYPILOT_VERSION_FILE=/opt/tinypilot/VERSION + CURRENT_VERSION= + [[ -f /opt/tinypilot/VERSION ]] ++ cat /opt/tinypilot/VERSION + CURRENT_VERSION=2.5.4 + readonly CURRENT_VERSION + HAS_COMMUNITY_INSTALLED=0 + readonly TINYPILOT_README_FILE=/opt/tinypilot/README.md + TINYPILOT_README_FILE=/opt/tinypilot/README.md + [[ -f /opt/tinypilot/README.md ]] ++ head -n 1 /opt/tinypilot/README.md + [[ # TinyPilot Pro == \#\ \T\i\n\y\P\i\l\o\t ]] + readonly HAS_COMMUNITY_INSTALLED + [[ -z 2.6.1 ]] + readonly TARGET_VERSION + [[ 2.5.4 == \2\.\6\.\1 ]] + readonly TINYPILOT_LICENSE_KEY=UNSPECIFIED + TINYPILOT_LICENSE_KEY=UNSPECIFIED ++ tr --delete '\0' + DEVICE_SERIAL_NUMBER=1000000097e9a431 + readonly DEVICE_SERIAL_NUMBER ++ curl https://gk.tinypilotkvm.com/pro/download/2.6.1 --location --header 'TP-License: UNSPECIFIED' --header 'TP-Device-Serial-Number: 1000000097e9a431' --output /mnt/tinypilot-installer/bundle.tgz --write-out '%{http_code}' --silent + HTTP_CODE=200 + readonly HTTP_CODE + [[ 200 != \2\0\0 ]] + sudo tar --gunzip --extract --file /mnt/tinypilot-installer/bundle.tgz --directory /mnt/tinypilot-installer + sudo chown root:root --recursive /mnt/tinypilot-installer + [[ 0 -eq 1 ]] + pushd /mnt/tinypilot-installer /mnt/tinypilot-installer /opt/tinypilot + sudo TMPDIR=/mnt/tinypilot-installer/tmp ./install + grep -q '^Model *: Raspberry Pi 3' /proc/cpuinfo ++ lsb_release --id --short + [[ Raspbian == \R\a\s\p\b\i\a\n ]] ++ lsb_release --release --short + (( 11 < 11 )) + grep -q boot=overlay /proc/cmdline ++ ls janus_1.0.1-1~bpo11+1_armhf.deb + JANUS_DEBIAN_PACKAGE=janus_1.0.1-1~bpo11+1_armhf.deb + readonly JANUS_DEBIAN_PACKAGE ++ ls ustreamer_5.38-20230802141939_armhf.deb + USTREAMER_DEBIAN_PACKAGE=ustreamer_5.38-20230802141939_armhf.deb + readonly USTREAMER_DEBIAN_PACKAGE ++ ls tinypilot_20230904111604_armhf.deb + TINYPILOT_DEBIAN_PACKAGE=tinypilot_20230904111604_armhf.deb + readonly TINYPILOT_DEBIAN_PACKAGE + apt-get install -y ./janus_1.0.1-1~bpo11+1_armhf.deb ./ustreamer_5.38-20230802141939_armhf.deb ./tinypilot_20230904111604_armhf.deb Reading package lists... Building dependency tree... Reading state information... janus is already the newest version (1.0.1-1~bpo11+1). The following package was automatically installed and is no longer required: dos2unix Use 'sudo apt autoremove' to remove it. The following NEW packages will be installed: ustreamer The following packages will be upgraded: tinypilot 1 upgraded, 1 newly installed, 0 to remove and 17 not upgraded. Need to get 0 B/2,659 kB of archives. After this operation, 11.9 MB of additional disk space will be used. Get:1 /mnt/tinypilot-installer/ustreamer_5.38-20230802141939_armhf.deb ustreamer armhf 5.38-20230802141939 [157 kB] Get:2 /mnt/tinypilot-installer/tinypilot_20230904111604_armhf.deb tinypilot armhf 20230904111604 [2,503 kB] apt-listchanges: Reading changelogs... debconf: unable to initialize frontend: Dialog debconf: (Dialog frontend will not work on a dumb terminal, an emacs shell buffer, or without a controlling terminal.) debconf: falling back to frontend: Readline debconf: unable to initialize frontend: Readline debconf: (This frontend requires a controlling tty.) debconf: falling back to frontend: Teletype dpkg-preconfigure: unable to re-open stdin: Selecting previously unselected package ustreamer. [614B blob data] Preparing to unpack .../ustreamer_5.38-20230802141939_armhf.deb ... Unpacking ustreamer (5.38-20230802141939) ... Preparing to unpack .../tinypilot_20230904111604_armhf.deb ... Unpacking tinypilot (20230904111604) over (20230427192344) ... Setting up ustreamer (5.38-20230802141939) ... Warning: The home dir /home/ustreamer you specified already exists. The system user `ustreamer' already exists. Exiting. Setting up tinypilot (20230904111604) ... Installing new version of config file /etc/sudoers.d/tinypilot ... Warning: The home dir /home/tinypilot you specified already exists. The system user `tinypilot' already exists. Exiting. /opt/tinypilot / / /opt/tinypilot / / /opt/tinypilot / / nginx: the configuration file /etc/nginx/nginx.conf syntax is ok nginx: configuration file /etc/nginx/nginx.conf test is successful active /opt/tinypilot / / Processing triggers for man-db (2.9.4-2) ... + mv yq /usr/bin/yq + chmod 0755 /usr/bin/yq + clean_up + sudo umount --lazy /mnt/tinypilot-installer + sudo rm -rf /opt/tinypilot-updater /mnt/tinypilot-installer 2023-09-26 18:10:23.919 __main__ INFO Update completed successfully 2023-09-26 18:10:23.921 update.result_store INFO Writing result file to /home/tinypilot/logs/latest-update-result.json 2023-09-26 18:10:23.922 update.target_version INFO Clearing target version file /home/tinypilot/target-version uStreamer configuration ==> /opt/ustreamer-launcher/configs.d/000-defaults.yml <== # Settings for TC358743 HDMI to CSI-2 bridge, which are included on the # TinyPilot Voyager series of devices. --- ustreamer_encoder: m2m-image ustreamer_format: uyvy ustreamer_use_dv_timings: true ustreamer_workers: "3" ustreamer_drop_same_frames: "30" ==> /opt/ustreamer-launcher/configs.d/100-tinypilot.yml <== uStreamer logs Oct 04 15:56:55 tinypilot launch[1194]: -- INFO [2280.468 stream] -- Using resolution: 640x416 Oct 04 15:56:55 tinypilot launch[1194]: -- INFO [2280.468 stream] -- Using format: UYVY Oct 04 15:56:55 tinypilot launch[1194]: -- INFO [2280.468 stream] -- Querying HW FPS changing is not supported Oct 04 15:56:55 tinypilot launch[1194]: -- INFO [2280.468 stream] -- Using IO method: MMAP Oct 04 15:56:55 tinypilot launch[1194]: -- INFO [2280.476 stream] -- Requested 5 device buffers, got 5 Oct 04 15:56:55 tinypilot launch[1194]: -- INFO [2280.486 stream] -- Capturing started Oct 04 15:56:55 tinypilot launch[1194]: -- INFO [2280.486 stream] -- Using JPEG quality: 80% Oct 04 15:56:55 tinypilot launch[1194]: -- INFO [2280.486 stream] -- Creating pool JPEG with 3 workers ... Oct 04 15:56:55 tinypilot launch[1194]: -- INFO [2280.487 stream] -- Capturing ... Oct 04 15:56:55 tinypilot launch[1194]: -- INFO [2280.491 stream] -- H264: Configuring encoder: DMA=1 ... Oct 04 15:56:56 tinypilot launch[1194]: -- INFO [2282.360 stream] -- Got V4L2 event Oct 04 15:56:56 tinypilot launch[1194]: -- INFO [2282.360 stream] -- Got V4L2_EVENT_SOURCE_CHANGE: source changed Oct 04 15:56:56 tinypilot launch[1194]: -- INFO [2282.361 stream] -- Destroying workers pool JPEG ... Oct 04 15:56:57 tinypilot launch[1194]: -- INFO [2282.421 stream] -- Capturing stopped Oct 04 15:56:57 tinypilot launch[1194]: -- INFO [2282.423 stream] -- Device fd=10 closed Oct 04 15:56:57 tinypilot launch[1194]: -- INFO [2282.423 stream] -- Changed video frame to BLANK Oct 04 15:56:57 tinypilot launch[1194]: -- INFO [2282.431 stream] -- H264: Configuring encoder: DMA=0 ... Oct 04 15:56:57 tinypilot launch[1194]: ================================================================================ Oct 04 15:56:57 tinypilot launch[1194]: -- INFO [2282.464 stream] -- Device fd=10 opened Oct 04 15:56:57 tinypilot launch[1194]: -- INFO [2282.464 stream] -- Using input channel: 0 Oct 04 15:56:57 tinypilot launch[1194]: -- ERROR [2282.509 stream] -- Requested resolution=640x480 is unavailable Oct 04 15:56:57 tinypilot launch[1194]: -- INFO [2282.553 stream] -- Using resolution: 16x16 Oct 04 15:56:57 tinypilot launch[1194]: -- INFO [2282.553 stream] -- Using format: UYVY Oct 04 15:56:57 tinypilot launch[1194]: -- INFO [2282.553 stream] -- Querying HW FPS changing is not supported Oct 04 15:56:57 tinypilot launch[1194]: -- INFO [2282.553 stream] -- Using IO method: MMAP Oct 04 15:56:57 tinypilot launch[1194]: -- INFO [2282.554 stream] -- Requested 5 device buffers, got 5 Oct 04 15:56:57 tinypilot launch[1194]: -- INFO [2282.565 stream] -- Capturing started Oct 04 15:56:57 tinypilot launch[1194]: -- INFO [2282.565 stream] -- Using JPEG quality: 80% Oct 04 15:56:57 tinypilot launch[1194]: -- INFO [2282.565 stream] -- Creating pool JPEG with 3 workers ... Oct 04 15:56:57 tinypilot launch[1194]: -- INFO [2282.566 stream] -- Capturing ... Oct 04 15:56:58 tinypilot launch[1194]: -- ERROR [2283.567 stream] -- Persistent device timeout (unplugged) Oct 04 15:57:00 tinypilot launch[1194]: -- INFO [2285.486 stream] -- Got V4L2 event Oct 04 15:57:00 tinypilot launch[1194]: -- INFO [2285.486 stream] -- Got V4L2_EVENT_SOURCE_CHANGE: source changed Oct 04 15:57:00 tinypilot launch[1194]: -- INFO [2285.486 stream] -- Destroying workers pool JPEG ... Oct 04 15:57:00 tinypilot launch[1194]: -- INFO [2285.554 stream] -- Capturing stopped Oct 04 15:57:00 tinypilot launch[1194]: -- INFO [2285.555 stream] -- Device fd=10 closed Oct 04 15:57:00 tinypilot launch[1194]: ================================================================================ Oct 04 15:57:00 tinypilot launch[1194]: -- INFO [2285.572 stream] -- Device fd=10 opened Oct 04 15:57:00 tinypilot launch[1194]: -- INFO [2285.573 stream] -- Using input channel: 0 Oct 04 15:57:00 tinypilot launch[1194]: -- INFO [2285.588 stream] -- Got new DV-timings: 640x416p70.00, pixclk=25144000, vsync=33, hsync=160 Oct 04 15:57:00 tinypilot launch[1194]: -- INFO [2285.665 stream] -- Using resolution: 640x416 Oct 04 15:57:00 tinypilot launch[1194]: -- INFO [2285.665 stream] -- Using format: UYVY Oct 04 15:57:00 tinypilot launch[1194]: -- INFO [2285.665 stream] -- Querying HW FPS changing is not supported Oct 04 15:57:00 tinypilot launch[1194]: -- INFO [2285.665 stream] -- Using IO method: MMAP Oct 04 15:57:00 tinypilot launch[1194]: -- INFO [2285.671 stream] -- Requested 5 device buffers, got 5 Oct 04 15:57:00 tinypilot launch[1194]: -- INFO [2285.681 stream] -- Capturing started Oct 04 15:57:00 tinypilot launch[1194]: -- INFO [2285.681 stream] -- Using JPEG quality: 80% Oct 04 15:57:00 tinypilot launch[1194]: -- INFO [2285.681 stream] -- Creating pool JPEG with 3 workers ... Oct 04 15:57:00 tinypilot launch[1194]: -- INFO [2285.682 stream] -- Capturing ... Oct 04 15:57:00 tinypilot launch[1194]: -- INFO [2285.688 stream] -- H264: Configuring encoder: DMA=1 ... Oct 04 15:57:02 tinypilot launch[1194]: -- INFO [2287.561 stream] -- Got V4L2 event Oct 04 15:57:02 tinypilot launch[1194]: -- INFO [2287.561 stream] -- Got V4L2_EVENT_SOURCE_CHANGE: source changed Oct 04 15:57:02 tinypilot launch[1194]: -- INFO [2287.561 stream] -- Destroying workers pool JPEG ... Oct 04 15:57:02 tinypilot launch[1194]: -- INFO [2287.621 stream] -- Capturing stopped Oct 04 15:57:02 tinypilot launch[1194]: -- INFO [2287.623 stream] -- Device fd=10 closed Oct 04 15:57:02 tinypilot launch[1194]: -- INFO [2287.623 stream] -- Changed video frame to BLANK Oct 04 15:57:02 tinypilot launch[1194]: -- INFO [2287.631 stream] -- H264: Configuring encoder: DMA=0 ... Oct 04 15:57:02 tinypilot launch[1194]: ================================================================================ Oct 04 15:57:02 tinypilot launch[1194]: -- INFO [2287.661 stream] -- Device fd=10 opened Oct 04 15:57:02 tinypilot launch[1194]: -- INFO [2287.661 stream] -- Using input channel: 0 Oct 04 15:57:02 tinypilot launch[1194]: -- ERROR [2287.708 stream] -- Requested resolution=640x480 is unavailable Oct 04 15:57:02 tinypilot launch[1194]: -- INFO [2287.748 stream] -- Using resolution: 16x16 Oct 04 15:57:02 tinypilot launch[1194]: -- INFO [2287.748 stream] -- Using format: UYVY Oct 04 15:57:02 tinypilot launch[1194]: -- INFO [2287.748 stream] -- Querying HW FPS changing is not supported Oct 04 15:57:02 tinypilot launch[1194]: -- INFO [2287.748 stream] -- Using IO method: MMAP Oct 04 15:57:02 tinypilot launch[1194]: -- INFO [2287.749 stream] -- Requested 5 device buffers, got 5 Oct 04 15:57:02 tinypilot launch[1194]: -- INFO [2287.759 stream] -- Capturing started Oct 04 15:57:02 tinypilot launch[1194]: -- INFO [2287.759 stream] -- Using JPEG quality: 80% Oct 04 15:57:02 tinypilot launch[1194]: -- INFO [2287.759 stream] -- Creating pool JPEG with 3 workers ... Oct 04 15:57:02 tinypilot launch[1194]: -- INFO [2287.759 stream] -- Capturing ... Oct 04 15:57:03 tinypilot launch[1194]: -- ERROR [2288.760 stream] -- Persistent device timeout (unplugged) Oct 04 15:57:04 tinypilot launch[1194]: -- INFO [2289.634 stream] -- Got V4L2 event Oct 04 15:57:04 tinypilot launch[1194]: -- INFO [2289.634 stream] -- Got V4L2_EVENT_SOURCE_CHANGE: source changed Oct 04 15:57:04 tinypilot launch[1194]: -- INFO [2289.634 stream] -- Destroying workers pool JPEG ... Oct 04 15:57:04 tinypilot launch[1194]: -- INFO [2289.667 stream] -- Capturing stopped Oct 04 15:57:04 tinypilot launch[1194]: -- INFO [2289.668 stream] -- Device fd=10 closed Oct 04 15:57:04 tinypilot launch[1194]: ================================================================================ Oct 04 15:57:04 tinypilot launch[1194]: -- INFO [2289.675 stream] -- Device fd=10 opened Oct 04 15:57:04 tinypilot launch[1194]: -- INFO [2289.675 stream] -- Using input channel: 0 Oct 04 15:57:04 tinypilot launch[1194]: -- INFO [2289.682 stream] -- Got new DV-timings: 640x416p70.00, pixclk=25144000, vsync=33, hsync=160 nginx logs -- Journal begins at Wed 2023-10-04 15:18:44 BST, ends at Wed 2023-10-04 15:57:04 BST. -- Oct 04 15:18:48 tinypilot systemd[1]: Starting A high performance web server and a reverse proxy server... Oct 04 15:18:48 tinypilot systemd[1]: Started A high performance web server and a reverse proxy server. 2023/10/04 15:16:06 [error] 592#592: *3 connect() failed (111: Connection refused) while connecting to upstream, client: 192.168.1.163, server: tinypilot, request: "HEAD /stream HTTP/2.0", upstream: "http://127.0.0.1:48001/stream", host: "192.168.1.110", referrer: "https://192.168.1.110/" 2023/10/04 15:16:25 [error] 592#592: *3 connect() failed (111: Connection refused) while connecting to upstream, client: 192.168.1.163, server: tinypilot, request: "HEAD /stream HTTP/2.0", upstream: "http://127.0.0.1:48001/stream", host: "192.168.1.110", referrer: "https://192.168.1.110/" 2023/10/04 15:16:34 [error] 592#592: *3 connect() failed (111: Connection refused) while connecting to upstream, client: 192.168.1.163, server: tinypilot, request: "HEAD /stream HTTP/2.0", upstream: "http://127.0.0.1:48001/stream", host: "192.168.1.110", referrer: "https://192.168.1.110/" 2023/10/04 15:18:42 [error] 592#592: *3 upstream prematurely closed connection while reading response header from upstream, client: 192.168.1.163, server: tinypilot, request: "POST /api/restart HTTP/2.0", upstream: "http://127.0.0.1:48000/api/restart", host: "192.168.1.110", referrer: "https://192.168.1.110/" 2023/10/04 15:18:42 [error] 592#592: *3 recv() failed (104: Connection reset by peer) while reading response header from upstream, client: 192.168.1.163, server: tinypilot, request: "GET /stream?advance_headers=1 HTTP/2.0", subrequest: "/auth", upstream: "http://127.0.0.1:48000/api/auth", host: "192.168.1.110", referrer: "https://192.168.1.110/" 2023/10/04 15:18:42 [error] 592#592: *3 auth request unexpected status: 502 while sending response to client, client: 192.168.1.163, server: tinypilot, request: "GET /stream?advance_headers=1 HTTP/2.0", host: "192.168.1.110", referrer: "https://192.168.1.110/" 2023/10/04 15:23:17 [error] 545#545: *2 connect() failed (111: Connection refused) while connecting to upstream, client: 192.168.1.163, server: tinypilot, request: "HEAD /stream HTTP/2.0", upstream: "http://127.0.0.1:48001/stream", host: "192.168.1.110", referrer: "https://192.168.1.110/" 192.168.1.163 - - [04/Oct/2023:15:52:39 +0100] "GET /js/controllers.js HTTP/2.0" 200 18721 "https://192.168.1.110/" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/117.0.0.0 Safari/537.36" "-" 192.168.1.163 - - [04/Oct/2023:15:52:39 +0100] "GET /js/events.js HTTP/2.0" 200 1890 "https://192.168.1.110/" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/117.0.0.0 Safari/537.36" "-" 192.168.1.163 - - [04/Oct/2023:15:52:39 +0100] "GET /js/poll.js HTTP/2.0" 200 1958 "https://192.168.1.110/" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/117.0.0.0 Safari/537.36" "-" 192.168.1.163 - - [04/Oct/2023:15:52:39 +0100] "GET /js/updatelogs.js HTTP/2.0" 200 861 "https://192.168.1.110/" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/117.0.0.0 Safari/537.36" "-" 192.168.1.163 - - [04/Oct/2023:15:52:39 +0100] "GET /js/wake-on-lan.js HTTP/2.0" 200 551 "https://192.168.1.110/" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/117.0.0.0 Safari/537.36" "-" 192.168.1.163 - - [04/Oct/2023:15:52:39 +0100] "GET /js/logs.js HTTP/2.0" 200 1484 "https://192.168.1.110/" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/117.0.0.0 Safari/537.36" "-" 192.168.1.163 - - [04/Oct/2023:15:52:39 +0100] "GET /js/settings.js HTTP/2.0" 200 1900 "https://192.168.1.110/" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/117.0.0.0 Safari/537.36" "-" 192.168.1.163 - - [04/Oct/2023:15:52:39 +0100] "GET /js/clipboard.js HTTP/2.0" 200 889 "https://192.168.1.110/" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/117.0.0.0 Safari/537.36" "-" 192.168.1.163 - - [04/Oct/2023:15:52:39 +0100] "GET /js/mouse.js HTTP/2.0" 200 8492 "https://192.168.1.110/" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/117.0.0.0 Safari/537.36" "-" 192.168.1.163 - - [04/Oct/2023:15:52:39 +0100] "GET /third-party/fonts/overpass-light.woff2 HTTP/2.0" 200 26568 "https://192.168.1.110/third-party/fonts/fonts.css" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/117.0.0.0 Safari/537.36" "-" 192.168.1.163 - - [04/Oct/2023:15:52:39 +0100] "GET /js/keycodes.js HTTP/2.0" 200 3205 "https://192.168.1.110/js/app.js" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/117.0.0.0 Safari/537.36" "-" 192.168.1.163 - - [04/Oct/2023:15:52:39 +0100] "GET /js/keyboardstate.js HTTP/2.0" 200 3164 "https://192.168.1.110/js/app.js" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/117.0.0.0 Safari/537.36" "-" 192.168.1.163 - - [04/Oct/2023:15:52:39 +0100] "GET /js/keystrokes.js HTTP/2.0" 200 362 "https://192.168.1.110/js/app.js" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/117.0.0.0 Safari/537.36" "-" 192.168.1.163 - - [04/Oct/2023:15:52:39 +0100] "GET /js/overlays.js HTTP/2.0" 200 495 "https://192.168.1.110/js/app.js" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/117.0.0.0 Safari/537.36" "-" 192.168.1.163 - - [04/Oct/2023:15:52:39 +0100] "GET /css/icons.css HTTP/2.0" 200 841 "https://192.168.1.110/" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/117.0.0.0 Safari/537.36" "-" 192.168.1.163 - - [04/Oct/2023:15:52:39 +0100] "GET /css/toggle.css HTTP/2.0" 200 1005 "https://192.168.1.110/" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/117.0.0.0 Safari/537.36" "-" 192.168.1.163 - - [04/Oct/2023:15:52:39 +0100] "GET /img/logo.svg HTTP/2.0" 200 5550 "https://192.168.1.110/" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/117.0.0.0 Safari/537.36" "-" 192.168.1.163 - - [04/Oct/2023:15:52:39 +0100] "GET /third-party/fonts/overpass-mono-light.woff2 HTTP/2.0" 200 50112 "https://192.168.1.110/third-party/fonts/fonts.css" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/117.0.0.0 Safari/537.36" "-" 192.168.1.163 - - [04/Oct/2023:15:52:39 +0100] "GET /third-party/fonts/overpass-semibold.woff2 HTTP/2.0" 200 25032 "https://192.168.1.110/third-party/fonts/fonts.css" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/117.0.0.0 Safari/537.36" "-" 192.168.1.163 - - [04/Oct/2023:15:52:39 +0100] "GET /img/video-stream-icon.svg HTTP/2.0" 200 840 "https://192.168.1.110/" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/117.0.0.0 Safari/537.36" "-" 192.168.1.163 - - [04/Oct/2023:15:52:39 +0100] "GET /img/warning-icon.svg HTTP/2.0" 200 2177 "https://192.168.1.110/" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/117.0.0.0 Safari/537.36" "-" 192.168.1.163 - - [04/Oct/2023:15:52:39 +0100] "GET /img/clipboard-icon.svg HTTP/2.0" 200 855 "https://192.168.1.110/" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/117.0.0.0 Safari/537.36" "-" 192.168.1.163 - - [04/Oct/2023:15:52:39 +0100] "GET /img/angle-down-icon.svg HTTP/2.0" 200 516 "https://192.168.1.110/" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/117.0.0.0 Safari/537.36" "-" 192.168.1.163 - - [04/Oct/2023:15:52:39 +0100] "GET /img/external-link-icon.svg HTTP/2.0" 200 1223 "https://192.168.1.110/" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/117.0.0.0 Safari/537.36" "-" 192.168.1.163 - - [04/Oct/2023:15:52:39 +0100] "GET /socket.io/?EIO=4&transport=polling&t=OhxBJbt HTTP/2.0" 200 97 "https://192.168.1.110/" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/117.0.0.0 Safari/537.36" "-" 192.168.1.163 - - [04/Oct/2023:15:52:39 +0100] "POST /socket.io/?EIO=4&transport=polling&t=OhxBJc1&sid=U7gsPjf4YsZgOLvTAAAG HTTP/2.0" 200 2 "https://192.168.1.110/" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/117.0.0.0 Safari/537.36" "-" 192.168.1.163 - - [04/Oct/2023:15:52:39 +0100] "GET /socket.io/?EIO=4&transport=polling&t=OhxBJc2&sid=U7gsPjf4YsZgOLvTAAAG HTTP/2.0" 200 32 "https://192.168.1.110/" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/117.0.0.0 Safari/537.36" "-" 192.168.1.163 - - [04/Oct/2023:15:52:39 +0100] "GET /favicon.ico HTTP/2.0" 200 1213 "https://192.168.1.110/" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/117.0.0.0 Safari/537.36" "-" 192.168.1.163 - - [04/Oct/2023:15:52:39 +0100] "GET /socket.io/?EIO=4&transport=polling&t=OhxBJcB&sid=U7gsPjf4YsZgOLvTAAAG HTTP/2.0" 200 1 "https://192.168.1.110/" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/117.0.0.0 Safari/537.36" "-" 192.168.1.163 - - [04/Oct/2023:15:52:48 +0100] "GET /api/debugLogs HTTP/2.0" 200 31794 "https://192.168.1.110/" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/117.0.0.0 Safari/537.36" "-"