-- Logs begin at Tue 2024-04-30 15:02:42 UTC, end at Wed 2024-05-01 12:05:27 UTC. --
May 01 12:04:00 volumio1 volumio[919]: info: Loading plugin "wizard"...
May 01 12:04:00 volumio1 volumio[919]: info: Loading plugin "volumio_command_line_client"...
May 01 12:04:00 volumio1 volumio[919]: info: Loading plugin "upnp"...
May 01 12:04:00 volumio1 volumio[919]: info: [1714565040402] Starting Upmpd Daemon
May 01 12:04:00 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 01 12:04:00 volumio1 volumio[919]: info: Loading plugin "my_music"...
May 01 12:04:00 volumio1 volumio[919]: info: Loading plugin "mpd"...
May 01 12:04:02 volumio1 volumio[919]: info: Loading plugin "upnp_browser"...
May 01 12:04:05 volumio1 volumio[919]: info: Loading plugin "networkfs"...
May 01 12:04:06 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 01 12:04:06 volumio1 volumio[919]: info: Loading plugin "alarm-clock"...
May 01 12:04:07 volumio1 volumio[919]: info: Loading plugin "airplay_emulation"...
May 01 12:04:07 volumio1 volumio[919]: info: Starting Shairport Sync
May 01 12:04:07 volumio1 volumio[919]: info: Loading plugin "last_100"...
May 01 12:04:07 volumio1 volumio[919]: info: Loading plugin "webradio"...
May 01 12:04:08 volumio1 volumio[919]: info: Loading plugin "i2s_dacs"...
May 01 12:04:08 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 01 12:04:08 volumio1 volumio[919]: info: Loading plugin "volumiodiscovery"...
May 01 12:04:08 volumio1 volumio[919]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
May 01 12:04:08 volumio1 node[919]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
May 01 12:04:08 volumio1 node[919]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 01 12:04:08 volumio1 node[919]: *** WARNING *** For more information see
May 01 12:04:08 volumio1 node[919]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
May 01 12:04:08 volumio1 node[919]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 01 12:04:08 volumio1 node[919]: *** WARNING *** For more information see
May 01 12:04:09 volumio1 volumio[919]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 01 12:04:09 volumio1 volumio[919]: *** WARNING *** For more information see
May 01 12:04:09 volumio1 volumio[919]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
May 01 12:04:09 volumio1 volumio[919]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 01 12:04:09 volumio1 volumio[919]: *** WARNING *** For more information see
May 01 12:04:09 volumio1 volumio[919]: info: Applying required configuration parameters for plugin volumiodiscovery
May 01 12:04:09 volumio1 volumio[919]: Discovery: StartAdv! undefined
May 01 12:04:09 volumio1 volumio[919]: Discovery: Started advertising... Volumio1 - undefined
May 01 12:04:09 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 01 12:04:09 volumio1 volumio[919]: info: Loading plugin "outputs"...
May 01 12:04:09 volumio1 volumio[919]: info: Loading plugin "albumart"...
May 01 12:04:09 volumio1 volumio[919]: info: Plugin example_plugin is not enabled
May 01 12:04:09 volumio1 volumio[919]: info: Loading plugin "inputs"...
May 01 12:04:09 volumio1 volumio[919]: info: Loading plugin "updater_comm"...
May 01 12:04:09 volumio1 smbd[966]: [2024/05/01 12:04:09.887057, 0] ../lib/util/debug.c:603(reopen_logs_internal)
May 01 12:04:09 volumio1 smbd[966]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory
May 01 12:04:10 volumio1 smbd[966]: [2024/05/01 12:04:10.067583, 0] ../lib/util/debug.c:603(reopen_logs_internal)
May 01 12:04:10 volumio1 smbd[966]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory
May 01 12:04:10 volumio1 smbd[966]: [2024/05/01 12:04:10.077581, 0] ../lib/util/debug.c:603(reopen_logs_internal)
May 01 12:04:10 volumio1 smbd[966]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory
May 01 12:04:10 volumio1 smbd[966]: [2024/05/01 12:04:10.079128, 0] ../lib/util/debug.c:603(reopen_logs_internal)
May 01 12:04:10 volumio1 smbd[966]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory
May 01 12:04:10 volumio1 smbd[966]: [2024/05/01 12:04:10.194498, 0] ../lib/util/debug.c:603(reopen_logs_internal)
May 01 12:04:10 volumio1 smbd[966]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory
May 01 12:04:10 volumio1 smbd[966]: [2024/05/01 12:04:10.241934, 0] ../lib/util/debug.c:603(reopen_logs_internal)
May 01 12:04:10 volumio1 smbd[966]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory
May 01 12:04:11 volumio1 smbd[969]: [2024/05/01 12:04:11.287002, 0] ../lib/util/debug.c:603(reopen_logs_internal)
May 01 12:04:11 volumio1 smbd[969]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory
May 01 12:04:11 volumio1 smbd[969]: [2024/05/01 12:04:11.315922, 0] ../lib/util/debug.c:603(reopen_logs_internal)
May 01 12:04:11 volumio1 smbd[969]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory
May 01 12:04:11 volumio1 smbd[969]: [2024/05/01 12:04:11.469703, 0] ../lib/util/debug.c:603(reopen_logs_internal)
May 01 12:04:11 volumio1 smbd[969]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory
May 01 12:04:11 volumio1 smbd[969]: [2024/05/01 12:04:11.500058, 0] ../lib/util/debug.c:603(reopen_logs_internal)
May 01 12:04:11 volumio1 smbd[969]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory
May 01 12:04:11 volumio1 smbd[969]: [2024/05/01 12:04:11.515437, 0] ../lib/util/debug.c:603(reopen_logs_internal)
May 01 12:04:11 volumio1 smbd[969]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory
May 01 12:04:12 volumio1 volumio[919]: info: Plugin mpdemulation is not enabled
May 01 12:04:12 volumio1 volumio[919]: info: Loading plugin "rest_api"...
May 01 12:04:12 volumio1 smbd[972]: [2024/05/01 12:04:12.607189, 0] ../lib/util/debug.c:603(reopen_logs_internal)
May 01 12:04:12 volumio1 smbd[972]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory
May 01 12:04:12 volumio1 smbd[972]: [2024/05/01 12:04:12.625856, 0] ../lib/util/debug.c:603(reopen_logs_internal)
May 01 12:04:12 volumio1 smbd[972]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory
May 01 12:04:12 volumio1 volumio-remote-updater[507]: [2024-05-01 12:04:12] [connect] Successful connection
May 01 12:04:12 volumio1 smbd[972]: [2024/05/01 12:04:12.762862, 0] ../lib/util/debug.c:603(reopen_logs_internal)
May 01 12:04:12 volumio1 smbd[972]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory
May 01 12:04:12 volumio1 volumio[919]: info: Loading plugin "websocket"...
May 01 12:04:13 volumio1 volumio[919]: info: ___________ START PLUGINS ___________
May 01 12:04:13 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 01 12:04:13 volumio1 volumio[919]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 01 12:04:13 volumio1 volumio[919]: info: [1714565053451] CoreMusicLibrary::Adding element Media Servers
May 01 12:04:13 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 01 12:04:13 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 01 12:04:14 volumio1 volumio[919]: Forking 1 albumart workers
May 01 12:04:14 volumio1 volumio[919]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 01 12:04:14 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 01 12:04:14 volumio1 volumio[919]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 01 12:04:14 volumio1 volumio[919]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 01 12:04:14 volumio1 volumio[919]: info: [1714565054729] CoreMusicLibrary::Adding element Last_100
May 01 12:04:14 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 01 12:04:14 volumio1 volumio[919]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 01 12:04:14 volumio1 volumio[919]: info: [1714565054779] CoreMusicLibrary::Adding element Webradio
May 01 12:04:14 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 01 12:04:14 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 01 12:04:14 volumio1 volumio[919]: info: -------------------------------------------
May 01 12:04:14 volumio1 volumio[919]: info: ----- MyVolumio plugins startup ----
May 01 12:04:14 volumio1 volumio[919]: info: -------------------------------------------
May 01 12:04:14 volumio1 volumio[919]: info: [MyVolumio PluginManager] Fetching plans data....
May 01 12:04:15 volumio1 volumio[919]: info: Loading i18n strings for locale en
May 01 12:04:15 volumio1 volumio[919]: Updating browse sources language
May 01 12:04:15 volumio1 volumio[919]: Cannot find translation for sourceMedia Servers
May 01 12:04:15 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 01 12:04:15 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 01 12:04:15 volumio1 volumio[919]: info: CoreCommandRouter::initPlayerControls
May 01 12:04:15 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 01 12:04:15 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 01 12:04:15 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 01 12:04:15 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 01 12:04:15 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 01 12:04:15 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 01 12:04:15 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 01 12:04:15 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 01 12:04:15 volumio1 volumio[919]: info: BOOT COMPLETED
May 01 12:04:15 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 01 12:04:20 volumio1 volumio[919]: Starting albumart workers
May 01 12:04:21 volumio1 volumio[919]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo
May 01 12:04:21 volumio1 volumio[919]: info: CoreCommandRouter::Close All Modals sent
May 01 12:04:21 volumio1 volumio[919]: info: CoreCommandRouter::Close All Modals sent
May 01 12:04:21 volumio1 volumio[919]: Express server listening on port 3000
May 01 12:04:21 volumio1 volumio[919]: Volumio Calling Home
May 01 12:04:22 volumio1 volumio[919]: info: CoreStateMachine::resetVolumioState
May 01 12:04:22 volumio1 volumio[919]: info: CoreStateMachine::getcurrentVolume
May 01 12:04:22 volumio1 volumio[919]: info: CoreCommandRouter::volumioRetrievevolume
May 01 12:04:23 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
May 01 12:04:23 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: raat , onStop
May 01 12:04:23 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
May 01 12:04:24 volumio1 sudo[1009]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 01 12:04:24 volumio1 sudo[1009]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 01 12:04:24 volumio1 sudo[1009]: pam_unix(sudo:session): session closed for user root
May 01 12:04:24 volumio1 volumio[919]: info: CoreStateMachine::pushState
May 01 12:04:24 volumio1 volumio[919]: info: CoreStateMachine::getState
May 01 12:04:24 volumio1 volumio[919]: info: CorePlayQueue::getTrack 0
May 01 12:04:24 volumio1 volumio[919]: info: CoreCommandRouter::volumioPushState
May 01 12:04:24 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 01 12:04:24 volumio1 volumio[919]: info: CoreStateMachine::updateTrackBlock
May 01 12:04:24 volumio1 volumio[919]: info: CorePlayQueue::getTrackBlock
May 01 12:04:24 volumio1 volumio[919]: info: CoreCommandRouter::volumioRetrievevolume
May 01 12:04:25 volumio1 volumio[919]: info: Setting Device type: Raspberry PI
May 01 12:04:25 volumio1 volumio[919]: error: Cannot initialize MPD Connection: MPD is not running
May 01 12:04:26 volumio1 volumio[919]: info:
May 01 12:04:26 volumio1 volumio[919]: ---------------------------- Client requests Volume 20
May 01 12:04:26 volumio1 volumio[919]: info: VolumeController::SetAlsaVolume20
May 01 12:04:26 volumio1 volumio[919]: info: CoreStateMachine::pushState
May 01 12:04:26 volumio1 volumio[919]: info: CoreStateMachine::getState
May 01 12:04:26 volumio1 volumio[919]: info: CorePlayQueue::getTrack 0
May 01 12:04:26 volumio1 volumio[919]: info: CoreCommandRouter::volumioPushState
May 01 12:04:26 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 01 12:04:26 volumio1 volumio[919]: info: CoreStateMachine::pushState
May 01 12:04:26 volumio1 volumio[919]: info: CoreStateMachine::getState
May 01 12:04:26 volumio1 volumio[919]: info: CorePlayQueue::getTrack 0
May 01 12:04:26 volumio1 volumio[919]: info: CoreCommandRouter::volumioPushState
May 01 12:04:26 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 01 12:04:27 volumio1 volumio[919]: info: Reloading queue from file
May 01 12:04:27 volumio1 volumio[919]: info: Setting volume on startup at 20
May 01 12:04:27 volumio1 volumio[919]: info: CoreStateMachine::setRepeat null single undefined
May 01 12:04:27 volumio1 volumio[919]: info: CoreStateMachine::pushState
May 01 12:04:27 volumio1 volumio[919]: info: CoreStateMachine::getState
May 01 12:04:27 volumio1 volumio[919]: info: CorePlayQueue::getTrack 0
May 01 12:04:27 volumio1 volumio[919]: info: CoreCommandRouter::volumioPushState
May 01 12:04:27 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 01 12:04:27 volumio1 volumio[919]: info: CoreStateMachine::setRandom null
May 01 12:04:27 volumio1 volumio[919]: info: CoreStateMachine::pushState
May 01 12:04:27 volumio1 volumio[919]: info: CoreStateMachine::getState
May 01 12:04:27 volumio1 volumio[919]: info: CorePlayQueue::getTrack 0
May 01 12:04:27 volumio1 volumio[919]: info: CoreCommandRouter::volumioPushState
May 01 12:04:27 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 01 12:04:27 volumio1 volumio-remote-updater[507]: [2024-05-01 12:04:27] [connect] Successful connection
May 01 12:04:28 volumio1 volumio[919]: info: Starting Shairport Sync
May 01 12:04:28 volumio1 volumio[919]: info: Starting Shairport Sync
May 01 12:04:28 volumio1 sudo[1027]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
May 01 12:04:28 volumio1 sudo[1027]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 01 12:04:28 volumio1 sudo[1029]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
May 01 12:04:28 volumio1 systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver...
May 01 12:04:28 volumio1 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
May 01 12:04:28 volumio1 sudo[1029]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 01 12:04:28 volumio1 sudo[1027]: pam_unix(sudo:session): session closed for user root
May 01 12:04:29 volumio1 sudo[1033]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
May 01 12:04:29 volumio1 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
May 01 12:04:29 volumio1 systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver...
May 01 12:04:29 volumio1 sudo[1033]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 01 12:04:29 volumio1 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
May 01 12:04:29 volumio1 sudo[1029]: pam_unix(sudo:session): session closed for user root
May 01 12:04:29 volumio1 systemd[1]: Starting UPnP Renderer front-end to MPD...
May 01 12:04:29 volumio1 systemd[1]: Started UPnP Renderer front-end to MPD.
May 01 12:04:29 volumio1 sudo[1033]: pam_unix(sudo:session): session closed for user root
May 01 12:04:30 volumio1 volumio[919]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
May 01 12:04:30 volumio1 volumio[919]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
May 01 12:04:30 volumio1 volumio[919]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
May 01 12:04:30 volumio1 volumio[919]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
May 01 12:04:30 volumio1 volumio[919]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
May 01 12:04:30 volumio1 volumio[919]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
May 01 12:04:30 volumio1 volumio[919]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
May 01 12:04:30 volumio1 volumio[919]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
May 01 12:04:30 volumio1 volumio[919]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
May 01 12:04:30 volumio1 volumio[919]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
May 01 12:04:30 volumio1 volumio[919]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
May 01 12:04:30 volumio1 volumio[919]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
May 01 12:04:30 volumio1 volumio[919]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
May 01 12:04:30 volumio1 volumio[919]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
May 01 12:04:30 volumio1 volumio[919]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
May 01 12:04:30 volumio1 volumio[919]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
May 01 12:04:30 volumio1 volumio[919]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
May 01 12:04:30 volumio1 volumio[919]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
May 01 12:04:30 volumio1 volumio[919]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
May 01 12:04:30 volumio1 volumio[919]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
May 01 12:04:30 volumio1 volumio[919]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
May 01 12:04:30 volumio1 volumio[919]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
May 01 12:04:30 volumio1 volumio[919]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
May 01 12:04:30 volumio1 volumio[919]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
May 01 12:04:30 volumio1 volumio[919]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
May 01 12:04:30 volumio1 volumio[919]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
May 01 12:04:30 volumio1 volumio[919]: info: Adding plugin bluetooth to MyMusic Plugins
May 01 12:04:30 volumio1 volumio[919]: info: Adding plugin cd_controller to MyMusic Plugins
May 01 12:04:30 volumio1 volumio[919]: info: Adding plugin smart_inputs to MyMusic Plugins
May 01 12:04:30 volumio1 volumio[919]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
May 01 12:04:42 volumio1 volumio-remote-updater[507]: [2024-05-01 12:04:42] [connect] Successful connection
May 01 12:04:43 volumio1 volumio[919]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
May 01 12:04:53 volumio1 volumio[919]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
May 01 12:04:53 volumio1 volumio[919]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
May 01 12:04:53 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 01 12:04:53 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 01 12:04:53 volumio1 volumio[919]: info: Starting MyVolumio Remote Streaming Endpoints
May 01 12:04:53 volumio1 volumio[919]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
May 01 12:04:53 volumio1 volumio[919]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
May 01 12:04:53 volumio1 volumio[919]: info: Streaming services startup
May 01 12:04:53 volumio1 volumio[919]: info: Starting Streaming Daemon
May 01 12:04:53 volumio1 volumio[919]: info: MyVolumio not started
May 01 12:04:53 volumio1 volumio[919]: info: Initializing device activation check
May 01 12:04:53 volumio1 sudo[1071]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
May 01 12:04:53 volumio1 sudo[1071]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 01 12:04:53 volumio1 systemd[1]: Stopping Volumio Streaming Daemon...
May 01 12:04:54 volumio1 systemd[1]: Starting Volumio Streaming Daemon...
May 01 12:04:54 volumio1 volumio[919]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
May 01 12:04:54 volumio1 systemd[1]: Started Volumio Streaming Daemon.
May 01 12:04:54 volumio1 sudo[1071]: pam_unix(sudo:session): session closed for user root
May 01 12:04:54 volumio1 volumio-streaming-daemon[1077]: ############################
May 01 12:04:54 volumio1 volumio-streaming-daemon[1077]: # Volumio Streaming Daemon #
May 01 12:04:54 volumio1 volumio-streaming-daemon[1077]: # Running on port 7777 #
May 01 12:04:54 volumio1 volumio-streaming-daemon[1077]: ############################
May 01 12:04:54 volumio1 volumio[919]: info: CoreCommandRouter::volumioGetState
May 01 12:04:54 volumio1 volumio[919]: info: CoreStateMachine::getState
May 01 12:04:54 volumio1 volumio[919]: info: CorePlayQueue::getTrack 0
May 01 12:04:54 volumio1 volumio[919]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.703&uuid=5e5cecd0379c44b5b42f9783849c5f11" http://updates.volumio.org:7070/downloader-v1/track-device
May 01 12:04:54 volumio1 volumio[919]: % Total % Received % Xferd Average Speed Time Time Time Current
May 01 12:04:54 volumio1 volumio[919]: Dload Upload Total Spent Left Speed
May 01 12:04:54 volumio1 volumio[919]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused
May 01 12:04:54 volumio1 volumio[919]: retrying in 5 seconds, trial 0
May 01 12:04:54 volumio1 volumio[919]: Volumio Calling Home
May 01 12:04:54 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 01 12:04:54 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 01 12:04:55 volumio1 volumio[919]: Discovery: adding 0bff7615-d831-4003-8df1-063fa5ab003f
May 01 12:04:55 volumio1 volumio[919]: info: mDNS: Found device Volumio1
May 01 12:04:55 volumio1 sudo[1090]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 01 12:04:55 volumio1 sudo[1090]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 01 12:04:55 volumio1 sudo[1090]: pam_unix(sudo:session): session closed for user root
May 01 12:04:56 volumio1 volumio[919]: info: Upmpdcli Daemon Started
May 01 12:04:56 volumio1 volumio[919]: info: Shairport-Sync Started
May 01 12:04:56 volumio1 volumio[919]: Error adding Membership: Error: addMembership EINVAL
May 01 12:04:56 volumio1 volumio[919]: info: Shairport-Sync Started
May 01 12:04:56 volumio1 volumio[919]: Discovery: adding 6379520e-048b-4162-8297-d80391a171a3
May 01 12:04:56 volumio1 volumio[919]: info: mDNS: Found device Volumio2
May 01 12:04:57 volumio1 sudo[1099]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 01 12:04:57 volumio1 volumio[919]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600
May 01 12:04:57 volumio1 sudo[1099]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 01 12:04:57 volumio1 sudo[1099]: pam_unix(sudo:session): session closed for user root
May 01 12:04:57 volumio1 volumio-remote-updater[507]: [2024-05-01 12:04:57] [connect] Successful connection
May 01 12:04:58 volumio1 volumio[919]: info: CoreCommandRouter::volumioGetState
May 01 12:04:58 volumio1 volumio[919]: info: CoreStateMachine::getState
May 01 12:04:58 volumio1 volumio[919]: info: CorePlayQueue::getTrack 0
May 01 12:04:58 volumio1 volumio-remote-updater[507]: [2024-05-01 12:04:58] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1714565097 101
May 01 12:04:58 volumio1 sudo[1108]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 01 12:04:58 volumio1 sudo[1108]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 01 12:04:59 volumio1 sudo[1108]: pam_unix(sudo:session): session closed for user root
May 01 12:04:59 volumio1 sudo[1117]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 01 12:04:59 volumio1 sudo[1117]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 01 12:04:59 volumio1 sudo[1119]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 01 12:04:59 volumio1 sudo[1117]: pam_unix(sudo:session): session closed for user root
May 01 12:04:59 volumio1 sudo[1119]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 01 12:04:59 volumio1 sudo[1119]: pam_unix(sudo:session): session closed for user root
May 01 12:05:01 volumio1 volumio[919]: info: CoreCommandRouter::volumioGetState
May 01 12:05:01 volumio1 volumio[919]: info: CoreStateMachine::getState
May 01 12:05:01 volumio1 volumio[919]: info: CorePlayQueue::getTrack 0
May 01 12:05:01 volumio1 sudo[1136]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 01 12:05:01 volumio1 sudo[1136]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 01 12:05:01 volumio1 sudo[1136]: pam_unix(sudo:session): session closed for user root
May 01 12:05:02 volumio1 volumio[919]: info: Fetching Streaming Services browse cache
May 01 12:05:02 volumio1 volumio[919]: info: CoreCommandRouter::volumioGetVisibleSources
May 01 12:05:02 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 01 12:05:02 volumio1 volumio[919]: info: CoreCommandRouter::volumioGetState
May 01 12:05:02 volumio1 volumio[919]: info: CoreStateMachine::getState
May 01 12:05:02 volumio1 volumio[919]: info: CorePlayQueue::getTrack 0
May 01 12:05:02 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
May 01 12:05:02 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 01 12:05:02 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
May 01 12:05:02 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
May 01 12:05:02 volumio1 sudo[1145]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 01 12:05:02 volumio1 sudo[1145]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 01 12:05:02 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
May 01 12:05:02 volumio1 volumio[919]: info: Listing playlists
May 01 12:05:02 volumio1 sudo[1145]: pam_unix(sudo:session): session closed for user root
May 01 12:05:03 volumio1 sudo[1150]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 01 12:05:03 volumio1 sudo[1150]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 01 12:05:03 volumio1 volumio[919]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesQOBUZ
May 01 12:05:03 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 01 12:05:03 volumio1 sudo[1150]: pam_unix(sudo:session): session closed for user root
May 01 12:05:03 volumio1 volumio[919]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesTIDAL
May 01 12:05:03 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 01 12:05:03 volumio1 volumio[919]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600
May 01 12:05:05 volumio1 volumio[919]: info: No input data
May 01 12:05:06 volumio1 volumio[919]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.703&uuid=5e5cecd0379c44b5b42f9783849c5f11" http://updates.volumio.org:7070/downloader-v1/track-device
May 01 12:05:06 volumio1 volumio[919]: % Total % Received % Xferd Average Speed Time Time Time Current
May 01 12:05:06 volumio1 volumio[919]: Dload Upload Total Spent Left Speed
May 01 12:05:06 volumio1 volumio[919]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused
May 01 12:05:06 volumio1 volumio[919]: retrying in 5 seconds, trial 1
May 01 12:05:06 volumio1 volumio[919]: Volumio Calling Home
May 01 12:05:09 volumio1 volumio[919]: info: CoreCommandRouter::volumioGetQueue
May 01 12:05:09 volumio1 volumio[919]: info: CoreStateMachine::getQueue
May 01 12:05:09 volumio1 volumio[919]: info: CorePlayQueue::getQueue
May 01 12:05:12 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
May 01 12:05:12 volumio1 volumio[919]: info: CURURI: music-library
May 01 12:05:12 volumio1 volumio[919]: error: Failed to execute browseSource: TypeError: Cannot read property 'then' of undefined
May 01 12:05:16 volumio1 volumio[919]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.703&uuid=5e5cecd0379c44b5b42f9783849c5f11" http://updates.volumio.org:7070/downloader-v1/track-device
May 01 12:05:16 volumio1 volumio[919]: % Total % Received % Xferd Average Speed Time Time Time Current
May 01 12:05:16 volumio1 volumio[919]: Dload Upload Total Spent Left Speed
May 01 12:05:16 volumio1 volumio[919]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused
May 01 12:05:16 volumio1 volumio[919]: retrying in 5 seconds, trial 2
May 01 12:05:16 volumio1 volumio[919]: Volumio Calling Home
May 01 12:05:17 volumio1 volumio[919]: info: CoreCommandRouter::getUIConfigOnPlugin
May 01 12:05:17 volumio1 volumio[919]: info: CoreCommandRouter::getUIConfigOnPlugin
May 01 12:05:17 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
May 01 12:05:17 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
May 01 12:05:17 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
May 01 12:05:17 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
May 01 12:05:17 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 01 12:05:17 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 01 12:05:17 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 01 12:05:17 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 01 12:05:17 volumio1 volumio[919]: info: CoreCommandRouter::volumioGetBrowseSources
May 01 12:05:17 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 01 12:05:17 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
May 01 12:05:21 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 01 12:05:22 volumio1 volumio[919]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb
May 01 12:05:22 volumio1 volumio[919]: info: ControllerMpd::sendMpdCommand rescan
May 01 12:05:22 volumio1 volumio[919]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 01 12:05:22 volumio1 volumio[919]: TypeError: Cannot read property 'then' of undefined
May 01 12:05:22 volumio1 volumio[919]: at ControllerMpd.sendMpdCommand (/volumio/app/plugins/music_service/mpd/index.js:347:10)
May 01 12:05:22 volumio1 volumio[919]: at ControllerMpd.rescanDb (/volumio/app/plugins/music_service/mpd/index.js:1907:17)
May 01 12:05:22 volumio1 volumio[919]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1078:29)
May 01 12:05:22 volumio1 volumio[919]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:986:24)
May 01 12:05:22 volumio1 volumio[919]: at emitTwo (events.js:126:13)
May 01 12:05:22 volumio1 volumio[919]: at Socket.emit (events.js:214:7)
May 01 12:05:22 volumio1 volumio[919]: at /volumio/node_modules/socket.io/lib/socket.js:503:12
May 01 12:05:22 volumio1 volumio[919]: at _combinedTickCallback (internal/process/next_tick.js:131:7)
May 01 12:05:22 volumio1 volumio[919]: at process._tickCallback (internal/process/next_tick.js:180:9)
May 01 12:05:22 volumio1 volumio[919]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 01 12:05:27 volumio1 sudo[1179]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-01 12:04
May 01 12:05:27 volumio1 sudo[1179]: 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="7441f93fb55fc13e1243278874bfebef55eaac89"
VOLUMIO_FE_VERSION=""
VOLUMIO_BE_VERSION="60cbd8a1e03b2e464c11c01f54954168a34e9b45"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Sat Feb 15 03:28:59 CET 2020"
VOLUMIO_VERSION="2.703"
VOLUMIO_HARDWARE="pi"
VOLUMIO_HASH="c6482eede154d29f2cc010e5a630bcb4"