-- Logs begin at Sat 2022-09-17 22:06:31 UTC, end at Mon 2024-04-01 10:03:59 UTC. -- Apr 01 10:02:00 volumio smbd[912]: [2024/04/01 10:02:00.432555, 0] ../lib/util/become_daemon.c:124(daemon_ready) Apr 01 10:02:00 volumio smbd[912]: STATUS=daemon 'smbd' finished starting up and ready to serve connections Apr 01 10:02:00 volumio smbd[924]: [2024/04/01 10:02:00.520511, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 01 10:02:00 volumio smbd[924]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Apr 01 10:02:01 volumio systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Apr 01 10:02:01 volumio systemd[1]: Stopping Xbindrc... Apr 01 10:02:01 volumio systemd[1]: Starting Xbindrc... Apr 01 10:02:01 volumio systemd[1]: Started Xbindrc. Apr 01 10:02:03 volumio systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Apr 01 10:02:03 volumio systemd[1]: Stopping Xbindrc... Apr 01 10:02:03 volumio systemd[1]: Starting Xbindrc... Apr 01 10:02:03 volumio systemd[1]: Started Xbindrc. Apr 01 10:02:03 volumio volumio-remote-updater[598]: [2024-04-01 10:02:03] [info] asio async_connect error: system:111 (Connection refused) Apr 01 10:02:03 volumio volumio-remote-updater[598]: [2024-04-01 10:02:03] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Apr 01 10:02:03 volumio volumio-remote-updater[598]: [2024-04-01 10:02:03] [error] handle_connect error: Underlying Transport Error Apr 01 10:02:05 volumio systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Apr 01 10:02:05 volumio systemd[1]: Stopping Xbindrc... Apr 01 10:02:05 volumio systemd[1]: Starting Xbindrc... Apr 01 10:02:05 volumio systemd[1]: Started Xbindrc. Apr 01 10:02:06 volumio systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Apr 01 10:02:06 volumio systemd[1]: Stopping Xbindrc... Apr 01 10:02:06 volumio systemd[1]: Starting Xbindrc... Apr 01 10:02:06 volumio systemd[1]: Started Xbindrc. Apr 01 10:02:08 volumio systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. Apr 01 10:02:08 volumio systemd[1]: Stopping Xbindrc... Apr 01 10:02:08 volumio systemd[1]: Starting Xbindrc... Apr 01 10:02:08 volumio systemd[1]: xbindkeysrc.service start request repeated too quickly, refusing to start. Apr 01 10:02:08 volumio systemd[1]: Failed to start Xbindrc. Apr 01 10:02:08 volumio systemd[1]: Unit xbindkeysrc.service entered failed state. Apr 01 10:02:13 volumio volumio[817]: info: ------------------------------------------- Apr 01 10:02:13 volumio volumio[817]: info: ----- Volumio2 ---- Apr 01 10:02:13 volumio volumio[817]: info: ------------------------------------------- Apr 01 10:02:13 volumio volumio[817]: info: ----- System startup ---- Apr 01 10:02:13 volumio volumio[817]: info: ------------------------------------------- Apr 01 10:02:13 volumio volumio-remote-updater[598]: [2024-04-01 10:02:13] [connect] Successful connection Apr 01 10:02:14 volumio volumio[817]: info: MYVOLUMIO Environment detected Apr 01 10:02:23 volumio volumio[817]: info: Plugin folders cleanup Apr 01 10:02:23 volumio volumio[817]: info: Scanning into folder /volumio/app/plugins/ Apr 01 10:02:23 volumio volumio[817]: info: Scanning category audio_interface Apr 01 10:02:23 volumio volumio[817]: info: Scanning category miscellanea Apr 01 10:02:23 volumio volumio[817]: info: Scanning category music_service Apr 01 10:02:23 volumio volumio[817]: info: Scanning category plugins.json Apr 01 10:02:23 volumio volumio[817]: info: Scanning category system_controller Apr 01 10:02:23 volumio volumio[817]: info: Scanning category user_interface Apr 01 10:02:23 volumio volumio[817]: info: Scanning into folder /data/plugins/ Apr 01 10:02:23 volumio volumio[817]: info: Scanning category miscellanea Apr 01 10:02:23 volumio volumio[817]: info: Scanning category music_service Apr 01 10:02:23 volumio volumio[817]: info: Plugin folders cleanup completed Apr 01 10:02:23 volumio volumio[817]: info: ------------------------------------------- Apr 01 10:02:23 volumio volumio[817]: info: ----- Core plugins startup ---- Apr 01 10:02:23 volumio volumio[817]: info: ------------------------------------------- Apr 01 10:02:23 volumio volumio[817]: info: Loading plugins from folder /volumio/app/plugins/ Apr 01 10:02:23 volumio volumio[817]: info: Adding plugin upnp to MyMusic Plugins Apr 01 10:02:23 volumio volumio[817]: info: Adding plugin airplay_emulation to MyMusic Plugins Apr 01 10:02:23 volumio volumio[817]: info: Adding plugin upnp_browser to MyMusic Plugins Apr 01 10:02:23 volumio volumio[817]: info: Loading plugins from folder /data/plugins/ Apr 01 10:02:23 volumio volumio[817]: info: Loading plugin "system"... Apr 01 10:02:23 volumio volumio[817]: info: Loading plugin "appearance"... Apr 01 10:02:28 volumio volumio-remote-updater[598]: [2024-04-01 10:02:28] [connect] Successful connection Apr 01 10:02:31 volumio volumio[817]: info: Loading plugin "network"... Apr 01 10:02:31 volumio volumio[817]: info: Loading plugin "services"... Apr 01 10:02:31 volumio volumio[817]: info: Loading plugin "alsa_controller"... Apr 01 10:02:32 volumio volumio[817]: info: Loading plugin "wizard"... Apr 01 10:02:32 volumio volumio[817]: info: Loading plugin "volumio_command_line_client"... Apr 01 10:02:33 volumio volumio[817]: info: Loading plugin "upnp"... Apr 01 10:02:33 volumio volumio[817]: info: [1711965753260] Starting Upmpd Daemon Apr 01 10:02:33 volumio volumio[817]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 01 10:02:33 volumio volumio[817]: info: Loading plugin "my_music"... Apr 01 10:02:33 volumio volumio[817]: info: Loading plugin "mpd"... Apr 01 10:02:38 volumio volumio[817]: info: Loading plugin "upnp_browser"... Apr 01 10:02:42 volumio volumio[817]: info: Loading plugin "networkfs"... Apr 01 10:02:43 volumio volumio-remote-updater[598]: [2024-04-01 10:02:43] [connect] Successful connection Apr 01 10:02:44 volumio volumio[817]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 01 10:02:44 volumio volumio[817]: info: Loading plugin "alarm-clock"... Apr 01 10:02:46 volumio volumio[817]: info: Loading plugin "airplay_emulation"... Apr 01 10:02:46 volumio volumio[817]: info: Starting Shairport Sync Apr 01 10:02:46 volumio volumio[817]: info: Loading plugin "last_100"... Apr 01 10:02:46 volumio volumio[817]: info: Loading plugin "webradio"... Apr 01 10:02:47 volumio volumio[817]: info: Loading plugin "i2s_dacs"... Apr 01 10:02:47 volumio volumio[817]: info: I2S DAC not set, start Auto-detection Apr 01 10:02:47 volumio volumio[817]: info: Loading plugin "volumiodiscovery"... Apr 01 10:02:48 volumio volumio[817]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 01 10:02:48 volumio node[817]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 01 10:02:48 volumio node[817]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 01 10:02:48 volumio node[817]: *** WARNING *** For more information see Apr 01 10:02:48 volumio node[817]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 01 10:02:48 volumio node[817]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 01 10:02:48 volumio node[817]: *** WARNING *** For more information see Apr 01 10:02:48 volumio volumio[817]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 01 10:02:48 volumio volumio[817]: *** WARNING *** For more information see Apr 01 10:02:48 volumio volumio[817]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 01 10:02:48 volumio volumio[817]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 01 10:02:48 volumio volumio[817]: *** WARNING *** For more information see Apr 01 10:02:48 volumio volumio[817]: info: Applying required configuration parameters for plugin volumiodiscovery Apr 01 10:02:48 volumio volumio[817]: Discovery: StartAdv! undefined Apr 01 10:02:48 volumio volumio[817]: Discovery: Started advertising... Volumio - undefined Apr 01 10:02:48 volumio volumio[817]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 01 10:02:48 volumio volumio[817]: info: Loading plugin "auto_play"... Apr 01 10:02:48 volumio volumio[817]: info: ControllerAutoPlay - connecting mpd on host: localhost; port: 6600 Apr 01 10:02:48 volumio volumio[817]: info: Loading plugin "autostart"... Apr 01 10:02:50 volumio volumio[817]: info: Applying required configuration parameters for plugin autostart Apr 01 10:02:50 volumio volumio[817]: info: Loading plugin "outputs"... Apr 01 10:02:50 volumio volumio[817]: info: Loading plugin "albumart"... Apr 01 10:02:50 volumio volumio[817]: info: Plugin example_plugin is not enabled Apr 01 10:02:50 volumio volumio[817]: info: Loading plugin "inputs"... Apr 01 10:02:50 volumio volumio[817]: info: Loading plugin "updater_comm"... Apr 01 10:02:53 volumio volumio[817]: info: Plugin mpdemulation is not enabled Apr 01 10:02:53 volumio volumio[817]: info: Loading plugin "rest_api"... Apr 01 10:02:54 volumio volumio[817]: info: Loading plugin "websocket"... Apr 01 10:02:55 volumio volumio[817]: info: Loading plugin "Systeminfo"... Apr 01 10:02:56 volumio volumio[817]: Forking 1 albumart workers Apr 01 10:02:58 volumio volumio-remote-updater[598]: [2024-04-01 10:02:58] [connect] Successful connection Apr 01 10:03:02 volumio volumio[817]: info: Loading plugin "spop"... Apr 01 10:03:12 volumio volumio[817]: Starting albumart workers Apr 01 10:03:13 volumio volumio-remote-updater[598]: [2024-04-01 10:03:13] [connect] Successful connection Apr 01 10:03:21 volumio volumio[817]: info: Plugin volspotconnect2 is not enabled Apr 01 10:03:21 volumio volumio[817]: info: ___________ START PLUGINS ___________ Apr 01 10:03:21 volumio volumio[817]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 01 10:03:21 volumio volumio[817]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 01 10:03:21 volumio volumio[817]: info: [1711965801615] CoreMusicLibrary::Adding element Media Servers Apr 01 10:03:21 volumio volumio[817]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 01 10:03:22 volumio volumio[817]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 01 10:03:22 volumio volumio[817]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 01 10:03:22 volumio volumio[817]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 01 10:03:22 volumio volumio[817]: info: [1711965802609] CoreMusicLibrary::Adding element Last_100 Apr 01 10:03:22 volumio volumio[817]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 01 10:03:22 volumio volumio[817]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 01 10:03:22 volumio volumio[817]: info: [1711965802665] CoreMusicLibrary::Adding element Webradio Apr 01 10:03:22 volumio volumio[817]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 01 10:03:22 volumio volumio[817]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 01 10:03:23 volumio volumio[817]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 01 10:03:23 volumio volumio[817]: [SpotifyConnect] Creating VLS config file Apr 01 10:03:23 volumio volumio[817]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 01 10:03:23 volumio volumio[817]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 01 10:03:23 volumio volumio[817]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 01 10:03:23 volumio volumio[817]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 01 10:03:23 volumio volumio[817]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 01 10:03:23 volumio sudo[1006]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hosts Apr 01 10:03:23 volumio volumio[817]: [SpotifyConnect] Starting metadata listener Apr 01 10:03:23 volumio sudo[1006]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 01 10:03:23 volumio sudo[1006]: pam_unix(sudo:session): session closed for user root Apr 01 10:03:23 volumio volumio[817]: info: ------------------------------------------- Apr 01 10:03:23 volumio volumio[817]: info: ----- MyVolumio plugins startup ---- Apr 01 10:03:23 volumio volumio[817]: info: ------------------------------------------- Apr 01 10:03:23 volumio volumio[817]: info: [MyVolumio PluginManager] Fetching plans data.... Apr 01 10:03:23 volumio sudo[1014]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect.service Apr 01 10:03:24 volumio sudo[1014]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 01 10:03:24 volumio volumio[817]: info: Loading i18n strings for locale de Apr 01 10:03:24 volumio volumio[817]: Updating browse sources language Apr 01 10:03:24 volumio volumio[817]: Cannot find translation for sourceMedia Servers Apr 01 10:03:24 volumio volumio[817]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 01 10:03:24 volumio systemd[1]: Starting Volspotconnect2 Daemon... Apr 01 10:03:24 volumio systemd[1]: Started Volspotconnect2 Daemon. Apr 01 10:03:24 volumio volumio[1020]: /usr/lib/startconnect.sh: line 5: 1021 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Apr 01 10:03:24 volumio volumio[817]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 01 10:03:24 volumio volumio[817]: info: CoreCommandRouter::initPlayerControls Apr 01 10:03:25 volumio volumio[817]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 01 10:03:25 volumio volumio[817]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Apr 01 10:03:25 volumio volumio[817]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 01 10:03:25 volumio volumio[817]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 01 10:03:25 volumio volumio[817]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 01 10:03:25 volumio volumio[817]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 01 10:03:25 volumio volumio[817]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 01 10:03:26 volumio volumio[817]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 01 10:03:26 volumio volumio[817]: info: BOOT COMPLETED Apr 01 10:03:26 volumio volumio[817]: [Metrics] CommandRouter: 73s 205.43ms Apr 01 10:03:26 volumio volumio[817]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 01 10:03:26 volumio sudo[1014]: pam_unix(sudo:session): session closed for user root Apr 01 10:03:26 volumio kernel: usb 1-1.3: 1:1: cannot get freq at ep 0x5 Apr 01 10:03:28 volumio systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Apr 01 10:03:28 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Apr 01 10:03:28 volumio systemd[1]: Starting Volspotconnect2 Daemon... Apr 01 10:03:28 volumio systemd[1]: Started Volspotconnect2 Daemon. Apr 01 10:03:28 volumio volumio[1030]: /usr/lib/startconnect.sh: line 5: 1031 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Apr 01 10:03:28 volumio volumio-remote-updater[598]: [2024-04-01 10:03:28] [connect] Successful connection Apr 01 10:03:30 volumio systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Apr 01 10:03:30 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Apr 01 10:03:30 volumio systemd[1]: Starting Volspotconnect2 Daemon... Apr 01 10:03:30 volumio systemd[1]: Started Volspotconnect2 Daemon. Apr 01 10:03:31 volumio volumio[1042]: /usr/lib/startconnect.sh: line 5: 1046 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Apr 01 10:03:32 volumio volumio[817]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Apr 01 10:03:32 volumio volumio[817]: info: CoreCommandRouter::Close All Modals sent Apr 01 10:03:32 volumio volumio[817]: info: CoreCommandRouter::Close All Modals sent Apr 01 10:03:32 volumio volumio[817]: Express server listening on port 3000 Apr 01 10:03:32 volumio volumio[817]: [Metrics] WebUI: 83s 28.12ms Apr 01 10:03:32 volumio volumio[817]: Volumio Calling Home Apr 01 10:03:33 volumio volumio[817]: info: CoreStateMachine::resetVolumioState Apr 01 10:03:33 volumio volumio[817]: info: CoreStateMachine::getcurrentVolume Apr 01 10:03:33 volumio volumio[817]: info: CoreCommandRouter::volumioRetrievevolume Apr 01 10:03:33 volumio systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Apr 01 10:03:33 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Apr 01 10:03:33 volumio systemd[1]: Starting Volspotconnect2 Daemon... Apr 01 10:03:33 volumio systemd[1]: Started Volspotconnect2 Daemon. Apr 01 10:03:33 volumio volumio[1056]: /usr/lib/startconnect.sh: line 5: 1057 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Apr 01 10:03:34 volumio volumio[817]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Apr 01 10:03:34 volumio sudo[1060]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 01 10:03:34 volumio sudo[1060]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 01 10:03:34 volumio sudo[1060]: pam_unix(sudo:session): session closed for user root Apr 01 10:03:35 volumio volumio[817]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Apr 01 10:03:35 volumio volumio[817]: info: AutoStart - getting queue Apr 01 10:03:35 volumio volumio[817]: info: CoreCommandRouter::volumioGetQueue Apr 01 10:03:35 volumio volumio[817]: info: CoreStateMachine::getQueue Apr 01 10:03:35 volumio volumio[817]: info: CorePlayQueue::getQueue Apr 01 10:03:35 volumio systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Apr 01 10:03:35 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Apr 01 10:03:35 volumio systemd[1]: Starting Volspotconnect2 Daemon... Apr 01 10:03:35 volumio systemd[1]: Started Volspotconnect2 Daemon. Apr 01 10:03:36 volumio volumio[1072]: /usr/lib/startconnect.sh: line 5: 1073 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Apr 01 10:03:37 volumio volumio[817]: info: Setting Device type: Raspberry PI Apr 01 10:03:37 volumio volumio[817]: [SpotifyConnect] Vollibrespot Daemon service started! Apr 01 10:03:37 volumio volumio[817]: [Metrics] SpotifyConnect: 14s 108.12ms Apr 01 10:03:37 volumio volumio[817]: info: MPD running with PID647 ,establishing connection Apr 01 10:03:37 volumio sudo[1079]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Apr 01 10:03:37 volumio sudo[1079]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 01 10:03:38 volumio sudo[1079]: pam_unix(sudo:session): session closed for user root Apr 01 10:03:38 volumio systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Apr 01 10:03:38 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Apr 01 10:03:38 volumio systemd[1]: Starting Volspotconnect2 Daemon... Apr 01 10:03:38 volumio systemd[1]: Started Volspotconnect2 Daemon. Apr 01 10:03:38 volumio volumio[1087]: /usr/lib/startconnect.sh: line 5: 1088 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Apr 01 10:03:39 volumio volumio[817]: info: VolumeController:: Volume=70 Mute =false Apr 01 10:03:39 volumio volumio[817]: info: CoreStateMachine::pushState Apr 01 10:03:39 volumio volumio[817]: info: CoreStateMachine::getState Apr 01 10:03:39 volumio volumio[817]: info: CorePlayQueue::getTrack 0 Apr 01 10:03:39 volumio volumio[817]: info: CoreCommandRouter::volumioPushState Apr 01 10:03:39 volumio volumio[817]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 01 10:03:39 volumio volumio[817]: info: CoreStateMachine::updateTrackBlock Apr 01 10:03:39 volumio volumio[817]: info: CorePlayQueue::getTrackBlock Apr 01 10:03:39 volumio volumio[817]: info: CoreCommandRouter::volumioRetrievevolume Apr 01 10:03:40 volumio systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Apr 01 10:03:40 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Apr 01 10:03:40 volumio systemd[1]: Starting Volspotconnect2 Daemon... Apr 01 10:03:40 volumio systemd[1]: Started Volspotconnect2 Daemon. Apr 01 10:03:41 volumio volumio[1091]: /usr/lib/startconnect.sh: line 5: 1092 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Apr 01 10:03:43 volumio systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Apr 01 10:03:43 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Apr 01 10:03:43 volumio systemd[1]: Starting Volspotconnect2 Daemon... Apr 01 10:03:43 volumio systemd[1]: Started Volspotconnect2 Daemon. Apr 01 10:03:43 volumio volumio[1094]: /usr/lib/startconnect.sh: line 5: 1095 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Apr 01 10:03:43 volumio volumio-remote-updater[598]: [2024-04-01 10:03:43] [connect] Successful connection Apr 01 10:03:44 volumio volumio[817]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 01 10:03:44 volumio volumio[817]: info: Checking Spotify Web API Apr 01 10:03:44 volumio volumio[817]: info: Reloading queue from file Apr 01 10:03:45 volumio volumio[817]: info: Apr 01 10:03:45 volumio volumio[817]: info: message= [50@0] {} No database, stack=Error: [50@0] {} No database Apr 01 10:03:45 volumio volumio[817]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:63:14) Apr 01 10:03:45 volumio volumio[817]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:10) Apr 01 10:03:45 volumio volumio[817]: at emitOne (events.js:116:13) Apr 01 10:03:45 volumio volumio[817]: at Socket.emit (events.js:211:7) Apr 01 10:03:45 volumio volumio[817]: at addChunk (_stream_readable.js:263:12) Apr 01 10:03:45 volumio volumio[817]: at readableAddChunk (_stream_readable.js:246:13) Apr 01 10:03:45 volumio volumio[817]: at Socket.Readable.push (_stream_readable.js:208:10) Apr 01 10:03:45 volumio volumio[817]: at Pipe.onread (net.js:607:20) Apr 01 10:03:45 volumio volumio[817]: info: VolumeController:: Volume=70 Mute =false Apr 01 10:03:45 volumio volumio[817]: info: CoreStateMachine::pushState Apr 01 10:03:45 volumio volumio[817]: info: CoreStateMachine::getState Apr 01 10:03:45 volumio volumio[817]: info: CorePlayQueue::getTrack 0 Apr 01 10:03:45 volumio volumio[817]: info: CoreCommandRouter::volumioPushState Apr 01 10:03:45 volumio volumio[817]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 01 10:03:45 volumio volumio[817]: info: CoreStateMachine::setRepeat true single undefined Apr 01 10:03:45 volumio volumio[817]: info: CoreStateMachine::pushState Apr 01 10:03:45 volumio volumio[817]: info: CoreStateMachine::getState Apr 01 10:03:45 volumio volumio[817]: info: CorePlayQueue::getTrack 0 Apr 01 10:03:45 volumio volumio[817]: info: CoreCommandRouter::volumioPushState Apr 01 10:03:45 volumio systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Apr 01 10:03:45 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Apr 01 10:03:45 volumio systemd[1]: Starting Volspotconnect2 Daemon... Apr 01 10:03:45 volumio systemd[1]: Started Volspotconnect2 Daemon. Apr 01 10:03:45 volumio volumio[817]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 01 10:03:45 volumio volumio[817]: info: CoreStateMachine::setRandom true Apr 01 10:03:45 volumio volumio[817]: info: CoreStateMachine::pushState Apr 01 10:03:45 volumio volumio[817]: info: CoreStateMachine::getState Apr 01 10:03:45 volumio volumio[817]: info: CorePlayQueue::getTrack 0 Apr 01 10:03:46 volumio volumio[817]: info: CoreCommandRouter::volumioPushState Apr 01 10:03:46 volumio volumio[817]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 01 10:03:46 volumio volumio[1099]: /usr/lib/startconnect.sh: line 5: 1100 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Apr 01 10:03:46 volumio volumio-remote-updater[598]: [2024-04-01 10:03:46] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1711965823 101 Apr 01 10:03:46 volumio volumio[817]: info: Starting Shairport Sync Apr 01 10:03:47 volumio volumio[817]: info: Starting Shairport Sync Apr 01 10:03:47 volumio sudo[1103]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 01 10:03:47 volumio sudo[1103]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 01 10:03:47 volumio volumio[817]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 01 10:03:47 volumio sudo[1105]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 01 10:03:47 volumio volumio[817]: Error: Non okay return status: "ACK [50@0] {} No database" Apr 01 10:03:47 volumio volumio[817]: at MPD._checkReturn (/data/plugins/miscellanea/auto_play/node_modules/node-mpd/src/mpd.js:353:10) Apr 01 10:03:47 volumio volumio[817]: at MPD. (/data/plugins/miscellanea/auto_play/node_modules/node-mpd/src/mpd.js:188:18) Apr 01 10:03:47 volumio volumio[817]: at MPD._handleResponse (/data/plugins/miscellanea/auto_play/node_modules/node-mpd/src/mpd.js:450:3) Apr 01 10:03:47 volumio volumio[817]: at MPD._onData (/data/plugins/miscellanea/auto_play/node_modules/node-mpd/src/mpd.js:344:10) Apr 01 10:03:47 volumio volumio[817]: at emitOne (events.js:116:13) Apr 01 10:03:47 volumio volumio[817]: at Socket.emit (events.js:211:7) Apr 01 10:03:47 volumio volumio[817]: at addChunk (_stream_readable.js:263:12) Apr 01 10:03:48 volumio volumio[817]: at readableAddChunk (_stream_readable.js:246:13) Apr 01 10:03:48 volumio volumio[817]: at Socket.Readable.push (_stream_readable.js:208:10) Apr 01 10:03:48 volumio volumio[817]: at TCP.onread (net.js:607:20) Apr 01 10:03:47 volumio sudo[1105]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 01 10:03:47 volumio sudo[1103]: pam_unix(sudo:session): session closed for user root Apr 01 10:03:47 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Apr 01 10:03:47 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 01 10:03:48 volumio sudo[1108]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 01 10:03:48 volumio volumio[817]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 01 10:03:48 volumio sudo[1108]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 01 10:03:48 volumio systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Apr 01 10:03:48 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Apr 01 10:03:48 volumio systemd[1]: Starting Volspotconnect2 Daemon... Apr 01 10:03:48 volumio systemd[1]: Started Volspotconnect2 Daemon. Apr 01 10:03:48 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 01 10:03:48 volumio volumio[1125]: /usr/lib/startconnect.sh: line 5: 1137 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Apr 01 10:03:48 volumio systemd[1]: Starting UPnP Renderer front-end to MPD... Apr 01 10:03:49 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Apr 01 10:03:49 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Apr 01 10:03:49 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 01 10:03:49 volumio sudo[1105]: pam_unix(sudo:session): session closed for user root Apr 01 10:03:49 volumio sudo[1108]: pam_unix(sudo:session): session closed for user root Apr 01 10:03:51 volumio systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Apr 01 10:03:51 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Apr 01 10:03:51 volumio systemd[1]: Starting Volspotconnect2 Daemon... Apr 01 10:03:51 volumio systemd[1]: Started Volspotconnect2 Daemon. Apr 01 10:03:51 volumio volumio[1157]: /usr/lib/startconnect.sh: line 5: 1158 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Apr 01 10:03:53 volumio systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Apr 01 10:03:53 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Apr 01 10:03:53 volumio systemd[1]: Starting Volspotconnect2 Daemon... Apr 01 10:03:53 volumio systemd[1]: Started Volspotconnect2 Daemon. Apr 01 10:03:53 volumio volumio[1160]: /usr/lib/startconnect.sh: line 5: 1161 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Apr 01 10:03:56 volumio systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Apr 01 10:03:56 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Apr 01 10:03:56 volumio systemd[1]: Starting Volspotconnect2 Daemon... Apr 01 10:03:56 volumio systemd[1]: Started Volspotconnect2 Daemon. Apr 01 10:03:56 volumio volumio[1163]: /usr/lib/startconnect.sh: line 5: 1164 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Apr 01 10:03:58 volumio systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Apr 01 10:03:58 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Apr 01 10:03:58 volumio systemd[1]: Starting Volspotconnect2 Daemon... Apr 01 10:03:58 volumio systemd[1]: Started Volspotconnect2 Daemon. Apr 01 10:03:58 volumio volumio[1166]: /usr/lib/startconnect.sh: line 5: 1167 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Apr 01 10:03:59 volumio sudo[1171]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-01 10:02 Apr 01 10:03:59 volumio sudo[1171]: 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="ba22215fabbe766d668749499a1c25fcefd90f0a" VOLUMIO_FE_VERSION="" VOLUMIO_BE_VERSION="043dcaee624f27d121213b83af11a9f2feac0945" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Mar 18 01:32:43 CET 2020" VOLUMIO_VERSION="2.729" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="5a0b29326faa8f5d0f5fe95d9e58c069"