-- Logs begin at Tue 2019-03-12 18:57:25 UTC, end at Mon 2024-04-29 10:43:30 UTC. -- Apr 29 10:42:00 volumio_libor wireless.js[778]: trying... Apr 29 10:42:00 volumio_libor sudo[1125]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 29 10:42:00 volumio_libor sudo[1125]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 10:42:00 volumio_libor sudo[1125]: pam_unix(sudo:session): session closed for user root Apr 29 10:42:01 volumio_libor volumio-remote-updater[659]: [2024-04-29 10:42:01] [info] asio async_connect error: system:111 (Connection refused) Apr 29 10:42:01 volumio_libor volumio-remote-updater[659]: [2024-04-29 10:42:01] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Apr 29 10:42:01 volumio_libor volumio-remote-updater[659]: [2024-04-29 10:42:01] [error] handle_connect error: Underlying Transport Error Apr 29 10:42:01 volumio_libor wireless.js[778]: trying... Apr 29 10:42:01 volumio_libor sudo[1134]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 29 10:42:01 volumio_libor sudo[1134]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 10:42:01 volumio_libor sudo[1134]: pam_unix(sudo:session): session closed for user root Apr 29 10:42:02 volumio_libor wireless.js[778]: trying... Apr 29 10:42:02 volumio_libor sudo[1143]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 29 10:42:02 volumio_libor sudo[1143]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 10:42:02 volumio_libor sudo[1143]: pam_unix(sudo:session): session closed for user root Apr 29 10:42:03 volumio_libor wireless.js[778]: trying... Apr 29 10:42:03 volumio_libor sudo[1152]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 29 10:42:03 volumio_libor sudo[1152]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 10:42:03 volumio_libor sudo[1152]: pam_unix(sudo:session): session closed for user root Apr 29 10:42:03 volumio_libor kernel: fat_get_cluster: 79 callbacks suppressed Apr 29 10:42:03 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start c1c20989) Apr 29 10:42:03 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 4e7f61dd) Apr 29 10:42:03 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 477d976f) Apr 29 10:42:03 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start a54ac259) Apr 29 10:42:03 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 186f8210) Apr 29 10:42:04 volumio_libor wireless.js[778]: Overtime, starting plan B Apr 29 10:42:04 volumio_libor systemd[1]: Started Wireless Services. Apr 29 10:42:04 volumio_libor systemd[1]: Starting Volumio Backend Module... Apr 29 10:42:04 volumio_libor systemd[1]: Started Volumio Backend Module. Apr 29 10:42:04 volumio_libor systemd[1]: Starting Volumio Streaming Daemon... Apr 29 10:42:04 volumio_libor systemd[1]: Started Volumio Streaming Daemon. Apr 29 10:42:04 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start ae837873) Apr 29 10:42:04 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start da0cd863) Apr 29 10:42:04 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 63944ed5) Apr 29 10:42:04 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start bc1a4d9a) Apr 29 10:42:04 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 9e928f75) Apr 29 10:42:04 volumio_libor volumio-streaming-daemon[1162]: ############################ Apr 29 10:42:04 volumio_libor volumio-streaming-daemon[1162]: # Volumio Streaming Daemon # Apr 29 10:42:04 volumio_libor volumio-streaming-daemon[1162]: # Running on port 7777 # Apr 29 10:42:04 volumio_libor volumio-streaming-daemon[1162]: ############################ Apr 29 10:42:04 volumio_libor volumio-streaming-daemon[1162]: Checking variant in static cache Apr 29 10:42:04 volumio_libor volumio-streaming-daemon[1162]: Enabled services: Apr 29 10:42:04 volumio_libor volumio-streaming-daemon[1162]: 1) tidal Apr 29 10:42:04 volumio_libor volumio-streaming-daemon[1162]: 2) qobuz Apr 29 10:42:05 volumio_libor wpa_supplicant[948]: wlan0: Failed to initiate sched scan Apr 29 10:42:06 volumio_libor volumio[1161]: info: ------------------------------------------- Apr 29 10:42:06 volumio_libor volumio[1161]: info: ----- Volumio2 ---- Apr 29 10:42:06 volumio_libor volumio[1161]: info: ------------------------------------------- Apr 29 10:42:06 volumio_libor volumio[1161]: info: ----- System startup ---- Apr 29 10:42:06 volumio_libor volumio[1161]: info: ------------------------------------------- Apr 29 10:42:06 volumio_libor volumio[1161]: info: MYVOLUMIO Environment detected Apr 29 10:42:06 volumio_libor volumio[1161]: info: Plugin folders cleanup Apr 29 10:42:06 volumio_libor volumio[1161]: info: Scanning into folder /volumio/app/plugins/ Apr 29 10:42:06 volumio_libor volumio[1161]: info: Scanning category audio_interface Apr 29 10:42:06 volumio_libor volumio[1161]: info: Scanning category miscellanea Apr 29 10:42:06 volumio_libor volumio[1161]: info: Scanning category music_service Apr 29 10:42:06 volumio_libor volumio[1161]: info: Scanning category plugins.json Apr 29 10:42:06 volumio_libor volumio[1161]: info: Scanning category system_controller Apr 29 10:42:06 volumio_libor volumio[1161]: info: Scanning category user_interface Apr 29 10:42:06 volumio_libor volumio[1161]: info: Scanning into folder /data/plugins/ Apr 29 10:42:06 volumio_libor volumio[1161]: info: Plugin folders cleanup completed Apr 29 10:42:06 volumio_libor volumio[1161]: info: ------------------------------------------- Apr 29 10:42:06 volumio_libor volumio[1161]: info: ----- Core plugins startup ---- Apr 29 10:42:06 volumio_libor volumio[1161]: info: ------------------------------------------- Apr 29 10:42:06 volumio_libor volumio[1161]: info: Loading plugins from folder /volumio/app/plugins/ Apr 29 10:42:06 volumio_libor volumio[1161]: info: Adding plugin upnp to MyMusic Plugins Apr 29 10:42:06 volumio_libor volumio[1161]: info: Adding plugin airplay_emulation to MyMusic Plugins Apr 29 10:42:06 volumio_libor volumio[1161]: info: Adding plugin upnp_browser to MyMusic Plugins Apr 29 10:42:06 volumio_libor volumio[1161]: info: Loading plugins from folder /data/plugins/ Apr 29 10:42:06 volumio_libor volumio[1161]: info: Loading plugin "system"... Apr 29 10:42:06 volumio_libor volumio[1161]: info: Loading plugin "appearance"... Apr 29 10:42:08 volumio_libor volumio[1161]: info: Loading plugin "network"... Apr 29 10:42:08 volumio_libor volumio[1161]: info: Loading plugin "services"... Apr 29 10:42:08 volumio_libor volumio[1161]: info: Loading plugin "alsa_controller"... Apr 29 10:42:08 volumio_libor volumio[1161]: info: Loading plugin "wizard"... Apr 29 10:42:08 volumio_libor volumio[1161]: info: Loading plugin "volumio_command_line_client"... Apr 29 10:42:08 volumio_libor volumio[1161]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 10:42:08 volumio_libor volumio[1161]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 10:42:08 volumio_libor volumio[1161]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 10:42:08 volumio_libor volumio[1161]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 10:42:08 volumio_libor volumio[1161]: info: Loading plugin "upnp"... Apr 29 10:42:08 volumio_libor volumio[1161]: info: [1714387328972] Starting Upmpd Daemon Apr 29 10:42:08 volumio_libor volumio[1161]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 29 10:42:08 volumio_libor volumio[1161]: info: Loading plugin "my_music"... Apr 29 10:42:08 volumio_libor volumio[1161]: info: Loading plugin "mpd"... Apr 29 10:42:09 volumio_libor kernel: fat_get_cluster: 36 callbacks suppressed Apr 29 10:42:09 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 2fd86f1e) Apr 29 10:42:09 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start fef80641) Apr 29 10:42:09 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start bad21466) Apr 29 10:42:09 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start bdce5376) Apr 29 10:42:09 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start fc18c66e) Apr 29 10:42:09 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid cluster chain (i_pos 0) Apr 29 10:42:09 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start b1c7b1e1) Apr 29 10:42:09 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 0a0b8d2e) Apr 29 10:42:09 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 3b6f331a) Apr 29 10:42:09 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start a04e8677) Apr 29 10:42:09 volumio_libor udisks-glue[657]: error: Timeout Apr 29 10:42:09 volumio_libor volumio[1161]: info: Loading plugin "upnp_browser"... Apr 29 10:42:10 volumio_libor volumio[1161]: info: Loading plugin "networkfs"... Apr 29 10:42:10 volumio_libor volumio[1161]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 29 10:42:10 volumio_libor volumio[1161]: info: Loading plugin "alarm-clock"... Apr 29 10:42:10 volumio_libor wpa_supplicant[948]: wlan0: Failed to initiate sched scan Apr 29 10:42:11 volumio_libor volumio[1161]: info: Loading plugin "airplay_emulation"... Apr 29 10:42:11 volumio_libor volumio[1161]: info: Starting Shairport Sync Apr 29 10:42:11 volumio_libor volumio[1161]: info: Loading plugin "last_100"... Apr 29 10:42:11 volumio_libor volumio[1161]: info: Loading plugin "webradio"... Apr 29 10:42:11 volumio_libor volumio[1161]: info: Loading plugin "i2s_dacs"... Apr 29 10:42:11 volumio_libor volumio[1161]: info: I2S DAC not set, start Auto-detection Apr 29 10:42:11 volumio_libor volumio[1161]: info: Loading plugin "volumiodiscovery"... Apr 29 10:42:11 volumio_libor volumio-remote-updater[659]: [2024-04-29 10:42:11] [connect] Successful connection Apr 29 10:42:11 volumio_libor volumio[1161]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 29 10:42:11 volumio_libor node[1161]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 29 10:42:11 volumio_libor node[1161]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 29 10:42:11 volumio_libor node[1161]: *** WARNING *** For more information see Apr 29 10:42:11 volumio_libor node[1161]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 29 10:42:11 volumio_libor node[1161]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 29 10:42:11 volumio_libor node[1161]: *** WARNING *** For more information see Apr 29 10:42:11 volumio_libor volumio[1161]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 29 10:42:11 volumio_libor volumio[1161]: *** WARNING *** For more information see Apr 29 10:42:11 volumio_libor volumio[1161]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 29 10:42:11 volumio_libor volumio[1161]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 29 10:42:11 volumio_libor volumio[1161]: *** WARNING *** For more information see Apr 29 10:42:11 volumio_libor volumio[1161]: info: Applying required configuration parameters for plugin volumiodiscovery Apr 29 10:42:11 volumio_libor volumio[1161]: Discovery: StartAdv! undefined Apr 29 10:42:11 volumio_libor volumio[1161]: Discovery: Started advertising... Volumiolibor - undefined Apr 29 10:42:11 volumio_libor volumio[1161]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 29 10:42:11 volumio_libor volumio[1161]: info: Loading plugin "outputs"... Apr 29 10:42:11 volumio_libor volumio[1161]: info: Loading plugin "albumart"... Apr 29 10:42:11 volumio_libor volumio[1161]: info: Plugin example_plugin is not enabled Apr 29 10:42:11 volumio_libor volumio[1161]: info: Loading plugin "updater_comm"... Apr 29 10:42:11 volumio_libor volumio[1161]: info: Plugin mpdemulation is not enabled Apr 29 10:42:11 volumio_libor volumio[1161]: info: Loading plugin "rest_api"... Apr 29 10:42:11 volumio_libor volumio[1161]: info: Loading plugin "websocket"... Apr 29 10:42:11 volumio_libor volumio[1161]: info: ___________ START PLUGINS ___________ Apr 29 10:42:11 volumio_libor volumio[1161]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 10:42:11 volumio_libor volumio[1161]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 29 10:42:11 volumio_libor volumio[1161]: info: [1714387331521] CoreMusicLibrary::Adding element Media Servers Apr 29 10:42:11 volumio_libor volumio[1161]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 29 10:42:11 volumio_libor volumio[1161]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 29 10:42:11 volumio_libor volumio[1161]: info: [1714387331553] CoreMusicLibrary::Adding element Last_100 Apr 29 10:42:11 volumio_libor volumio[1161]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 29 10:42:11 volumio_libor volumio[1161]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 29 10:42:11 volumio_libor volumio[1161]: info: [1714387331558] CoreMusicLibrary::Adding element Webradio Apr 29 10:42:11 volumio_libor volumio[1161]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 29 10:42:11 volumio_libor volumio[1161]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 29 10:42:11 volumio_libor volumio[1161]: info: ------------------------------------------- Apr 29 10:42:11 volumio_libor volumio[1161]: info: ----- MyVolumio plugins startup ---- Apr 29 10:42:11 volumio_libor volumio[1161]: info: ------------------------------------------- Apr 29 10:42:11 volumio_libor volumio[1161]: info: Loading plugins from folder /myvolumio/plugins Apr 29 10:42:11 volumio_libor volumio[1161]: info: Loading plugins from folder /data/myvolumio/plugins Apr 29 10:42:11 volumio_libor volumio[1161]: info: Loading plugin "streaming_services"... Apr 29 10:42:11 volumio_libor volumio[1161]: Forking 3 albumart workers Apr 29 10:42:12 volumio_libor volumio[1161]: info: Loading plugin "my_volumio"... Apr 29 10:42:12 volumio_libor volumio[1161]: Starting albumart workers Apr 29 10:42:12 volumio_libor volumio[1161]: Starting albumart workers Apr 29 10:42:12 volumio_libor volumio[1161]: Starting albumart workers Apr 29 10:42:13 volumio_libor volumio[1161]: info: Streaming services startup Apr 29 10:42:13 volumio_libor volumio[1161]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 10:42:13 volumio_libor volumio[1161]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 10:42:13 volumio_libor volumio[1161]: info: Starting MyVolumio Remote Streaming Endpoints Apr 29 10:42:13 volumio_libor sudo[1214]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 29 10:42:13 volumio_libor sudo[1214]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 10:42:13 volumio_libor volumio[1161]: info: Loading i18n strings for locale cs Apr 29 10:42:13 volumio_libor volumio[1161]: Updating browse sources language Apr 29 10:42:13 volumio_libor volumio[1161]: Cannot find translation for sourceMedia Servers Apr 29 10:42:13 volumio_libor systemd[1]: Stopping Volumio Streaming Daemon... Apr 29 10:42:13 volumio_libor volumio[1161]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 29 10:42:13 volumio_libor systemd[1]: Starting Volumio Streaming Daemon... Apr 29 10:42:13 volumio_libor sudo[1214]: pam_unix(sudo:session): session closed for user root Apr 29 10:42:13 volumio_libor systemd[1]: Started Volumio Streaming Daemon. Apr 29 10:42:13 volumio_libor volumio-streaming-daemon[1220]: ############################ Apr 29 10:42:13 volumio_libor volumio-streaming-daemon[1220]: # Volumio Streaming Daemon # Apr 29 10:42:13 volumio_libor volumio-streaming-daemon[1220]: # Running on port 7777 # Apr 29 10:42:13 volumio_libor volumio-streaming-daemon[1220]: ############################ Apr 29 10:42:13 volumio_libor volumio-streaming-daemon[1220]: Checking variant in static cache Apr 29 10:42:13 volumio_libor volumio-streaming-daemon[1220]: Enabled services: Apr 29 10:42:13 volumio_libor volumio-streaming-daemon[1220]: 1) tidal Apr 29 10:42:13 volumio_libor volumio-streaming-daemon[1220]: 2) qobuz Apr 29 10:42:13 volumio_libor volumio[1161]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 10:42:13 volumio_libor volumio[1161]: info: CoreCommandRouter::initPlayerControls Apr 29 10:42:13 volumio_libor volumio[1161]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 10:42:13 volumio_libor volumio[1161]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Apr 29 10:42:13 volumio_libor volumio[1161]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 10:42:13 volumio_libor volumio[1161]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 10:42:13 volumio_libor volumio[1161]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 10:42:13 volumio_libor volumio[1161]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 10:42:13 volumio_libor volumio[1161]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 10:42:13 volumio_libor volumio[1161]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 10:42:13 volumio_libor volumio[1161]: info: BOOT COMPLETED Apr 29 10:42:13 volumio_libor volumio[1161]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 10:42:14 volumio_libor kernel: fat_get_cluster: 63 callbacks suppressed Apr 29 10:42:14 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 9227038b) Apr 29 10:42:14 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 0131fd00) Apr 29 10:42:14 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start a62f7fdf) Apr 29 10:42:15 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 64fa6349) Apr 29 10:42:15 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 0561ead8) Apr 29 10:42:15 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start e5c4d3b7) Apr 29 10:42:15 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 6edb507d) Apr 29 10:42:15 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 272813f1) Apr 29 10:42:15 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 35a96911) Apr 29 10:42:15 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 648c15a7) Apr 29 10:42:16 volumio_libor wpa_supplicant[948]: wlan0: Failed to initiate sched scan Apr 29 10:42:18 volumio_libor volumio[1161]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Apr 29 10:42:18 volumio_libor volumio[1161]: info: CoreCommandRouter::Close All Modals sent Apr 29 10:42:18 volumio_libor volumio[1161]: info: CoreCommandRouter::Close All Modals sent Apr 29 10:42:18 volumio_libor volumio[1161]: Express server listening on port 3000 Apr 29 10:42:18 volumio_libor volumio[1161]: Volumio Calling Home Apr 29 10:42:18 volumio_libor volumio[1161]: info: MyVolumio not started Apr 29 10:42:18 volumio_libor volumio[1161]: info: CoreStateMachine::resetVolumioState Apr 29 10:42:18 volumio_libor volumio[1161]: info: CoreStateMachine::getcurrentVolume Apr 29 10:42:18 volumio_libor volumio[1161]: info: CoreCommandRouter::volumioRetrievevolume Apr 29 10:42:18 volumio_libor volumio[1161]: info: CoreStateMachine::pushState Apr 29 10:42:18 volumio_libor volumio[1161]: info: CoreStateMachine::getState Apr 29 10:42:18 volumio_libor volumio[1161]: info: CorePlayQueue::getTrack 0 Apr 29 10:42:18 volumio_libor volumio[1161]: info: CoreCommandRouter::volumioPushState Apr 29 10:42:18 volumio_libor volumio[1161]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 10:42:19 volumio_libor volumio[1161]: info: Setting Device type: Raspberry PI Apr 29 10:42:19 volumio_libor volumio[1161]: info: MPD running with PID685 ,establishing connection Apr 29 10:42:19 volumio_libor sudo[1239]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Apr 29 10:42:19 volumio_libor sudo[1239]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 10:42:19 volumio_libor sudo[1243]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 29 10:42:19 volumio_libor sudo[1243]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 10:42:19 volumio_libor sudo[1243]: pam_unix(sudo:session): session closed for user root Apr 29 10:42:19 volumio_libor sudo[1239]: pam_unix(sudo:session): session closed for user root Apr 29 10:42:19 volumio_libor volumio[1161]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 10:42:19 volumio_libor volumio[1161]: info: Reloading queue from file Apr 29 10:42:19 volumio_libor volumio[1161]: info: CoreStateMachine::setRepeat false single undefined Apr 29 10:42:19 volumio_libor volumio[1161]: info: CoreStateMachine::pushState Apr 29 10:42:19 volumio_libor volumio[1161]: info: CoreStateMachine::getState Apr 29 10:42:19 volumio_libor volumio[1161]: info: CorePlayQueue::getTrack 0 Apr 29 10:42:19 volumio_libor volumio[1161]: info: CoreCommandRouter::volumioPushState Apr 29 10:42:19 volumio_libor volumio[1161]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 10:42:19 volumio_libor volumio[1161]: info: CoreStateMachine::setRandom false Apr 29 10:42:19 volumio_libor volumio[1161]: info: CoreStateMachine::pushState Apr 29 10:42:19 volumio_libor volumio[1161]: info: CoreStateMachine::getState Apr 29 10:42:19 volumio_libor volumio[1161]: info: CorePlayQueue::getTrack 0 Apr 29 10:42:19 volumio_libor volumio[1161]: info: CoreCommandRouter::volumioPushState Apr 29 10:42:19 volumio_libor volumio[1161]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 10:42:19 volumio_libor sudo[1258]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Apr 29 10:42:19 volumio_libor sudo[1258]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 10:42:19 volumio_libor sudo[1260]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Apr 29 10:42:19 volumio_libor sudo[1260]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 10:42:19 volumio_libor systemd[1]: Starting ShairportSync AirTunes receiver... Apr 29 10:42:19 volumio_libor systemd[1]: Started ShairportSync AirTunes receiver. Apr 29 10:42:19 volumio_libor sudo[1258]: pam_unix(sudo:session): session closed for user root Apr 29 10:42:19 volumio_libor systemd[1]: Stopping ShairportSync AirTunes receiver... Apr 29 10:42:19 volumio_libor systemd[1]: Starting ShairportSync AirTunes receiver... Apr 29 10:42:19 volumio_libor systemd[1]: Started ShairportSync AirTunes receiver. Apr 29 10:42:19 volumio_libor sudo[1260]: pam_unix(sudo:session): session closed for user root Apr 29 10:42:19 volumio_libor shairport-sync[1272]: Successful Startup Apr 29 10:42:19 volumio_libor sudo[1277]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 29 10:42:19 volumio_libor sudo[1277]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 10:42:19 volumio_libor systemd[1]: Starting UPnP Renderer front-end to MPD... Apr 29 10:42:19 volumio_libor systemd[1]: Started UPnP Renderer front-end to MPD. Apr 29 10:42:19 volumio_libor sudo[1277]: pam_unix(sudo:session): session closed for user root Apr 29 10:42:19 volumio_libor volumio[1161]: Discovery: adding be664e44-6cd1-42a4-b196-e878717e32f6 Apr 29 10:42:19 volumio_libor volumio[1161]: info: mDNS: Found device Volumiolibor Apr 29 10:42:19 volumio_libor sudo[1291]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 29 10:42:19 volumio_libor sudo[1291]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 10:42:19 volumio_libor volumio[1161]: info: Upmpdcli Daemon Started Apr 29 10:42:19 volumio_libor volumio[1161]: info: Shairport-Sync Started Apr 29 10:42:19 volumio_libor volumio[1161]: Error adding Membership: Error: addMembership EINVAL Apr 29 10:42:19 volumio_libor volumio[1161]: info: Shairport-Sync Started Apr 29 10:42:19 volumio_libor volumio[1161]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Apr 29 10:42:19 volumio_libor sudo[1291]: pam_unix(sudo:session): session closed for user root Apr 29 10:42:19 volumio_libor volumio[1161]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Apr 29 10:42:19 volumio_libor volumio[1161]: info: CoreCommandRouter::volumioGetState Apr 29 10:42:19 volumio_libor volumio[1161]: info: CoreStateMachine::getState Apr 29 10:42:19 volumio_libor volumio[1161]: info: CorePlayQueue::getTrack 0 Apr 29 10:42:19 volumio_libor sudo[1302]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 29 10:42:19 volumio_libor sudo[1302]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 10:42:19 volumio_libor sudo[1302]: pam_unix(sudo:session): session closed for user root Apr 29 10:42:20 volumio_libor kernel: fat_get_cluster: 70 callbacks suppressed Apr 29 10:42:20 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 2a27dcc9) Apr 29 10:42:21 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start e3276e8f) Apr 29 10:42:21 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 8ed5628b) Apr 29 10:42:21 volumio_libor volumio-streaming-daemon[1220]: Checking variant in static cache Apr 29 10:42:21 volumio_libor volumio[1161]: info: Fetching Streaming Services browse cache Apr 29 10:42:21 volumio_libor volumio[1161]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesTIDAL Apr 29 10:42:21 volumio_libor volumio[1161]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 29 10:42:21 volumio_libor volumio[1161]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesQOBUZ Apr 29 10:42:21 volumio_libor volumio[1161]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 29 10:42:21 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start a661a486) Apr 29 10:42:21 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 552cf97e) Apr 29 10:42:21 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 6af4bcf4) Apr 29 10:42:21 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 1c065da6) Apr 29 10:42:21 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 768270c1) Apr 29 10:42:21 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 86da3d95) Apr 29 10:42:21 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start da0fbc48) Apr 29 10:42:21 volumio_libor wpa_supplicant[948]: wlan0: Failed to initiate sched scan Apr 29 10:42:25 volumio_libor kernel: fat_get_cluster: 24 callbacks suppressed Apr 29 10:42:25 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start c62d3995) Apr 29 10:42:25 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 04fd734e) Apr 29 10:42:25 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 5c3bcab6) Apr 29 10:42:26 volumio_libor volumio-remote-updater[659]: [2024-04-29 10:42:26] [connect] Successful connection Apr 29 10:42:26 volumio_libor volumio-remote-updater[659]: [2024-04-29 10:42:26] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1714387346 101 Apr 29 10:42:26 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 2f7598ef) Apr 29 10:42:26 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 97b69fa7) Apr 29 10:42:26 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 6839f67e) Apr 29 10:42:26 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start d5528660) Apr 29 10:42:26 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start b387fb74) Apr 29 10:42:26 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 50c19dc3) Apr 29 10:42:26 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 04635bb2) Apr 29 10:42:27 volumio_libor wpa_supplicant[948]: wlan0: Failed to initiate sched scan Apr 29 10:42:29 volumio_libor volumio[1161]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.565&uuid=3b689f521c8359d7df02453a07346a2b" http://updates.volumio.org:7070/downloader-v1/track-device Apr 29 10:42:29 volumio_libor volumio[1161]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 29 10:42:29 volumio_libor volumio[1161]: Dload Upload Total Spent Left Speed Apr 29 10:42:29 volumio_libor volumio[1161]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused Apr 29 10:42:29 volumio_libor volumio[1161]: retrying in 5 seconds, trial 0 Apr 29 10:42:29 volumio_libor volumio[1161]: Volumio Calling Home Apr 29 10:42:31 volumio_libor kernel: fat_get_cluster: 79 callbacks suppressed Apr 29 10:42:31 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 45af2155) Apr 29 10:42:31 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 03fe06eb) Apr 29 10:42:31 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 85244317) Apr 29 10:42:31 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 8873288d) Apr 29 10:42:31 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 0746df13) Apr 29 10:42:31 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 15869b4a) Apr 29 10:42:31 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start f2f82f87) Apr 29 10:42:31 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start c93deeac) Apr 29 10:42:31 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 5a7189dd) Apr 29 10:42:31 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 162de462) Apr 29 10:42:32 volumio_libor wpa_supplicant[948]: wlan0: Failed to initiate sched scan Apr 29 10:42:37 volumio_libor kernel: fat_get_cluster: 60 callbacks suppressed Apr 29 10:42:37 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 68db629c) Apr 29 10:42:37 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 09a3ec53) Apr 29 10:42:37 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 946f1325) Apr 29 10:42:37 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 6fd29090) Apr 29 10:42:37 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start d59a43fa) Apr 29 10:42:37 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 011fecef) Apr 29 10:42:37 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 974e591d) Apr 29 10:42:37 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 8b50d47b) Apr 29 10:42:37 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 4b1b47ab) Apr 29 10:42:37 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 464ec865) Apr 29 10:42:38 volumio_libor wpa_supplicant[948]: wlan0: Failed to initiate sched scan Apr 29 10:42:39 volumio_libor volumio[1161]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.565&uuid=3b689f521c8359d7df02453a07346a2b" http://updates.volumio.org:7070/downloader-v1/track-device Apr 29 10:42:39 volumio_libor volumio[1161]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 29 10:42:39 volumio_libor volumio[1161]: Dload Upload Total Spent Left Speed Apr 29 10:42:39 volumio_libor volumio[1161]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused Apr 29 10:42:39 volumio_libor volumio[1161]: retrying in 5 seconds, trial 1 Apr 29 10:42:39 volumio_libor volumio[1161]: Volumio Calling Home Apr 29 10:42:41 volumio_libor volumio[1161]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 29 10:42:41 volumio_libor volumio[1161]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 10:42:42 volumio_libor kernel: fat_get_cluster: 57 callbacks suppressed Apr 29 10:42:42 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start cd7002f4) Apr 29 10:42:42 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start fa4e1014) Apr 29 10:42:42 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start d15fb6c5) Apr 29 10:42:42 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 920b273c) Apr 29 10:42:42 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start ab427f2f) Apr 29 10:42:44 volumio_libor wpa_supplicant[948]: wlan0: Failed to initiate sched scan Apr 29 10:42:44 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start d78ee26f) Apr 29 10:42:44 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 71d0b6d0) Apr 29 10:42:44 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start d3c30ea7) Apr 29 10:42:44 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start a8d35701) Apr 29 10:42:44 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 99aba242) Apr 29 10:42:47 volumio_libor kernel: fat_get_cluster: 64 callbacks suppressed Apr 29 10:42:47 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 12df85dd) Apr 29 10:42:47 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 690e59fe) Apr 29 10:42:47 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 0f776810) Apr 29 10:42:47 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 8d2f4fa9) Apr 29 10:42:47 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 80f73f47) Apr 29 10:42:47 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 5001bf0d) Apr 29 10:42:47 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start bab00a67) Apr 29 10:42:47 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 4975de40) Apr 29 10:42:47 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start eaecea48) Apr 29 10:42:47 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 66fefe1e) Apr 29 10:42:49 volumio_libor wpa_supplicant[948]: wlan0: Failed to initiate sched scan Apr 29 10:42:49 volumio_libor volumio[1161]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.565&uuid=3b689f521c8359d7df02453a07346a2b" http://updates.volumio.org:7070/downloader-v1/track-device Apr 29 10:42:49 volumio_libor volumio[1161]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 29 10:42:49 volumio_libor volumio[1161]: Dload Upload Total Spent Left Speed Apr 29 10:42:49 volumio_libor volumio[1161]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused Apr 29 10:42:49 volumio_libor volumio[1161]: retrying in 5 seconds, trial 2 Apr 29 10:42:49 volumio_libor volumio[1161]: Volumio Calling Home Apr 29 10:42:52 volumio_libor kernel: fat_get_cluster: 56 callbacks suppressed Apr 29 10:42:52 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 5156defd) Apr 29 10:42:52 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 7d5cf1fa) Apr 29 10:42:52 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 7c5ed19a) Apr 29 10:42:52 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start c72b35e2) Apr 29 10:42:52 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 401cdee0) Apr 29 10:42:52 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 96080769) Apr 29 10:42:52 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 7a7d105d) Apr 29 10:42:52 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 92858883) Apr 29 10:42:52 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 4fd2b319) Apr 29 10:42:52 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 879b2508) Apr 29 10:42:55 volumio_libor wpa_supplicant[948]: wlan0: Failed to initiate sched scan Apr 29 10:42:57 volumio_libor kernel: fat_get_cluster: 55 callbacks suppressed Apr 29 10:42:57 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 3b0395f3) Apr 29 10:42:57 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 54d35f0c) Apr 29 10:42:57 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 6a24e6f3) Apr 29 10:42:57 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start e9b3f2e4) Apr 29 10:42:57 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 8c1b11b7) Apr 29 10:42:57 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 4016c28d) Apr 29 10:42:58 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 80157a7e) Apr 29 10:42:58 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start fb5b0f40) Apr 29 10:42:58 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start d40baef5) Apr 29 10:42:59 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start aa561e8a) Apr 29 10:43:00 volumio_libor wpa_supplicant[948]: wlan0: Failed to initiate sched scan Apr 29 10:43:02 volumio_libor kernel: fat_get_cluster: 64 callbacks suppressed Apr 29 10:43:02 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 32fa5137) Apr 29 10:43:02 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 02df31e4) Apr 29 10:43:02 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 93c6e1a5) Apr 29 10:43:02 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start fa4eb4a7) Apr 29 10:43:02 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 8b2ac718) Apr 29 10:43:02 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 3fb0f265) Apr 29 10:43:02 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start fc2fc9c5) Apr 29 10:43:02 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 2f3c05e6) Apr 29 10:43:02 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start b30b6af0) Apr 29 10:43:02 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start f8aa6431) Apr 29 10:43:06 volumio_libor wpa_supplicant[948]: wlan0: Failed to initiate sched scan Apr 29 10:43:07 volumio_libor systemd[1]: mpd.service start operation timed out. Terminating. Apr 29 10:43:07 volumio_libor kernel: fat_get_cluster: 58 callbacks suppressed Apr 29 10:43:07 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 87cf1f15) Apr 29 10:43:08 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 21ffd55e) Apr 29 10:43:08 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start e3ddc9db) Apr 29 10:43:08 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 3bc85052) Apr 29 10:43:08 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start ae7a7841) Apr 29 10:43:08 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start bf9f8a04) Apr 29 10:43:09 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start b365ba13) Apr 29 10:43:09 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 0a52781e) Apr 29 10:43:09 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start b04f0ede) Apr 29 10:43:09 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 30ab2ae2) Apr 29 10:43:11 volumio_libor sudo[1326]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 29 10:43:11 volumio_libor sudo[1326]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 10:43:11 volumio_libor sudo[1328]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 29 10:43:11 volumio_libor sudo[1328]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 10:43:11 volumio_libor sudo[1326]: pam_unix(sudo:session): session closed for user root Apr 29 10:43:11 volumio_libor sudo[1328]: pam_unix(sudo:session): session closed for user root Apr 29 10:43:11 volumio_libor volumio[1161]: info: CoreCommandRouter::volumioGetVisibleSources Apr 29 10:43:11 volumio_libor volumio[1161]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 29 10:43:11 volumio_libor volumio[1161]: info: CoreCommandRouter::volumioGetState Apr 29 10:43:11 volumio_libor volumio[1161]: info: CoreStateMachine::getState Apr 29 10:43:11 volumio_libor volumio[1161]: info: CorePlayQueue::getTrack 0 Apr 29 10:43:11 volumio_libor volumio[1161]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 29 10:43:11 volumio_libor volumio[1161]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 29 10:43:11 volumio_libor volumio[1161]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 29 10:43:11 volumio_libor sudo[1344]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 29 10:43:11 volumio_libor sudo[1344]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 10:43:11 volumio_libor volumio[1161]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 29 10:43:11 volumio_libor volumio[1161]: info: Listing playlists Apr 29 10:43:11 volumio_libor sudo[1344]: pam_unix(sudo:session): session closed for user root Apr 29 10:43:11 volumio_libor sudo[1349]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 29 10:43:11 volumio_libor sudo[1349]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 10:43:11 volumio_libor sudo[1349]: pam_unix(sudo:session): session closed for user root Apr 29 10:43:11 volumio_libor wpa_supplicant[948]: wlan0: Failed to initiate sched scan Apr 29 10:43:13 volumio_libor kernel: fat_get_cluster: 112 callbacks suppressed Apr 29 10:43:13 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start c49d9405) Apr 29 10:43:13 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start e2e0d360) Apr 29 10:43:13 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 0710786a) Apr 29 10:43:13 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 8e4ad4da) Apr 29 10:43:13 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start eef59df3) Apr 29 10:43:14 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 1d2e577a) Apr 29 10:43:14 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 38246756) Apr 29 10:43:14 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 549a419b) Apr 29 10:43:14 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 88c8051e) Apr 29 10:43:14 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 5baaf147) Apr 29 10:43:14 volumio_libor volumio[1161]: info: CoreCommandRouter::volumioGetQueue Apr 29 10:43:14 volumio_libor volumio[1161]: info: CoreStateMachine::getQueue Apr 29 10:43:14 volumio_libor volumio[1161]: info: CorePlayQueue::getQueue Apr 29 10:43:16 volumio_libor volumio[1161]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 29 10:43:16 volumio_libor volumio[1161]: info: CURURI: music-library Apr 29 10:43:17 volumio_libor wpa_supplicant[948]: wlan0: Failed to initiate sched scan Apr 29 10:43:18 volumio_libor kernel: fat_get_cluster: 67 callbacks suppressed Apr 29 10:43:18 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start ac344190) Apr 29 10:43:18 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start dc92cca5) Apr 29 10:43:18 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 89b49856) Apr 29 10:43:18 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start b2165431) Apr 29 10:43:18 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 6435d7f3) Apr 29 10:43:18 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start b71cc9cf) Apr 29 10:43:18 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 92fe4607) Apr 29 10:43:18 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 89ac70fb) Apr 29 10:43:19 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 6de1a249) Apr 29 10:43:19 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start c619b44e) Apr 29 10:43:22 volumio_libor wpa_supplicant[948]: wlan0: Failed to initiate sched scan Apr 29 10:43:23 volumio_libor kernel: fat_get_cluster: 36 callbacks suppressed Apr 29 10:43:23 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 073b44f3) Apr 29 10:43:24 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start c457a36f) Apr 29 10:43:24 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 44c4eafb) Apr 29 10:43:24 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start b96a03b9) Apr 29 10:43:24 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 40f68045) Apr 29 10:43:24 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start a6ccb067) Apr 29 10:43:24 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 643c8cb8) Apr 29 10:43:24 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 2f3154c2) Apr 29 10:43:24 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 333ef945) Apr 29 10:43:24 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start da1db080) Apr 29 10:43:28 volumio_libor wpa_supplicant[948]: wlan0: Failed to initiate sched scan Apr 29 10:43:29 volumio_libor kernel: fat_get_cluster: 16 callbacks suppressed Apr 29 10:43:29 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start cb073600) Apr 29 10:43:29 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start d08f5f65) Apr 29 10:43:29 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start 0f469afb) Apr 29 10:43:29 volumio_libor kernel: FAT-fs (sda1): error, fat_get_cluster: invalid start cluster (i_pos 0, start e9df034a) Apr 29 10:43:29 volumio_libor volumio[1161]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 29 10:43:29 volumio_libor volumio[1161]: info: CURURI: albums:// Apr 29 10:43:29 volumio_libor volumio[1161]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 29 10:43:29 volumio_libor volumio[1161]: { AssertionError [ERR_ASSERTION]: false == true Apr 29 10:43:29 volumio_libor volumio[1161]: at MpdClient.sendCommand (/volumio/app/plugins/music_service/mpd/lib/mpd.js:92:9) Apr 29 10:43:29 volumio_libor volumio[1161]: at /volumio/app/plugins/music_service/mpd/index.js:3061:19 Apr 29 10:43:29 volumio_libor volumio[1161]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Apr 29 10:43:29 volumio_libor volumio[1161]: at process._tickCallback (internal/process/next_tick.js:180:9) Apr 29 10:43:29 volumio_libor volumio[1161]: generatedMessage: true, Apr 29 10:43:29 volumio_libor volumio[1161]: name: 'AssertionError [ERR_ASSERTION]', Apr 29 10:43:29 volumio_libor volumio[1161]: code: 'ERR_ASSERTION', Apr 29 10:43:29 volumio_libor volumio[1161]: actual: false, Apr 29 10:43:29 volumio_libor volumio[1161]: expected: true, Apr 29 10:43:29 volumio_libor volumio[1161]: operator: '==' } Apr 29 10:43:29 volumio_libor volumio[1161]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 29 10:43:30 volumio_libor sudo[1369]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-29 10:42 Apr 29 10:43:30 volumio_libor sudo[1369]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" 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="f1b59d96a3893a42f8609371956ecba0438017d7" VOLUMIO_FE_VERSION="95791212f747b95a2cb050c16459a831bfe5c7e7" VOLUMIO_BE_VERSION="1c3c01aeeeb4cff8e6c9a4b6c34e1a558d1b237b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 12 19:57:25 CET 2019" VOLUMIO_VERSION="2.565" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="64b803aae2d00ba86d00d612c4abb38d"