TinyPilot Pro log dump https://tinypilotkvm.com Timestamp: 2022-11-10T21:52:16+00:00 Software versions TinyPilot version: 2.5.0 uStreamer version: v4.13 61ab2a8 OS version: Linux tinypilot 5.10.103-v7l+ #1529 SMP Tue Mar 8 12:24:00 GMT 2022 armv7l GNU/Linux TinyPilot state temp=37.9'C throttled=0x0 voltage logs TinyPilot configuration [Unit] Description=TinyPilot - RPi-based virtual KVM After=syslog.target network.target StartLimitIntervalSec=0 [Service] Type=simple User=tinypilot WorkingDirectory=/opt/tinypilot ExecStart=/opt/tinypilot/venv/bin/python app/main.py Environment=HOST=127.0.0.1 Environment=PORT=8000 Environment=APP_SETTINGS_FILE=/home/tinypilot/app_settings.cfg Restart=always [Install] WantedBy=multi-user.target TinyPilot logs -- Logs begin at Mon 2022-04-04 14:54:35 BST, end at Thu 2022-11-10 21:52:16 GMT. -- Apr 04 14:55:10 tinypilot systemd[1]: Started TinyPilot - RPi-based virtual KVM. Apr 04 14:55:11 tinypilot python[750]: 2022-04-04 14:55:11.938 __main__ INFO Starting app Apr 04 14:55:11 tinypilot python[750]: 2022-04-04 14:55:11.943 secret_key INFO No flask secret key found Apr 04 14:55:11 tinypilot python[750]: 2022-04-04 14:55:11.944 secret_key INFO Creating new flask secret key at /home/tinypilot/.flask-secret-key Nov 10 21:52:04 tinypilot python[750]: 2022-11-10 21:52:04.565 db.store INFO Migration counter: 0/5 (actual/total) Nov 10 21:52:04 tinypilot python[750]: 2022-11-10 21:52:04.614 db.store INFO Applied migration, counter is now at 1 Nov 10 21:52:04 tinypilot python[750]: 2022-11-10 21:52:04.651 db.store INFO Applied migration, counter is now at 2 Nov 10 21:52:04 tinypilot python[750]: 2022-11-10 21:52:04.688 db.store INFO Applied migration, counter is now at 3 Nov 10 21:52:04 tinypilot python[750]: 2022-11-10 21:52:04.726 db.store INFO Applied migration, counter is now at 4 Nov 10 21:52:04 tinypilot python[750]: 2022-11-10 21:52:04.750 db.store INFO Applied migration, counter is now at 5 Nov 10 21:52:05 tinypilot python[750]: 2022-11-10 21:52:05.293 socket_api INFO Client lQGAHRNnzbUi6VCjAAAB connected Nov 10 21:52:06 tinypilot python[750]: Process ProcessWithResult-1: Nov 10 21:52:06 tinypilot python[750]: Traceback (most recent call last): Nov 10 21:52:06 tinypilot python[750]: File "/usr/lib/python3.7/multiprocessing/process.py", line 297, in _bootstrap Nov 10 21:52:06 tinypilot python[750]: self.run() Nov 10 21:52:06 tinypilot python[750]: File "/opt/tinypilot/app/hid/write.py", line 45, in run Nov 10 21:52:06 tinypilot python[750]: result.return_value = self._target(*self._args, **self._kwargs) Nov 10 21:52:06 tinypilot python[750]: File "/opt/tinypilot/app/hid/write.py", line 65, in _write_to_hid_interface_immediately Nov 10 21:52:06 tinypilot python[750]: hid_handle.write(bytearray(buffer)) Nov 10 21:52:06 tinypilot python[750]: BrokenPipeError: [Errno 108] Cannot send after transport endpoint shutdown Nov 10 21:52:06 tinypilot python[750]: 2022-11-10 21:52:06.609 socket_api ERROR [SENSITIVE] Failed to forward mouse event: Failed to write to HID interface: /dev/hidg1. Is USB cable connected? [/SENSITIVE] Nov 10 21:52:07 tinypilot python[750]: Process ProcessWithResult-2: Nov 10 21:52:07 tinypilot python[750]: Traceback (most recent call last): Nov 10 21:52:07 tinypilot python[750]: File "/usr/lib/python3.7/multiprocessing/process.py", line 297, in _bootstrap Nov 10 21:52:07 tinypilot python[750]: self.run() Nov 10 21:52:07 tinypilot python[750]: File "/opt/tinypilot/app/hid/write.py", line 45, in run Nov 10 21:52:07 tinypilot python[750]: result.return_value = self._target(*self._args, **self._kwargs) Nov 10 21:52:07 tinypilot python[750]: File "/opt/tinypilot/app/hid/write.py", line 65, in _write_to_hid_interface_immediately Nov 10 21:52:07 tinypilot python[750]: hid_handle.write(bytearray(buffer)) Nov 10 21:52:07 tinypilot python[750]: BrokenPipeError: [Errno 108] Cannot send after transport endpoint shutdown Nov 10 21:52:07 tinypilot python[750]: 2022-11-10 21:52:07.196 socket_api ERROR [SENSITIVE] Failed to forward mouse event: Failed to write to HID interface: /dev/hidg1. Is USB cable connected? [/SENSITIVE] Nov 10 21:52:09 tinypilot python[750]: Process ProcessWithResult-3: Nov 10 21:52:09 tinypilot python[750]: Traceback (most recent call last): Nov 10 21:52:09 tinypilot python[750]: File "/usr/lib/python3.7/multiprocessing/process.py", line 297, in _bootstrap Nov 10 21:52:09 tinypilot python[750]: self.run() Nov 10 21:52:09 tinypilot python[750]: File "/opt/tinypilot/app/hid/write.py", line 45, in run Nov 10 21:52:09 tinypilot python[750]: result.return_value = self._target(*self._args, **self._kwargs) Nov 10 21:52:09 tinypilot python[750]: File "/opt/tinypilot/app/hid/write.py", line 65, in _write_to_hid_interface_immediately Nov 10 21:52:09 tinypilot python[750]: hid_handle.write(bytearray(buffer)) Nov 10 21:52:09 tinypilot python[750]: BrokenPipeError: [Errno 108] Cannot send after transport endpoint shutdown Nov 10 21:52:09 tinypilot python[750]: 2022-11-10 21:52:09.101 socket_api ERROR [SENSITIVE] Failed to write key: F1 (keycode=F1). Failed to write to HID interface: /dev/hidg0. Is USB cable connected? [/SENSITIVE] Nov 10 21:52:14 tinypilot python[750]: Process ProcessWithResult-4: Nov 10 21:52:14 tinypilot python[750]: Traceback (most recent call last): Nov 10 21:52:14 tinypilot python[750]: File "/usr/lib/python3.7/multiprocessing/process.py", line 297, in _bootstrap Nov 10 21:52:14 tinypilot python[750]: self.run() Nov 10 21:52:14 tinypilot python[750]: File "/opt/tinypilot/app/hid/write.py", line 45, in run Nov 10 21:52:14 tinypilot python[750]: result.return_value = self._target(*self._args, **self._kwargs) Nov 10 21:52:14 tinypilot python[750]: File "/opt/tinypilot/app/hid/write.py", line 65, in _write_to_hid_interface_immediately Nov 10 21:52:14 tinypilot python[750]: hid_handle.write(bytearray(buffer)) Nov 10 21:52:14 tinypilot python[750]: BrokenPipeError: [Errno 108] Cannot send after transport endpoint shutdown Nov 10 21:52:14 tinypilot python[750]: 2022-11-10 21:52:14.945 socket_api ERROR [SENSITIVE] Failed to forward mouse event: Failed to write to HID interface: /dev/hidg1. Is USB cable connected? [/SENSITIVE] Nov 10 21:52:16 tinypilot python[750]: Process ProcessWithResult-5: Nov 10 21:52:16 tinypilot python[750]: Traceback (most recent call last): Nov 10 21:52:16 tinypilot python[750]: File "/usr/lib/python3.7/multiprocessing/process.py", line 297, in _bootstrap Nov 10 21:52:16 tinypilot python[750]: self.run() Nov 10 21:52:16 tinypilot python[750]: File "/opt/tinypilot/app/hid/write.py", line 45, in run Nov 10 21:52:16 tinypilot python[750]: result.return_value = self._target(*self._args, **self._kwargs) Nov 10 21:52:16 tinypilot python[750]: File "/opt/tinypilot/app/hid/write.py", line 65, in _write_to_hid_interface_immediately Nov 10 21:52:16 tinypilot python[750]: hid_handle.write(bytearray(buffer)) Nov 10 21:52:16 tinypilot python[750]: BrokenPipeError: [Errno 108] Cannot send after transport endpoint shutdown Nov 10 21:52:16 tinypilot python[750]: 2022-11-10 21:52:16.544 socket_api ERROR [SENSITIVE] Failed to forward mouse event: Failed to write to HID interface: /dev/hidg1. Is USB cable connected? [/SENSITIVE] Nov 10 21:52:16 tinypilot sudo[1318]: tinypilot : TTY=unknown ; PWD=/opt/tinypilot ; USER=root ; COMMAND=/opt/tinypilot-privileged/collect-debug-logs -q Nov 10 21:52:16 tinypilot sudo[1318]: pam_unix(sudo:session): session opened for user root by (uid=0) TinyPilot update logs uStreamer configuration [Unit] Description=uStreamer - Lightweight, optimized video encoder After=syslog.target network.target [Service] Type=simple User=ustreamer WorkingDirectory=/opt/ustreamer ExecStart=/opt/ustreamer/ustreamer \ --host 127.0.0.1 \ --port 8001 \ --encoder omx \ --format uyvy \ --workers 3 \ --drop-same-frames 30 \ --persistent \ --dv-timings \ && : # This last line is just to end the multi-line command because the line # before is ending with backslash and so expects to be continued. Restart=always [Install] WantedBy=multi-user.target uStreamer logs -- Logs begin at Mon 2022-04-04 14:54:35 BST, end at Thu 2022-11-10 21:52:16 GMT. -- Apr 04 14:55:10 tinypilot systemd[1]: Started uStreamer - Lightweight, optimized video encoder. Apr 04 14:55:10 tinypilot ustreamer[748]: -- INFO [38.573 main] -- Using internal blank placeholder Apr 04 14:55:10 tinypilot ustreamer[748]: -- INFO [38.576 main] -- Listening HTTP on [127.0.0.1]:8001 Apr 04 14:55:10 tinypilot ustreamer[748]: -- INFO [38.577 stream] -- Using V4L2 device: /dev/video0 Apr 04 14:55:10 tinypilot ustreamer[748]: -- INFO [38.577 stream] -- Using desired FPS: 0 Apr 04 14:55:10 tinypilot ustreamer[748]: ================================================================================ Apr 04 14:55:10 tinypilot ustreamer[748]: -- INFO [38.577 http] -- Starting HTTP eventloop ... Apr 04 14:55:10 tinypilot ustreamer[748]: -- INFO [38.577 stream] -- Device fd=9 opened Apr 04 14:55:10 tinypilot ustreamer[748]: -- INFO [38.577 stream] -- Using input channel: 0 Apr 04 14:55:10 tinypilot ustreamer[748]: -- INFO [38.600 stream] -- Using resolution: 640x480 Apr 04 14:55:10 tinypilot ustreamer[748]: -- INFO [38.600 stream] -- Using pixelformat: UYVY Apr 04 14:55:10 tinypilot ustreamer[748]: -- INFO [38.600 stream] -- Querying HW FPS changing is not supported Apr 04 14:55:10 tinypilot ustreamer[748]: -- INFO [38.600 stream] -- Using IO method: MMAP Apr 04 14:55:10 tinypilot ustreamer[748]: -- INFO [38.604 stream] -- Requested 5 device buffers, got 5 Apr 04 14:55:10 tinypilot ustreamer[748]: -- INFO [38.611 stream] -- Capturing started Apr 04 14:55:10 tinypilot ustreamer[748]: -- INFO [38.611 stream] -- Initializing OMX encoder ... Apr 04 14:55:10 tinypilot ustreamer[748]: -- INFO [38.613 stream] -- Initializing OMX encoder ... Apr 04 14:55:10 tinypilot ustreamer[748]: -- INFO [38.615 stream] -- Initializing OMX encoder ... Apr 04 14:55:10 tinypilot ustreamer[748]: -- INFO [38.626 stream] -- Using JPEG quality: 80% Apr 04 14:55:10 tinypilot ustreamer[748]: -- INFO [38.626 stream] -- Creating pool JPEG with 3 workers ... Apr 04 14:55:10 tinypilot ustreamer[748]: -- INFO [38.626 stream] -- Capturing ... Apr 04 14:55:11 tinypilot ustreamer[748]: -- ERROR [39.627 stream] -- Persistent device timeout (unplugged) Nov 10 21:52:05 tinypilot ustreamer[748]: -- INFO [158.820 http] -- HTTP: Registered client: [2603:8000:7600:c404:14e6:9d7b:424b:7ef6]:34826, id=6f2db5ed58c39019; clients now: 1 nginx logs -- Logs begin at Mon 2022-04-04 14:54:35 BST, end at Thu 2022-11-10 21:52:16 GMT. -- Nov 10 21:50:50 tinypilot systemd[1]: Starting A high performance web server and a reverse proxy server... Nov 10 21:50:50 tinypilot systemd[1]: Started A high performance web server and a reverse proxy server.