-- Logs begin at Sun 2023-12-03 00:50:19 UTC, end at Sat 2025-01-18 13:42:36 UTC. -- Jan 18 13:41:03 volumio volumio[2012]: Traceback (most recent call last): Jan 18 13:41:03 volumio volumio[2012]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 13, in Jan 18 13:41:03 volumio volumio[2012]: import ST7789 # v0.0.6 Jan 18 13:41:03 volumio volumio[2012]: ModuleNotFoundError: No module named 'ST7789' Jan 18 13:41:04 volumio systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Jan 18 13:41:04 volumio systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Jan 18 13:41:04 volumio systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Jan 18 13:41:04 volumio systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 8. Jan 18 13:41:04 volumio systemd[1]: Stopped Service for using pirate audio display in volumio. Jan 18 13:41:04 volumio systemd[1]: Started Service for using pirate audio display in volumio. Jan 18 13:41:05 volumio volumio-remote-updater[554]: [2025-01-18 13:41:05] [connect] Successful connection Jan 18 13:41:09 volumio volumio[2118]: Traceback (most recent call last): Jan 18 13:41:09 volumio volumio[2118]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 13, in Jan 18 13:41:09 volumio volumio[2118]: import ST7789 # v0.0.6 Jan 18 13:41:09 volumio volumio[2118]: ModuleNotFoundError: No module named 'ST7789' Jan 18 13:41:09 volumio systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Jan 18 13:41:09 volumio systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Jan 18 13:41:10 volumio systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Jan 18 13:41:10 volumio systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 9. Jan 18 13:41:10 volumio systemd[1]: Stopped Service for using pirate audio display in volumio. Jan 18 13:41:10 volumio systemd[1]: Started Service for using pirate audio display in volumio. Jan 18 13:41:11 volumio volumio[951]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jan 18 13:41:12 volumio volumio[2296]: Traceback (most recent call last): Jan 18 13:41:12 volumio volumio[2296]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 13, in Jan 18 13:41:12 volumio volumio[2296]: import ST7789 # v0.0.6 Jan 18 13:41:12 volumio volumio[2296]: ModuleNotFoundError: No module named 'ST7789' Jan 18 13:41:11 volumio systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Jan 18 13:41:12 volumio volumio[951]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jan 18 13:41:11 volumio systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Jan 18 13:41:12 volumio systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Jan 18 13:41:12 volumio systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 10. Jan 18 13:41:12 volumio systemd[1]: Stopped Service for using pirate audio display in volumio. Jan 18 13:41:12 volumio systemd[1]: Started Service for using pirate audio display in volumio. Jan 18 13:41:12 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 13:41:12 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 13:41:12 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 13:41:12 volumio volumio[951]: info: Starting MyVolumio Remote Streaming Endpoints Jan 18 13:41:12 volumio volumio[951]: info: MyVolumio login type: Token Jan 18 13:41:13 volumio volumio[951]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jan 18 13:41:13 volumio volumio[951]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jan 18 13:41:13 volumio volumio[2341]: Traceback (most recent call last): Jan 18 13:41:13 volumio volumio[2341]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 13, in Jan 18 13:41:13 volumio volumio[2341]: import ST7789 # v0.0.6 Jan 18 13:41:13 volumio volumio[2341]: ModuleNotFoundError: No module named 'ST7789' Jan 18 13:41:13 volumio systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Jan 18 13:41:13 volumio systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Jan 18 13:41:13 volumio systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Jan 18 13:41:13 volumio systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 11. Jan 18 13:41:13 volumio systemd[1]: Stopped Service for using pirate audio display in volumio. Jan 18 13:41:14 volumio systemd[1]: Started Service for using pirate audio display in volumio. Jan 18 13:41:15 volumio volumio[2359]: Traceback (most recent call last): Jan 18 13:41:15 volumio volumio[2359]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 13, in Jan 18 13:41:15 volumio volumio[2359]: import ST7789 # v0.0.6 Jan 18 13:41:15 volumio volumio[2359]: ModuleNotFoundError: No module named 'ST7789' Jan 18 13:41:15 volumio systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Jan 18 13:41:15 volumio systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Jan 18 13:41:15 volumio systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Jan 18 13:41:15 volumio systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 12. Jan 18 13:41:15 volumio systemd[1]: Stopped Service for using pirate audio display in volumio. Jan 18 13:41:15 volumio systemd[1]: Started Service for using pirate audio display in volumio. Jan 18 13:41:16 volumio volumio[2360]: Traceback (most recent call last): Jan 18 13:41:16 volumio volumio[2360]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 13, in Jan 18 13:41:16 volumio volumio[2360]: import ST7789 # v0.0.6 Jan 18 13:41:16 volumio volumio[2360]: ModuleNotFoundError: No module named 'ST7789' Jan 18 13:41:17 volumio systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Jan 18 13:41:17 volumio systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Jan 18 13:41:17 volumio volumio[1309]: ...........................................................................++++ Jan 18 13:41:17 volumio volumio[1309]: e is 65537 (0x010001) Jan 18 13:41:17 volumio systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Jan 18 13:41:17 volumio systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 13. Jan 18 13:41:17 volumio systemd[1]: Stopped Service for using pirate audio display in volumio. Jan 18 13:41:17 volumio systemd[1]: Started Service for using pirate audio display in volumio. Jan 18 13:41:17 volumio volumio[1309]: writing RSA key Jan 18 13:41:19 volumio volumio[2361]: Traceback (most recent call last): Jan 18 13:41:19 volumio volumio[2361]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 13, in Jan 18 13:41:19 volumio volumio[2361]: import ST7789 # v0.0.6 Jan 18 13:41:19 volumio volumio[2361]: ModuleNotFoundError: No module named 'ST7789' Jan 18 13:41:19 volumio systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Jan 18 13:41:19 volumio systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Jan 18 13:41:19 volumio systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Jan 18 13:41:19 volumio systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 14. Jan 18 13:41:19 volumio systemd[1]: Stopped Service for using pirate audio display in volumio. Jan 18 13:41:19 volumio systemd[1]: Started Service for using pirate audio display in volumio. Jan 18 13:41:20 volumio volumio[951]: info: Starting Streaming Service Transparent Proxy Jan 18 13:41:20 volumio volumio[951]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jan 18 13:41:20 volumio volumio[951]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jan 18 13:41:20 volumio volumio[951]: info: Streaming services startup Jan 18 13:41:20 volumio volumio[951]: info: Starting Streaming Daemon Jan 18 13:41:20 volumio volumio-remote-updater[554]: [2025-01-18 13:41:20] [connect] Successful connection Jan 18 13:41:20 volumio volumio[951]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Jan 18 13:41:20 volumio sudo[2380]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jan 18 13:41:20 volumio sudo[2380]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 13:41:20 volumio volumio[951]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Jan 18 13:41:20 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 13:41:20 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 18 13:41:20 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 13:41:20 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 18 13:41:21 volumio sudo[2380]: pam_unix(sudo:session): session closed for user root Jan 18 13:41:21 volumio volumio[951]: Upnp client error: Error: This socket has been ended by the other party Jan 18 13:41:21 volumio volumio[951]: verbose: New Socket.io Connection to 192.168.1.173:3000 from 192.168.1.240 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 1 Jan 18 13:41:21 volumio volumio[2377]: Traceback (most recent call last): Jan 18 13:41:21 volumio volumio[2377]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 13, in Jan 18 13:41:21 volumio volumio[2377]: import ST7789 # v0.0.6 Jan 18 13:41:21 volumio volumio[2377]: ModuleNotFoundError: No module named 'ST7789' Jan 18 13:41:22 volumio volumio[951]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 4 Jan 18 13:41:22 volumio volumio-remote-updater[554]: [2025-01-18 13:41:22] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1737207680 101 Jan 18 13:41:22 volumio volumio[951]: error: Cannot start Volumio Streaming Daemon Jan 18 13:41:22 volumio volumio[951]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jan 18 13:41:22 volumio volumio[951]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jan 18 13:41:22 volumio systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Jan 18 13:41:22 volumio systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Jan 18 13:41:22 volumio volumio[951]: info: camilladsp spawned new process with pid 2394, instance 1, run: true Jan 18 13:41:22 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 18 13:41:22 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 18 13:41:22 volumio volumio[951]: info: Discovery: Getting this device information Jan 18 13:41:22 volumio volumio[951]: info: CoreCommandRouter::volumioGetState Jan 18 13:41:22 volumio volumio[951]: info: CorePlayQueue::getTrack 3 Jan 18 13:41:22 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 18 13:41:22 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 18 13:41:22 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 18 13:41:22 volumio volumio[951]: info: Discovery: Getting this device information Jan 18 13:41:22 volumio volumio[951]: info: CoreCommandRouter::volumioGetState Jan 18 13:41:22 volumio volumio[951]: info: CorePlayQueue::getTrack 3 Jan 18 13:41:22 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 18 13:41:22 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 18 13:41:22 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 18 13:41:22 volumio volumio[951]: info: Discovery: Getting this device information Jan 18 13:41:22 volumio volumio[951]: info: CoreCommandRouter::volumioGetState Jan 18 13:41:22 volumio volumio[951]: info: CorePlayQueue::getTrack 3 Jan 18 13:41:22 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 18 13:41:22 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 18 13:41:22 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 18 13:41:22 volumio volumio[951]: info: Discovery: Getting this device information Jan 18 13:41:22 volumio volumio[951]: info: CoreCommandRouter::volumioGetState Jan 18 13:41:22 volumio volumio[951]: info: CorePlayQueue::getTrack 3 Jan 18 13:41:22 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 18 13:41:22 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 18 13:41:22 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 18 13:41:22 volumio volumio[951]: info: Discovery: Getting this device information Jan 18 13:41:22 volumio volumio[951]: info: CoreCommandRouter::volumioGetState Jan 18 13:41:22 volumio volumio[951]: info: CorePlayQueue::getTrack 3 Jan 18 13:41:22 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 18 13:41:22 volumio volumio[951]: Upnp client error: Error: This socket has been ended by the other party Jan 18 13:41:22 volumio volumio[951]: Upnp client error: Error: This socket has been ended by the other party Jan 18 13:41:22 volumio volumio[951]: Upnp client error: Error: This socket has been ended by the other party Jan 18 13:41:22 volumio volumio[951]: Upnp client error: Error: This socket has been ended by the other party Jan 18 13:41:22 volumio volumio[951]: Upnp client error: Error: This socket has been ended by the other party Jan 18 13:41:22 volumio volumio[951]: Upnp client error: Error: This socket has been ended by the other party Jan 18 13:41:22 volumio volumio[951]: Upnp client error: Error: This socket has been ended by the other party Jan 18 13:41:22 volumio volumio[951]: Upnp client error: Error: This socket has been ended by the other party Jan 18 13:41:22 volumio volumio[951]: Upnp client error: Error: This socket has been ended by the other party Jan 18 13:41:22 volumio volumio[951]: Upnp client error: Error: This socket has been ended by the other party Jan 18 13:41:22 volumio volumio[951]: Upnp client error: Error: This socket has been ended by the other party Jan 18 13:41:22 volumio volumio[951]: Upnp client error: Error: This socket has been ended by the other party Jan 18 13:41:22 volumio volumio[951]: Upnp client error: Error: This socket has been ended by the other party Jan 18 13:41:22 volumio volumio[951]: Upnp client error: Error: This socket has been ended by the other party Jan 18 13:41:22 volumio systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Jan 18 13:41:22 volumio systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 15. Jan 18 13:41:22 volumio systemd[1]: Stopped Service for using pirate audio display in volumio. Jan 18 13:41:22 volumio systemd[1]: Started Service for using pirate audio display in volumio. Jan 18 13:41:22 volumio mpd_monitor.sh[520]: MPD error: Connection closed by the server Jan 18 13:41:23 volumio volumio[951]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Jan 18 13:41:23 volumio systemd[1]: Stopping Music Player Daemon... Jan 18 13:41:23 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Jan 18 13:41:23 volumio volumio[951]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Jan 18 13:41:23 volumio volumio[951]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Jan 18 13:41:23 volumio volumio-remote-updater[554]: No test mode Jan 18 13:41:23 volumio volumio-remote-updater[554]: No alpha test mode Jan 18 13:41:23 volumio volumio[951]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Jan 18 13:41:23 volumio volumio[951]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Jan 18 13:41:27 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 18 13:41:27 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 18 13:41:27 volumio volumio[951]: info: Discovery: Getting this device information Jan 18 13:41:27 volumio volumio[951]: info: CoreCommandRouter::volumioGetState Jan 18 13:41:27 volumio volumio[951]: info: CorePlayQueue::getTrack 3 Jan 18 13:41:27 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 18 13:41:27 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 18 13:41:27 volumio volumio[951]: info: MyVolumio token set successfully Jan 18 13:41:27 volumio volumio[951]: info: MYVOLUMIO: Adding device Jan 18 13:41:27 volumio volumio[951]: info: MYVOLUMIO: Evaluating Server Jan 18 13:41:27 volumio volumio[951]: verbose: New Socket.io Connection to 192.168.1.173:3000 from 192.168.1.240 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8 Jan 18 13:41:27 volumio volumio[951]: info: camilladsp spawned new process with pid 2423, instance 1, run: true Jan 18 13:41:27 volumio volumio[951]: info: CoreCommandRouter::volumioGetState Jan 18 13:41:27 volumio volumio[951]: info: CorePlayQueue::getTrack 3 Jan 18 13:41:27 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 18 13:41:27 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 18 13:41:28 volumio volumio[951]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Jan 18 13:41:28 volumio volumio[2397]: Traceback (most recent call last): Jan 18 13:41:28 volumio volumio[2397]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 13, in Jan 18 13:41:28 volumio volumio[2397]: import ST7789 # v0.0.6 Jan 18 13:41:28 volumio volumio[2397]: ModuleNotFoundError: No module named 'ST7789' Jan 18 13:41:28 volumio systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Jan 18 13:41:28 volumio systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Jan 18 13:41:28 volumio systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Jan 18 13:41:28 volumio systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 16. Jan 18 13:41:28 volumio systemd[1]: Stopped Service for using pirate audio display in volumio. Jan 18 13:41:29 volumio systemd[1]: Started Service for using pirate audio display in volumio. Jan 18 13:41:29 volumio volumio[951]: info: MyVolumio status changed Jan 18 13:41:29 volumio volumio[951]: info: Streaming services startup Jan 18 13:41:29 volumio volumio[951]: info: Starting Streaming Daemon Jan 18 13:41:29 volumio volumio[951]: info: Removing browser output: myVolumio user plan is not superstar Jan 18 13:41:29 volumio volumio[951]: info: Removing audio output: Jan 18 13:41:29 volumio volumio[951]: info: Stoppping Tunnel 1 Jan 18 13:41:29 volumio volumio[951]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Jan 18 13:41:29 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jan 18 13:41:29 volumio volumio[951]: info: CoreCommandRouter::volumioGetState Jan 18 13:41:29 volumio volumio[951]: info: CorePlayQueue::getTrack 3 Jan 18 13:41:29 volumio volumio[951]: info: Setting Geolocation for MyVolumio to as1 Jan 18 13:41:29 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 13:41:29 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 13:41:29 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 13:41:29 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 13:41:29 volumio volumio[951]: info: camilladsp spawned new process with pid 2451, instance 1, run: true Jan 18 13:41:29 volumio volumio[951]: info: CoreCommandRouter::volumioGetState Jan 18 13:41:29 volumio sudo[2447]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jan 18 13:41:29 volumio volumio[951]: info: CorePlayQueue::getTrack 3 Jan 18 13:41:29 volumio sudo[2449]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Jan 18 13:41:29 volumio sudo[2447]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 13:41:29 volumio sudo[2449]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 13:41:30 volumio volumio[951]: info: camilladsp spawned new process with pid 2460, instance 1, run: true Jan 18 13:41:30 volumio sudo[2447]: pam_unix(sudo:session): session closed for user root Jan 18 13:41:30 volumio volumio[951]: error: Cannot start Volumio Streaming Daemon Jan 18 13:41:30 volumio volumio[951]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jan 18 13:41:30 volumio volumio[951]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jan 18 13:41:30 volumio sudo[2449]: pam_unix(sudo:session): session closed for user root Jan 18 13:41:30 volumio volumio[951]: info: Remote SSH Stopped Jan 18 13:41:30 volumio volumio[951]: info: Updating MyVolumio device info Jan 18 13:41:30 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 13:41:30 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 13:41:30 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 13:41:30 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 13:41:30 volumio volumio[951]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Jan 18 13:41:30 volumio volumio[951]: info: camilladsp spawned new process with pid 2471, instance 1, run: true Jan 18 13:41:30 volumio sudo[2468]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 18 13:41:30 volumio sudo[2468]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 13:41:30 volumio sudo[2470]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 18 13:41:30 volumio sudo[2470]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 13:41:30 volumio sudo[2470]: pam_unix(sudo:session): session closed for user root Jan 18 13:41:31 volumio volumio[951]: info: camilladsp spawned new process with pid 2481, instance 1, run: true Jan 18 13:41:31 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 18 13:41:31 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 18 13:41:31 volumio volumio[951]: info: Discovery: Getting this device information Jan 18 13:41:31 volumio volumio[951]: info: CoreCommandRouter::volumioGetState Jan 18 13:41:31 volumio volumio[951]: info: CorePlayQueue::getTrack 3 Jan 18 13:41:31 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 18 13:41:31 volumio volumio[951]: info: camilladsp spawned new process with pid 2488, instance 1, run: true Jan 18 13:41:31 volumio sudo[2468]: pam_unix(sudo:session): session closed for user root Jan 18 13:41:31 volumio volumio[951]: info: camilladsp spawned new process with pid 2496, instance 1, run: true Jan 18 13:41:31 volumio volumio[951]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Jan 18 13:41:31 volumio volumio[951]: verbose: New Socket.io Connection to 192.168.1.173 from 192.168.1.240 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_2 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 10 Jan 18 13:41:31 volumio volumio[951]: info: camilladsp spawned new process with pid 2503, instance 1, run: true Jan 18 13:41:31 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 18 13:41:31 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jan 18 13:41:32 volumio volumio[951]: info: camilladsp spawned new process with pid 2514, instance 1, run: true Jan 18 13:41:32 volumio sudo[2513]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 18 13:41:32 volumio sudo[2513]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 13:41:32 volumio sudo[2513]: pam_unix(sudo:session): session closed for user root Jan 18 13:41:32 volumio sudo[2512]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 18 13:41:32 volumio sudo[2512]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 13:41:32 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 13:41:32 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 13:41:32 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jan 18 13:41:32 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jan 18 13:41:32 volumio sudo[2512]: pam_unix(sudo:session): session closed for user root Jan 18 13:41:32 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jan 18 13:41:32 volumio volumio[951]: info: CoreCommandRouter::volumioGetBrowseSources Jan 18 13:41:33 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 18 13:41:33 volumio volumio[951]: info: camilladsp spawned new process with pid 2538, instance 1, run: true Jan 18 13:41:34 volumio volumio[951]: verbose: New Socket.io Connection to 192.168.1.173 from 192.168.1.240 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_2 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 11 Jan 18 13:41:35 volumio volumio[951]: info: MYVOLUMIO: Adding device Jan 18 13:41:35 volumio volumio[951]: info: MYVOLUMIO: Evaluating Server Jan 18 13:41:35 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 18 13:41:35 volumio volumio[951]: info: CoreCommandRouter::volumioGetVisibleSources Jan 18 13:41:35 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 18 13:41:35 volumio volumio[951]: info: CoreCommandRouter::volumioGetState Jan 18 13:41:35 volumio volumio[951]: info: CorePlayQueue::getTrack 3 Jan 18 13:41:35 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jan 18 13:41:35 volumio volumio[951]: info: CoreCommandRouter::volumioGetQueue Jan 18 13:41:35 volumio volumio[951]: info: CoreStateMachine::getQueue Jan 18 13:41:35 volumio volumio[951]: info: CorePlayQueue::getQueue Jan 18 13:41:35 volumio volumio[951]: info: Listing playlists Jan 18 13:41:35 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 18 13:41:35 volumio volumio[951]: info: Received Get System Info Jan 18 13:41:35 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 18 13:41:35 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 18 13:41:35 volumio volumio[951]: info: Discovery: Getting this device information Jan 18 13:41:35 volumio volumio[951]: info: CoreCommandRouter::volumioGetState Jan 18 13:41:35 volumio volumio[951]: info: CorePlayQueue::getTrack 3 Jan 18 13:41:35 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 18 13:41:35 volumio volumio[951]: info: CoreCommandRouter::volumioGetState Jan 18 13:41:35 volumio volumio[951]: info: CorePlayQueue::getTrack 3 Jan 18 13:41:35 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jan 18 13:41:35 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 18 13:41:36 volumio volumio[2441]: Traceback (most recent call last): Jan 18 13:41:36 volumio volumio[2441]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 13, in Jan 18 13:41:36 volumio volumio[2441]: import ST7789 # v0.0.6 Jan 18 13:41:36 volumio volumio[2441]: ModuleNotFoundError: No module named 'ST7789' Jan 18 13:41:37 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jan 18 13:41:37 volumio systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Jan 18 13:41:37 volumio systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Jan 18 13:41:37 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 18 13:41:37 volumio volumio[951]: info: camilladsp spawned new process with pid 2561, instance 1, run: true Jan 18 13:41:37 volumio volumio[951]: info: Received Get System Info Jan 18 13:41:37 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 18 13:41:37 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 18 13:41:37 volumio volumio[951]: info: Discovery: Getting this device information Jan 18 13:41:37 volumio volumio[951]: info: CoreCommandRouter::volumioGetState Jan 18 13:41:37 volumio volumio[951]: info: CorePlayQueue::getTrack 3 Jan 18 13:41:37 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 18 13:41:37 volumio volumio[951]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 18 13:41:37 volumio volumio[951]: info: Setting Geolocation for MyVolumio to as1 Jan 18 13:41:37 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 13:41:37 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 13:41:37 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 13:41:37 volumio systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Jan 18 13:41:37 volumio systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 17. Jan 18 13:41:37 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 13:41:37 volumio systemd[1]: Stopped Service for using pirate audio display in volumio. Jan 18 13:41:37 volumio systemd[1]: Started Service for using pirate audio display in volumio. Jan 18 13:41:38 volumio volumio[951]: info: camilladsp spawned new process with pid 2569, instance 1, run: true Jan 18 13:41:38 volumio volumio[951]: info: Updating MyVolumio device info Jan 18 13:41:38 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 13:41:38 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 13:41:38 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 13:41:38 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 13:41:38 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jan 18 13:41:39 volumio volumio[951]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Jan 18 13:41:39 volumio volumio[951]: info: CoreCommandRouter::volumioNext Jan 18 13:41:39 volumio volumio[951]: info: CoreStateMachine::next Jan 18 13:41:39 volumio volumio[951]: info: CoreStateMachine::stop Jan 18 13:41:39 volumio volumio[951]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 13:41:39 volumio volumio[951]: info: CoreStateMachine::stPlaybackTimer Jan 18 13:41:39 volumio volumio[951]: info: CoreStateMachine::updateTrackBlock Jan 18 13:41:39 volumio volumio[951]: info: CorePlayQueue::getTrackBlock Jan 18 13:41:39 volumio volumio[951]: info: CoreStateMachine::pushState Jan 18 13:41:39 volumio volumio[951]: info: CorePlayQueue::getTrack 3 Jan 18 13:41:39 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 13:41:39 volumio volumio[951]: info: CoreCommandRouter::volumioPushState Jan 18 13:41:39 volumio volumio[951]: info: CoreStateMachine::serviceStop Jan 18 13:41:39 volumio volumio[951]: info: CorePlayQueue::getTrack 3 Jan 18 13:41:39 volumio volumio[951]: info: CoreCommandRouter::serviceStop Jan 18 13:41:39 volumio volumio[951]: info: ControllerMpd::stop Jan 18 13:41:39 volumio volumio[951]: verbose: ControllerMpd::sendMpdCommand stop Jan 18 13:41:39 volumio volumio[951]: error: MPD error: Error: This socket has been ended by the other party Jan 18 13:41:39 volumio volumio[951]: error: This socket has been ended by the other party {"code":"EPIPE"} Jan 18 13:41:39 volumio volumio[951]: error: MPD error: Error: This socket has been ended by the other party Jan 18 13:41:39 volumio volumio[951]: error: This socket has been ended by the other party {"code":"EPIPE"} Jan 18 13:41:39 volumio volumio[951]: error: MPD error: Error: This socket has been ended by the other party Jan 18 13:41:39 volumio volumio[951]: error: This socket has been ended by the other party {"code":"EPIPE"} Jan 18 13:41:39 volumio volumio[951]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Jan 18 13:41:40 volumio volumio[951]: info: camilladsp spawned new process with pid 2578, instance 1, run: true Jan 18 13:41:40 volumio volumio[951]: error: MyVolumio Plugin failed to authenticate in a timely fashion Jan 18 13:41:40 volumio volumio[951]: info: Completed starting MyVolumio Plugin Jan 18 13:41:40 volumio volumio[951]: [Metrics] CommandRouter: 120s 719.42ms Jan 18 13:41:40 volumio volumio[951]: info: CoreCommandRouter::volumiosetStartupVolume Jan 18 13:41:40 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 13:41:40 volumio volumio[951]: info: VolumeController:: Setting startup Volume 45 Jan 18 13:41:40 volumio volumio[951]: info: VolumeController::SetAlsaVolume45 Jan 18 13:41:40 volumio volumio[951]: STREAMING PROXY: Starting server on port 3245 Jan 18 13:41:40 volumio volumio[951]: Node JS runtime: 14 Jan 18 13:41:40 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 13:41:40 volumio volumio[951]: info: CoreCommandRouter::Close All Modals sent Jan 18 13:41:40 volumio volumio[951]: info: CoreCommandRouter::Close All Modals sent Jan 18 13:41:41 volumio volumio[951]: info: CoreCommandRouter::volumioGetState Jan 18 13:41:41 volumio volumio[951]: info: CorePlayQueue::getTrack 3 Jan 18 13:41:41 volumio volumio[951]: info: CoreStateMachine::pushState Jan 18 13:41:41 volumio volumio[951]: info: CorePlayQueue::getTrack 3 Jan 18 13:41:41 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 13:41:41 volumio volumio[951]: info: CoreCommandRouter::volumioPushState Jan 18 13:41:41 volumio volumio[951]: info: CoreCommandRouter::volumioPlay Jan 18 13:41:41 volumio volumio[951]: info: CoreStateMachine::play index undefined Jan 18 13:41:41 volumio volumio[951]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 18 13:41:41 volumio volumio[951]: info: CorePlayQueue::getTrack 3 Jan 18 13:41:41 volumio volumio[951]: info: CoreStateMachine::startPlaybackTimer Jan 18 13:41:41 volumio volumio[951]: info: CorePlayQueue::getTrack 3 Jan 18 13:41:41 volumio volumio[951]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/FusionDsp/tools/HouseCurveTestSignal.wav Jan 18 13:41:41 volumio volumio[951]: verbose: ControllerMpd::sendMpdCommand stop Jan 18 13:41:41 volumio volumio[951]: error: MPD error: Error: This socket has been ended by the other party Jan 18 13:41:41 volumio volumio[951]: error: This socket has been ended by the other party {"code":"EPIPE"} Jan 18 13:41:41 volumio volumio[951]: error: MPD error: Error: This socket has been ended by the other party Jan 18 13:41:41 volumio volumio[951]: error: This socket has been ended by the other party {"code":"EPIPE"} Jan 18 13:41:41 volumio volumio[951]: error: MPD error: Error: This socket has been ended by the other party Jan 18 13:41:41 volumio volumio[951]: error: This socket has been ended by the other party {"code":"EPIPE"} Jan 18 13:41:41 volumio volumio[951]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Jan 18 13:41:41 volumio volumio[951]: info: touch_display: Setting screensaver timeout to 120 seconds. Jan 18 13:41:41 volumio volumio[951]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jan 18 13:41:41 volumio volumio[951]: info: FusionDsp - ---- read samplerate from file: 44100 Jan 18 13:41:41 volumio volumio[951]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jan 18 13:41:41 volumio volumio[951]: info: FusionDsp - Nulleq applied Jan 18 13:41:41 volumio volumio[951]: info: camilladsp spawned new process with pid 2589, instance 1, run: true Jan 18 13:41:41 volumio volumio[951]: error: FusionDsp - WebSocket error: [object Object] Jan 18 13:41:41 volumio volumio[951]: info: camilladsp spawned new process with pid 2596, instance 1, run: true Jan 18 13:41:41 volumio volumio[951]: info: camilladsp spawned new process with pid 2603, instance 1, run: true Jan 18 13:41:42 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jan 18 13:41:42 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 18 13:41:42 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jan 18 13:41:42 volumio volumio[951]: info: camilladsp spawned new process with pid 2610, instance 1, run: true Jan 18 13:41:42 volumio volumio[951]: info: camilladsp spawned new process with pid 2617, instance 1, run: true Jan 18 13:41:42 volumio systemd[1]: mpd.service: Succeeded. Jan 18 13:41:42 volumio systemd[1]: Stopped Music Player Daemon. Jan 18 13:41:42 volumio systemd[1]: Starting Music Player Daemon... Jan 18 13:41:42 volumio volumio[951]: info: camilladsp spawned new process with pid 2625, instance 1, run: true Jan 18 13:41:42 volumio volumio[951]: info: camilladsp spawned new process with pid 2632, instance 1, run: true Jan 18 13:41:42 volumio volumio[951]: info: camilladsp spawned new process with pid 2639, instance 1, run: true Jan 18 13:41:43 volumio volumio[951]: info: camilladsp spawned new process with pid 2646, instance 1, run: true Jan 18 13:41:43 volumio volumio[951]: info: camilladsp spawned new process with pid 2653, instance 1, run: true Jan 18 13:41:43 volumio volumio[951]: info: VolumeController::SetAlsaVolume100 Jan 18 13:41:43 volumio volumio[951]: info: CoreCommandRouter::volumioGetState Jan 18 13:41:43 volumio volumio[951]: info: CorePlayQueue::getTrack 3 Jan 18 13:41:43 volumio volumio[951]: info: CoreStateMachine::pushState Jan 18 13:41:43 volumio volumio[951]: info: CorePlayQueue::getTrack 3 Jan 18 13:41:43 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 13:41:43 volumio volumio[951]: info: CoreCommandRouter::volumioPushState Jan 18 13:41:43 volumio sudo[2624]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 18 13:41:43 volumio sudo[2624]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 13:41:43 volumio sudo[2624]: pam_unix(sudo:session): session closed for user root Jan 18 13:41:43 volumio volumio[951]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Jan 18 13:41:44 volumio volumio[951]: info: camilladsp spawned new process with pid 2663, instance 1, run: true Jan 18 13:41:44 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 18 13:41:44 volumio volumio[951]: info: camilladsp spawned new process with pid 2674, instance 1, run: true Jan 18 13:41:44 volumio volumio[2568]: Traceback (most recent call last): Jan 18 13:41:44 volumio volumio[2568]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 13, in Jan 18 13:41:44 volumio volumio[2568]: import ST7789 # v0.0.6 Jan 18 13:41:44 volumio volumio[2568]: ModuleNotFoundError: No module named 'ST7789' Jan 18 13:41:44 volumio volumio[951]: info: camilladsp spawned new process with pid 2690, instance 1, run: true Jan 18 13:41:44 volumio systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Jan 18 13:41:44 volumio systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Jan 18 13:41:44 volumio volumio[951]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 Jan 18 13:41:44 volumio volumio[951]: info: camilladsp spawned new process with pid 2698, instance 1, run: true Jan 18 13:41:44 volumio volumio[951]: info: camilladsp spawned new process with pid 2705, instance 1, run: true Jan 18 13:41:44 volumio systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Jan 18 13:41:44 volumio systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 18. Jan 18 13:41:44 volumio systemd[1]: Stopped Service for using pirate audio display in volumio. Jan 18 13:41:44 volumio systemd[1]: Started Service for using pirate audio display in volumio. Jan 18 13:41:44 volumio volumio[951]: info: camilladsp spawned new process with pid 2713, instance 1, run: true Jan 18 13:41:44 volumio volumio[951]: info: camilladsp spawned new process with pid 2720, instance 1, run: true Jan 18 13:41:45 volumio volumio[951]: info: camilladsp spawned new process with pid 2727, instance 1, run: true Jan 18 13:41:45 volumio volumio[951]: info: camilladsp spawned new process with pid 2734, instance 1, run: true Jan 18 13:41:45 volumio volumio[951]: info: VolumeController::SetAlsaVolume100 Jan 18 13:41:45 volumio volumio[951]: info: CoreCommandRouter::volumioGetState Jan 18 13:41:45 volumio volumio[951]: info: CorePlayQueue::getTrack 3 Jan 18 13:41:45 volumio volumio[951]: info: CoreStateMachine::pushState Jan 18 13:41:45 volumio volumio[951]: info: CorePlayQueue::getTrack 3 Jan 18 13:41:45 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 13:41:45 volumio volumio[951]: info: CoreCommandRouter::volumioPushState Jan 18 13:41:46 volumio volumio[951]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Jan 18 13:41:46 volumio volumio[951]: info: camilladsp spawned new process with pid 2742, instance 1, run: true Jan 18 13:41:46 volumio volumio[951]: info: camilladsp spawned new process with pid 2749, instance 1, run: true Jan 18 13:41:46 volumio volumio[951]: info: camilladsp spawned new process with pid 2756, instance 1, run: true Jan 18 13:41:46 volumio volumio[951]: info: camilladsp spawned new process with pid 2763, instance 1, run: true Jan 18 13:41:47 volumio volumio[951]: info: camilladsp spawned new process with pid 2770, instance 1, run: true Jan 18 13:41:47 volumio volumio[951]: info: VolumeController::SetAlsaVolume100 Jan 18 13:41:47 volumio volumio[951]: info: CoreCommandRouter::volumioGetState Jan 18 13:41:47 volumio volumio[951]: info: CorePlayQueue::getTrack 3 Jan 18 13:41:47 volumio volumio[951]: info: CoreStateMachine::pushState Jan 18 13:41:47 volumio volumio[951]: info: CorePlayQueue::getTrack 3 Jan 18 13:41:47 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 13:41:47 volumio volumio[951]: info: CoreCommandRouter::volumioPushState Jan 18 13:41:47 volumio volumio[951]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Jan 18 13:41:47 volumio volumio[951]: info: camilladsp spawned new process with pid 2778, instance 1, run: true Jan 18 13:41:47 volumio volumio[951]: info: camilladsp spawned new process with pid 2786, instance 1, run: true Jan 18 13:41:47 volumio volumio[951]: info: camilladsp spawned new process with pid 2793, instance 1, run: true Jan 18 13:41:48 volumio volumio[951]: info: camilladsp spawned new process with pid 2800, instance 1, run: true Jan 18 13:41:48 volumio volumio[951]: info: BOOT COMPLETED Jan 18 13:41:48 volumio volumio[951]: info: camilladsp spawned new process with pid 2807, instance 1, run: true Jan 18 13:41:48 volumio volumio[951]: info: camilladsp spawned new process with pid 2814, instance 1, run: true Jan 18 13:41:48 volumio volumio[951]: info: camilladsp spawned new process with pid 2821, instance 1, run: true Jan 18 13:41:48 volumio volumio[951]: info: camilladsp spawned new process with pid 2828, instance 1, run: true Jan 18 13:41:48 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 18 13:41:49 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jan 18 13:41:49 volumio volumio[951]: info: CorePlayQueue::getTrack 3 Jan 18 13:41:49 volumio volumio[951]: info: CorePlayQueue::getTrack 6 Jan 18 13:41:49 volumio volumio[951]: info: Prefetching next song Jan 18 13:41:49 volumio volumio[951]: info: DOING PREFETCH IN MPD Jan 18 13:41:49 volumio volumio[951]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/FusionDsp/tools/PinkNoise_44k_R.wav" Jan 18 13:41:49 volumio volumio[951]: error: MPD error: Error: This socket has been ended by the other party Jan 18 13:41:49 volumio volumio[951]: error: This socket has been ended by the other party {"code":"EPIPE"} Jan 18 13:41:49 volumio volumio[951]: error: MPD error: Error: This socket has been ended by the other party Jan 18 13:41:49 volumio volumio[951]: error: This socket has been ended by the other party {"code":"EPIPE"} Jan 18 13:41:49 volumio volumio[951]: error: MPD error: Error: This socket has been ended by the other party Jan 18 13:41:49 volumio volumio[951]: error: This socket has been ended by the other party {"code":"EPIPE"} Jan 18 13:41:49 volumio volumio[951]: info: camilladsp spawned new process with pid 2835, instance 1, run: true Jan 18 13:41:50 volumio volumio[2708]: Traceback (most recent call last): Jan 18 13:41:50 volumio volumio[2708]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 13, in Jan 18 13:41:50 volumio volumio[2708]: import ST7789 # v0.0.6 Jan 18 13:41:50 volumio volumio[2708]: ModuleNotFoundError: No module named 'ST7789' Jan 18 13:41:50 volumio systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Jan 18 13:41:50 volumio systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Jan 18 13:41:50 volumio systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Jan 18 13:41:50 volumio systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 19. Jan 18 13:41:50 volumio systemd[1]: Stopped Service for using pirate audio display in volumio. Jan 18 13:41:51 volumio systemd[1]: Started Service for using pirate audio display in volumio. Jan 18 13:41:51 volumio volumio[951]: info: camilladsp spawned new process with pid 2844, instance 1, run: true Jan 18 13:41:51 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 18 13:41:51 volumio volumio[951]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jan 18 13:41:51 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jan 18 13:41:51 volumio volumio[951]: info: Received Get System Version Jan 18 13:41:51 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 18 13:41:51 volumio volumio[951]: info: Received Get System Info Jan 18 13:41:51 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 18 13:41:51 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 18 13:41:51 volumio volumio[951]: info: Discovery: Getting this device information Jan 18 13:41:51 volumio volumio[951]: info: CoreCommandRouter::volumioGetState Jan 18 13:41:51 volumio volumio[951]: info: CorePlayQueue::getTrack 3 Jan 18 13:41:51 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 18 13:41:51 volumio volumio[951]: info: camilladsp spawned new process with pid 2851, instance 1, run: true Jan 18 13:41:51 volumio volumio[951]: info: camilladsp spawned new process with pid 2858, instance 1, run: true Jan 18 13:41:51 volumio volumio[951]: info: camilladsp spawned new process with pid 2865, instance 1, run: true Jan 18 13:41:52 volumio volumio[951]: info: camilladsp spawned new process with pid 2872, instance 1, run: true Jan 18 13:41:52 volumio volumio[951]: info: camilladsp spawned new process with pid 2879, instance 1, run: true Jan 18 13:41:53 volumio volumio[951]: info: camilladsp spawned new process with pid 2886, instance 1, run: true Jan 18 13:41:53 volumio volumio[951]: info: camilladsp spawned new process with pid 2893, instance 1, run: true Jan 18 13:41:53 volumio volumio[951]: info: camilladsp spawned new process with pid 2900, instance 1, run: true Jan 18 13:41:53 volumio volumio[2843]: Traceback (most recent call last): Jan 18 13:41:53 volumio volumio[2843]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 13, in Jan 18 13:41:53 volumio volumio[2843]: import ST7789 # v0.0.6 Jan 18 13:41:53 volumio volumio[2843]: ModuleNotFoundError: No module named 'ST7789' Jan 18 13:41:53 volumio volumio[951]: info: CoreStateMachine::startPlaybackTimer Jan 18 13:41:53 volumio volumio[951]: info: CorePlayQueue::getTrack 6 Jan 18 13:41:53 volumio volumio[951]: info: camilladsp spawned new process with pid 2907, instance 1, run: true Jan 18 13:41:54 volumio systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Jan 18 13:41:54 volumio systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Jan 18 13:41:54 volumio volumio[951]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Jan 18 13:41:54 volumio volumio[951]: info: camilladsp spawned new process with pid 2914, instance 1, run: true Jan 18 13:41:54 volumio systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Jan 18 13:41:54 volumio systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 20. Jan 18 13:41:54 volumio systemd[1]: Stopped Service for using pirate audio display in volumio. Jan 18 13:41:54 volumio volumio[951]: info: CoreStateMachine::pushState Jan 18 13:41:54 volumio volumio[951]: info: CorePlayQueue::getTrack 6 Jan 18 13:41:54 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 13:41:54 volumio volumio[951]: info: CoreCommandRouter::volumioPushState Jan 18 13:41:54 volumio systemd[1]: Started Service for using pirate audio display in volumio. Jan 18 13:41:54 volumio volumio[951]: info: camilladsp spawned new process with pid 2922, instance 1, run: true Jan 18 13:41:54 volumio volumio[951]: info: camilladsp spawned new process with pid 2933, instance 1, run: true Jan 18 13:41:54 volumio volumio[951]: info: camilladsp spawned new process with pid 2949, instance 1, run: true Jan 18 13:41:54 volumio volumio[951]: info: camilladsp spawned new process with pid 2957, instance 1, run: true Jan 18 13:41:55 volumio volumio[951]: info: camilladsp spawned new process with pid 2964, instance 1, run: true Jan 18 13:41:55 volumio volumio[951]: info: camilladsp spawned new process with pid 2971, instance 1, run: true Jan 18 13:41:55 volumio volumio[951]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 18 13:41:55 volumio volumio[951]: info: camilladsp spawned new process with pid 2978, instance 1, run: true Jan 18 13:41:56 volumio volumio[2921]: Traceback (most recent call last): Jan 18 13:41:56 volumio volumio[2921]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 13, in Jan 18 13:41:56 volumio volumio[2921]: import ST7789 # v0.0.6 Jan 18 13:41:56 volumio volumio[2921]: ModuleNotFoundError: No module named 'ST7789' Jan 18 13:41:56 volumio systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Jan 18 13:41:56 volumio systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Jan 18 13:41:56 volumio mpd[2662]: Jan 18 13:41 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 18 13:41:57 volumio systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Jan 18 13:41:57 volumio systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 21. Jan 18 13:41:57 volumio systemd[1]: Started Music Player Daemon. Jan 18 13:41:57 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jan 18 13:41:57 volumio systemd[1]: Stopped Service for using pirate audio display in volumio. Jan 18 13:41:57 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 13:41:57 volumio systemd[1]: Started Service for using pirate audio display in volumio. Jan 18 13:41:57 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 18 13:41:57 volumio volumio[951]: info: Getting Alsa Cards List without I2S DAC Jan 18 13:41:57 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Jan 18 13:41:57 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 13:41:57 volumio mpd_monitor.sh[520]: MPD restarted due to no mpc output. Jan 18 13:41:57 volumio volumio[951]: Invalid card number. Jan 18 13:41:57 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 18 13:41:57 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 18 13:41:57 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 18 13:41:57 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 18 13:41:57 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 18 13:41:57 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 18 13:41:57 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 18 13:41:57 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jan 18 13:41:57 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 18 13:41:58 volumio volumio[951]: Upnp client error: Error: This socket has been ended by the other party Jan 18 13:41:58 volumio volumio[951]: Upnp client error: Error: This socket has been ended by the other party Jan 18 13:41:58 volumio volumio[951]: Upnp client error: Error: This socket has been ended by the other party Jan 18 13:41:58 volumio volumio[951]: Upnp client error: Error: This socket has been ended by the other party Jan 18 13:41:58 volumio volumio[951]: Upnp client error: Error: This socket has been ended by the other party Jan 18 13:41:58 volumio volumio[951]: info: camilladsp spawned new process with pid 2997, instance 1, run: true Jan 18 13:41:58 volumio volumio[951]: Upnp client error: Error: This socket has been ended by the other party Jan 18 13:41:58 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 18 13:41:58 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 18 13:41:58 volumio volumio[951]: info: Discovery: Getting this device information Jan 18 13:41:58 volumio volumio[951]: info: CoreCommandRouter::volumioGetState Jan 18 13:41:58 volumio volumio[951]: info: CorePlayQueue::getTrack 6 Jan 18 13:41:58 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 18 13:41:59 volumio volumio[951]: info: camilladsp spawned new process with pid 3004, instance 1, run: true Jan 18 13:41:59 volumio volumio[951]: Upnp client error: Error: This socket has been ended by the other party Jan 18 13:41:59 volumio volumio[951]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 Jan 18 13:41:59 volumio volumio[951]: Upnp client error: Error: This socket has been ended by the other party Jan 18 13:42:00 volumio volumio[951]: info: camilladsp spawned new process with pid 3012, instance 1, run: true Jan 18 13:42:00 volumio volumio[951]: info: camilladsp spawned new process with pid 3019, instance 1, run: true Jan 18 13:42:00 volumio volumio[951]: info: camilladsp spawned new process with pid 3027, instance 1, run: true Jan 18 13:42:00 volumio volumio[951]: info: camilladsp spawned new process with pid 3034, instance 1, run: true Jan 18 13:42:00 volumio volumio[951]: info: camilladsp spawned new process with pid 3041, instance 1, run: true Jan 18 13:42:00 volumio volumio[951]: info: camilladsp spawned new process with pid 3048, instance 1, run: true Jan 18 13:42:00 volumio volumio[2989]: Traceback (most recent call last): Jan 18 13:42:00 volumio volumio[2989]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 13, in Jan 18 13:42:00 volumio volumio[2989]: import ST7789 # v0.0.6 Jan 18 13:42:00 volumio volumio[2989]: ModuleNotFoundError: No module named 'ST7789' Jan 18 13:42:01 volumio volumio[951]: info: camilladsp spawned new process with pid 3055, instance 1, run: true Jan 18 13:42:01 volumio volumio[951]: info: camilladsp spawned new process with pid 3062, instance 1, run: true Jan 18 13:42:01 volumio systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Jan 18 13:42:01 volumio volumio[951]: info: camilladsp spawned new process with pid 3069, instance 1, run: true Jan 18 13:42:01 volumio systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Jan 18 13:42:01 volumio volumio[951]: info: camilladsp spawned new process with pid 3076, instance 1, run: true Jan 18 13:42:01 volumio volumio[951]: info: camilladsp spawned new process with pid 3085, instance 1, run: true Jan 18 13:42:01 volumio systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Jan 18 13:42:01 volumio systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 22. Jan 18 13:42:01 volumio systemd[1]: Stopped Service for using pirate audio display in volumio. Jan 18 13:42:01 volumio systemd[1]: Started Service for using pirate audio display in volumio. Jan 18 13:42:01 volumio volumio[951]: info: camilladsp spawned new process with pid 3093, instance 1, run: true Jan 18 13:42:01 volumio volumio[951]: Upnp client error: Error: This socket has been ended by the other party Jan 18 13:42:01 volumio volumio[951]: info: camilladsp spawned new process with pid 3100, instance 1, run: true Jan 18 13:42:02 volumio volumio[951]: info: camilladsp spawned new process with pid 3107, instance 1, run: true Jan 18 13:42:02 volumio volumio[951]: info: camilladsp spawned new process with pid 3114, instance 1, run: true Jan 18 13:42:02 volumio volumio[951]: info: camilladsp spawned new process with pid 3121, instance 1, run: true Jan 18 13:42:02 volumio volumio[951]: info: camilladsp spawned new process with pid 3128, instance 1, run: true Jan 18 13:42:02 volumio volumio[951]: info: camilladsp spawned new process with pid 3137, instance 1, run: true Jan 18 13:42:02 volumio volumio[951]: info: camilladsp spawned new process with pid 3144, instance 1, run: true Jan 18 13:42:03 volumio volumio[951]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 Jan 18 13:42:03 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 18 13:42:03 volumio volumio[951]: info: camilladsp spawned new process with pid 3151, instance 1, run: true Jan 18 13:42:03 volumio volumio[951]: info: CoreCommandRouter::volumioGetVisibleSources Jan 18 13:42:03 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 18 13:42:03 volumio volumio[951]: info: CoreCommandRouter::volumioGetState Jan 18 13:42:03 volumio volumio[951]: info: CorePlayQueue::getTrack 6 Jan 18 13:42:03 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jan 18 13:42:03 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 18 13:42:03 volumio volumio[951]: info: Received Get System Info Jan 18 13:42:03 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 18 13:42:03 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 18 13:42:03 volumio volumio[951]: info: Discovery: Getting this device information Jan 18 13:42:03 volumio volumio[951]: info: CoreCommandRouter::volumioGetState Jan 18 13:42:03 volumio volumio[951]: info: CorePlayQueue::getTrack 6 Jan 18 13:42:03 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 18 13:42:03 volumio volumio[951]: info: CoreCommandRouter::volumioGetState Jan 18 13:42:03 volumio volumio[951]: info: CorePlayQueue::getTrack 6 Jan 18 13:42:03 volumio volumio[951]: info: Listing playlists Jan 18 13:42:03 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 18 13:42:03 volumio volumio[951]: info: Received Get System Info Jan 18 13:42:03 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 18 13:42:03 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 18 13:42:03 volumio volumio[951]: info: Discovery: Getting this device information Jan 18 13:42:03 volumio volumio[951]: info: CoreCommandRouter::volumioGetState Jan 18 13:42:03 volumio volumio[951]: info: CorePlayQueue::getTrack 6 Jan 18 13:42:03 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 18 13:42:03 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jan 18 13:42:03 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 18 13:42:03 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 18 13:42:03 volumio volumio[951]: info: Received Get System Info Jan 18 13:42:03 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 18 13:42:03 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 18 13:42:03 volumio volumio[951]: info: Discovery: Getting this device information Jan 18 13:42:03 volumio volumio[951]: info: CoreCommandRouter::volumioGetState Jan 18 13:42:03 volumio volumio[951]: info: CorePlayQueue::getTrack 6 Jan 18 13:42:03 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 18 13:42:03 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 18 13:42:03 volumio volumio[951]: info: CoreCommandRouter::volumioGetVisibleSources Jan 18 13:42:03 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 18 13:42:03 volumio volumio[951]: info: CoreCommandRouter::volumioGetState Jan 18 13:42:03 volumio volumio[951]: info: CorePlayQueue::getTrack 6 Jan 18 13:42:03 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jan 18 13:42:03 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 18 13:42:03 volumio volumio[951]: info: Received Get System Info Jan 18 13:42:03 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 18 13:42:03 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 18 13:42:03 volumio volumio[951]: info: Discovery: Getting this device information Jan 18 13:42:03 volumio volumio[951]: info: CoreCommandRouter::volumioGetState Jan 18 13:42:03 volumio volumio[951]: info: CorePlayQueue::getTrack 6 Jan 18 13:42:03 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 18 13:42:03 volumio volumio[951]: info: CoreCommandRouter::volumioGetState Jan 18 13:42:03 volumio volumio[951]: info: CorePlayQueue::getTrack 6 Jan 18 13:42:03 volumio volumio[951]: info: Listing playlists Jan 18 13:42:03 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jan 18 13:42:03 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jan 18 13:42:03 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 18 13:42:04 volumio volumio[951]: info: camilladsp spawned new process with pid 3159, instance 1, run: true Jan 18 13:42:04 volumio volumio[951]: info: camilladsp spawned new process with pid 3167, instance 1, run: true Jan 18 13:42:04 volumio volumio[951]: info: camilladsp spawned new process with pid 3174, instance 1, run: true Jan 18 13:42:04 volumio volumio[3092]: Traceback (most recent call last): Jan 18 13:42:04 volumio volumio[3092]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 13, in Jan 18 13:42:04 volumio volumio[3092]: import ST7789 # v0.0.6 Jan 18 13:42:04 volumio volumio[3092]: ModuleNotFoundError: No module named 'ST7789' Jan 18 13:42:04 volumio volumio[951]: info: camilladsp spawned new process with pid 3181, instance 1, run: true Jan 18 13:42:04 volumio volumio[951]: info: camilladsp spawned new process with pid 3188, instance 1, run: true Jan 18 13:42:04 volumio systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Jan 18 13:42:04 volumio systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Jan 18 13:42:05 volumio volumio[951]: info: camilladsp spawned new process with pid 3199, instance 1, run: true Jan 18 13:42:05 volumio volumio[951]: Upnp client error: Error: This socket has been ended by the other party Jan 18 13:42:05 volumio volumio[951]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 18 13:42:05 volumio volumio[951]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 18 13:42:05 volumio volumio[951]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 18 13:42:05 volumio volumio[951]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 18 13:42:05 volumio volumio[951]: info: camilladsp spawned new process with pid 3218, instance 1, run: true Jan 18 13:42:05 volumio systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Jan 18 13:42:05 volumio systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 23. Jan 18 13:42:05 volumio systemd[1]: Stopped Service for using pirate audio display in volumio. Jan 18 13:42:05 volumio systemd[1]: Started Service for using pirate audio display in volumio. Jan 18 13:42:10 volumio volumio[3225]: Traceback (most recent call last): Jan 18 13:42:10 volumio volumio[3225]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 13, in Jan 18 13:42:10 volumio volumio[3225]: import ST7789 # v0.0.6 Jan 18 13:42:10 volumio volumio[3225]: ModuleNotFoundError: No module named 'ST7789' Jan 18 13:42:10 volumio systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Jan 18 13:42:10 volumio systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Jan 18 13:42:10 volumio systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Jan 18 13:42:10 volumio systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 24. Jan 18 13:42:10 volumio systemd[1]: Stopped Service for using pirate audio display in volumio. Jan 18 13:42:10 volumio systemd[1]: Started Service for using pirate audio display in volumio. Jan 18 13:42:13 volumio volumio[3229]: Traceback (most recent call last): Jan 18 13:42:13 volumio volumio[3229]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 13, in Jan 18 13:42:13 volumio volumio[3229]: import ST7789 # v0.0.6 Jan 18 13:42:13 volumio volumio[3229]: ModuleNotFoundError: No module named 'ST7789' Jan 18 13:42:14 volumio systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Jan 18 13:42:14 volumio systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Jan 18 13:42:14 volumio systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Jan 18 13:42:14 volumio systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 25. Jan 18 13:42:14 volumio systemd[1]: Stopped Service for using pirate audio display in volumio. Jan 18 13:42:14 volumio systemd[1]: Started Service for using pirate audio display in volumio. Jan 18 13:42:16 volumio volumio[3274]: Traceback (most recent call last): Jan 18 13:42:16 volumio volumio[3274]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 13, in Jan 18 13:42:16 volumio volumio[3274]: import ST7789 # v0.0.6 Jan 18 13:42:16 volumio volumio[3274]: ModuleNotFoundError: No module named 'ST7789' Jan 18 13:42:16 volumio systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Jan 18 13:42:16 volumio systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Jan 18 13:42:17 volumio volumio[951]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Jan 18 13:42:17 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Jan 18 13:42:17 volumio systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Jan 18 13:42:17 volumio systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 26. Jan 18 13:42:17 volumio systemd[1]: Stopped Service for using pirate audio display in volumio. Jan 18 13:42:17 volumio systemd[1]: Started Service for using pirate audio display in volumio. Jan 18 13:42:17 volumio volumio-remote-updater[554]: [2025-01-18 13:42:17] [disconnect] Disconnect close local:[1008,Pong timeout] remote:[1006] Jan 18 13:42:17 volumio volumio[951]: info: Preparing to save Alsa Options, stopping services first Jan 18 13:42:17 volumio volumio[951]: info: CoreCommandRouter::volumioGetState Jan 18 13:42:17 volumio volumio[951]: info: CorePlayQueue::getTrack 6 Jan 18 13:42:17 volumio volumio[951]: info: CoreCommandRouter::volumioPause Jan 18 13:42:17 volumio volumio[951]: info: CoreStateMachine::pause Jan 18 13:42:17 volumio volumio[951]: info: Saving Audio Output to: {"output_device":{"value":"0","label":"HDMI Out"},"i2s":true,"i2sid":{"value":"hifiberry-dac","label":"HiFiBerry DAC"}} Jan 18 13:42:17 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 18 13:42:17 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Jan 18 13:42:18 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 13:42:18 volumio volumio[951]: info: Enabling I2S DAC: HiFiBerry DAC Jan 18 13:42:18 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , enableI2SDAC Jan 18 13:42:18 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 13:42:19 volumio sudo[3295]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 18 13:42:19 volumio sudo[3295]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 13:42:19 volumio sudo[3295]: pam_unix(sudo:session): session closed for user root Jan 18 13:42:19 volumio volumio[951]: info: No Overlays Loaded Jan 18 13:42:19 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 13:42:19 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SAlsaName Jan 18 13:42:19 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 13:42:19 volumio sudo[3298]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay hifiberry-dac Jan 18 13:42:19 volumio sudo[3298]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 13:42:20 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/i2s@7e203000/status Jan 18 13:42:20 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/compatible Jan 18 13:42:20 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/i2s-controller Jan 18 13:42:20 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/status Jan 18 13:42:20 volumio sudo[3298]: pam_unix(sudo:session): session closed for user root Jan 18 13:42:20 volumio volumio[951]: warn: Unable to locate the device HDMI Out a reboot may be required. Jan 18 13:42:21 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 18 13:42:21 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SMixer Jan 18 13:42:21 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 13:42:21 volumio volumio[951]: info: Setting default mixerSoftMaster for Softvolume device Jan 18 13:42:21 volumio volumio[951]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jan 18 13:42:21 volumio volumio[951]: info: Updating Volume Controller Parameters: Device: 2 Name: softvolume Mixer: SoftMaster Max Vol: 80 Vol Curve; logarithmic Vol Steps: 2 Jan 18 13:42:21 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jan 18 13:42:21 volumio volumio[951]: info: Disabling external Volume Control Jan 18 13:42:21 volumio volumio[951]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 18 13:42:21 volumio volumio[951]: info: Enable softmixer device for audio device undefined Jan 18 13:42:21 volumio volumio[3289]: Traceback (most recent call last): Jan 18 13:42:21 volumio volumio[3289]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 13, in Jan 18 13:42:21 volumio volumio[3289]: import ST7789 # v0.0.6 Jan 18 13:42:21 volumio volumio[3289]: ModuleNotFoundError: No module named 'ST7789' Jan 18 13:42:21 volumio volumio[951]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Jan 18 13:42:21 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Jan 18 13:42:21 volumio volumio[951]: info: Preparing to save Alsa Options, stopping services first Jan 18 13:42:21 volumio volumio[951]: info: CoreCommandRouter::volumioGetState Jan 18 13:42:21 volumio volumio[951]: info: CorePlayQueue::getTrack 6 Jan 18 13:42:21 volumio volumio[951]: info: CoreCommandRouter::volumioPause Jan 18 13:42:21 volumio volumio[951]: info: CoreStateMachine::pause Jan 18 13:42:21 volumio volumio[951]: info: Saving Audio Output to: {"output_device":{"value":"0","label":"HDMI Out"},"i2s":true,"i2sid":{"value":"hifiberry-dac","label":"HiFiBerry DAC"}} Jan 18 13:42:21 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 18 13:42:21 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Jan 18 13:42:21 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 13:42:21 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SAlsaName Jan 18 13:42:22 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 13:42:22 volumio systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Jan 18 13:42:22 volumio systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Jan 18 13:42:22 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 18 13:42:22 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SMixer Jan 18 13:42:22 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 13:42:22 volumio volumio[951]: info: Setting default mixerSoftMaster for Softvolume device Jan 18 13:42:22 volumio systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Jan 18 13:42:22 volumio systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 27. Jan 18 13:42:22 volumio systemd[1]: Stopped Service for using pirate audio display in volumio. Jan 18 13:42:22 volumio volumio[951]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jan 18 13:42:22 volumio volumio[951]: info: Updating Volume Controller Parameters: Device: 2 Name: softvolume Mixer: SoftMaster Max Vol: 80 Vol Curve; logarithmic Vol Steps: 2 Jan 18 13:42:22 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jan 18 13:42:22 volumio volumio[951]: info: Disabling external Volume Control Jan 18 13:42:22 volumio volumio[951]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 18 13:42:22 volumio volumio[951]: info: Enable softmixer device for audio device undefined Jan 18 13:42:22 volumio volumio[951]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Jan 18 13:42:22 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Jan 18 13:42:22 volumio volumio[951]: info: Preparing to save Alsa Options, stopping services first Jan 18 13:42:22 volumio systemd[1]: Started Service for using pirate audio display in volumio. Jan 18 13:42:22 volumio volumio[951]: info: CoreCommandRouter::volumioGetState Jan 18 13:42:22 volumio volumio[951]: info: CorePlayQueue::getTrack 6 Jan 18 13:42:22 volumio volumio[951]: info: CoreCommandRouter::volumioPause Jan 18 13:42:22 volumio volumio[951]: info: CoreStateMachine::pause Jan 18 13:42:22 volumio volumio[951]: info: Saving Audio Output to: {"output_device":{"value":"0","label":"HDMI Out"},"i2s":true,"i2sid":{"value":"hifiberry-dac","label":"HiFiBerry DAC"}} Jan 18 13:42:22 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 18 13:42:22 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Jan 18 13:42:22 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 13:42:22 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SAlsaName Jan 18 13:42:22 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 13:42:22 volumio volumio-remote-updater[554]: [2025-01-18 13:42:22] [connect] Successful connection Jan 18 13:42:22 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 18 13:42:22 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SMixer Jan 18 13:42:22 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 13:42:22 volumio volumio[951]: info: Setting default mixerSoftMaster for Softvolume device Jan 18 13:42:23 volumio volumio[951]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jan 18 13:42:23 volumio volumio[951]: info: Updating Volume Controller Parameters: Device: 2 Name: softvolume Mixer: SoftMaster Max Vol: 80 Vol Curve; logarithmic Vol Steps: 2 Jan 18 13:42:23 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jan 18 13:42:23 volumio volumio[951]: info: Disabling external Volume Control Jan 18 13:42:23 volumio volumio[951]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 18 13:42:23 volumio volumio[951]: info: Enable softmixer device for audio device undefined Jan 18 13:42:23 volumio volumio[951]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Jan 18 13:42:23 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Jan 18 13:42:23 volumio volumio[951]: info: Preparing to save Alsa Options, stopping services first Jan 18 13:42:23 volumio volumio[951]: info: CoreCommandRouter::volumioGetState Jan 18 13:42:23 volumio volumio[951]: info: CorePlayQueue::getTrack 6 Jan 18 13:42:23 volumio volumio[951]: info: CoreCommandRouter::volumioPause Jan 18 13:42:23 volumio volumio[951]: info: CoreStateMachine::pause Jan 18 13:42:23 volumio volumio[951]: info: Saving Audio Output to: {"output_device":{"value":"0","label":"HDMI Out"},"i2s":true,"i2sid":{"value":"hifiberry-dac","label":"HiFiBerry DAC"}} Jan 18 13:42:23 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 18 13:42:23 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Jan 18 13:42:23 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 13:42:23 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SAlsaName Jan 18 13:42:23 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 13:42:23 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 18 13:42:23 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SMixer Jan 18 13:42:23 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 13:42:23 volumio volumio[951]: info: Setting default mixerSoftMaster for Softvolume device Jan 18 13:42:23 volumio volumio[951]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jan 18 13:42:23 volumio volumio[951]: info: Updating Volume Controller Parameters: Device: 2 Name: softvolume Mixer: SoftMaster Max Vol: 80 Vol Curve; logarithmic Vol Steps: 2 Jan 18 13:42:23 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jan 18 13:42:23 volumio volumio[951]: info: Disabling external Volume Control Jan 18 13:42:23 volumio volumio[951]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 18 13:42:23 volumio volumio[951]: info: Enable softmixer device for audio device undefined Jan 18 13:42:23 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction Jan 18 13:42:23 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jan 18 13:42:23 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jan 18 13:42:23 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 18 13:42:24 volumio volumio[951]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jan 18 13:42:24 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jan 18 13:42:24 volumio volumio[951]: info: Received Get System Version Jan 18 13:42:24 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 18 13:42:24 volumio volumio[951]: info: Received Get System Info Jan 18 13:42:24 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 18 13:42:24 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 18 13:42:24 volumio volumio[951]: info: Discovery: Getting this device information Jan 18 13:42:24 volumio volumio[951]: info: CoreCommandRouter::volumioGetState Jan 18 13:42:24 volumio volumio[951]: info: CorePlayQueue::getTrack 6 Jan 18 13:42:24 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 18 13:42:27 volumio volumio[951]: info: camilladsp spawned new process with pid 3379, instance 1, run: true Jan 18 13:42:27 volumio volumio[951]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Jan 18 13:42:27 volumio volumio[951]: info: CoreStateMachine::getcurrentVolume Jan 18 13:42:27 volumio volumio[951]: info: CoreCommandRouter::volumioRetrievevolume Jan 18 13:42:27 volumio volumio[951]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Jan 18 13:42:27 volumio volumio[951]: info: CoreStateMachine::getcurrentVolume Jan 18 13:42:27 volumio volumio[951]: info: CoreCommandRouter::volumioRetrievevolume Jan 18 13:42:27 volumio volumio[951]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Jan 18 13:42:27 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Jan 18 13:42:27 volumio volumio[951]: info: Preparing to save Alsa Options, stopping services first Jan 18 13:42:27 volumio volumio[951]: info: CoreCommandRouter::volumioGetState Jan 18 13:42:27 volumio volumio[951]: info: CorePlayQueue::getTrack 6 Jan 18 13:42:27 volumio volumio[951]: info: CoreCommandRouter::volumioPause Jan 18 13:42:27 volumio volumio[951]: info: CoreStateMachine::pause Jan 18 13:42:27 volumio volumio[951]: info: Saving Audio Output to: {"output_device":{"value":"0","label":"HDMI Out"},"i2s":true,"i2sid":{"value":"hifiberry-dac","label":"HiFiBerry DAC"}} Jan 18 13:42:27 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 18 13:42:27 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Jan 18 13:42:27 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 13:42:27 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SAlsaName Jan 18 13:42:27 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 13:42:28 volumio volumio[3337]: Traceback (most recent call last): Jan 18 13:42:28 volumio volumio[3337]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 13, in Jan 18 13:42:28 volumio volumio[3337]: import ST7789 # v0.0.6 Jan 18 13:42:28 volumio volumio[3337]: ModuleNotFoundError: No module named 'ST7789' Jan 18 13:42:28 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 18 13:42:28 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SMixer Jan 18 13:42:28 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 13:42:28 volumio systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Jan 18 13:42:28 volumio systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Jan 18 13:42:28 volumio systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Jan 18 13:42:28 volumio systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 28. Jan 18 13:42:28 volumio systemd[1]: Stopped Service for using pirate audio display in volumio. Jan 18 13:42:28 volumio volumio[951]: info: Setting default mixerSoftMaster for Softvolume device Jan 18 13:42:28 volumio systemd[1]: Started Service for using pirate audio display in volumio. Jan 18 13:42:28 volumio volumio[951]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jan 18 13:42:28 volumio volumio[951]: info: Updating Volume Controller Parameters: Device: 2 Name: softvolume Mixer: SoftMaster Max Vol: 80 Vol Curve; logarithmic Vol Steps: 2 Jan 18 13:42:28 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jan 18 13:42:28 volumio volumio[951]: info: Disabling external Volume Control Jan 18 13:42:28 volumio volumio[951]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 18 13:42:28 volumio volumio[951]: info: Enable softmixer device for audio device undefined Jan 18 13:42:28 volumio volumio[951]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Jan 18 13:42:28 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Jan 18 13:42:28 volumio volumio[951]: info: Preparing to save Alsa Options, stopping services first Jan 18 13:42:28 volumio volumio[951]: info: CoreCommandRouter::volumioGetState Jan 18 13:42:28 volumio volumio[951]: info: CorePlayQueue::getTrack 6 Jan 18 13:42:28 volumio volumio[951]: info: CoreCommandRouter::volumioPause Jan 18 13:42:28 volumio volumio[951]: info: CoreStateMachine::pause Jan 18 13:42:28 volumio volumio[951]: info: Saving Audio Output to: {"output_device":{"value":"0","label":"HDMI Out"},"i2s":true,"i2sid":{"value":"hifiberry-amp","label":"HiFiBerry Amp"}} Jan 18 13:42:28 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 18 13:42:28 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Jan 18 13:42:28 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 13:42:28 volumio volumio[951]: info: Enabling I2S DAC: HiFiBerry Amp Jan 18 13:42:28 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , enableI2SDAC Jan 18 13:42:28 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 13:42:29 volumio sudo[3429]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Jan 18 13:42:29 volumio sudo[3429]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 13:42:29 volumio sudo[3429]: pam_unix(sudo:session): session closed for user root Jan 18 13:42:29 volumio sudo[3432]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -r hifiberry-dac Jan 18 13:42:29 volumio sudo[3432]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 13:42:30 volumio sudo[3432]: pam_unix(sudo:session): session closed for user root Jan 18 13:42:30 volumio volumio[951]: info: Removed overlay hifiberry-dac Jan 18 13:42:30 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 13:42:30 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SAlsaName Jan 18 13:42:30 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 13:42:30 volumio sudo[3445]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay hifiberry-amp Jan 18 13:42:30 volumio sudo[3445]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 13:42:30 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/i2s@7e203000/status Jan 18 13:42:30 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/i2c@7e804000/status Jan 18 13:42:30 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/compatible Jan 18 13:42:30 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/i2s-controller Jan 18 13:42:30 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/status Jan 18 13:42:30 volumio sudo[3445]: pam_unix(sudo:session): session closed for user root Jan 18 13:42:30 volumio volumio[951]: warn: Unable to locate the device HDMI Out a reboot may be required. Jan 18 13:42:31 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 18 13:42:31 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SMixer Jan 18 13:42:31 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 13:42:31 volumio volumio[951]: info: Found match in i2s Card Database: setting mixer Master for card HiFiBerry Amp Jan 18 13:42:31 volumio kernel: tas5713 1-001b: ASoC: error at soc_component_write_no_lock on tas5713.1-001b for register: [0x00000002] -5 Jan 18 13:42:31 volumio kernel: tas5713 1-001b: ASoC: error at snd_soc_component_probe on tas5713.1-001b: -5 Jan 18 13:42:31 volumio kernel: snd-rpi-simple soc:sound: ASoC: failed to instantiate card -5 Jan 18 13:42:31 volumio kernel: snd-rpi-simple soc:sound: Failed to register card -5 Jan 18 13:42:31 volumio kernel: snd-rpi-simple: probe of soc:sound failed with error -5 Jan 18 13:42:31 volumio volumio[951]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jan 18 13:42:31 volumio volumio[951]: info: Updating Volume Controller Parameters: Device: 2 Name: softvolume Mixer: Master Max Vol: 80 Vol Curve; logarithmic Vol Steps: 2 Jan 18 13:42:31 volumio volumio[951]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jan 18 13:42:31 volumio volumio[951]: info: Disabling external Volume Control Jan 18 13:42:31 volumio volumio[951]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 18 13:42:31 volumio volumio[951]: info: Enable softmixer device for audio device undefined Jan 18 13:42:31 volumio volumio[951]: info: ___________ PLUGINS: Run onVolumioReboot Tasks ___________ Jan 18 13:42:31 volumio volumio[951]: info: PLUGIN onReboot : networkfs Jan 18 13:42:31 volumio volumio[951]: info: PLUGIN onReboot : audiophonicsonoff Jan 18 13:42:31 volumio volumio[951]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 18 13:42:31 volumio volumio[951]: TypeError: Cannot read property 'writeSync' of undefined Jan 18 13:42:31 volumio volumio[951]: at ControllerAudiophonicsOnOff.onVolumioReboot (/data/plugins/system_controller/audiophonicsonoff/index.js:35:25) Jan 18 13:42:31 volumio volumio[951]: at PluginManager.onVolumioRebootPlugin (/volumio/app/pluginmanager.js:684:30) Jan 18 13:42:31 volumio volumio[951]: at HashMap. (/volumio/app/pluginmanager.js:668:31) Jan 18 13:42:31 volumio volumio[951]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Jan 18 13:42:31 volumio volumio[951]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Jan 18 13:42:31 volumio volumio[951]: at PluginManager.onVolumioReboot (/volumio/app/pluginmanager.js:666:20) Jan 18 13:42:31 volumio volumio[951]: at CoreCommandRouter.reboot (/volumio/app/index.js:1344:22) Jan 18 13:42:31 volumio volumio[951]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:864:33) Jan 18 13:42:31 volumio volumio[951]: at Socket.emit (events.js:315:20) Jan 18 13:42:31 volumio volumio[951]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Jan 18 13:42:31 volumio volumio[951]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Jan 18 13:42:31 volumio volumio[951]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 18 13:42:32 volumio volumio[3417]: Traceback (most recent call last): Jan 18 13:42:32 volumio volumio[3417]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 13, in Jan 18 13:42:32 volumio volumio[3417]: import ST7789 # v0.0.6 Jan 18 13:42:32 volumio volumio[3417]: ModuleNotFoundError: No module named 'ST7789' Jan 18 13:42:32 volumio systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Jan 18 13:42:32 volumio systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Jan 18 13:42:32 volumio systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Jan 18 13:42:32 volumio systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 29. Jan 18 13:42:32 volumio systemd[1]: Stopped Service for using pirate audio display in volumio. Jan 18 13:42:32 volumio systemd[1]: Started Service for using pirate audio display in volumio. Jan 18 13:42:35 volumio volumio-remote-updater[554]: [2025-01-18 13:42:35] [connect] Successful connection Jan 18 13:42:35 volumio volumio[3481]: Traceback (most recent call last): Jan 18 13:42:35 volumio volumio[3481]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 13, in Jan 18 13:42:35 volumio volumio[3481]: import ST7789 # v0.0.6 Jan 18 13:42:35 volumio volumio[3481]: ModuleNotFoundError: No module named 'ST7789' Jan 18 13:42:35 volumio systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Jan 18 13:42:35 volumio systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Jan 18 13:42:35 volumio systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Jan 18 13:42:35 volumio systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 30. Jan 18 13:42:35 volumio systemd[1]: Stopped Service for using pirate audio display in volumio. Jan 18 13:42:36 volumio systemd[1]: Started Service for using pirate audio display in volumio. Jan 18 13:42:36 volumio sudo[3484]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-18 13:41 Jan 18 13:42:36 volumio sudo[3484]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"