-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Fri 2025-03-07 00:58:50 CET. -- Mar 07 00:57:43 volumio systemd-timedated[1185]: Changed local time to Fri Mar 7 00:57:43 2025 Mar 07 00:57:43 volumio sudo[1179]: pam_unix(sudo:session): session closed for user root Mar 07 00:57:43 volumio volumio[886]: verbose: New Socket.io Connection to 192.168.178.43 from 192.168.178.111 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:135.0) Gecko/20100101 Firefox/135.0 Engine version: 3 Transport: polling Total Clients: 37 Mar 07 00:57:43 volumio volumio-time-update[598]: volumio-time-update-util: System time updated successfully. Mar 07 00:57:43 volumio volumio[886]: verbose: New Socket.io Connection to 192.168.178.43 from 192.168.178.111 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:135.0) Gecko/20100101 Firefox/135.0 Engine version: 3 Transport: polling Total Clients: 38 Mar 07 00:57:43 volumio systemd[1]: Started Volumio Time Update Utility. Mar 07 00:57:43 volumio systemd[1]: Reached target Multi-User System. Mar 07 00:57:43 volumio systemd[1]: Reached target Graphical Interface. Mar 07 00:57:43 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 07 00:57:43 volumio volumio[886]: verbose: New Socket.io Connection to 192.168.178.43 from 192.168.178.111 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:135.0) Gecko/20100101 Firefox/135.0 Engine version: 3 Transport: polling Total Clients: 39 Mar 07 00:57:43 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Mar 07 00:57:43 volumio volumio[886]: error: Cannot initialize MPD Connection: MPD is not running Mar 07 00:57:43 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 07 00:57:43 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 07 00:57:43 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 07 00:57:43 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 07 00:57:43 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 07 00:57:43 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 07 00:57:43 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 07 00:57:43 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 07 00:57:43 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 07 00:57:43 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 07 00:57:43 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Mar 07 00:57:43 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Mar 07 00:57:43 volumio volumio[886]: verbose: New Socket.io Connection to 192.168.178.43 from 192.168.178.111 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:135.0) Gecko/20100101 Firefox/135.0 Engine version: 3 Transport: polling Total Clients: 40 Mar 07 00:57:43 volumio volumio[886]: verbose: New Socket.io Connection to 192.168.178.43 from 192.168.178.111 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:135.0) Gecko/20100101 Firefox/135.0 Engine version: 3 Transport: polling Total Clients: 41 Mar 07 00:57:43 volumio volumio[886]: verbose: New Socket.io Connection to 192.168.178.43 from 192.168.178.111 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:135.0) Gecko/20100101 Firefox/135.0 Engine version: 3 Transport: polling Total Clients: 42 Mar 07 00:57:43 volumio volumio[886]: verbose: New Socket.io Connection to 192.168.178.43 from 192.168.178.111 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:135.0) Gecko/20100101 Firefox/135.0 Engine version: 3 Transport: polling Total Clients: 43 Mar 07 00:57:43 volumio volumio[886]: info: Starting Shairport Sync Mar 07 00:57:43 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 07 00:57:43 volumio sudo[1193]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 07 00:57:43 volumio sudo[1193]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 00:57:43 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 07 00:57:43 volumio systemd[1]: shairport-sync.service: Succeeded. Mar 07 00:57:43 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 07 00:57:43 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 07 00:57:43 volumio sudo[1193]: pam_unix(sudo:session): session closed for user root Mar 07 00:57:43 volumio volumio[886]: info: Shairport-Sync Started Mar 07 00:57:43 volumio mpd[1181]: Mar 07 00:57 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 07 00:57:43 volumio systemd[1]: Started Music Player Daemon. Mar 07 00:57:43 volumio systemd[1]: Startup finished in 11.770s (kernel) + 19.662s (userspace) = 31.433s. Mar 07 00:57:43 volumio sudo[1161]: pam_unix(sudo:session): session closed for user root Mar 07 00:57:43 volumio volumio[886]: error: MPD error: The expression evaluated to a falsy value: Mar 07 00:57:43 volumio volumio[886]: assert.ok(self.idling) Mar 07 00:57:43 volumio volumio[886]: error: The expression evaluated to a falsy value: Mar 07 00:57:43 volumio volumio[886]: assert.ok(self.idling) Mar 07 00:57:43 volumio volumio[886]: error: updateQueue error: null Mar 07 00:57:43 volumio volumio[886]: info: VolumeController::SetAlsaVolume0 Mar 07 00:57:43 volumio volumio[886]: info: CoreStateMachine::pushState Mar 07 00:57:43 volumio volumio[886]: info: CorePlayQueue::getTrack 0 Mar 07 00:57:43 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 07 00:57:43 volumio volumio[886]: info: CoreCommandRouter::volumioPushState Mar 07 00:57:43 volumio volumio[886]: error: updateQueue error: null Mar 07 00:57:43 volumio volumio[886]: info: [GPIO_Control] Status changed: stop Mar 07 00:57:43 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 07 00:57:44 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 07 00:57:44 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 07 00:57:45 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 07 00:57:45 volumio sshd[1202]: Accepted password for volumio from 192.168.178.111 port 49872 ssh2 Mar 07 00:57:45 volumio sshd[1202]: pam_unix(sshd:session): session opened for user volumio by (uid=0) Mar 07 00:57:45 volumio systemd[1]: Created slice User Slice of UID 1000. Mar 07 00:57:45 volumio systemd[1]: Starting User Runtime Directory /run/user/1000... Mar 07 00:57:45 volumio systemd-logind[634]: New session 1 of user volumio. Mar 07 00:57:45 volumio systemd[1]: Started User Runtime Directory /run/user/1000. Mar 07 00:57:45 volumio systemd[1]: Starting User Manager for UID 1000... Mar 07 00:57:45 volumio systemd[1205]: pam_unix(systemd-user:session): session opened for user volumio by (uid=0) Mar 07 00:57:45 volumio systemd[1205]: Listening on GnuPG cryptographic agent and passphrase cache. Mar 07 00:57:45 volumio systemd[1205]: Listening on Sound System. Mar 07 00:57:45 volumio systemd[1205]: Reached target Timers. Mar 07 00:57:45 volumio systemd[1205]: Listening on GnuPG cryptographic agent (ssh-agent emulation). Mar 07 00:57:45 volumio systemd[1205]: Listening on GnuPG cryptographic agent and passphrase cache (restricted). Mar 07 00:57:45 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 07 00:57:45 volumio systemd[1205]: Starting D-Bus User Message Bus Socket. Mar 07 00:57:45 volumio systemd[1205]: Listening on GnuPG network certificate management daemon. Mar 07 00:57:45 volumio systemd[1205]: Listening on GnuPG cryptographic agent and passphrase cache (access for web browsers). Mar 07 00:57:45 volumio systemd[1205]: Reached target Paths. Mar 07 00:57:45 volumio systemd[1205]: Listening on D-Bus User Message Bus Socket. Mar 07 00:57:45 volumio systemd[1205]: Reached target Sockets. Mar 07 00:57:45 volumio systemd[1205]: Reached target Basic System. Mar 07 00:57:45 volumio systemd[1205]: Reached target Default. Mar 07 00:57:45 volumio systemd[1205]: Startup finished in 304ms. Mar 07 00:57:45 volumio systemd[1]: Started User Manager for UID 1000. Mar 07 00:57:45 volumio systemd[1]: Started Session 1 of user volumio. Mar 07 00:57:46 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 07 00:57:46 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 07 00:57:47 volumio volumio[886]: info: Volumio Network Manager: Network status updated: 1 Mar 07 00:57:47 volumio sudo[1240]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 07 00:57:47 volumio sudo[1240]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 00:57:47 volumio sudo[1240]: pam_unix(sudo:session): session closed for user root Mar 07 00:57:47 volumio sudo[1243]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 07 00:57:47 volumio sudo[1243]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 00:57:47 volumio sudo[1243]: pam_unix(sudo:session): session closed for user root Mar 07 00:57:47 volumio sudo[1246]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Mar 07 00:57:47 volumio sudo[1246]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 00:57:47 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 07 00:57:47 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Mar 07 00:57:47 volumio sudo[1246]: pam_unix(sudo:session): session closed for user root Mar 07 00:57:47 volumio volumio[886]: info: Upmpdcli Daemon Started Mar 07 00:57:47 volumio volumio[1248]: Generating RSA private key, 4096 bit long modulus (2 primes) Mar 07 00:57:47 volumio volumio[1248]: ..++++ Mar 07 00:57:47 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 07 00:57:48 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 07 00:57:48 volumio volumio[886]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Mar 07 00:57:48 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 07 00:57:49 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 07 00:57:49 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 07 00:57:50 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 07 00:57:50 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 07 00:57:51 volumio volumio[1248]: ...................................++++ Mar 07 00:57:51 volumio volumio[1248]: e is 65537 (0x010001) Mar 07 00:57:51 volumio volumio[1248]: writing RSA key Mar 07 00:57:51 volumio volumio[886]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Mar 07 00:57:51 volumio volumio[886]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Mar 07 00:57:51 volumio volumio[886]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Mar 07 00:57:51 volumio volumio[886]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Mar 07 00:57:51 volumio volumio[886]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Mar 07 00:57:51 volumio volumio[886]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Mar 07 00:57:51 volumio volumio[886]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Mar 07 00:57:51 volumio volumio[886]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Mar 07 00:57:51 volumio volumio[886]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Mar 07 00:57:51 volumio volumio[886]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Mar 07 00:57:51 volumio volumio[886]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Mar 07 00:57:51 volumio volumio[886]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Mar 07 00:57:51 volumio volumio[886]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Mar 07 00:57:51 volumio volumio[886]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Mar 07 00:57:51 volumio volumio[886]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Mar 07 00:57:51 volumio volumio[886]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Mar 07 00:57:51 volumio volumio[886]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Mar 07 00:57:51 volumio volumio[886]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Mar 07 00:57:51 volumio volumio[886]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Mar 07 00:57:51 volumio volumio[886]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Mar 07 00:57:51 volumio volumio[886]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Mar 07 00:57:51 volumio volumio[886]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Mar 07 00:57:51 volumio volumio[886]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Mar 07 00:57:51 volumio volumio[886]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Mar 07 00:57:51 volumio volumio[886]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Mar 07 00:57:51 volumio volumio[886]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Mar 07 00:57:51 volumio volumio[886]: info: Adding plugin bluetooth to MyMusic Plugins Mar 07 00:57:51 volumio volumio[886]: info: Adding plugin multiroom to MyMusic Plugins Mar 07 00:57:51 volumio volumio[886]: info: Adding plugin metavolumio to MyMusic Plugins Mar 07 00:57:51 volumio volumio[886]: info: Adding plugin cd_controller to MyMusic Plugins Mar 07 00:57:51 volumio volumio[886]: info: Adding plugin smart_inputs to MyMusic Plugins Mar 07 00:57:51 volumio volumio[886]: info: Adding plugin tidalconnect to MyMusic Plugins Mar 07 00:57:51 volumio volumio[886]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Mar 07 00:57:51 volumio volumio[886]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Mar 07 00:57:52 volumio volumio[886]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Mar 07 00:57:52 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 07 00:57:52 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 07 00:57:52 volumio volumio[886]: info: Starting MyVolumio Remote Streaming Endpoints Mar 07 00:57:52 volumio volumio[886]: info: MyVolumio login type: Token Mar 07 00:57:52 volumio volumio[886]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Mar 07 00:57:52 volumio volumio[886]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Mar 07 00:57:52 volumio volumio[886]: info: Starting Streaming Service Transparent Proxy Mar 07 00:57:52 volumio volumio[886]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Mar 07 00:57:52 volumio volumio[886]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Mar 07 00:57:52 volumio volumio[886]: info: Streaming services startup Mar 07 00:57:52 volumio volumio[886]: info: Starting Streaming Daemon Mar 07 00:57:52 volumio sudo[1290]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 07 00:57:52 volumio sudo[1290]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 00:57:52 volumio sudo[1290]: pam_unix(sudo:session): session closed for user root Mar 07 00:57:52 volumio volumio[886]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Mar 07 00:57:52 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 07 00:57:52 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 07 00:57:52 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 07 00:57:52 volumio volumio[886]: error: Cannot start Volumio Streaming Daemon Mar 07 00:57:52 volumio volumio[886]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Mar 07 00:57:52 volumio volumio[886]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Mar 07 00:57:53 volumio volumio[886]: STREAMING PROXY: Starting server on port 3245 Mar 07 00:57:53 volumio volumio[886]: Node JS runtime: 14 Mar 07 00:57:53 volumio volumio[886]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Mar 07 00:57:53 volumio volumio[886]: info: MyVolumio token set successfully Mar 07 00:57:53 volumio volumio[886]: info: MYVOLUMIO: Adding device Mar 07 00:57:53 volumio volumio[886]: info: MYVOLUMIO: Evaluating Server Mar 07 00:57:54 volumio volumio[886]: info: MyVolumio status changed Mar 07 00:57:54 volumio volumio[886]: info: Streaming services startup Mar 07 00:57:54 volumio volumio[886]: info: Starting Streaming Daemon Mar 07 00:57:54 volumio volumio[886]: info: Removing browser output: myVolumio user plan is not superstar Mar 07 00:57:54 volumio volumio[886]: info: Removing audio output: Mar 07 00:57:54 volumio volumio[886]: info: Stoppping Tunnel 1 Mar 07 00:57:54 volumio sudo[1315]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 07 00:57:54 volumio sudo[1315]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 00:57:54 volumio sudo[1318]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Mar 07 00:57:54 volumio sudo[1318]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 00:57:54 volumio sudo[1315]: pam_unix(sudo:session): session closed for user root Mar 07 00:57:54 volumio volumio[886]: error: Cannot start Volumio Streaming Daemon Mar 07 00:57:54 volumio volumio[886]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Mar 07 00:57:54 volumio volumio[886]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Mar 07 00:57:54 volumio sudo[1318]: pam_unix(sudo:session): session closed for user root Mar 07 00:57:54 volumio volumio[886]: info: Remote SSH Stopped Mar 07 00:57:54 volumio volumio[886]: info: Setting Geolocation for MyVolumio to eu5 Mar 07 00:57:54 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 07 00:57:54 volumio volumio[886]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Mar 07 00:57:55 volumio volumio[886]: info: Updating MyVolumio device info Mar 07 00:57:55 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 07 00:57:55 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 07 00:57:55 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 07 00:57:55 volumio volumio[886]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Mar 07 00:57:56 volumio systemd[1]: systemd-fsckd.service: Succeeded. Mar 07 00:57:58 volumio systemd[1]: systemd-hostnamed.service: Succeeded. Mar 07 00:57:58 volumio volumio[886]: info: MYVOLUMIO: Adding device Mar 07 00:57:58 volumio volumio[886]: info: MYVOLUMIO: Evaluating Server Mar 07 00:57:59 volumio volumio[886]: info: Setting Geolocation for MyVolumio to eu2 Mar 07 00:57:59 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 07 00:57:59 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 07 00:57:59 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 07 00:57:59 volumio volumio[886]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Mar 07 00:58:00 volumio volumio[886]: info: Updating MyVolumio device info Mar 07 00:58:00 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 07 00:58:00 volumio volumio[886]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Mar 07 00:58:03 volumio volumio[886]: verbose: New Socket.io Connection to volumio.local from 192.168.178.111 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:135.0) Gecko/20100101 Firefox/135.0 Engine version: 3 Transport: polling Total Clients: 44 Mar 07 00:58:03 volumio volumio[886]: verbose: New Socket.io Connection to volumio.local from 192.168.178.111 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:135.0) Gecko/20100101 Firefox/135.0 Engine version: 3 Transport: polling Total Clients: 45 Mar 07 00:58:03 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Mar 07 00:58:03 volumio volumio[886]: info: CorePlayQueue::getTrack 0 Mar 07 00:58:04 volumio volumio[886]: info: CoreCommandRouter::volumioGetQueue Mar 07 00:58:04 volumio volumio[886]: info: CoreStateMachine::getQueue Mar 07 00:58:04 volumio volumio[886]: info: CorePlayQueue::getQueue Mar 07 00:58:04 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid Mar 07 00:58:04 volumio volumio[886]: info: CALLMETHOD: music_service inputs serialMonitorAction [object Object] Mar 07 00:58:04 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: inputs , serialMonitorAction Mar 07 00:58:04 volumio volumio[886]: info: Error : CoreCommandRouter::executeOnPlugin: No method [serialMonitorAction] in plugin inputs Mar 07 00:58:04 volumio volumio[886]: info: CALLMETHOD: system_controller motivocontrol displaySelection [object Object] Mar 07 00:58:04 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: motivocontrol , displaySelection Mar 07 00:58:07 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 07 00:58:07 volumio volumio[886]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 45 Mar 07 00:58:07 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Mar 07 00:58:07 volumio volumio[886]: info: CorePlayQueue::getTrack 0 Mar 07 00:58:07 volumio sudo[1371]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 07 00:58:07 volumio sudo[1371]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 00:58:07 volumio sudo[1371]: pam_unix(sudo:session): session closed for user root Mar 07 00:58:07 volumio sudo[1374]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 07 00:58:07 volumio sudo[1374]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 00:58:07 volumio sudo[1374]: pam_unix(sudo:session): session closed for user root Mar 07 00:58:07 volumio volumio[886]: verbose: New Socket.io Connection to 192.168.178.43 from 192.168.178.111 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:135.0) Gecko/20100101 Firefox/135.0 Engine version: 3 Transport: polling Total Clients: 46 Mar 07 00:58:07 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 07 00:58:07 volumio volumio[886]: info: CoreCommandRouter::volumioGetVisibleSources Mar 07 00:58:07 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 07 00:58:07 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Mar 07 00:58:07 volumio volumio[886]: info: CorePlayQueue::getTrack 0 Mar 07 00:58:07 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 07 00:58:07 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 07 00:58:07 volumio volumio[886]: info: Received Get System Info Mar 07 00:58:07 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 07 00:58:07 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 07 00:58:07 volumio volumio[886]: info: Discovery: Getting this device information Mar 07 00:58:07 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Mar 07 00:58:07 volumio volumio[886]: info: CorePlayQueue::getTrack 0 Mar 07 00:58:07 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 07 00:58:07 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Mar 07 00:58:07 volumio volumio[886]: info: CorePlayQueue::getTrack 0 Mar 07 00:58:07 volumio volumio[886]: info: Listing playlists Mar 07 00:58:07 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Mar 07 00:58:07 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 07 00:58:07 volumio volumio[886]: info: Received Get System Info Mar 07 00:58:07 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 07 00:58:07 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 07 00:58:07 volumio volumio[886]: info: Discovery: Getting this device information Mar 07 00:58:07 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Mar 07 00:58:07 volumio volumio[886]: info: CorePlayQueue::getTrack 0 Mar 07 00:58:07 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 07 00:58:07 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 07 00:58:08 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Mar 07 00:58:08 volumio volumio[886]: info: CorePlayQueue::getTrack 0 Mar 07 00:58:11 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 07 00:58:11 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 07 00:58:11 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 07 00:58:11 volumio volumio-remote-updater[615]: No test mode Mar 07 00:58:11 volumio volumio-remote-updater[615]: No alpha test mode Mar 07 00:58:11 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Mar 07 00:58:12 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 07 00:58:12 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 07 00:58:12 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Mar 07 00:58:12 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Mar 07 00:58:12 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 07 00:58:12 volumio volumio[886]: info: CoreCommandRouter::volumioGetBrowseSources Mar 07 00:58:12 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 07 00:58:12 volumio volumio[886]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Mar 07 00:58:12 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 07 00:58:12 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 07 00:58:12 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 07 00:58:12 volumio volumio[886]: error: MyVolumio Plugin failed to authenticate in a timely fashion Mar 07 00:58:12 volumio volumio[886]: info: Completed starting MyVolumio Plugin Mar 07 00:58:12 volumio volumio[886]: [Metrics] CommandRouter: 37s 604.86ms Mar 07 00:58:12 volumio volumio[886]: info: CoreCommandRouter::volumiosetStartupVolume Mar 07 00:58:12 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 07 00:58:12 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 07 00:58:12 volumio volumio[886]: info: CoreCommandRouter::Close All Modals sent Mar 07 00:58:12 volumio volumio[886]: info: CoreCommandRouter::Close All Modals sent Mar 07 00:58:13 volumio systemd[1]: systemd-timedated.service: Succeeded. Mar 07 00:58:13 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Mar 07 00:58:13 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Mar 07 00:58:13 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 07 00:58:13 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Mar 07 00:58:15 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 07 00:58:15 volumio volumio[886]: info: Received Get System Info Mar 07 00:58:15 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 07 00:58:15 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 07 00:58:15 volumio volumio[886]: info: Discovery: Getting this device information Mar 07 00:58:15 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Mar 07 00:58:15 volumio volumio[886]: info: CorePlayQueue::getTrack 0 Mar 07 00:58:15 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 07 00:58:16 volumio sshd[1382]: Accepted password for volumio from 192.168.178.111 port 50235 ssh2 Mar 07 00:58:16 volumio sshd[1382]: pam_unix(sshd:session): session opened for user volumio by (uid=0) Mar 07 00:58:16 volumio systemd-logind[634]: New session 3 of user volumio. Mar 07 00:58:16 volumio systemd[1]: Started Session 3 of user volumio. Mar 07 00:58:17 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 07 00:58:19 volumio volumio[886]: info: BOOT COMPLETED Mar 07 00:58:23 volumio sudo[1416]: volumio : TTY=pts/0 ; PWD=/home/volumio ; USER=root ; COMMAND=/bin/bash Mar 07 00:58:23 volumio sudo[1416]: pam_unix(sudo:session): session opened for user root by volumio(uid=0) Mar 07 00:58:24 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 07 00:58:24 volumio volumio[886]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Mar 07 00:58:24 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Mar 07 00:58:24 volumio volumio[886]: info: Received Get System Version Mar 07 00:58:24 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 07 00:58:24 volumio volumio[886]: info: Received Get System Info Mar 07 00:58:24 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 07 00:58:24 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 07 00:58:24 volumio volumio[886]: info: Discovery: Getting this device information Mar 07 00:58:24 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Mar 07 00:58:24 volumio volumio[886]: info: CorePlayQueue::getTrack 0 Mar 07 00:58:24 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 07 00:58:34 volumio ntpd[768]: Soliciting pool server 85.215.166.214 Mar 07 00:58:35 volumio volumio[886]: verbose: New Socket.io Connection to volumio.local from 192.168.178.111 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:135.0) Gecko/20100101 Firefox/135.0 Engine version: 3 Transport: polling Total Clients: 10 Mar 07 00:58:35 volumio volumio[886]: info: CoreCommandRouter::volumioGetState Mar 07 00:58:35 volumio volumio[886]: info: CorePlayQueue::getTrack 0 Mar 07 00:58:35 volumio volumio[886]: info: CoreCommandRouter::volumioGetQueue Mar 07 00:58:35 volumio volumio[886]: info: CoreStateMachine::getQueue Mar 07 00:58:35 volumio volumio[886]: info: CorePlayQueue::getQueue Mar 07 00:58:35 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid Mar 07 00:58:35 volumio volumio[886]: info: CALLMETHOD: music_service inputs serialMonitorAction [object Object] Mar 07 00:58:35 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: inputs , serialMonitorAction Mar 07 00:58:35 volumio volumio[886]: info: Error : CoreCommandRouter::executeOnPlugin: No method [serialMonitorAction] in plugin inputs Mar 07 00:58:35 volumio volumio[886]: info: CALLMETHOD: system_controller motivocontrol displaySelection [object Object] Mar 07 00:58:35 volumio volumio[886]: info: CoreCommandRouter::executeOnPlugin: motivocontrol , displaySelection Mar 07 00:58:35 volumio ntpd[768]: Soliciting pool server 85.215.93.134 Mar 07 00:58:36 volumio ntpd[768]: Soliciting pool server 51.75.67.47 Mar 07 00:58:36 volumio ntpd[768]: Soliciting pool server 207.180.217.145 Mar 07 00:58:37 volumio ntpd[768]: Soliciting pool server 185.232.69.65 Mar 07 00:58:37 volumio ntpd[768]: Soliciting pool server 88.99.86.9 Mar 07 00:58:37 volumio ntpd[768]: Soliciting pool server 185.228.138.224 Mar 07 00:58:37 volumio ntpd[768]: Soliciting pool server 213.239.234.28 Mar 07 00:58:38 volumio ntpd[768]: Soliciting pool server 176.9.42.91 Mar 07 00:58:38 volumio ntpd[768]: Soliciting pool server 141.144.246.224 Mar 07 00:58:38 volumio ntpd[768]: Soliciting pool server 90.187.112.137 Mar 07 00:58:39 volumio ntpd[768]: Soliciting pool server 94.16.122.152 Mar 07 00:58:39 volumio ntpd[768]: Soliciting pool server 5.1.73.50 Mar 07 00:58:39 volumio ntpd[768]: Soliciting pool server 79.133.44.140 Mar 07 00:58:40 volumio ntpd[768]: Soliciting pool server 94.130.184.193 Mar 07 00:58:40 volumio ntpd[768]: Soliciting pool server 2001:41d0:700:49bc::6 Mar 07 00:58:49 volumio volumio[886]: info: GPIO-Buttons: next-button pressed Mar 07 00:58:49 volumio volumio[886]: info: newUrl: volumio.local/browse Mar 07 00:58:49 volumio volumio[886]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 07 00:58:49 volumio volumio[886]: ReferenceError: document is not defined Mar 07 00:58:49 volumio volumio[886]: at GPIOButtons.next (/data/plugins/system_hardware/gpio-buttons/index.js:258:3) Mar 07 00:58:49 volumio volumio[886]: at GPIOButtons.listener (/data/plugins/system_hardware/gpio-buttons/index.js:227:15) Mar 07 00:58:49 volumio volumio[886]: at /data/plugins/system_hardware/gpio-buttons/node_modules/onoff/onoff.js:135:9 Mar 07 00:58:49 volumio volumio[886]: at Array.forEach () Mar 07 00:58:49 volumio volumio[886]: at pollerEventHandler (/data/plugins/system_hardware/gpio-buttons/node_modules/onoff/onoff.js:134:32) Mar 07 00:58:49 volumio volumio[886]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 07 00:58:50 volumio sudo[1520]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-07 00:57 Mar 07 00:58:50 volumio sudo[1520]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"