-- Logs begin at Thu 2019-02-14 10:11:59 GMT, end at Sun 2024-07-14 16:37:57 BST. -- Jul 14 16:37:24 sufc ntpd[762]: receive: Unexpected origin timestamp 0xe8fdd001.ce53ede1 does not match aorg 0000000000.00000000 from server@185.177.149.33 xmt 0xea3e6f34.27c586cb Jul 14 16:37:24 sufc ntpd[762]: receive: Unexpected origin timestamp 0xe8fdd001.ce50828e does not match aorg 0000000000.00000000 from server@131.111.8.63 xmt 0xea3e6f34.28c8105d Jul 14 16:37:24 sufc volumio[700]: info: Loading plugin "albumart"... Jul 14 16:37:24 sufc ntpd[762]: receive: Unexpected origin timestamp 0xe8fdd001.ce3e7624 does not match aorg 0000000000.00000000 from server@195.171.43.12 xmt 0xea3e6f34.291c6dec Jul 14 16:37:24 sufc volumio[700]: info: Plugin example_plugin is not enabled Jul 14 16:37:24 sufc volumio[700]: info: Loading plugin "inputs"... Jul 14 16:37:24 sufc systemd[1]: Starting Daily apt download activities... Jul 14 16:37:24 sufc volumio[700]: info: Loading plugin "updater_comm"... Jul 14 16:37:24 sufc ntpd[762]: Soliciting pool server 176.58.109.199 Jul 14 16:37:24 sufc mpd[833]: Jul 14 16:37 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 14 16:37:24 sufc mpd[833]: Jul 14 16:37 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Jul 14 16:37:24 sufc mpd[833]: Jul 14 16:37 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Jul 14 16:37:24 sufc systemd[1]: Started Music Player Daemon. Jul 14 16:37:24 sufc sudo[827]: pam_unix(sudo:session): session closed for user root Jul 14 16:37:24 sufc volumio[700]: info: Plugin mpdemulation is not enabled Jul 14 16:37:24 sufc volumio[700]: info: Loading plugin "rest_api"... Jul 14 16:37:24 sufc volumio-remote-updater[499]: [2024-07-14 16:37:24] [connect] Successful connection Jul 14 16:37:24 sufc volumio[700]: info: Loading plugin "websocket"... Jul 14 16:37:24 sufc volumio[700]: Forking 3 albumart workers Jul 14 16:37:24 sufc volumio[700]: info: Loading i18n strings for locale en Jul 14 16:37:24 sufc volumio[700]: Updating browse sources language Jul 14 16:37:24 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 14 16:37:25 sufc ntpd[762]: Soliciting pool server 131.111.8.61 Jul 14 16:37:25 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 14 16:37:25 sufc volumio[700]: info: CoreCommandRouter::initPlayerControls Jul 14 16:37:25 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:37:25 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:37:25 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:37:25 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:37:25 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:37:25 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:37:25 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:37:25 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:37:25 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 14 16:37:25 sufc volumio[700]: Express server listening on port 3000 Jul 14 16:37:25 sufc volumio[700]: [Metrics] WebUI: 7s 535.69ms Jul 14 16:37:25 sufc volumio[700]: info: CoreStateMachine::resetVolumioState Jul 14 16:37:25 sufc volumio[700]: info: CoreStateMachine::getcurrentVolume Jul 14 16:37:25 sufc volumio[700]: info: CoreCommandRouter::volumioRetrievevolume Jul 14 16:37:25 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 16:37:25 sufc systemd[1]: apt-daily.service: Succeeded. Jul 14 16:37:25 sufc systemd[1]: Started Daily apt download activities. Jul 14 16:37:25 sufc systemd[1]: Starting Daily apt upgrade and clean activities... Jul 14 16:37:25 sufc volumio[700]: info: MPD Permissions set Jul 14 16:37:25 sufc volumio-remote-updater[499]: [2024-07-14 16:37:25] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1720971444 101 Jul 14 16:37:25 sufc volumio[700]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 1 Jul 14 16:37:25 sufc volumio[700]: info: MPD running with PID833 Jul 14 16:37:25 sufc volumio[700]: ,establishing connection Jul 14 16:37:25 sufc volumio[700]: info: VolumeController:: Volume=52 Mute =false Jul 14 16:37:25 sufc volumio[700]: info: CoreStateMachine::pushState Jul 14 16:37:25 sufc volumio[700]: info: CorePlayQueue::getTrack 0 Jul 14 16:37:25 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 14 16:37:25 sufc volumio[700]: info: CoreCommandRouter::volumioPushState Jul 14 16:37:25 sufc volumio[700]: info: CoreStateMachine::updateTrackBlock Jul 14 16:37:25 sufc volumio[700]: info: CorePlayQueue::getTrackBlock Jul 14 16:37:25 sufc volumio[700]: info: CoreCommandRouter::volumioRetrievevolume Jul 14 16:37:26 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:37:26 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:37:26 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:37:26 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:37:26 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:37:26 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:37:26 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:37:26 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:37:26 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 16:37:26 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:37:26 sufc volumio[700]: info: Reloading queue from file Jul 14 16:37:26 sufc volumio[700]: error: updateQueue error: null Jul 14 16:37:26 sufc volumio[700]: info: Setting Device type: Raspberry PI Jul 14 16:37:26 sufc volumio[700]: info: CoreStateMachine::setRepeat true single undefined Jul 14 16:37:26 sufc volumio[700]: info: CoreStateMachine::pushState Jul 14 16:37:26 sufc volumio[700]: info: CorePlayQueue::getTrack 0 Jul 14 16:37:26 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 14 16:37:26 sufc volumio[700]: info: CoreCommandRouter::volumioPushState Jul 14 16:37:26 sufc volumio[700]: info: CoreStateMachine::setRandom true Jul 14 16:37:26 sufc volumio[700]: info: CoreStateMachine::pushState Jul 14 16:37:26 sufc volumio[700]: info: CorePlayQueue::getTrack 0 Jul 14 16:37:26 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 14 16:37:26 sufc volumio[700]: info: CoreCommandRouter::volumioPushState Jul 14 16:37:26 sufc volumio[700]: error: updateQueue error: null Jul 14 16:37:26 sufc volumio[700]: Starting albumart workers Jul 14 16:37:26 sufc volumio[700]: Starting albumart workers Jul 14 16:37:26 sufc volumio[700]: info: Completed loading Core Plugins Jul 14 16:37:26 sufc volumio[700]: info: Preparing to generate the ALSA configuration file Jul 14 16:37:26 sufc volumio[700]: Starting albumart workers Jul 14 16:37:26 sufc volumio[700]: info: VolumeController:: Volume=52 Mute =false Jul 14 16:37:26 sufc volumio[700]: info: CoreStateMachine::pushState Jul 14 16:37:26 sufc volumio[700]: info: CorePlayQueue::getTrack 0 Jul 14 16:37:26 sufc volumio[700]: info: CoreCommandRouter::volumioPushState Jul 14 16:37:26 sufc volumio[700]: info: Discovery: adding 4bb45c89-04c9-4688-8952-500055e7129f Jul 14 16:37:26 sufc volumio[700]: info: Discovery: Found device SUFC Jul 14 16:37:26 sufc volumio[700]: info: CoreCommandRouter::volumioGetState Jul 14 16:37:26 sufc volumio[700]: info: CorePlayQueue::getTrack 0 Jul 14 16:37:26 sufc volumio[700]: info: Asound.conf file unchanged, so no further update is needed Jul 14 16:37:26 sufc volumio[700]: info: Output device has changed, restarting MPD Jul 14 16:37:26 sufc volumio[700]: info: ___________ START PLUGINS ___________ Jul 14 16:37:26 sufc volumio[700]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 14 16:37:26 sufc sudo[972]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 14 16:37:26 sufc sudo[972]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:37:26 sufc volumio[700]: info: [1720971446368] CoreMusicLibrary::Adding element Last_100 Jul 14 16:37:26 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 14 16:37:26 sufc sudo[974]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 14 16:37:26 sufc sudo[974]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:37:26 sufc volumio[700]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 14 16:37:26 sufc volumio[700]: info: [1720971446386] CoreMusicLibrary::Adding element Webradio Jul 14 16:37:26 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 14 16:37:26 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 14 16:37:26 sufc volumio[700]: info: Volumio Calling Home Jul 14 16:37:26 sufc sudo[972]: pam_unix(sudo:session): session closed for user root Jul 14 16:37:26 sufc systemd[1]: Stopping Music Player Daemon... Jul 14 16:37:26 sufc systemd[1]: mpd.service: Succeeded. Jul 14 16:37:26 sufc systemd[1]: Stopped Music Player Daemon. Jul 14 16:37:26 sufc systemd[1]: Starting Music Player Daemon... Jul 14 16:37:26 sufc systemd[1]: apt-daily-upgrade.service: Succeeded. Jul 14 16:37:26 sufc systemd[1]: Started Daily apt upgrade and clean activities. Jul 14 16:37:26 sufc volumio[700]: info: Completed starting Core Plugins Jul 14 16:37:26 sufc volumio[700]: info: ------------------------------------------- Jul 14 16:37:26 sufc volumio[700]: info: ----- MyVolumio plugins startup ---- Jul 14 16:37:26 sufc volumio[700]: info: ------------------------------------------- Jul 14 16:37:26 sufc volumio[700]: info: [MyVolumio PluginManager] Fetching plans data.... Jul 14 16:37:26 sufc volumio[700]: info: MPD Permissions set Jul 14 16:37:26 sufc volumio[700]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 2 Jul 14 16:37:26 sufc volumio[700]: info: Volumio called home Jul 14 16:37:26 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:37:26 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 16:37:26 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:37:27 sufc volumio[700]: info: CoreCommandRouter::volumioGetState Jul 14 16:37:27 sufc volumio[700]: info: CorePlayQueue::getTrack 0 Jul 14 16:37:28 sufc mpd[995]: Jul 14 16:37 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 14 16:37:28 sufc mpd[995]: Jul 14 16:37 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Jul 14 16:37:28 sufc mpd[995]: Jul 14 16:37 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Jul 14 16:37:28 sufc systemd[1]: Started Music Player Daemon. Jul 14 16:37:28 sufc sudo[974]: pam_unix(sudo:session): session closed for user root Jul 14 16:37:28 sufc volumio[700]: error: updateQueue error: null Jul 14 16:37:30 sufc volumio[700]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Jul 14 16:37:34 sufc volumio[700]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jul 14 16:37:34 sufc volumio[700]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jul 14 16:37:34 sufc volumio[700]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jul 14 16:37:34 sufc volumio[700]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jul 14 16:37:34 sufc volumio[700]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jul 14 16:37:34 sufc volumio[700]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jul 14 16:37:34 sufc volumio[700]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jul 14 16:37:34 sufc volumio[700]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jul 14 16:37:34 sufc volumio[700]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jul 14 16:37:34 sufc volumio[700]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jul 14 16:37:34 sufc volumio[700]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jul 14 16:37:34 sufc volumio[700]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jul 14 16:37:34 sufc volumio[700]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jul 14 16:37:34 sufc volumio[700]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jul 14 16:37:34 sufc volumio[700]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jul 14 16:37:34 sufc volumio[700]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jul 14 16:37:34 sufc volumio[700]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jul 14 16:37:34 sufc volumio[700]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jul 14 16:37:34 sufc volumio[700]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jul 14 16:37:34 sufc volumio[700]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jul 14 16:37:34 sufc volumio[700]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jul 14 16:37:34 sufc volumio[700]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jul 14 16:37:34 sufc volumio[700]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jul 14 16:37:34 sufc volumio[700]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jul 14 16:37:34 sufc volumio[700]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jul 14 16:37:34 sufc volumio[700]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jul 14 16:37:34 sufc volumio[700]: info: Adding plugin bluetooth to MyMusic Plugins Jul 14 16:37:34 sufc volumio[700]: info: Adding plugin multiroom to MyMusic Plugins Jul 14 16:37:35 sufc volumio[700]: info: Adding plugin metavolumio to MyMusic Plugins Jul 14 16:37:35 sufc volumio[700]: info: Adding plugin cd_controller to MyMusic Plugins Jul 14 16:37:35 sufc volumio[700]: info: Adding plugin smart_inputs to MyMusic Plugins Jul 14 16:37:35 sufc volumio[700]: info: Adding plugin tidalconnect to MyMusic Plugins Jul 14 16:37:35 sufc volumio[700]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jul 14 16:37:36 sufc volumio[700]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jul 14 16:37:36 sufc volumio[700]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jul 14 16:37:36 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 16:37:36 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 16:37:36 sufc volumio[700]: info: Starting MyVolumio Remote Streaming Endpoints Jul 14 16:37:36 sufc volumio[700]: info: MyVolumio login type: Token Jul 14 16:37:36 sufc volumio[700]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jul 14 16:37:36 sufc volumio[700]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jul 14 16:37:38 sufc volumio[700]: info: Starting Streaming Service Transparent Proxy Jul 14 16:37:38 sufc volumio[700]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jul 14 16:37:38 sufc volumio[700]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jul 14 16:37:38 sufc volumio[700]: info: Streaming services startup Jul 14 16:37:38 sufc volumio[700]: info: Starting Streaming Daemon Jul 14 16:37:38 sufc sudo[1033]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jul 14 16:37:38 sufc sudo[1033]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:37:38 sufc volumio[700]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Jul 14 16:37:38 sufc sudo[1033]: pam_unix(sudo:session): session closed for user root Jul 14 16:37:38 sufc volumio[700]: error: Cannot start Volumio Streaming Daemon Jul 14 16:37:38 sufc volumio[700]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jul 14 16:37:38 sufc volumio[700]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jul 14 16:37:38 sufc volumio[700]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Jul 14 16:37:38 sufc volumio[700]: info: MyVolumio token set successfully Jul 14 16:37:38 sufc volumio[700]: info: MYVOLUMIO: Adding device Jul 14 16:37:38 sufc volumio[700]: info: MYVOLUMIO: Evaluating Server Jul 14 16:37:39 sufc volumio[700]: STREAMING PROXY: Starting server on port 3245 Jul 14 16:37:39 sufc volumio[700]: Node JS runtime: 14 Jul 14 16:37:39 sufc volumio[700]: info: MyVolumio status changed Jul 14 16:37:39 sufc volumio[700]: info: Streaming services startup Jul 14 16:37:39 sufc volumio[700]: info: Starting Streaming Daemon Jul 14 16:37:39 sufc volumio[700]: info: Removing browser output: myVolumio user plan is not superstar Jul 14 16:37:39 sufc volumio[700]: info: Removing audio output: Jul 14 16:37:39 sufc volumio[700]: info: Stoppping Tunnel 1 Jul 14 16:37:39 sufc sudo[1058]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jul 14 16:37:39 sufc sudo[1058]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:37:39 sufc sudo[1058]: pam_unix(sudo:session): session closed for user root Jul 14 16:37:39 sufc sudo[1060]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Jul 14 16:37:39 sufc volumio[700]: error: Cannot start Volumio Streaming Daemon Jul 14 16:37:39 sufc sudo[1060]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 16:37:39 sufc volumio[700]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jul 14 16:37:39 sufc volumio[700]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jul 14 16:37:39 sufc sudo[1060]: pam_unix(sudo:session): session closed for user root Jul 14 16:37:39 sufc volumio[700]: info: Remote SSH Stopped Jul 14 16:37:39 sufc systemd[1]: systemd-fsckd.service: Succeeded. Jul 14 16:37:39 sufc volumio[700]: info: Setting Geolocation for MyVolumio to eu3 Jul 14 16:37:39 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 16:37:39 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 16:37:39 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 16:37:40 sufc volumio[700]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Jul 14 16:37:40 sufc volumio[700]: info: Updating MyVolumio device info Jul 14 16:37:40 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 16:37:41 sufc volumio[700]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Jul 14 16:37:43 sufc systemd[1]: systemd-hostnamed.service: Succeeded. Jul 14 16:37:44 sufc volumio[700]: info: MYVOLUMIO: Adding device Jul 14 16:37:44 sufc volumio[700]: info: MYVOLUMIO: Evaluating Server Jul 14 16:37:44 sufc volumio[700]: info: Setting Geolocation for MyVolumio to eu3 Jul 14 16:37:44 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 16:37:44 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 16:37:44 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 16:37:45 sufc volumio[700]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Jul 14 16:37:45 sufc volumio[700]: info: Updating MyVolumio device info Jul 14 16:37:45 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 16:37:45 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 16:37:45 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 16:37:46 sufc volumio[700]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Jul 14 16:37:51 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 14 16:37:51 sufc volumio[700]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 3 Jul 14 16:37:51 sufc volumio[700]: info: CoreCommandRouter::volumioGetState Jul 14 16:37:51 sufc volumio[700]: info: CorePlayQueue::getTrack 0 Jul 14 16:37:52 sufc volumio[700]: info: Partition removed: {"syspath":"/sys/devices/platform/soc/3f202000.mmc/mmc_host/mmc0/mmc0:5ba1/block/mmcblk0/mmcblk0p1","ACTION":"remove","DEVLINKS":"/dev/disk/by-id/mmc-UE0DA_0xe3510aa3-part1 /dev/disk/by-partuuid/f02042ea-01 /dev/disk/by-uuid/2E0A-AE55 /dev/disk/by-path/platform-3f202000.mmc-part1 /dev/disk/by-label/boot","DEVNAME":"/dev/mmcblk0p1","DEVPATH":"/devices/platform/soc/3f202000.mmc/mmc_host/mmc0/mmc0:5ba1/block/mmcblk0/mmcblk0p1","DEVTYPE":"partition","DISKSEQ":"25","ID_FS_LABEL":"boot","ID_FS_LABEL_ENC":"boot","ID_FS_TYPE":"vfat","ID_FS_USAGE":"filesystem","ID_FS_UUID":"2E0A-AE55","ID_FS_UUID_ENC":"2E0A-AE55","ID_FS_VERSION":"FAT16","ID_NAME":"UE0DA","ID_PART_ENTRY_DISK":"179:0","ID_PART_ENTRY_FLAGS":"0x80","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"1","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"187500","ID_PART_ENTRY_TYPE":"0xc","ID_PART_ENTRY_UUID":"f02042ea-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"f02042ea","ID_PATH":"platform-3f202000.mmc","ID_PATH_TAG":"platform-3f202000_mmc","ID_SERIAL":"0xe3510aa3","MAJOR":"179","MINOR":"1","PARTN":"1","SEQNUM":"1415","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"13943298"} Jul 14 16:37:52 sufc kernel: mmc0: card 5ba1 removed Jul 14 16:37:52 sufc volumio[700]: info: Partition removed: {"syspath":"/sys/devices/platform/soc/3f202000.mmc/mmc_host/mmc0/mmc0:5ba1/block/mmcblk0/mmcblk0p2","ACTION":"remove","DEVLINKS":"/dev/disk/by-path/platform-3f202000.mmc-part2 /dev/disk/by-id/mmc-UE0DA_0xe3510aa3-part2 /dev/disk/by-uuid/af3faec2-9654-4fec-8791-d5638a5837ad /dev/disk/by-partuuid/f02042ea-02 /dev/disk/by-label/volumio","DEVNAME":"/dev/mmcblk0p2","DEVPATH":"/devices/platform/soc/3f202000.mmc/mmc_host/mmc0/mmc0:5ba1/block/mmcblk0/mmcblk0p2","DEVTYPE":"partition","DISKSEQ":"25","ID_FS_LABEL":"volumio","ID_FS_LABEL_ENC":"volumio","ID_FS_TYPE":"ext4","ID_FS_USAGE":"filesystem","ID_FS_UUID":"af3faec2-9654-4fec-8791-d5638a5837ad","ID_FS_UUID_ENC":"af3faec2-9654-4fec-8791-d5638a5837ad","ID_FS_VERSION":"1.0","ID_NAME":"UE0DA","ID_PART_ENTRY_DISK":"179:0","ID_PART_ENTRY_NUMBER":"2","ID_PART_ENTRY_OFFSET":"188416","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"5279744","ID_PART_ENTRY_TYPE":"0x83","ID_PART_ENTRY_UUID":"f02042ea-02","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"f02042ea","ID_PATH":"platform-3f202000.mmc","ID_PATH_TAG":"platform-3f202000_mmc","ID_SERIAL":"0xe3510aa3","MAJOR":"179","MINOR":"2","PARTN":"2","SEQNUM":"1416","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"14056086"} Jul 14 16:37:52 sufc volumio[700]: info: Partition removed: {"syspath":"/sys/devices/platform/soc/3f202000.mmc/mmc_host/mmc0/mmc0:5ba1/block/mmcblk0/mmcblk0p3","ACTION":"remove","DEVLINKS":"/dev/disk/by-label/volumio_data /dev/disk/by-partuuid/f02042ea-03 /dev/disk/by-uuid/660717eb-e471-4727-aac1-2c263938c365 /dev/disk/by-id/mmc-UE0DA_0xe3510aa3-part3 /dev/disk/by-path/platform-3f202000.mmc-part3","DEVNAME":"/dev/mmcblk0p3","DEVPATH":"/devices/platform/soc/3f202000.mmc/mmc_host/mmc0/mmc0:5ba1/block/mmcblk0/mmcblk0p3","DEVTYPE":"partition","DISKSEQ":"25","ID_FS_LABEL":"volumio_data","ID_FS_LABEL_ENC":"volumio_data","ID_FS_TYPE":"ext4","ID_FS_USAGE":"filesystem","ID_FS_UUID":"660717eb-e471-4727-aac1-2c263938c365","ID_FS_UUID_ENC":"660717eb-e471-4727-aac1-2c263938c365","ID_FS_VERSION":"1.0","ID_NAME":"UE0DA","ID_PART_ENTRY_DISK":"179:0","ID_PART_ENTRY_NUMBER":"3","ID_PART_ENTRY_OFFSET":"5468160","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"54955669","ID_PART_ENTRY_TYPE":"0x83","ID_PART_ENTRY_UUID":"f02042ea-03","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"f02042ea","ID_PATH":"platform-3f202000.mmc","ID_PATH_TAG":"platform-3f202000_mmc","ID_SERIAL":"0xe3510aa3","MAJOR":"179","MINOR":"3","PARTN":"3","SEQNUM":"1417","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"14200713"} Jul 14 16:37:52 sufc systemd[1]: Stopped target Local File Systems. Jul 14 16:37:52 sufc kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #12: comm node: reading directory lblock 0 Jul 14 16:37:52 sufc kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #12: comm node: reading directory lblock 0 Jul 14 16:37:52 sufc kernel: EXT4-fs error (device mmcblk0p3): __ext4_find_entry:1684: inode #12: comm node: reading directory lblock 0 Jul 14 16:37:52 sufc systemd[1]: Unmounting /boot... Jul 14 16:37:52 sufc kernel: FAT-fs (mmcblk0p1): unable to read boot sector to mark fs as dirty Jul 14 16:37:52 sufc systemd[1]: boot.mount: Succeeded. Jul 14 16:37:52 sufc systemd[1]: Unmounted /boot. Jul 14 16:37:52 sufc systemd[1]: systemd-fsck@dev-mmcblk0p1.service: Succeeded. Jul 14 16:37:52 sufc systemd[1]: Stopped File System Check on /dev/mmcblk0p1. Jul 14 16:37:56 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 14 16:37:56 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 16:37:56 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 14 16:37:56 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:37:56 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 14 16:37:56 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jul 14 16:37:56 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jul 14 16:37:56 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jul 14 16:37:56 sufc volumio[700]: info: CoreCommandRouter::volumioGetBrowseSources Jul 14 16:37:56 sufc volumio[700]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 14 16:37:56 sufc volumio[700]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 14 16:37:56 sufc kernel: EXT4-fs warning (device mmcblk0p3): htree_dirblock_to_tree:1082: inode #116: lblock 0: comm node: error -5 reading directory block Jul 14 16:37:56 sufc volumio[700]: Error: EIO: i/o error, scandir '/data/plugins/' Jul 14 16:37:56 sufc volumio[700]: at Object.readdirSync (fs.js:1021:3) Jul 14 16:37:56 sufc volumio[700]: at PluginManager.getInstalledPlugins (/volumio/app/pluginmanager.js:1627:30) Jul 14 16:37:56 sufc volumio[700]: at CoreCommandRouter.getInstalledPlugins (/volumio/app/index.js:1514:29) Jul 14 16:37:56 sufc volumio[700]: at myVolumio.identifyUserProperties (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:42317) Jul 14 16:37:56 sufc volumio[700]: at Timeout._onTimeout (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:2508) Jul 14 16:37:56 sufc volumio[700]: at listOnTimeout (internal/timers.js:554:17) Jul 14 16:37:56 sufc volumio[700]: at processTimers (internal/timers.js:497:7) { Jul 14 16:37:56 sufc volumio[700]: errno: -5, Jul 14 16:37:56 sufc volumio[700]: syscall: 'scandir', Jul 14 16:37:56 sufc volumio[700]: code: 'EIO', Jul 14 16:37:56 sufc volumio[700]: path: '/data/plugins/' Jul 14 16:37:56 sufc volumio[700]: } Jul 14 16:37:56 sufc volumio[700]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 14 16:37:57 sufc sudo[1095]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-14 16:36 Jul 14 16:37:57 sufc sudo[1095]: 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="893d2e91c55a7857b58762e70c2f65b9d163562b" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="30b77d58bf3c2745acc494ddafed946392a79905" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 20 Oct 2023 03:38:28 PM CEST" VOLUMIO_VERSION="3.569" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4163d3756b55b3bf7c480d7285f68954"