-- Logs begin at Mon 2025-03-03 16:31:09 -03, end at Mon 2025-03-03 16:36:50 -03. -- Mar 03 16:36:07 volumio-primo systemd-timedated[1896]: Changed local time to Mon Mar 3 16:36:07 2025 Mar 03 16:36:07 volumio-primo sudo[1851]: pam_unix(sudo:session): session closed for user root Mar 03 16:36:07 volumio-primo volumio-time-update[538]: volumio-time-update-util: System time updated successfully. Mar 03 16:36:07 volumio-primo systemd[1]: Started Volumio Time Update Utility. Mar 03 16:36:07 volumio-primo systemd[1]: Reached target Multi-User System. Mar 03 16:36:07 volumio-primo systemd[1]: Reached target Graphical Interface. Mar 03 16:36:07 volumio-primo systemd[1]: Starting Update UTMP about System Runlevel Changes... Mar 03 16:36:07 volumio-primo systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Mar 03 16:36:07 volumio-primo systemd[1]: Started Update UTMP about System Runlevel Changes. Mar 03 16:36:07 volumio-primo systemd[1]: Startup finished in 14.390s (kernel) + 23.552s (userspace) = 37.943s. Mar 03 16:36:07 volumio-primo lircd[1435]: lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:07 volumio-primo lircd[1435]: lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:07 volumio-primo lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:07 volumio-primo lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:07 volumio-primo volumio[851]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Mar 03 16:36:07 volumio-primo volumio[851]: info: Volumio called home Mar 03 16:36:07 volumio-primo nmbd[784]: [2025/03/03 16:36:07.787461, 0] ../source3/libsmb/nmblib.c:917(send_udp) Mar 03 16:36:07 volumio-primo nmbd[784]: Packet send failed to 169.254.255.255(138) ERRNO=Invalid argument Mar 03 16:36:07 volumio-primo ntpd[1904]: Soliciting pool server 5.178.87.93 Mar 03 16:36:08 volumio-primo lircd[1435]: lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:08 volumio-primo lircd[1435]: lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:08 volumio-primo lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:08 volumio-primo lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:08 volumio-primo nmbd[784]: [2025/03/03 16:36:08.788564, 0] ../source3/libsmb/nmblib.c:917(send_udp) Mar 03 16:36:08 volumio-primo nmbd[784]: Packet send failed to 169.254.255.255(138) ERRNO=Invalid argument Mar 03 16:36:08 volumio-primo ntpd[1904]: Soliciting pool server 80.93.187.13 Mar 03 16:36:08 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Mar 03 16:36:08 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Mar 03 16:36:08 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Mar 03 16:36:08 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Mar 03 16:36:08 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Mar 03 16:36:08 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Mar 03 16:36:08 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Mar 03 16:36:08 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Mar 03 16:36:08 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Mar 03 16:36:08 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Mar 03 16:36:08 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Mar 03 16:36:08 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Mar 03 16:36:08 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Mar 03 16:36:08 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Mar 03 16:36:08 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Mar 03 16:36:08 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Mar 03 16:36:08 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Mar 03 16:36:08 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Mar 03 16:36:08 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Mar 03 16:36:08 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Mar 03 16:36:08 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Mar 03 16:36:08 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Mar 03 16:36:08 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Mar 03 16:36:08 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Mar 03 16:36:08 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Mar 03 16:36:08 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Mar 03 16:36:08 volumio-primo volumio[851]: info: Adding plugin bluetooth to MyMusic Plugins Mar 03 16:36:08 volumio-primo volumio[851]: info: Adding plugin multiroom to MyMusic Plugins Mar 03 16:36:08 volumio-primo volumio[851]: info: Adding plugin metavolumio to MyMusic Plugins Mar 03 16:36:08 volumio-primo volumio[851]: info: Adding plugin cd_controller to MyMusic Plugins Mar 03 16:36:08 volumio-primo volumio[851]: info: Adding plugin smart_inputs to MyMusic Plugins Mar 03 16:36:08 volumio-primo volumio[851]: info: Adding plugin tidalconnect to MyMusic Plugins Mar 03 16:36:08 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Mar 03 16:36:08 volumio-primo ntpd[1904]: Soliciting pool server 193.106.93.116 Mar 03 16:36:09 volumio-primo lircd[1435]: lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:09 volumio-primo lircd[1435]: lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:09 volumio-primo lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:09 volumio-primo lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:09 volumio-primo ntpd[1904]: Soliciting pool server 194.67.201.38 Mar 03 16:36:09 volumio-primo ntpd[1904]: Soliciting pool server 5.178.87.15 Mar 03 16:36:09 volumio-primo ntpd[1904]: Soliciting pool server 178.217.98.201 Mar 03 16:36:10 volumio-primo lircd[1435]: lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:10 volumio-primo lircd[1435]: lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:10 volumio-primo lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:10 volumio-primo lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:10 volumio-primo volumio[851]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Mar 03 16:36:10 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Mar 03 16:36:10 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 03 16:36:10 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 03 16:36:10 volumio-primo volumio[851]: info: Starting MyVolumio Remote Streaming Endpoints Mar 03 16:36:10 volumio-primo volumio[851]: info: MyVolumio login type: Token Mar 03 16:36:10 volumio-primo volumio[851]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Mar 03 16:36:10 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Mar 03 16:36:10 volumio-primo ntpd[1904]: Soliciting pool server 51.250.110.169 Mar 03 16:36:10 volumio-primo ntpd[1904]: Soliciting pool server 195.90.182.235 Mar 03 16:36:10 volumio-primo ntpd[1904]: Soliciting pool server 89.109.251.25 Mar 03 16:36:10 volumio-primo ntpd[1904]: Soliciting pool server 192.36.143.130 Mar 03 16:36:11 volumio-primo lircd[1435]: lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:11 volumio-primo lircd[1435]: lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:11 volumio-primo lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:11 volumio-primo lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:11 volumio-primo volumio[851]: info: Starting Streaming Service Transparent Proxy Mar 03 16:36:11 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Mar 03 16:36:11 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Mar 03 16:36:11 volumio-primo volumio[851]: info: Streaming services startup Mar 03 16:36:11 volumio-primo volumio[851]: info: Starting Streaming Daemon Mar 03 16:36:11 volumio-primo ntpd[1904]: Soliciting pool server 217.170.87.229 Mar 03 16:36:11 volumio-primo ntpd[1904]: Soliciting pool server 2a00:1390:5:722b:1337:c0de:4:11 Mar 03 16:36:11 volumio-primo sudo[1949]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 03 16:36:11 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Mar 03 16:36:11 volumio-primo sudo[1949]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 16:36:11 volumio-primo sudo[1949]: pam_unix(sudo:session): session closed for user root Mar 03 16:36:12 volumio-primo lircd[1435]: lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:12 volumio-primo lircd[1435]: lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:12 volumio-primo lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:12 volumio-primo lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:12 volumio-primo volumio[851]: verbose: New Socket.io Connection to 192.168.1.118 from 192.168.1.39 UA: Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:109.0) Gecko/20100101 Firefox/115.0 Engine version: 3 Transport: polling Total Clients: 7 Mar 03 16:36:12 volumio-primo volumio[851]: verbose: New Socket.io Connection to 192.168.1.118 from 192.168.1.39 UA: Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:109.0) Gecko/20100101 Firefox/115.0 Engine version: 3 Transport: polling Total Clients: 8 Mar 03 16:36:12 volumio-primo volumio[851]: error: Cannot start Volumio Streaming Daemon Mar 03 16:36:12 volumio-primo volumio[851]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Mar 03 16:36:12 volumio-primo volumio[851]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Mar 03 16:36:12 volumio-primo volumio[851]: verbose: New Socket.io Connection to 192.168.1.118 from 192.168.1.39 UA: Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:109.0) Gecko/20100101 Firefox/115.0 Engine version: 3 Transport: polling Total Clients: 9 Mar 03 16:36:12 volumio-primo ntpd[1904]: Soliciting pool server 51.250.68.198 Mar 03 16:36:12 volumio-primo volumio[851]: verbose: New Socket.io Connection to 192.168.1.118 from 192.168.1.39 UA: Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:109.0) Gecko/20100101 Firefox/115.0 Engine version: 3 Transport: polling Total Clients: 10 Mar 03 16:36:12 volumio-primo volumio[851]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 11 Mar 03 16:36:13 volumio-primo lircd[1435]: lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:13 volumio-primo lircd[1435]: lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:13 volumio-primo lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:13 volumio-primo lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:13 volumio-primo volumio[851]: STREAMING PROXY: Starting server on port 3245 Mar 03 16:36:13 volumio-primo volumio[851]: Node JS runtime: 14 Mar 03 16:36:13 volumio-primo ntpd[1904]: Soliciting pool server 5.23.48.22 Mar 03 16:36:13 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 03 16:36:14 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Mar 03 16:36:14 volumio-primo lircd[1435]: lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:14 volumio-primo lircd[1435]: lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:14 volumio-primo lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:14 volumio-primo lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:14 volumio-primo volumio[851]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Mar 03 16:36:15 volumio-primo systemd[1]: systemd-fsckd.service: Succeeded. Mar 03 16:36:15 volumio-primo lircd[1435]: lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:15 volumio-primo lircd[1435]: lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:15 volumio-primo lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:15 volumio-primo lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:17 volumio-primo ntpd[1904]: receive: Unexpected origin timestamp 0xeb70832f.d2caa2bf does not match aorg 0000000000.00000000 from server@192.36.143.130 xmt 0xeb708331.070a807b Mar 03 16:36:17 volumio-primo lircd[1435]: lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:17 volumio-primo lircd[1435]: lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:17 volumio-primo lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:17 volumio-primo lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:18 volumio-primo systemd[1]: systemd-hostnamed.service: Succeeded. Mar 03 16:36:18 volumio-primo lircd[1435]: lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:18 volumio-primo lircd[1435]: lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:18 volumio-primo lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:18 volumio-primo lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:19 volumio-primo lircd[1435]: lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:19 volumio-primo lircd[1435]: lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:19 volumio-primo lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:19 volumio-primo lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:20 volumio-primo volumio[851]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 12 Mar 03 16:36:20 volumio-primo volumio[851]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 13 Mar 03 16:36:20 volumio-primo volumio[851]: verbose: New Socket.io Connection to 192.168.1.118 from 192.168.1.39 UA: Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:109.0) Gecko/20100101 Firefox/115.0 Engine version: 3 Transport: polling Total Clients: 14 Mar 03 16:36:20 volumio-primo volumio[851]: info: MyVolumio token set successfully Mar 03 16:36:20 volumio-primo volumio[851]: info: MYVOLUMIO: Adding device Mar 03 16:36:20 volumio-primo volumio[851]: info: MYVOLUMIO: Evaluating Server Mar 03 16:36:20 volumio-primo lircd[1435]: lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:20 volumio-primo lircd[1435]: lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:20 volumio-primo lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:20 volumio-primo lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:20 volumio-primo volumio[851]: info: MyVolumio Plan changed: superstar Mar 03 16:36:20 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Subscribed plan changed to superstar Mar 03 16:36:20 volumio-primo volumio[851]: info: Adding audio output: Mar 03 16:36:20 volumio-primo volumio[851]: info: MYVOLUMIO: Adding device Mar 03 16:36:20 volumio-primo volumio[851]: info: MYVOLUMIO: Evaluating Server Mar 03 16:36:20 volumio-primo volumio[851]: info: Remote config written successfully Mar 03 16:36:20 volumio-primo volumio[851]: info: Starting Tunnel 1 Mar 03 16:36:20 volumio-primo volumio[851]: info: Starting Tunnel Connection Checker Mar 03 16:36:20 volumio-primo volumio[851]: info: Completed starting MyVolumio Plugin Mar 03 16:36:21 volumio-primo volumio[851]: info: MYVolumio Device enabled Mar 03 16:36:21 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Mar 03 16:36:21 volumio-primo volumio[851]: info: MyVolumio status changed Mar 03 16:36:21 volumio-primo volumio[851]: info: Streaming services startup Mar 03 16:36:21 volumio-primo volumio[851]: info: Starting Streaming Daemon Mar 03 16:36:21 volumio-primo sudo[2020]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 03 16:36:21 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Mar 03 16:36:21 volumio-primo sudo[2020]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 16:36:21 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Mar 03 16:36:21 volumio-primo sudo[2020]: pam_unix(sudo:session): session closed for user root Mar 03 16:36:21 volumio-primo volumio[851]: info: [1741030581430] Starting BluetoothController Mar 03 16:36:21 volumio-primo lircd[1435]: lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:21 volumio-primo lircd[1435]: lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:21 volumio-primo lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:21 volumio-primo lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:21 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Mar 03 16:36:22 volumio-primo lircd[1435]: lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:22 volumio-primo lircd[1435]: lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:22 volumio-primo lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:22 volumio-primo lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:22 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom Mar 03 16:36:22 volumio-primo sudo[2033]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Mar 03 16:36:22 volumio-primo sudo[2033]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 16:36:22 volumio-primo sudo[2033]: pam_unix(sudo:session): session closed for user root Mar 03 16:36:22 volumio-primo volumio[851]: info: MRS: MultiRoom plugin initialized Mar 03 16:36:22 volumio-primo volumio[851]: info: MRS: STOPPING SNAPCLIENT Mar 03 16:36:22 volumio-primo volumio[851]: info: MRS: Snap server stop Mar 03 16:36:22 volumio-primo volumio[851]: info: MRS: STOPPING volumioStreaming Mar 03 16:36:22 volumio-primo sudo[2056]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Mar 03 16:36:22 volumio-primo sudo[2059]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Mar 03 16:36:22 volumio-primo sudo[2056]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 16:36:22 volumio-primo sudo[2059]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 16:36:23 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Mar 03 16:36:23 volumio-primo sudo[2066]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Mar 03 16:36:23 volumio-primo sudo[2066]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 16:36:23 volumio-primo sudo[2073]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Mar 03 16:36:23 volumio-primo sudo[2073]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 16:36:23 volumio-primo sudo[2073]: pam_unix(sudo:session): session closed for user root Mar 03 16:36:23 volumio-primo sudo[2056]: pam_unix(sudo:session): session closed for user root Mar 03 16:36:23 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Mar 03 16:36:23 volumio-primo sudo[2059]: pam_unix(sudo:session): session closed for user root Mar 03 16:36:23 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Mar 03 16:36:23 volumio-primo sudo[2066]: pam_unix(sudo:session): session closed for user root Mar 03 16:36:23 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Mar 03 16:36:23 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Mar 03 16:36:23 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio Mar 03 16:36:23 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Mar 03 16:36:23 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Mar 03 16:36:23 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Mar 03 16:36:23 volumio-primo volumio[851]: info: Preparing to generate the ALSA configuration file Mar 03 16:36:23 volumio-primo volumio[851]: info: Setting Geolocation for MyVolumio to eu10 Mar 03 16:36:23 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 03 16:36:23 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 03 16:36:23 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 03 16:36:23 volumio-primo volumio[851]: info: Setting Geolocation for MyVolumio to eu10 Mar 03 16:36:23 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 03 16:36:23 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 03 16:36:23 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 03 16:36:23 volumio-primo volumio[851]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 15 Mar 03 16:36:23 volumio-primo volumio[851]: info: MRS: Removed streaming files Mar 03 16:36:23 volumio-primo volumio[851]: info: MRS: volumioStreaming STOPPED Mar 03 16:36:23 volumio-primo volumio[851]: info: MRS: SNAPSERVER STOPPED Mar 03 16:36:23 volumio-primo volumio[851]: info: MRS: SNAPCLIENT STOPPED Mar 03 16:36:23 volumio-primo volumio[851]: error: Cannot start Volumio Streaming Daemon Mar 03 16:36:23 volumio-primo volumio[851]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Mar 03 16:36:23 volumio-primo volumio[851]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Mar 03 16:36:23 volumio-primo lircd[1435]: lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:23 volumio-primo lircd[1435]: lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:23 volumio-primo lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:23 volumio-primo lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:23 volumio-primo volumio[851]: info: Asound.conf file unchanged, so no further update is needed Mar 03 16:36:23 volumio-primo volumio[851]: info: Output device has changed, restarting MPD Mar 03 16:36:23 volumio-primo volumio[851]: info: Output device has changed, restarting Shairport Sync Mar 03 16:36:23 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 16:36:23 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 03 16:36:23 volumio-primo sudo[2098]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 03 16:36:23 volumio-primo sudo[2096]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 03 16:36:23 volumio-primo sudo[2098]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 16:36:23 volumio-primo sudo[2096]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 16:36:23 volumio-primo sudo[2096]: pam_unix(sudo:session): session closed for user root Mar 03 16:36:23 volumio-primo systemd[1]: Stopping Music Player Daemon... Mar 03 16:36:23 volumio-primo volumio[851]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Mar 03 16:36:23 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 16:36:23 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth Mar 03 16:36:23 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 03 16:36:23 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom Mar 03 16:36:23 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Plugin multiroom disabled by user. Not starting Mar 03 16:36:23 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio Mar 03 16:36:23 volumio-primo volumio[851]: info: Adding METAVOLUMIO REST API Endpoints Mar 03 16:36:23 volumio-primo volumio[851]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Mar 03 16:36:23 volumio-primo volumio[851]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Mar 03 16:36:23 volumio-primo volumio[851]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Mar 03 16:36:23 volumio-primo volumio[851]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Mar 03 16:36:23 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui Mar 03 16:36:23 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller Mar 03 16:36:23 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Plugin cd_controller disabled by user. Not starting Mar 03 16:36:23 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs Mar 03 16:36:23 volumio-primo volumio[851]: info: Adding inputs REST Endpoints Mar 03 16:36:23 volumio-primo volumio[851]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Mar 03 16:36:23 volumio-primo volumio[851]: info: Scanning Audio Inputs Mar 03 16:36:23 volumio-primo sudo[2119]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name Volumio Primo Mar 03 16:36:23 volumio-primo sudo[2119]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 16:36:23 volumio-primo volumio[851]: info: Checking against Known Cards name Mar 03 16:36:23 volumio-primo volumio[851]: info: Checking against Known Cards name Mar 03 16:36:23 volumio-primo volumio[851]: info: Checking against Known Cards name Mar 03 16:36:23 volumio-primo volumio[851]: info: Adding Server instance for streaming Mar 03 16:36:23 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio Mar 03 16:36:23 volumio-primo systemd[1]: mpd.service: Succeeded. Mar 03 16:36:23 volumio-primo systemd[1]: Stopped Music Player Daemon. Mar 03 16:36:23 volumio-primo systemd[1]: Starting Music Player Daemon... Mar 03 16:36:23 volumio-primo volumio[851]: error: Hi Res Audio Failed Login: Missing Login Data Mar 03 16:36:23 volumio-primo volumio[851]: info: Adding HIGHRESAUDIO REST API Endpoints Mar 03 16:36:23 volumio-primo volumio[851]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Mar 03 16:36:23 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal Mar 03 16:36:23 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz Mar 03 16:36:23 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect Mar 03 16:36:23 volumio-primo volumio[851]: info: [MyVolumio PluginManager] Plugin tidalconnect disabled by user. Not starting Mar 03 16:36:23 volumio-primo volumio[851]: info: Stopping AccessToken refresher cron Mar 03 16:36:23 volumio-primo volumio[851]: info: AccessToken refresher cron started Mar 03 16:36:23 volumio-primo volumio[851]: info: Stopping AccessToken refresher cron for QOBUZ Mar 03 16:36:23 volumio-primo volumio[851]: info: AccessToken refresher cron started for QOBUZ Mar 03 16:36:23 volumio-primo volumio[851]: info: Adding TIDAL REST API Endpoints Mar 03 16:36:23 volumio-primo volumio[851]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal Mar 03 16:36:23 volumio-primo volumio[851]: info: Adding QOBUZ REST API Endpoints Mar 03 16:36:23 volumio-primo volumio[851]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Mar 03 16:36:23 volumio-primo sudo[2127]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 03 16:36:23 volumio-primo volumio[851]: [Metrics] CommandRouter: 32s 172.28ms Mar 03 16:36:23 volumio-primo volumio[851]: info: CoreCommandRouter::volumiosetStartupVolume Mar 03 16:36:23 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 16:36:23 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 03 16:36:23 volumio-primo sudo[2127]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 16:36:23 volumio-primo volumio[851]: info: CoreCommandRouter::Close All Modals sent Mar 03 16:36:23 volumio-primo volumio[851]: info: CoreCommandRouter::Close All Modals sent Mar 03 16:36:23 volumio-primo sudo[2127]: pam_unix(sudo:session): session closed for user root Mar 03 16:36:23 volumio-primo volumio[851]: info: MPD Permissions set Mar 03 16:36:23 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 16:36:23 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 16:36:23 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 16:36:23 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 16:36:23 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 16:36:23 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 16:36:23 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 16:36:23 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 16:36:23 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 03 16:36:23 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Mar 03 16:36:23 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 16:36:24 volumio-primo sudo[2119]: pam_unix(sudo:session): session closed for user root Mar 03 16:36:24 volumio-primo volumio[851]: info: Bluetooth name changed to Volumio Primo Mar 03 16:36:24 volumio-primo volumio[851]: info: Starting Shairport Sync Mar 03 16:36:24 volumio-primo volumio[851]: info: CoreCommandRouter::volumioGetState Mar 03 16:36:24 volumio-primo volumio[851]: info: CorePlayQueue::getTrack 0 Mar 03 16:36:24 volumio-primo volumio[851]: info: CoreCommandRouter::volumioPause Mar 03 16:36:24 volumio-primo volumio[851]: info: CoreStateMachine::pause Mar 03 16:36:24 volumio-primo volumio[851]: info: mpdhttpout --- Volumio set on pause Mar 03 16:36:24 volumio-primo volumio[851]: info: mpdhttpout ---Configuration successfully added to mpd.conf. Mar 03 16:36:24 volumio-primo sudo[2149]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 03 16:36:24 volumio-primo sudo[2149]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 16:36:24 volumio-primo systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 03 16:36:24 volumio-primo systemd[1]: shairport-sync.service: Succeeded. Mar 03 16:36:24 volumio-primo systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 03 16:36:24 volumio-primo systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 03 16:36:24 volumio-primo sudo[2149]: pam_unix(sudo:session): session closed for user root Mar 03 16:36:24 volumio-primo volumio[851]: info: Shairport-Sync Started Mar 03 16:36:24 volumio-primo volumio[851]: info: Updating MyVolumio device info Mar 03 16:36:24 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 03 16:36:24 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 03 16:36:24 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 03 16:36:24 volumio-primo volumio[851]: info: Updating MyVolumio device info Mar 03 16:36:24 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 03 16:36:24 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 03 16:36:24 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 03 16:36:24 volumio-primo volumio[1704]: .............................................................................................................................................................................................................................................................++++ Mar 03 16:36:24 volumio-primo lircd[1435]: lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:24 volumio-primo lircd[1435]: lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:24 volumio-primo lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:24 volumio-primo lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:24 volumio-primo volumio[851]: info: Successfully Added MyVolumio device Mar 03 16:36:24 volumio-primo volumio[851]: verbose: New Socket.io Connection to 192.168.1.118 from 192.168.1.39 UA: Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:109.0) Gecko/20100101 Firefox/115.0 Engine version: 3 Transport: polling Total Clients: 16 Mar 03 16:36:24 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 03 16:36:24 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:24 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:24 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:24 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:24 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:24 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:24 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 03 16:36:24 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 03 16:36:24 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 03 16:36:24 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 03 16:36:24 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 03 16:36:24 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 03 16:36:24 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 03 16:36:24 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 03 16:36:24 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 03 16:36:24 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 03 16:36:24 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 03 16:36:24 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 03 16:36:24 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 03 16:36:24 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 03 16:36:24 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 03 16:36:24 volumio-primo volumio[851]: info: CoreCommandRouter::volumioGetVisibleSources Mar 03 16:36:24 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 03 16:36:24 volumio-primo volumio[851]: info: CoreCommandRouter::volumioGetState Mar 03 16:36:24 volumio-primo volumio[851]: info: CorePlayQueue::getTrack 0 Mar 03 16:36:24 volumio-primo volumio[851]: info: CoreCommandRouter::volumioGetState Mar 03 16:36:24 volumio-primo volumio[851]: info: CorePlayQueue::getTrack 0 Mar 03 16:36:24 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 03 16:36:24 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 03 16:36:24 volumio-primo volumio[851]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Mar 03 16:36:24 volumio-primo volumio[851]: info: Received Get System Info Mar 03 16:36:24 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 03 16:36:24 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 03 16:36:24 volumio-primo volumio[851]: info: Discovery: Getting this device information Mar 03 16:36:24 volumio-primo volumio[851]: info: CoreCommandRouter::volumioGetState Mar 03 16:36:24 volumio-primo volumio[851]: info: CorePlayQueue::getTrack 0 Mar 03 16:36:24 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 03 16:36:24 volumio-primo volumio[851]: info: CoreCommandRouter::volumioGetState Mar 03 16:36:24 volumio-primo volumio[851]: info: CorePlayQueue::getTrack 0 Mar 03 16:36:24 volumio-primo volumio[851]: info: Listing playlists Mar 03 16:36:24 volumio-primo volumio[851]: info: CoreCommandRouter::volumioGetQueue Mar 03 16:36:24 volumio-primo volumio[851]: info: CoreStateMachine::getQueue Mar 03 16:36:24 volumio-primo volumio[851]: info: CorePlayQueue::getQueue Mar 03 16:36:24 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:24 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:24 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:24 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:24 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:24 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:24 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:24 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:24 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:24 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:24 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:24 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:24 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:24 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:24 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:24 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:24 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:24 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:24 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:24 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:24 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:24 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:24 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:24 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:24 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:24 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:24 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:24 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:24 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:24 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:24 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:24 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:24 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:24 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:24 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:24 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:24 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:24 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:24 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:24 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:24 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:24 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:24 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:24 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:24 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:24 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:24 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:24 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:24 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:24 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:24 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:24 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:24 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:24 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:24 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:24 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:24 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:24 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:24 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:24 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:24 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:24 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:24 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:24 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:24 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:24 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:24 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:24 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:24 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:24 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:24 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:24 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:24 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:24 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:24 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:24 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:24 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:24 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:24 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:24 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:24 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:24 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:24 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:24 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:24 volumio-primo volumio[851]: info: Successfully Added MyVolumio device Mar 03 16:36:24 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Mar 03 16:36:24 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Mar 03 16:36:24 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 03 16:36:24 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Mar 03 16:36:24 volumio-primo volumio[851]: info: Successfully Updated MyVolumio device Mar 03 16:36:25 volumio-primo volumio[851]: info: Successfully Updated MyVolumio device Mar 03 16:36:25 volumio-primo volumio[851]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 17 Mar 03 16:36:25 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 03 16:36:25 volumio-primo volumio[851]: info: CoreCommandRouter::volumioGetVisibleSources Mar 03 16:36:25 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 03 16:36:25 volumio-primo volumio[851]: info: CoreCommandRouter::volumioGetState Mar 03 16:36:25 volumio-primo volumio[851]: info: CorePlayQueue::getTrack 0 Mar 03 16:36:25 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 03 16:36:25 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 03 16:36:25 volumio-primo volumio[851]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Mar 03 16:36:25 volumio-primo volumio[851]: info: Received Get System Info Mar 03 16:36:25 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 03 16:36:25 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 03 16:36:25 volumio-primo volumio[851]: info: Discovery: Getting this device information Mar 03 16:36:25 volumio-primo volumio[851]: info: CoreCommandRouter::volumioGetState Mar 03 16:36:25 volumio-primo volumio[851]: info: CorePlayQueue::getTrack 0 Mar 03 16:36:25 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 03 16:36:25 volumio-primo volumio[851]: info: CoreCommandRouter::volumioGetState Mar 03 16:36:25 volumio-primo volumio[851]: info: CorePlayQueue::getTrack 0 Mar 03 16:36:25 volumio-primo volumio[851]: info: Listing playlists Mar 03 16:36:25 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 03 16:36:25 volumio-primo volumio[851]: info: Received Get System Info Mar 03 16:36:25 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 03 16:36:25 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 03 16:36:25 volumio-primo volumio[851]: info: Discovery: Getting this device information Mar 03 16:36:25 volumio-primo volumio[851]: info: CoreCommandRouter::volumioGetState Mar 03 16:36:25 volumio-primo volumio[851]: info: CorePlayQueue::getTrack 0 Mar 03 16:36:25 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 03 16:36:25 volumio-primo volumio[851]: info: CoreCommandRouter::volumioGetState Mar 03 16:36:25 volumio-primo volumio[851]: info: CorePlayQueue::getTrack 0 Mar 03 16:36:25 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 03 16:36:25 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 03 16:36:25 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 03 16:36:25 volumio-primo volumio[851]: info: Received Get System Info Mar 03 16:36:25 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 03 16:36:25 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 03 16:36:25 volumio-primo volumio[851]: info: Discovery: Getting this device information Mar 03 16:36:25 volumio-primo volumio[851]: info: CoreCommandRouter::volumioGetState Mar 03 16:36:25 volumio-primo volumio[851]: info: CorePlayQueue::getTrack 0 Mar 03 16:36:25 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 03 16:36:25 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 03 16:36:25 volumio-primo volumio[851]: info: CoreCommandRouter::volumioGetVisibleSources Mar 03 16:36:25 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 03 16:36:25 volumio-primo volumio[851]: info: CoreCommandRouter::volumioGetState Mar 03 16:36:25 volumio-primo volumio[851]: info: CorePlayQueue::getTrack 0 Mar 03 16:36:25 volumio-primo volumio[851]: info: CoreCommandRouter::volumioGetState Mar 03 16:36:25 volumio-primo volumio[851]: info: CorePlayQueue::getTrack 0 Mar 03 16:36:25 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 03 16:36:25 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 03 16:36:25 volumio-primo volumio[851]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Mar 03 16:36:25 volumio-primo volumio[851]: info: Received Get System Info Mar 03 16:36:25 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 03 16:36:25 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 03 16:36:25 volumio-primo volumio[851]: info: Discovery: Getting this device information Mar 03 16:36:25 volumio-primo volumio[851]: info: CoreCommandRouter::volumioGetState Mar 03 16:36:25 volumio-primo volumio[851]: info: CorePlayQueue::getTrack 0 Mar 03 16:36:25 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 03 16:36:25 volumio-primo volumio[851]: info: CoreCommandRouter::volumioGetState Mar 03 16:36:25 volumio-primo volumio[851]: info: CorePlayQueue::getTrack 0 Mar 03 16:36:25 volumio-primo volumio[851]: info: Listing playlists Mar 03 16:36:25 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Mar 03 16:36:25 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Mar 03 16:36:25 volumio-primo lircd[1435]: lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:25 volumio-primo lircd[1435]: lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:25 volumio-primo lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:25 volumio-primo lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:25 volumio-primo mpd[2143]: Mar 03 16:36 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 03 16:36:25 volumio-primo systemd[1]: Started Music Player Daemon. Mar 03 16:36:25 volumio-primo sudo[2098]: pam_unix(sudo:session): session closed for user root Mar 03 16:36:25 volumio-primo sudo[2188]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Mar 03 16:36:25 volumio-primo sudo[2188]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 16:36:25 volumio-primo volumio[851]: error: updateQueue error: null Mar 03 16:36:25 volumio-primo systemd[1]: Started MyVolumio SSH Tunnel. Mar 03 16:36:25 volumio-primo sudo[2188]: pam_unix(sudo:session): session closed for user root Mar 03 16:36:26 volumio-primo autossh[2199]: port set to 0, monitoring disabled Mar 03 16:36:26 volumio-primo autossh[2199]: starting ssh (count 1) Mar 03 16:36:26 volumio-primo autossh[2199]: ssh child pid is 2204 Mar 03 16:36:26 volumio-primo volumio[851]: info: Remote SSH Started Mar 03 16:36:26 volumio-primo volumio[851]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 18 Mar 03 16:36:26 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Mar 03 16:36:26 volumio-primo sudo[2206]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 03 16:36:26 volumio-primo volumiossh-tunnel[2197]: Warning: Permanently added '[eu10.myvolumio.org]:2222,[46.101.141.203]:2222' (RSA) to the list of known hosts. Mar 03 16:36:26 volumio-primo volumio[851]: info: CoreCommandRouter::volumioGetState Mar 03 16:36:26 volumio-primo volumio[851]: info: CorePlayQueue::getTrack 0 Mar 03 16:36:26 volumio-primo sudo[2206]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 16:36:26 volumio-primo systemd[1]: Stopping Music Player Daemon... Mar 03 16:36:26 volumio-primo systemd[1]: mpd.service: Succeeded. Mar 03 16:36:26 volumio-primo systemd[1]: Stopped Music Player Daemon. Mar 03 16:36:26 volumio-primo systemd[1]: Starting Music Player Daemon... Mar 03 16:36:26 volumio-primo lircd[1435]: lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:26 volumio-primo lircd[1435]: lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:26 volumio-primo lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:26 volumio-primo lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:26 volumio-primo sudo[2212]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 03 16:36:26 volumio-primo sudo[2212]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 16:36:26 volumio-primo sudo[2212]: pam_unix(sudo:session): session closed for user root Mar 03 16:36:26 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 03 16:36:26 volumio-primo volumio[851]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 19 Mar 03 16:36:26 volumio-primo volumio[1704]: ...................................++++ Mar 03 16:36:26 volumio-primo volumio[1704]: e is 65537 (0x010001) Mar 03 16:36:26 volumio-primo volumio[1704]: writing RSA key Mar 03 16:36:26 volumio-primo sudo[2224]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Mar 03 16:36:26 volumio-primo sudo[2224]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 16:36:26 volumio-primo systemd[1]: Started Volumio Bluetooth Module. Mar 03 16:36:26 volumio-primo volumio[851]: info: CoreCommandRouter::volumioGetState Mar 03 16:36:26 volumio-primo volumio[851]: info: CorePlayQueue::getTrack 0 Mar 03 16:36:26 volumio-primo sudo[2224]: pam_unix(sudo:session): session closed for user root Mar 03 16:36:26 volumio-primo sudo[2234]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/* Mar 03 16:36:26 volumio-primo volumio[851]: info: Volumio BT Module successfully started Mar 03 16:36:26 volumio-primo sudo[2234]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 16:36:26 volumio-primo volumiobt[2232]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory Mar 03 16:36:26 volumio-primo sudo[2234]: pam_unix(sudo:session): session closed for user root Mar 03 16:36:27 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Mar 03 16:36:27 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 03 16:36:27 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 03 16:36:27 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 03 16:36:27 volumio-primo lircd[1435]: lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:27 volumio-primo lircd[1435]: lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:27 volumio-primo lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:27 volumio-primo lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:27 volumio-primo volumio[851]: info: Executing endpoint metavolumio Mar 03 16:36:27 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 03 16:36:27 volumio-primo volumio[851]: info: Executing endpoint metavolumio Mar 03 16:36:27 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 03 16:36:27 volumio-primo volumio[851]: info: Executing endpoint metavolumio Mar 03 16:36:27 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 03 16:36:27 volumio-primo volumio-remote-updater[533]: No test mode Mar 03 16:36:27 volumio-primo volumio-remote-updater[533]: No alpha test mode Mar 03 16:36:27 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Mar 03 16:36:27 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 03 16:36:27 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 03 16:36:27 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:27 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:27 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:27 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:27 volumio-primo volumio[851]: error: MPD error: Error: This socket has been ended by the other party Mar 03 16:36:27 volumio-primo volumio[851]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 03 16:36:27 volumio-primo volumio[851]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Mar 03 16:36:27 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 03 16:36:27 volumio-primo mpd[2221]: Mar 03 16:36 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 03 16:36:27 volumio-primo sudo[2249]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio Mar 03 16:36:27 volumio-primo sudo[2249]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 16:36:27 volumio-primo volumiobt[2232]: pulseaudio: no process found Mar 03 16:36:27 volumio-primo sudo[2249]: pam_unix(sudo:session): session closed for user root Mar 03 16:36:27 volumio-primo systemd[1]: Started Music Player Daemon. Mar 03 16:36:27 volumio-primo sudo[2206]: pam_unix(sudo:session): session closed for user root Mar 03 16:36:28 volumio-primo volumio[851]: error: updateQueue error: null Mar 03 16:36:28 volumio-primo dbus-daemon[545]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.21' (uid=1000 pid=2265 comm="/usr/bin/pulseaudio --high-priority=true ") Mar 03 16:36:28 volumio-primo systemd[1]: Starting RealtimeKit Scheduling Policy Service... Mar 03 16:36:28 volumio-primo kernel: IPVS: Creating netns size=1496 id=3 Mar 03 16:36:28 volumio-primo kernel: IPVS: ftp: loaded support on port[0] = 21 Mar 03 16:36:28 volumio-primo volumio[851]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 03 16:36:28 volumio-primo dbus-daemon[545]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1' Mar 03 16:36:28 volumio-primo systemd[1]: Started RealtimeKit Scheduling Policy Service. Mar 03 16:36:28 volumio-primo rtkit-daemon[2266]: Successfully called chroot. Mar 03 16:36:28 volumio-primo rtkit-daemon[2266]: Successfully dropped privileges. Mar 03 16:36:28 volumio-primo rtkit-daemon[2266]: Successfully limited resources. Mar 03 16:36:28 volumio-primo rtkit-daemon[2266]: Running. Mar 03 16:36:28 volumio-primo rtkit-daemon[2266]: Watchdog thread running. Mar 03 16:36:28 volumio-primo rtkit-daemon[2266]: Canary thread running. Mar 03 16:36:28 volumio-primo dbus-daemon[545]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.22' (uid=0 pid=2266 comm="/usr/lib/rtkit/rtkit-daemon ") Mar 03 16:36:28 volumio-primo systemd[1]: Starting Authorization Manager... Mar 03 16:36:28 volumio-primo volumio[851]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 03 16:36:28 volumio-primo polkitd[2270]: started daemon version 0.105 using authority implementation `local' version `0.105' Mar 03 16:36:28 volumio-primo dbus-daemon[545]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Mar 03 16:36:28 volumio-primo systemd[1]: Started Authorization Manager. Mar 03 16:36:28 volumio-primo pulseaudio[2265]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Mar 03 16:36:28 volumio-primo pulseaudio[2265]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Mar 03 16:36:28 volumio-primo volumiobt[2232]: Applying permissions Mar 03 16:36:28 volumio-primo volumiobt[2232]: Setting BT discoverable and pairable Mar 03 16:36:28 volumio-primo bluetoothd[584]: Endpoint registered: sender=:1.42 path=/MediaEndpoint/A2DPSource Mar 03 16:36:28 volumio-primo bluetoothd[584]: Endpoint registered: sender=:1.42 path=/MediaEndpoint/A2DPSink Mar 03 16:36:28 volumio-primo pulseaudio[2265]: Failed to register as a handsfree audio agent with ofono: org.freedesktop.DBus.Error.ServiceUnknown: The name org.ofono was not provided by any .service files Mar 03 16:36:28 volumio-primo volumiobt[2232]: Agent registered Mar 03 16:36:28 volumio-primo volumiobt[2232]: [bluetooth]# -e power on Mar 03 16:36:28 volumio-primo volumiobt[2232]: Invalid command in menu main: -e Mar 03 16:36:28 volumio-primo volumiobt[2232]: Mar 03 16:36:28 volumio-primo volumiobt[2232]: Use "help" for a list of available commands in a menu. Mar 03 16:36:28 volumio-primo volumiobt[2232]: Use "menu " if you want to enter any submenu. Mar 03 16:36:28 volumio-primo volumiobt[2232]: Use "back" if you want to return to menu main. Mar 03 16:36:28 volumio-primo volumiobt[2232]: [bluetooth]# agent on Mar 03 16:36:28 volumio-primo volumiobt[2232]: Agent is already registered Mar 03 16:36:28 volumio-primo volumiobt[2232]: [bluetooth]# discoverable on Mar 03 16:36:28 volumio-primo volumiobt[2232]: [bluetooth]# pairable on Mar 03 16:36:28 volumio-primo volumiobt[2232]: [bluetooth]# agent NoInputNoOutput Mar 03 16:36:28 volumio-primo volumiobt[2232]: Agent is already registered Mar 03 16:36:28 volumio-primo volumiobt[2232]: [bluetooth]# default-agent Mar 03 16:36:28 volumio-primo volumiobt[2232]: [bluetooth]# quit Mar 03 16:36:28 volumio-primo volumiobt[2232]: [59B blob data] Mar 03 16:36:28 volumio-primo lircd[1435]: lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:28 volumio-primo lircd[1435]: lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:28 volumio-primo lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:28 volumio-primo lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:29 volumio-primo lircd[1435]: lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:29 volumio-primo lircd[1435]: lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:29 volumio-primo lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:29 volumio-primo lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:30 volumio-primo lircd[1435]: lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:30 volumio-primo lircd[1435]: lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:30 volumio-primo lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:30 volumio-primo lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:30 volumio-primo volumio[851]: info: BOOT COMPLETED Mar 03 16:36:31 volumio-primo volumio[851]: info: mpdhttpout ---Boot completed detected! Patching mpd now! Mar 03 16:36:31 volumio-primo volumio[851]: info: mpdhttpout ---Configuration successfully replaced in mpd.conf. Mar 03 16:36:31 volumio-primo volumio[851]: info: CoreCommandRouter::volumioGetState Mar 03 16:36:31 volumio-primo volumio[851]: info: CorePlayQueue::getTrack 0 Mar 03 16:36:31 volumio-primo volumio[851]: info: CoreCommandRouter::volumioPause Mar 03 16:36:31 volumio-primo volumio[851]: info: CoreStateMachine::pause Mar 03 16:36:31 volumio-primo volumio[851]: info: mpdhttpout --- Volumio set on pause Mar 03 16:36:31 volumio-primo lircd[1435]: lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:31 volumio-primo lircd[1435]: lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:31 volumio-primo lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:31 volumio-primo lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:31 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 03 16:36:31 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 16:36:31 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 16:36:31 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Mar 03 16:36:31 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Mar 03 16:36:31 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 03 16:36:31 volumio-primo volumio[851]: info: CoreCommandRouter::volumioGetBrowseSources Mar 03 16:36:31 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 03 16:36:32 volumio-primo lircd[1435]: lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:32 volumio-primo lircd[1435]: lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:32 volumio-primo lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:32 volumio-primo lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:33 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Mar 03 16:36:33 volumio-primo sudo[2286]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 03 16:36:33 volumio-primo sudo[2286]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 16:36:33 volumio-primo systemd[1]: Stopping Music Player Daemon... Mar 03 16:36:33 volumio-primo lircd[1435]: lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:33 volumio-primo lircd[1435]: lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:33 volumio-primo lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:33 volumio-primo lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:33 volumio-primo volumio[851]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 03 16:36:33 volumio-primo systemd[1]: mpd.service: Succeeded. Mar 03 16:36:33 volumio-primo systemd[1]: Stopped Music Player Daemon. Mar 03 16:36:33 volumio-primo volumio[851]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 03 16:36:33 volumio-primo systemd[1]: Starting Music Player Daemon... Mar 03 16:36:33 volumio-primo volumio[851]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 03 16:36:33 volumio-primo sudo[2292]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 03 16:36:33 volumio-primo sudo[2292]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 16:36:33 volumio-primo sudo[2292]: pam_unix(sudo:session): session closed for user root Mar 03 16:36:34 volumio-primo lircd[1435]: lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:34 volumio-primo lircd[1435]: lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:34 volumio-primo lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:34 volumio-primo lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:34 volumio-primo mpd[2301]: Mar 03 16:36 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 03 16:36:34 volumio-primo systemd[1]: Started Music Player Daemon. Mar 03 16:36:34 volumio-primo sudo[2286]: pam_unix(sudo:session): session closed for user root Mar 03 16:36:34 volumio-primo volumio[851]: error: updateQueue error: null Mar 03 16:36:35 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 03 16:36:35 volumio-primo volumio[851]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Mar 03 16:36:35 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Mar 03 16:36:35 volumio-primo volumio[851]: info: Received Get System Version Mar 03 16:36:35 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 03 16:36:35 volumio-primo volumio[851]: info: Received Get System Info Mar 03 16:36:35 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 03 16:36:35 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 03 16:36:35 volumio-primo volumio[851]: info: Discovery: Getting this device information Mar 03 16:36:35 volumio-primo volumio[851]: info: CoreCommandRouter::volumioGetState Mar 03 16:36:35 volumio-primo volumio[851]: info: CorePlayQueue::getTrack 0 Mar 03 16:36:35 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 03 16:36:35 volumio-primo lircd[1435]: lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:35 volumio-primo lircd[1435]: lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:35 volumio-primo lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:35 volumio-primo lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:35 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 03 16:36:36 volumio-primo lircd[1435]: lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:36 volumio-primo lircd[1435]: lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:36 volumio-primo lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:36 volumio-primo lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:37 volumio-primo lircd[1435]: lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:37 volumio-primo lircd[1435]: lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:37 volumio-primo lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:37 volumio-primo lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:38 volumio-primo systemd[1]: systemd-timedated.service: Succeeded. Mar 03 16:36:38 volumio-primo lircd[1435]: lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:38 volumio-primo lircd[1435]: lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:38 volumio-primo lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:38 volumio-primo lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:39 volumio-primo lircd[1435]: lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:39 volumio-primo lircd[1435]: lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:39 volumio-primo lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:39 volumio-primo lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:39 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 03 16:36:40 volumio-primo lircd[1435]: lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:40 volumio-primo lircd[1435]: lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:40 volumio-primo lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:40 volumio-primo lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:41 volumio-primo lircd[1435]: lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:41 volumio-primo lircd[1435]: lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:41 volumio-primo lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:41 volumio-primo lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:41 volumio-primo nmbd[784]: [2025/03/03 16:36:41.853756, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Mar 03 16:36:41 volumio-primo nmbd[784]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.118 for name WORKGROUP<1d>. Mar 03 16:36:41 volumio-primo nmbd[784]: This response was from IP 192.168.1.37, reporting an IP address of 192.168.1.37. Mar 03 16:36:42 volumio-primo sudo[2335]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 03 16:36:42 volumio-primo sudo[2335]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 16:36:42 volumio-primo sudo[2338]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 03 16:36:42 volumio-primo sudo[2335]: pam_unix(sudo:session): session closed for user root Mar 03 16:36:42 volumio-primo sudo[2338]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 16:36:42 volumio-primo sudo[2338]: pam_unix(sudo:session): session closed for user root Mar 03 16:36:42 volumio-primo volumio[851]: verbose: New Socket.io Connection to 192.168.1.118 from 192.168.1.39 UA: Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:109.0) Gecko/20100101 Firefox/115.0 Engine version: 3 Transport: polling Total Clients: 16 Mar 03 16:36:42 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 03 16:36:42 volumio-primo volumio[851]: info: CoreCommandRouter::volumioGetVisibleSources Mar 03 16:36:42 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 03 16:36:42 volumio-primo volumio[851]: info: CoreCommandRouter::volumioGetState Mar 03 16:36:42 volumio-primo volumio[851]: info: CorePlayQueue::getTrack 0 Mar 03 16:36:42 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 03 16:36:42 volumio-primo volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 03 16:36:42 volumio-primo volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 03 16:36:42 volumio-primo volumio[851]: info: Retrieving Cloud Streaming UI Mar 03 16:36:42 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 03 16:36:42 volumio-primo volumio[851]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Mar 03 16:36:42 volumio-primo volumio[851]: info: Received Get System Info Mar 03 16:36:42 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 03 16:36:42 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 03 16:36:42 volumio-primo volumio[851]: info: Discovery: Getting this device information Mar 03 16:36:42 volumio-primo volumio[851]: info: CoreCommandRouter::volumioGetState Mar 03 16:36:42 volumio-primo volumio[851]: info: CorePlayQueue::getTrack 0 Mar 03 16:36:42 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 03 16:36:42 volumio-primo volumio[851]: info: CoreCommandRouter::volumioGetState Mar 03 16:36:42 volumio-primo volumio[851]: info: CorePlayQueue::getTrack 0 Mar 03 16:36:42 volumio-primo volumio[851]: info: Listing playlists Mar 03 16:36:42 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 03 16:36:42 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 03 16:36:42 volumio-primo volumio[851]: info: Getting Tidal Cloud Configuration Mar 03 16:36:42 volumio-primo volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 03 16:36:42 volumio-primo volumio[851]: info: Getting Qobuz Cloud Configuration Mar 03 16:36:42 volumio-primo volumio[851]: info: Asking plugin for UI Config Mar 03 16:36:42 volumio-primo volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 03 16:36:42 volumio-primo volumio[851]: info: Getting Spotify Cloud Configuration Mar 03 16:36:42 volumio-primo volumio[851]: info: Asking plugin for UI Config Mar 03 16:36:42 volumio-primo volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 03 16:36:42 volumio-primo volumio[851]: info: Saving Spotify Acccount Mar 03 16:36:42 volumio-primo volumio[851]: info: Got it Mar 03 16:36:42 volumio-primo volumio[851]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Mar 03 16:36:42 volumio-primo volumio[851]: info: Got Tidal Cloud Configuration Mar 03 16:36:42 volumio-primo volumio[851]: info: Got it Mar 03 16:36:42 volumio-primo volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 03 16:36:42 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 03 16:36:42 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 03 16:36:42 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 03 16:36:42 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 03 16:36:42 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 03 16:36:42 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 03 16:36:42 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 03 16:36:42 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 03 16:36:42 volumio-primo volumio[851]: info: CoreCommandRouter::volumioGetBrowseSources Mar 03 16:36:42 volumio-primo volumio[851]: info: CoreCommandRouter::volumioGetBrowseSources Mar 03 16:36:42 volumio-primo volumio[851]: info: CoreCommandRouter::volumioGetBrowseSources Mar 03 16:36:42 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Mar 03 16:36:42 volumio-primo lircd[1435]: lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:42 volumio-primo lircd[1435]: lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:42 volumio-primo lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:42 volumio-primo lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:42 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 03 16:36:42 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Mar 03 16:36:43 volumio-primo lircd[1435]: lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:43 volumio-primo lircd[1435]: lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:43 volumio-primo lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:43 volumio-primo lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:43 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Mar 03 16:36:44 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 03 16:36:44 volumio-primo volumio[851]: info: Received Get System Info Mar 03 16:36:44 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 03 16:36:44 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 03 16:36:44 volumio-primo volumio[851]: info: Discovery: Getting this device information Mar 03 16:36:44 volumio-primo volumio[851]: info: CoreCommandRouter::volumioGetState Mar 03 16:36:44 volumio-primo volumio[851]: info: CorePlayQueue::getTrack 0 Mar 03 16:36:44 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 03 16:36:44 volumio-primo lircd[1435]: lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:44 volumio-primo lircd[1435]: lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:44 volumio-primo lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:44 volumio-primo lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:44 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 03 16:36:44 volumio-primo volumio[851]: info: Received Get System Info Mar 03 16:36:44 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 03 16:36:44 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 03 16:36:44 volumio-primo volumio[851]: info: Discovery: Getting this device information Mar 03 16:36:44 volumio-primo volumio[851]: info: CoreCommandRouter::volumioGetState Mar 03 16:36:44 volumio-primo volumio[851]: info: CorePlayQueue::getTrack 0 Mar 03 16:36:44 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 03 16:36:45 volumio-primo lircd[1435]: lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:45 volumio-primo lircd[1435]: lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:45 volumio-primo lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:45 volumio-primo lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:46 volumio-primo lircd[1435]: lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:46 volumio-primo lircd[1435]: lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:46 volumio-primo lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:46 volumio-primo lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:46 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 03 16:36:46 volumio-primo volumiologrotate[530]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Mar 03 16:36:46 volumio-primo volumiologrotate[530]: ls: cannot access 'PRIMO': No such file or directory Mar 03 16:36:47 volumio-primo lircd[1435]: lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:47 volumio-primo lircd[1435]: lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:47 volumio-primo lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:47 volumio-primo lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:48 volumio-primo lircd[1435]: lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:48 volumio-primo lircd[1435]: lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:48 volumio-primo lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:48 volumio-primo lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:49 volumio-primo lircd[1435]: lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:49 volumio-primo lircd[1435]: lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:49 volumio-primo lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:49 volumio-primo lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:50 volumio-primo volumio[851]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Mar 03 16:36:50 volumio-primo sudo[2419]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /mnt/NAS/Mycloud Mar 03 16:36:50 volumio-primo sudo[2419]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 16:36:50 volumio-primo sudo[2419]: pam_unix(sudo:session): session closed for user root Mar 03 16:36:50 volumio-primo volumio[851]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 03 16:36:50 volumio-primo volumio[851]: Error: EBUSY: resource busy or locked, rmdir '/mnt/NAS/Mycloud' Mar 03 16:36:50 volumio-primo volumio[851]: at Object.rmdirSync (fs.js:917:10) Mar 03 16:36:50 volumio-primo volumio[851]: at /volumio/node_modules/linux-mountutils/mountutils.js:178:12 Mar 03 16:36:50 volumio-primo volumio[851]: at ChildProcess.exithandler (child_process.js:374:7) Mar 03 16:36:50 volumio-primo volumio[851]: at ChildProcess.emit (events.js:400:28) Mar 03 16:36:50 volumio-primo volumio[851]: at maybeClose (internal/child_process.js:1088:16) Mar 03 16:36:50 volumio-primo volumio[851]: at Process.ChildProcess._handle.onexit (internal/child_process.js:296:5) { Mar 03 16:36:50 volumio-primo volumio[851]: errno: -16, Mar 03 16:36:50 volumio-primo volumio[851]: syscall: 'rmdir', Mar 03 16:36:50 volumio-primo volumio[851]: code: 'EBUSY', Mar 03 16:36:50 volumio-primo volumio[851]: path: '/mnt/NAS/Mycloud' Mar 03 16:36:50 volumio-primo volumio[851]: } Mar 03 16:36:50 volumio-primo volumio[851]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 03 16:36:50 volumio-primo lircd[1435]: lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:50 volumio-primo lircd[1435]: lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:50 volumio-primo lircd-0.10.1[1435]: Error: could not get file information for /dev/lirc0 Mar 03 16:36:50 volumio-primo lircd-0.10.1[1435]: default_init(): No such file or directory Mar 03 16:36:50 volumio-primo sudo[2438]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-03 16:35 Mar 03 16:36:50 volumio-primo sudo[2438]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 07:11:38 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_DEVICENAME="Asus Tinkerboard" VOLUMIO_HASH="932fc3546f7cc8faa2b4d349036752dd"