-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Sat 2025-03-08 18:08:48 CET. -- Mar 08 18:07:30 volumio systemd-timedated[907]: Changed local time to Sat Mar 8 18:07:30 2025 Mar 08 18:07:30 volumio sudo[901]: pam_unix(sudo:session): session closed for user root Mar 08 18:07:30 volumio volumio-time-update[519]: volumio-time-update-util: System time updated successfully. Mar 08 18:07:30 volumio volumio[780]: info: Starting Udev Watcher for removable devices Mar 08 18:07:30 volumio volumio[780]: info: Ignoring mount for partition: boot Mar 08 18:07:30 volumio volumio[780]: info: Ignoring mount for partition: volumio Mar 08 18:07:30 volumio volumio[780]: info: Ignoring mount for partition: volumio_data Mar 08 18:07:30 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 08 18:07:30 volumio volumio[780]: info: Loading plugin "volumio_command_line_client"... Mar 08 18:07:30 volumio systemd[1]: Starting Daily apt download activities... Mar 08 18:07:30 volumio systemd[1]: Started Volumio Time Update Utility. Mar 08 18:07:30 volumio systemd[1]: Reached target Multi-User System. Mar 08 18:07:30 volumio systemd[1]: Reached target Graphical Interface. Mar 08 18:07:30 volumio volumio[780]: info: Loading plugin "upnp"... Mar 08 18:07:30 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Mar 08 18:07:30 volumio volumio[780]: info: [1741453650121] Starting Upmpd Daemon Mar 08 18:07:30 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 08 18:07:30 volumio volumio[780]: info: Loading plugin "my_music"... Mar 08 18:07:30 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Mar 08 18:07:30 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Mar 08 18:07:30 volumio volumio[780]: info: Loading plugin "mpd"... Mar 08 18:07:30 volumio volumio[780]: info: Loading plugin "upnp_browser"... Mar 08 18:07:31 volumio volumio[780]: info: Loading plugin "alarm-clock"... Mar 08 18:07:31 volumio volumio-remote-updater[509]: [2025-03-08 18:07:31] [connect] Successful connection Mar 08 18:07:31 volumio volumio[780]: info: Plugin airplay_emulation is not enabled Mar 08 18:07:31 volumio volumio[780]: info: Loading plugin "last_100"... Mar 08 18:07:31 volumio volumio[780]: info: Loading plugin "webradio"... Mar 08 18:07:32 volumio volumio[780]: info: Loading plugin "i2s_dacs"... Mar 08 18:07:32 volumio volumio[780]: info: Loading plugin "volumiodiscovery"... Mar 08 18:07:32 volumio volumio[780]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 08 18:07:32 volumio volumio[780]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 08 18:07:32 volumio volumio[780]: *** WARNING *** For more information see Mar 08 18:07:32 volumio volumio[780]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 08 18:07:32 volumio node[780]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 08 18:07:32 volumio volumio[780]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 08 18:07:32 volumio volumio[780]: *** WARNING *** For more information see Mar 08 18:07:32 volumio node[780]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 08 18:07:32 volumio node[780]: *** WARNING *** For more information see Mar 08 18:07:32 volumio node[780]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 08 18:07:32 volumio node[780]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 08 18:07:32 volumio node[780]: *** WARNING *** For more information see Mar 08 18:07:32 volumio volumio[780]: info: Applying required configuration parameters for plugin volumiodiscovery Mar 08 18:07:32 volumio volumio[780]: info: Discovery: Started advertising with name: Volumio Mar 08 18:07:32 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 08 18:07:32 volumio volumio[780]: info: Loading plugin "autostart"... Mar 08 18:07:32 volumio volumio[780]: info: Applying required configuration parameters for plugin autostart Mar 08 18:07:32 volumio volumio[780]: info: AutoStart - onVolumioStart - read config.json Mar 08 18:07:32 volumio volumio[780]: info: Loading plugin "gpio-buttons"... Mar 08 18:07:33 volumio volumio[780]: info: GPIO-Buttons initialized Mar 08 18:07:33 volumio volumio[780]: info: Loading plugin "outputs"... Mar 08 18:07:33 volumio volumio[780]: info: Loading plugin "albumart"... Mar 08 18:07:33 volumio volumio[780]: info: Plugin example_plugin is not enabled Mar 08 18:07:33 volumio volumio[780]: info: Loading plugin "inputs"... Mar 08 18:07:33 volumio volumio[780]: info: Loading plugin "updater_comm"... Mar 08 18:07:33 volumio volumio[780]: info: Plugin mpdemulation is not enabled Mar 08 18:07:33 volumio volumio[780]: info: Loading plugin "rest_api"... Mar 08 18:07:33 volumio volumio[780]: info: Loading plugin "websocket"... Mar 08 18:07:33 volumio volumio[780]: info: Starting Socket.io Server version 2.3.0 Mar 08 18:07:33 volumio volumio[780]: info: Loading plugin "ir_controller"... Mar 08 18:07:33 volumio systemd[1]: apt-daily.service: Succeeded. Mar 08 18:07:33 volumio systemd[1]: Started Daily apt download activities. Mar 08 18:07:33 volumio volumio[780]: Forking 3 albumart workers Mar 08 18:07:33 volumio systemd[1]: Starting Daily apt upgrade and clean activities... Mar 08 18:07:34 volumio volumio[780]: info: Applying required configuration parameters for plugin ir_controller Mar 08 18:07:34 volumio volumio[780]: info: Loading i18n strings for locale en Mar 08 18:07:34 volumio volumio[780]: Updating browse sources language Mar 08 18:07:34 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 08 18:07:34 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 08 18:07:34 volumio volumio[780]: info: CoreCommandRouter::initPlayerControls Mar 08 18:07:34 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 18:07:34 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 18:07:34 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 18:07:34 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 18:07:34 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 18:07:34 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 18:07:34 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 18:07:34 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 18:07:35 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 08 18:07:35 volumio volumio[780]: Express server listening on port 3000 Mar 08 18:07:35 volumio volumio[780]: [Metrics] WebUI: 9s 783.25ms Mar 08 18:07:35 volumio volumio[780]: info: CoreStateMachine::resetVolumioState Mar 08 18:07:35 volumio volumio[780]: info: CoreStateMachine::getcurrentVolume Mar 08 18:07:35 volumio volumio[780]: info: CoreCommandRouter::volumioRetrievevolume Mar 08 18:07:35 volumio volumio[780]: Starting albumart workers Mar 08 18:07:35 volumio volumio[780]: info: Volumio Network Manager: Network status updated: 1 Mar 08 18:07:35 volumio volumio[780]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Mar 08 18:07:35 volumio volumio[780]: wlan0 Interface doesn't support scanning. Mar 08 18:07:35 volumio volumio[780]: info: Cannot use regular scanning, forcing with ap-force Mar 08 18:07:35 volumio volumio[780]: Starting albumart workers Mar 08 18:07:35 volumio sudo[1055]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Mar 08 18:07:35 volumio sudo[1055]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 18:07:35 volumio sudo[1055]: pam_unix(sudo:session): session closed for user root Mar 08 18:07:35 volumio volumio[780]: command failed: No such device (-19) Mar 08 18:07:35 volumio volumio[780]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Mar 08 18:07:35 volumio volumio[780]: command failed: No such device (-19) Mar 08 18:07:35 volumio volumio-remote-updater[509]: [2025-03-08 18:07:35] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1741453651 101 Mar 08 18:07:35 volumio volumio[780]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 1 Mar 08 18:07:35 volumio volumio[780]: Starting albumart workers Mar 08 18:07:35 volumio volumio[780]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Mar 08 18:07:35 volumio volumio[780]: info: Reloading queue from file Mar 08 18:07:35 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 18:07:35 volumio volumio[780]: info: VolumeController:: Volume=100 Mute =false Mar 08 18:07:35 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:07:35 volumio volumio[780]: info: CorePlayQueue::getTrack 0 Mar 08 18:07:35 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 18:07:35 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:07:35 volumio volumio[780]: info: CoreStateMachine::updateTrackBlock Mar 08 18:07:35 volumio volumio[780]: info: CorePlayQueue::getTrackBlock Mar 08 18:07:35 volumio volumio[780]: info: CoreCommandRouter::volumioRetrievevolume Mar 08 18:07:35 volumio volumio[780]: info: CoreStateMachine::setRepeat null single undefined Mar 08 18:07:35 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:07:35 volumio volumio[780]: info: CorePlayQueue::getTrack 0 Mar 08 18:07:35 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:07:35 volumio volumio[780]: info: CoreStateMachine::setRandom null Mar 08 18:07:35 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:07:35 volumio volumio[780]: info: CorePlayQueue::getTrack 0 Mar 08 18:07:35 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:07:35 volumio volumio[780]: info: Setting Device type: Raspberry PI Mar 08 18:07:35 volumio volumio[780]: info: Completed loading Core Plugins Mar 08 18:07:35 volumio volumio[780]: info: Preparing to generate the ALSA configuration file Mar 08 18:07:35 volumio volumio[780]: info: Discovery: adding ab656c91-b53a-456f-bc3b-eb814fe96013 Mar 08 18:07:35 volumio volumio[780]: info: Discovery: Found device Volumio Mar 08 18:07:35 volumio volumio[780]: info: CoreCommandRouter::volumioGetState Mar 08 18:07:35 volumio volumio[780]: info: CorePlayQueue::getTrack 0 Mar 08 18:07:35 volumio volumio[780]: info: Asound.conf file unchanged, so no further update is needed Mar 08 18:07:35 volumio volumio[780]: info: Output device has changed, restarting MPD Mar 08 18:07:36 volumio sudo[1100]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 08 18:07:36 volumio sudo[1100]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 18:07:36 volumio volumio[780]: info: ___________ START PLUGINS ___________ Mar 08 18:07:36 volumio sudo[1100]: pam_unix(sudo:session): session closed for user root Mar 08 18:07:36 volumio volumio[780]: info: ControllerMpd::onStart: Initializing MPD Mar 08 18:07:36 volumio volumio[780]: info: Creating MPD Configuration file Mar 08 18:07:36 volumio sudo[1108]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 08 18:07:36 volumio sudo[1108]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 18:07:36 volumio systemd[1]: Stopping Music Player Daemon... Mar 08 18:07:36 volumio sudo[1117]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 08 18:07:36 volumio sudo[1117]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 18:07:36 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 08 18:07:36 volumio volumio[780]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 08 18:07:36 volumio volumio[780]: info: [1741453656144] CoreMusicLibrary::Adding element Media Servers Mar 08 18:07:36 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 08 18:07:36 volumio sudo[1120]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 08 18:07:36 volumio sudo[1120]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 18:07:36 volumio sudo[1117]: pam_unix(sudo:session): session closed for user root Mar 08 18:07:36 volumio volumio[780]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 08 18:07:36 volumio volumio[780]: info: [1741453656196] CoreMusicLibrary::Adding element Last_100 Mar 08 18:07:36 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 08 18:07:36 volumio volumio[780]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 08 18:07:36 volumio volumio[780]: info: [1741453656210] CoreMusicLibrary::Adding element Webradio Mar 08 18:07:36 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 08 18:07:36 volumio systemd[1]: apt-daily-upgrade.service: Succeeded. Mar 08 18:07:36 volumio systemd[1]: Started Daily apt upgrade and clean activities. Mar 08 18:07:36 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 08 18:07:36 volumio volumio[780]: info: Initializing BBC Radios Mar 08 18:07:36 volumio systemd[1]: mpd.service: Succeeded. Mar 08 18:07:36 volumio systemd[1]: Stopped Music Player Daemon. Mar 08 18:07:36 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 08 18:07:36 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 18:07:36 volumio volumio[780]: info: AutoStart - onStart Mar 08 18:07:36 volumio systemd[1]: Starting Music Player Daemon... Mar 08 18:07:36 volumio volumio[780]: info: GPIO-Buttons: Reading config and creating triggers... Mar 08 18:07:36 volumio volumio[780]: info: GPIO-Buttons: shutdown on pin 516 Mar 08 18:07:36 volumio volumio[780]: info: Loading i18n strings for locale en Mar 08 18:07:36 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 08 18:07:36 volumio volumio[780]: info: Volumio Calling Home Mar 08 18:07:36 volumio sudo[1133]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 08 18:07:36 volumio sudo[1133]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 18:07:36 volumio sudo[1133]: pam_unix(sudo:session): session closed for user root Mar 08 18:07:36 volumio volumio[780]: info: GPIO-Buttons started Mar 08 18:07:36 volumio sudo[1166]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R a+rwX /etc/lirc/irexec.lircrc /etc/lirc/lirc_options.conf /etc/lirc/lircd.conf /etc/lirc/lircd.conf.d /etc/lirc/lircmd.conf /etc/lirc/lircrc Mar 08 18:07:36 volumio sudo[1166]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 18:07:36 volumio sudo[1166]: pam_unix(sudo:session): session closed for user root Mar 08 18:07:36 volumio volumio[780]: info: VolumeController:: Volume=100 Mute =false Mar 08 18:07:36 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:07:36 volumio volumio[780]: info: CorePlayQueue::getTrack 0 Mar 08 18:07:36 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:07:36 volumio volumio[780]: info: ir_controller: File permissions successfully set on /etc/lirc/*. Mar 08 18:07:36 volumio volumio[780]: info: MPD Permissions set Mar 08 18:07:36 volumio volumio[780]: info: MPD Permissions set Mar 08 18:07:36 volumio volumio[780]: info: Volumio called home Mar 08 18:07:36 volumio volumio[780]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 08 18:07:36 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 18:07:36 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 18:07:36 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 18:07:36 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 18:07:36 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 18:07:36 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 18:07:36 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 18:07:36 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 18:07:36 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 18:07:36 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 18:07:36 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 18:07:36 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 18:07:36 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 18:07:36 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 18:07:36 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 18:07:36 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 18:07:36 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 18:07:36 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 18:07:36 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 18:07:36 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 18:07:37 volumio volumio[780]: info: CoreCommandRouter::volumioGetState Mar 08 18:07:37 volumio volumio[780]: info: CorePlayQueue::getTrack 0 Mar 08 18:07:37 volumio volumio[780]: info: ir_controller: LIRC correctly updated. Mar 08 18:07:37 volumio volumio[780]: info: ir_controller: HAT did not load /proc/device-tree/ir_receiver! Mar 08 18:07:37 volumio volumio[780]: info: ir_controller: Raspberry Pi revision code: a020d4 Mar 08 18:07:37 volumio sudo[1181]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -r -1 Mar 08 18:07:37 volumio sudo[1181]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 18:07:37 volumio sudo[1181]: pam_unix(sudo:session): session closed for user root Mar 08 18:07:37 volumio sudo[1188]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay gpio-ir gpio_pin=26 gpio_pull=up Mar 08 18:07:37 volumio sudo[1188]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 18:07:37 volumio kernel: Registered IR keymap rc-rc6-mce Mar 08 18:07:37 volumio sudo[1188]: pam_unix(sudo:session): session closed for user root Mar 08 18:07:37 volumio volumio[780]: info: ir_controller: Overlay gpio-ir gpio_pin=26 gpio_pull=up loaded. Mar 08 18:07:37 volumio kernel: IR RC6 protocol handler initialized Mar 08 18:07:37 volumio sudo[1200]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart lircd.service Mar 08 18:07:37 volumio sudo[1200]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 18:07:37 volumio kernel: rc rc0: gpio_ir_recv as /devices/platform/ir-receiver@1a/rc/rc0 Mar 08 18:07:37 volumio kernel: rc rc0: lirc_dev: driver gpio_ir_recv registered at minor = 0, raw IR receiver, no transmitter Mar 08 18:07:37 volumio kernel: input: gpio_ir_recv as /devices/platform/ir-receiver@1a/rc/rc0/input0 Mar 08 18:07:37 volumio systemd[1]: Starting lircd(8) initialization helper tool... Mar 08 18:07:37 volumio systemd-udevd[1196]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Mar 08 18:07:37 volumio systemd-logind[514]: Watching system buttons on /dev/input/event0 (gpio_ir_recv) Mar 08 18:07:37 volumio lircd-setup[1206]: /usr/sbin/lircd-setup:37: DeprecationWarning: The SafeConfigParser class has been renamed to ConfigParser in Python 3.2. This alias will be removed in future versions. Use ConfigParser directly instead. Mar 08 18:07:37 volumio lircd-setup[1206]: parser = configparser.SafeConfigParser() Mar 08 18:07:39 volumio ntpd[839]: receive: Unexpected origin timestamp 0xeb76f7d9.fb1ba73b does not match aorg 0000000000.00000000 from server@185.103.216.7 xmt 0xeb76f7db.01d85b75 Mar 08 18:07:39 volumio mpd[1153]: Mar 08 18:07 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 08 18:07:39 volumio systemd[1]: Started Music Player Daemon. Mar 08 18:07:39 volumio sudo[1120]: pam_unix(sudo:session): session closed for user root Mar 08 18:07:39 volumio sudo[1108]: pam_unix(sudo:session): session closed for user root Mar 08 18:07:39 volumio systemd[1]: lircd-setup.service: Succeeded. Mar 08 18:07:39 volumio systemd[1]: Started lircd(8) initialization helper tool. Mar 08 18:07:39 volumio volumio[780]: info: Completed starting Core Plugins Mar 08 18:07:39 volumio volumio[780]: info: ------------------------------------------- Mar 08 18:07:39 volumio volumio[780]: info: ----- MyVolumio plugins startup ---- Mar 08 18:07:39 volumio volumio[780]: info: ------------------------------------------- Mar 08 18:07:39 volumio volumio[780]: info: [MyVolumio PluginManager] Fetching plans data.... Mar 08 18:07:39 volumio systemd[1]: Starting Flexible IR remote input/output application support... Mar 08 18:07:39 volumio lircd-0.10.1[1210]: Info: lircd: Opening log, level: Info Mar 08 18:07:39 volumio lircd-0.10.1[1210]: Notice: Version: lircd 0.10.1 Mar 08 18:07:39 volumio lircd-0.10.1[1210]: Notice: System info: Linux volumio 6.6.56-v7+ #1803 SMP Thu Oct 10 14:08:55 BST 2024 armv7l GNU/Linux Mar 08 18:07:39 volumio volumio[780]: error: MPD error: The expression evaluated to a falsy value: Mar 08 18:07:39 volumio volumio[780]: assert.ok(self.idling) Mar 08 18:07:39 volumio volumio[780]: error: The expression evaluated to a falsy value: Mar 08 18:07:39 volumio volumio[780]: assert.ok(self.idling) Mar 08 18:07:39 volumio volumio[780]: error: updateQueue error: null Mar 08 18:07:39 volumio volumio[780]: info: MPD running with PID1153 Mar 08 18:07:39 volumio volumio[780]: ,establishing connection Mar 08 18:07:39 volumio volumio[780]: error: updateQueue error: null Mar 08 18:07:39 volumio sudo[1218]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart lircd.service Mar 08 18:07:39 volumio sudo[1218]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 18:07:39 volumio systemd[1]: lircd.service: Main process exited, code=killed, status=15/TERM Mar 08 18:07:39 volumio systemd[1]: lircd.service: Succeeded. Mar 08 18:07:39 volumio systemd[1]: Stopped Flexible IR remote input/output application support. Mar 08 18:07:39 volumio systemd[1]: Starting lircd(8) initialization helper tool... Mar 08 18:07:39 volumio lircd-setup[1220]: /usr/sbin/lircd-setup:37: DeprecationWarning: The SafeConfigParser class has been renamed to ConfigParser in Python 3.2. This alias will be removed in future versions. Use ConfigParser directly instead. Mar 08 18:07:39 volumio lircd-setup[1220]: parser = configparser.SafeConfigParser() Mar 08 18:07:39 volumio systemd[1]: lircd-setup.service: Succeeded. Mar 08 18:07:39 volumio systemd[1]: Started lircd(8) initialization helper tool. Mar 08 18:07:39 volumio systemd[1]: Starting Flexible IR remote input/output application support... Mar 08 18:07:39 volumio lircd-0.10.1[1221]: Info: lircd: Opening log, level: Info Mar 08 18:07:39 volumio lircd-0.10.1[1221]: Notice: Version: lircd 0.10.1 Mar 08 18:07:39 volumio lircd-0.10.1[1221]: Notice: System info: Linux volumio 6.6.56-v7+ #1803 SMP Thu Oct 10 14:08:55 BST 2024 armv7l GNU/Linux Mar 08 18:07:39 volumio lircd-0.10.1[1221]: Info: Initial device: /dev/lirc0 Mar 08 18:07:39 volumio lircd-0.10.1[1221]: Notice: 'lirc' written to protocols file /sys/class/rc/rc0/protocols Mar 08 18:07:39 volumio lircd-0.10.1[1221]: Info: Initial device: /dev/lirc0 Mar 08 18:07:39 volumio lircd-0.10.1[1221]: Info: [lirc] protocol is enabled Mar 08 18:07:39 volumio lircd-0.10.1[1221]: Notice: Options: driver: default Mar 08 18:07:39 volumio lircd[1221]: lircd-0.10.1[1221]: Info: lircd: Opening log, level: Info Mar 08 18:07:39 volumio lircd-0.10.1[1221]: Notice: Options: output: /var/run/lirc/lircd Mar 08 18:07:39 volumio lircd[1221]: lircd-0.10.1[1221]: Notice: Using systemd fd Mar 08 18:07:39 volumio lircd[1221]: lircd-0.10.1[1221]: Warning: Running as root Mar 08 18:07:39 volumio lircd[1221]: lircd-0.10.1[1221]: Info: Using remote: lircd.conf. Mar 08 18:07:39 volumio lircd-0.10.1[1221]: Notice: Options: nodaemon: 1 Mar 08 18:07:39 volumio lircd-0.10.1[1221]: Notice: Options: plugindir: /usr/lib/arm-linux-gnueabihf/lirc/plugins Mar 08 18:07:39 volumio lircd-0.10.1[1221]: Notice: Options: logfile: syslog Mar 08 18:07:39 volumio lircd[1221]: lircd-0.10.1[1221]: Notice: lircd(default) ready, using /var/run/lirc/lircd Mar 08 18:07:39 volumio lircd-0.10.1[1221]: Notice: Options: immediate-init: 0 Mar 08 18:07:39 volumio systemd[1]: Started Flexible IR remote input/output application support. Mar 08 18:07:39 volumio lircd-0.10.1[1221]: Notice: Options: permission: 666 Mar 08 18:07:39 volumio lircd-0.10.1[1221]: Notice: Options: driver-options: Mar 08 18:07:39 volumio lircd-0.10.1[1221]: Notice: Options: pidfile: /var/run/lirc/lircd.pid Mar 08 18:07:39 volumio lircd-0.10.1[1221]: Notice: Options: listen: 0 Mar 08 18:07:39 volumio lircd-0.10.1[1221]: Notice: Options: connect: (null) Mar 08 18:07:39 volumio lircd-0.10.1[1221]: Notice: Options: userelease: 0 Mar 08 18:07:39 volumio lircd-0.10.1[1221]: Notice: Options: effective_user: (null) Mar 08 18:07:39 volumio lircd-0.10.1[1221]: Notice: Options: release_suffix: _EVUP Mar 08 18:07:39 volumio lircd-0.10.1[1221]: Notice: Options: allow_simulate: 0 Mar 08 18:07:39 volumio lircd-0.10.1[1221]: Notice: Options: repeat_max: 600 Mar 08 18:07:39 volumio lircd-0.10.1[1221]: Notice: Options: configfile: /etc/lirc/lircd.conf Mar 08 18:07:39 volumio lircd-0.10.1[1221]: Notice: Options: dynamic_codes: (null) Mar 08 18:07:39 volumio lircd-0.10.1[1221]: Notice: Current driver: default Mar 08 18:07:39 volumio systemd[1]: Startup finished in 17.817s (kernel) + 27.982s (userspace) = 45.799s. Mar 08 18:07:39 volumio lircd-0.10.1[1221]: Notice: Driver API version: 3 Mar 08 18:07:39 volumio lircd-0.10.1[1221]: Notice: Driver version: 0.10.0 Mar 08 18:07:39 volumio lircd-0.10.1[1221]: Notice: Driver info: See file:///usr/share/doc/lirc/plugindocs/default.html Mar 08 18:07:39 volumio lircd-0.10.1[1221]: Info: lircd: Opening log, level: Info Mar 08 18:07:39 volumio lircd-0.10.1[1221]: Notice: Using systemd fd Mar 08 18:07:39 volumio lircd-0.10.1[1221]: Warning: Running as root Mar 08 18:07:39 volumio lircd-0.10.1[1221]: Info: Using remote: lircd.conf. Mar 08 18:07:39 volumio lircd-0.10.1[1221]: Notice: lircd(default) ready, using /var/run/lirc/lircd Mar 08 18:07:39 volumio sudo[1200]: pam_unix(sudo:session): session closed for user root Mar 08 18:07:39 volumio sudo[1218]: pam_unix(sudo:session): session closed for user root Mar 08 18:07:39 volumio volumio[780]: info: ir_controller: systemctl restart lircd.service succeeded. Mar 08 18:07:39 volumio volumio[780]: info: ir_controller: systemctl restart lircd.service succeeded. Mar 08 18:07:39 volumio sudo[1225]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart irexec.service Mar 08 18:07:39 volumio sudo[1225]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 18:07:39 volumio sudo[1227]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart irexec.service Mar 08 18:07:39 volumio sudo[1227]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 18:07:39 volumio systemd[1]: Started Handle events from IR remotes decoded by lircd(8). Mar 08 18:07:39 volumio sudo[1225]: pam_unix(sudo:session): session closed for user root Mar 08 18:07:39 volumio volumio[780]: info: ir_controller: systemctl restart irexec.service succeeded. Mar 08 18:07:39 volumio systemd[1]: Stopping Handle events from IR remotes decoded by lircd(8)... Mar 08 18:07:39 volumio systemd[1]: irexec.service: Main process exited, code=killed, status=15/TERM Mar 08 18:07:39 volumio systemd[1]: irexec.service: Succeeded. Mar 08 18:07:39 volumio systemd[1]: Stopped Handle events from IR remotes decoded by lircd(8). Mar 08 18:07:39 volumio systemd[1]: Started Handle events from IR remotes decoded by lircd(8). Mar 08 18:07:39 volumio sudo[1227]: pam_unix(sudo:session): session closed for user root Mar 08 18:07:39 volumio volumio[780]: info: ir_controller: systemctl restart irexec.service succeeded. Mar 08 18:07:39 volumio lircd[1221]: lircd-0.10.1[1221]: Notice: accepted new client on /var/run/lirc/lircd Mar 08 18:07:39 volumio lircd[1221]: lircd-0.10.1[1221]: Info: [lirc] protocol is enabled Mar 08 18:07:39 volumio lircd-0.10.1[1221]: Notice: accepted new client on /var/run/lirc/lircd Mar 08 18:07:39 volumio lircd-0.10.1[1221]: Info: [lirc] protocol is enabled Mar 08 18:07:41 volumio sudo[1247]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 08 18:07:41 volumio sudo[1247]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 18:07:41 volumio sudo[1247]: pam_unix(sudo:session): session closed for user root Mar 08 18:07:41 volumio sudo[1249]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 08 18:07:41 volumio sudo[1249]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 18:07:41 volumio sudo[1253]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Mar 08 18:07:41 volumio sudo[1249]: pam_unix(sudo:session): session closed for user root Mar 08 18:07:41 volumio sudo[1253]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 18:07:41 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Mar 08 18:07:41 volumio sudo[1253]: pam_unix(sudo:session): session closed for user root Mar 08 18:07:41 volumio volumio[780]: info: Upmpdcli Daemon Started Mar 08 18:07:41 volumio volumio[1257]: Generating RSA private key, 4096 bit long modulus (2 primes) Mar 08 18:07:44 volumio volumio[780]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Mar 08 18:07:46 volumio systemd[1]: systemd-fsckd.service: Succeeded. Mar 08 18:07:47 volumio volumio[780]: info: AutoStart - Plugin is starting Mar 08 18:07:47 volumio volumio[780]: info: CoreCommandRouter::volumioGetQueue Mar 08 18:07:47 volumio volumio[780]: info: CoreStateMachine::getQueue Mar 08 18:07:47 volumio volumio[780]: info: CorePlayQueue::getQueue Mar 08 18:07:47 volumio volumio[780]: info: AutoStart - start playing Mar 08 18:07:47 volumio volumio[780]: info: AutoStart - start playing with no specific position Mar 08 18:07:47 volumio volumio[780]: info: CoreCommandRouter::volumioPlay Mar 08 18:07:47 volumio volumio[780]: info: CoreStateMachine::play index 0 Mar 08 18:07:47 volumio volumio[780]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 18:07:47 volumio volumio[780]: info: CoreStateMachine::stop Mar 08 18:07:47 volumio volumio[780]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 18:07:47 volumio volumio[780]: info: CoreStateMachine::play index undefined Mar 08 18:07:47 volumio volumio[780]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 18:07:47 volumio volumio[780]: info: CorePlayQueue::getTrack 0 Mar 08 18:07:47 volumio volumio[780]: info: CoreStateMachine::startPlaybackTimer Mar 08 18:07:47 volumio volumio[780]: info: CorePlayQueue::getTrack 0 Mar 08 18:07:47 volumio volumio[780]: info: [1741453667366] ControllerWebradio::clearAddPlayTrack Mar 08 18:07:47 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand stop Mar 08 18:07:47 volumio volumio[780]: info: sendMpdCommand stop took 3 milliseconds Mar 08 18:07:47 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand clear Mar 08 18:07:47 volumio volumio[780]: info: Mar 08 18:07:47 volumio volumio[780]: ---------------------------- MPD announces system playlist update Mar 08 18:07:47 volumio volumio[780]: info: Ignoring MPD Status Update Mar 08 18:07:47 volumio volumio[780]: info: sendMpdCommand clear took 4 milliseconds Mar 08 18:07:47 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497960" Mar 08 18:07:47 volumio volumio[780]: info: Mar 08 18:07:47 volumio volumio[780]: ---------------------------- MPD announces system playlist update Mar 08 18:07:47 volumio volumio[780]: info: Ignoring MPD Status Update Mar 08 18:07:47 volumio volumio[780]: info: Mar 08 18:07:47 volumio volumio[780]: ---------------------------- MPD announces system playlist update Mar 08 18:07:47 volumio volumio[780]: info: Ignoring MPD Status Update Mar 08 18:07:47 volumio volumio[780]: error: updateQueue error: null Mar 08 18:07:47 volumio volumio[780]: info: ------------------------------ 12ms Mar 08 18:07:47 volumio volumio[780]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Mar 08 18:07:47 volumio volumio[780]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Mar 08 18:07:47 volumio volumio[780]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Mar 08 18:07:47 volumio volumio[780]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Mar 08 18:07:47 volumio volumio[780]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Mar 08 18:07:47 volumio volumio[780]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Mar 08 18:07:47 volumio volumio[780]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Mar 08 18:07:47 volumio volumio[780]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Mar 08 18:07:47 volumio volumio[780]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Mar 08 18:07:47 volumio volumio[780]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Mar 08 18:07:47 volumio volumio[780]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Mar 08 18:07:47 volumio volumio[780]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Mar 08 18:07:47 volumio volumio[780]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Mar 08 18:07:47 volumio volumio[780]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Mar 08 18:07:47 volumio volumio[780]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Mar 08 18:07:47 volumio volumio[780]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Mar 08 18:07:47 volumio volumio[780]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Mar 08 18:07:47 volumio volumio[780]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Mar 08 18:07:47 volumio volumio[780]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Mar 08 18:07:47 volumio volumio[780]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Mar 08 18:07:47 volumio volumio[780]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Mar 08 18:07:47 volumio volumio[780]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Mar 08 18:07:47 volumio volumio[780]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Mar 08 18:07:47 volumio volumio[780]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Mar 08 18:07:47 volumio volumio[780]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Mar 08 18:07:47 volumio volumio[780]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Mar 08 18:07:47 volumio volumio[780]: info: Adding plugin bluetooth to MyMusic Plugins Mar 08 18:07:47 volumio volumio[780]: info: Adding plugin multiroom to MyMusic Plugins Mar 08 18:07:47 volumio volumio[780]: info: Adding plugin metavolumio to MyMusic Plugins Mar 08 18:07:47 volumio volumio[780]: info: Adding plugin cd_controller to MyMusic Plugins Mar 08 18:07:47 volumio volumio[780]: info: Adding plugin smart_inputs to MyMusic Plugins Mar 08 18:07:47 volumio volumio[780]: info: Adding plugin tidalconnect to MyMusic Plugins Mar 08 18:07:47 volumio volumio[780]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Mar 08 18:07:48 volumio volumio[780]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Mar 08 18:07:48 volumio volumio[780]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Mar 08 18:07:48 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 18:07:48 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 18:07:48 volumio volumio[780]: info: Starting MyVolumio Remote Streaming Endpoints Mar 08 18:07:48 volumio volumio[780]: info: MyVolumio login type: Token Mar 08 18:07:48 volumio volumio[780]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Mar 08 18:07:48 volumio volumio[780]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Mar 08 18:07:50 volumio volumio[780]: info: Starting Streaming Service Transparent Proxy Mar 08 18:07:50 volumio volumio[780]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Mar 08 18:07:50 volumio volumio[780]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Mar 08 18:07:50 volumio volumio[780]: info: Streaming services startup Mar 08 18:07:50 volumio volumio[780]: info: Starting Streaming Daemon Mar 08 18:07:50 volumio sudo[1284]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 08 18:07:50 volumio sudo[1284]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 18:07:50 volumio volumio[780]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Mar 08 18:07:50 volumio sudo[1284]: pam_unix(sudo:session): session closed for user root Mar 08 18:07:50 volumio volumio[780]: info: Mar 08 18:07:50 volumio volumio[780]: ---------------------------- MPD announces system playlist update Mar 08 18:07:50 volumio volumio[780]: info: Ignoring MPD Status Update Mar 08 18:07:50 volumio volumio[780]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497960" took 2971 milliseconds Mar 08 18:07:50 volumio volumio[780]: info: ------------------------------ 2969ms Mar 08 18:07:50 volumio volumio[780]: info: ------------------------------ 2968ms Mar 08 18:07:50 volumio volumio[780]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 08 18:07:50 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand play Mar 08 18:07:50 volumio volumio[780]: info: Mar 08 18:07:50 volumio volumio[780]: ---------------------------- MPD announces system playlist update Mar 08 18:07:50 volumio volumio[780]: info: Ignoring MPD Status Update Mar 08 18:07:50 volumio volumio[780]: info: Mar 08 18:07:50 volumio volumio[780]: ---------------------------- MPD announces system playlist update Mar 08 18:07:50 volumio volumio[780]: info: Ignoring MPD Status Update Mar 08 18:07:50 volumio volumio[780]: error: Cannot start Volumio Streaming Daemon Mar 08 18:07:50 volumio volumio[780]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Mar 08 18:07:50 volumio volumio[780]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Mar 08 18:07:50 volumio volumio[780]: info: ------------------------------ 40ms Mar 08 18:07:50 volumio volumio[780]: info: sendMpdCommand play took 34 milliseconds Mar 08 18:07:50 volumio volumio[780]: info: ------------------------------ 31ms Mar 08 18:07:50 volumio volumio[780]: info: ------------------------------ 28ms Mar 08 18:07:50 volumio volumio[780]: error: MyVolumio Custom Token format not valid, refreshing it Mar 08 18:07:51 volumio volumio[780]: STREAMING PROXY: Starting server on port 3245 Mar 08 18:07:51 volumio volumio[780]: Node JS runtime: 14 Mar 08 18:07:51 volumio volumio[780]: info: MyVolumio login type: Token Mar 08 18:07:52 volumio volumio[780]: info: Mar 08 18:07:52 volumio volumio[780]: ---------------------------- MPD announces state update: player Mar 08 18:07:52 volumio volumio[780]: info: ControllerMpd::getState Mar 08 18:07:52 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand status Mar 08 18:07:52 volumio volumio[780]: info: Mar 08 18:07:52 volumio volumio[780]: ---------------------------- MPD announces state update: player Mar 08 18:07:52 volumio volumio[780]: info: ControllerMpd::getState Mar 08 18:07:52 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand status Mar 08 18:07:52 volumio volumio[780]: info: Mar 08 18:07:52 volumio volumio[780]: ---------------------------- MPD announces state update: player Mar 08 18:07:52 volumio volumio[780]: info: ControllerMpd::getState Mar 08 18:07:52 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand status Mar 08 18:07:52 volumio volumio[780]: info: Mar 08 18:07:52 volumio volumio[780]: ---------------------------- MPD announces state update: player Mar 08 18:07:52 volumio volumio[780]: info: sendMpdCommand status took 27 milliseconds Mar 08 18:07:52 volumio volumio[780]: info: sendMpdCommand status took 26 milliseconds Mar 08 18:07:52 volumio volumio[780]: info: sendMpdCommand status took 24 milliseconds Mar 08 18:07:52 volumio volumio[780]: info: ControllerMpd::getState Mar 08 18:07:52 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand status Mar 08 18:07:52 volumio volumio[780]: verbose: ControllerMpd::parseState Mar 08 18:07:52 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 18:07:52 volumio volumio[780]: verbose: ControllerMpd::parseState Mar 08 18:07:52 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 18:07:52 volumio volumio[780]: verbose: ControllerMpd::parseState Mar 08 18:07:52 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 18:07:52 volumio volumio[780]: info: sendMpdCommand status took 7 milliseconds Mar 08 18:07:52 volumio volumio[780]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 08 18:07:52 volumio volumio[780]: verbose: ControllerMpd::parseState Mar 08 18:07:52 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 18:07:52 volumio volumio[780]: verbose: ControllerMpd::parseTrackInfo Mar 08 18:07:52 volumio volumio[780]: info: ControllerMpd::pushState Mar 08 18:07:52 volumio volumio[780]: info: CoreCommandRouter::servicePushState Mar 08 18:07:52 volumio volumio[780]: info: CorePlayQueue::getTrack 0 Mar 08 18:07:52 volumio volumio[780]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"chillout","artist":"(#1 - 921/500000) ANTENNE BAYERN Chillout (Germany)","album":null,"uri":"http://stream.antenne.de:80/chillout","trackType":""} Mar 08 18:07:52 volumio volumio[780]: verbose: CURRENT POSITION 0 Mar 08 18:07:52 volumio volumio[780]: info: CoreStateMachine::syncState stateService play Mar 08 18:07:52 volumio volumio[780]: info: CoreStateMachine::syncState currentStatus stop Mar 08 18:07:52 volumio volumio[780]: info: ControllerMpd::pushState Mar 08 18:07:52 volumio volumio[780]: info: CoreCommandRouter::servicePushState Mar 08 18:07:52 volumio volumio[780]: info: CorePlayQueue::getTrack 0 Mar 08 18:07:52 volumio volumio[780]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"chillout","artist":"(#1 - 921/500000) ANTENNE BAYERN Chillout (Germany)","album":null,"uri":"http://stream.antenne.de:80/chillout","trackType":""} Mar 08 18:07:52 volumio volumio[780]: verbose: CURRENT POSITION 0 Mar 08 18:07:52 volumio volumio[780]: info: CoreStateMachine::syncState stateService play Mar 08 18:07:52 volumio volumio[780]: info: CoreStateMachine::syncState currentStatus play Mar 08 18:07:52 volumio volumio[780]: info: Received an update from plugin. extracting info from payload Mar 08 18:07:52 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 08 18:07:52 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:07:52 volumio volumio[780]: info: CorePlayQueue::getTrack 0 Mar 08 18:07:52 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 18:07:52 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:07:52 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:07:52 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:07:52 volumio volumio[780]: info: ControllerMpd::pushState Mar 08 18:07:52 volumio volumio[780]: info: CoreCommandRouter::servicePushState Mar 08 18:07:52 volumio volumio[780]: info: CorePlayQueue::getTrack 0 Mar 08 18:07:52 volumio volumio[780]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"chillout","artist":"(#1 - 921/500000) ANTENNE BAYERN Chillout (Germany)","album":null,"uri":"http://stream.antenne.de:80/chillout","trackType":""} Mar 08 18:07:52 volumio volumio[780]: verbose: CURRENT POSITION 0 Mar 08 18:07:52 volumio volumio[780]: info: CoreStateMachine::syncState stateService play Mar 08 18:07:52 volumio volumio[780]: info: CoreStateMachine::syncState currentStatus play Mar 08 18:07:52 volumio volumio[780]: info: Received an update from plugin. extracting info from payload Mar 08 18:07:52 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 08 18:07:52 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:07:52 volumio volumio[780]: info: CorePlayQueue::getTrack 0 Mar 08 18:07:52 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:07:52 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:07:52 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:07:52 volumio volumio[780]: info: ------------------------------ 73ms Mar 08 18:07:52 volumio volumio[780]: info: ------------------------------ 89ms Mar 08 18:07:52 volumio volumio[780]: info: ------------------------------ 90ms Mar 08 18:07:52 volumio volumio[780]: info: Mar 08 18:07:52 volumio volumio[780]: ---------------------------- MPD announces state update: player Mar 08 18:07:52 volumio volumio[780]: info: ControllerMpd::getState Mar 08 18:07:52 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand status Mar 08 18:07:52 volumio volumio[780]: info: Mar 08 18:07:52 volumio volumio[780]: ---------------------------- MPD announces state update: player Mar 08 18:07:52 volumio volumio[780]: info: ControllerMpd::getState Mar 08 18:07:52 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand status Mar 08 18:07:52 volumio volumio[780]: info: Mar 08 18:07:52 volumio volumio[780]: ---------------------------- MPD announces system playlist update Mar 08 18:07:52 volumio volumio[780]: info: Ignoring MPD Status Update Mar 08 18:07:52 volumio volumio[780]: info: Mar 08 18:07:52 volumio volumio[780]: ---------------------------- MPD announces state update: player Mar 08 18:07:52 volumio volumio[780]: info: Mar 08 18:07:52 volumio volumio[780]: ---------------------------- MPD announces system playlist update Mar 08 18:07:52 volumio volumio[780]: info: Ignoring MPD Status Update Mar 08 18:07:52 volumio volumio[780]: info: Mar 08 18:07:52 volumio volumio[780]: ---------------------------- MPD announces state update: player Mar 08 18:07:52 volumio volumio[780]: info: Mar 08 18:07:52 volumio volumio[780]: ---------------------------- MPD announces system playlist update Mar 08 18:07:52 volumio volumio[780]: info: Ignoring MPD Status Update Mar 08 18:07:52 volumio volumio[780]: info: Mar 08 18:07:52 volumio volumio[780]: ---------------------------- MPD announces state update: player Mar 08 18:07:52 volumio volumio[780]: info: ControllerMpd::getState Mar 08 18:07:52 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand status Mar 08 18:07:52 volumio volumio[780]: info: sendMpdCommand playlistinfo took 67 milliseconds Mar 08 18:07:52 volumio volumio[780]: info: ControllerMpd::getState Mar 08 18:07:52 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand status Mar 08 18:07:52 volumio volumio[780]: info: sendMpdCommand status took 13 milliseconds Mar 08 18:07:52 volumio volumio[780]: info: ControllerMpd::getState Mar 08 18:07:52 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand status Mar 08 18:07:52 volumio volumio[780]: info: sendMpdCommand status took 10 milliseconds Mar 08 18:07:52 volumio volumio[780]: verbose: ControllerMpd::parseTrackInfo Mar 08 18:07:52 volumio volumio[780]: verbose: ControllerMpd::parseState Mar 08 18:07:52 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 18:07:52 volumio volumio[780]: verbose: ControllerMpd::parseState Mar 08 18:07:52 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 18:07:52 volumio volumio[780]: info: ControllerMpd::pushState Mar 08 18:07:52 volumio volumio[780]: info: CoreCommandRouter::servicePushState Mar 08 18:07:52 volumio volumio[780]: info: CorePlayQueue::getTrack 0 Mar 08 18:07:52 volumio volumio[780]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Armin van Buuren x Alok x Norma Jean Martine x Lawrent - Euphoria","artist":"CHILLOUT ANTENNE","album":null,"uri":"http://stream.antenne.de:80/chillout","trackType":""} Mar 08 18:07:52 volumio volumio[780]: verbose: CURRENT POSITION 0 Mar 08 18:07:52 volumio volumio[780]: info: CoreStateMachine::syncState stateService play Mar 08 18:07:52 volumio volumio[780]: info: CoreStateMachine::syncState currentStatus play Mar 08 18:07:52 volumio volumio[780]: info: Received an update from plugin. extracting info from payload Mar 08 18:07:52 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 08 18:07:52 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:07:52 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 18:07:52 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:07:52 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:07:52 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:07:52 volumio volumio[780]: info: ------------------------------ 116ms Mar 08 18:07:52 volumio volumio[780]: info: Mar 08 18:07:52 volumio volumio[780]: ---------------------------- MPD announces system playlist update Mar 08 18:07:52 volumio volumio[780]: info: Ignoring MPD Status Update Mar 08 18:07:52 volumio volumio[780]: info: Mar 08 18:07:52 volumio volumio[780]: ---------------------------- MPD announces state update: player Mar 08 18:07:52 volumio volumio[780]: info: ControllerMpd::getState Mar 08 18:07:52 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand status Mar 08 18:07:52 volumio volumio[780]: info: Mar 08 18:07:52 volumio volumio[780]: ---------------------------- MPD announces system playlist update Mar 08 18:07:52 volumio volumio[780]: info: Ignoring MPD Status Update Mar 08 18:07:52 volumio volumio[780]: info: Mar 08 18:07:52 volumio volumio[780]: ---------------------------- MPD announces state update: player Mar 08 18:07:52 volumio volumio[780]: info: ControllerMpd::getState Mar 08 18:07:52 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand status Mar 08 18:07:52 volumio volumio[780]: info: ------------------------------ 67ms Mar 08 18:07:52 volumio volumio[780]: info: sendMpdCommand status took 62 milliseconds Mar 08 18:07:52 volumio volumio[780]: info: ------------------------------ 67ms Mar 08 18:07:52 volumio volumio[780]: info: sendMpdCommand status took 61 milliseconds Mar 08 18:07:52 volumio volumio[780]: info: ------------------------------ 67ms Mar 08 18:07:52 volumio volumio[780]: info: sendMpdCommand status took 61 milliseconds Mar 08 18:07:52 volumio volumio[780]: info: sendMpdCommand playlistinfo took 59 milliseconds Mar 08 18:07:52 volumio volumio[780]: info: sendMpdCommand playlistinfo took 58 milliseconds Mar 08 18:07:52 volumio volumio[780]: info: ------------------------------ 29ms Mar 08 18:07:52 volumio volumio[780]: info: sendMpdCommand status took 28 milliseconds Mar 08 18:07:52 volumio volumio[780]: info: ------------------------------ 27ms Mar 08 18:07:52 volumio volumio[780]: info: sendMpdCommand status took 26 milliseconds Mar 08 18:07:52 volumio volumio[780]: verbose: ControllerMpd::parseState Mar 08 18:07:52 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 18:07:52 volumio volumio[780]: verbose: ControllerMpd::parseState Mar 08 18:07:52 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 18:07:52 volumio volumio[780]: verbose: ControllerMpd::parseState Mar 08 18:07:52 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 18:07:52 volumio volumio[780]: verbose: ControllerMpd::parseTrackInfo Mar 08 18:07:52 volumio volumio[780]: verbose: ControllerMpd::parseTrackInfo Mar 08 18:07:52 volumio volumio[780]: verbose: ControllerMpd::parseState Mar 08 18:07:52 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 18:07:52 volumio volumio[780]: verbose: ControllerMpd::parseState Mar 08 18:07:52 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 18:07:52 volumio volumio[780]: info: ControllerMpd::pushState Mar 08 18:07:52 volumio volumio[780]: info: CoreCommandRouter::servicePushState Mar 08 18:07:52 volumio volumio[780]: info: CorePlayQueue::getTrack 0 Mar 08 18:07:52 volumio volumio[780]: verbose: STATE SERVICE {"status":"play","position":0,"seek":884,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Armin van Buuren x Alok x Norma Jean Martine x Lawrent - Euphoria","artist":"CHILLOUT ANTENNE","album":null,"uri":"http://stream.antenne.de:80/chillout","trackType":""} Mar 08 18:07:52 volumio volumio[780]: verbose: CURRENT POSITION 0 Mar 08 18:07:52 volumio volumio[780]: info: CoreStateMachine::syncState stateService play Mar 08 18:07:52 volumio volumio[780]: info: CoreStateMachine::syncState currentStatus play Mar 08 18:07:52 volumio volumio[780]: info: Received an update from plugin. extracting info from payload Mar 08 18:07:52 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 08 18:07:52 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:07:52 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 18:07:52 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:07:52 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:07:52 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:07:52 volumio volumio[780]: info: ControllerMpd::pushState Mar 08 18:07:52 volumio volumio[780]: info: CoreCommandRouter::servicePushState Mar 08 18:07:52 volumio volumio[780]: info: CorePlayQueue::getTrack 0 Mar 08 18:07:52 volumio volumio[780]: verbose: STATE SERVICE {"status":"play","position":0,"seek":884,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Armin van Buuren x Alok x Norma Jean Martine x Lawrent - Euphoria","artist":"CHILLOUT ANTENNE","album":null,"uri":"http://stream.antenne.de:80/chillout","trackType":""} Mar 08 18:07:52 volumio volumio[780]: verbose: CURRENT POSITION 0 Mar 08 18:07:52 volumio volumio[780]: info: CoreStateMachine::syncState stateService play Mar 08 18:07:52 volumio volumio[780]: info: CoreStateMachine::syncState currentStatus play Mar 08 18:07:52 volumio volumio[780]: info: Received an update from plugin. extracting info from payload Mar 08 18:07:52 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 08 18:07:52 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:07:52 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:07:52 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:07:52 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:07:52 volumio volumio[780]: info: ------------------------------ 118ms Mar 08 18:07:52 volumio volumio[780]: info: ------------------------------ 116ms Mar 08 18:07:52 volumio volumio[780]: info: sendMpdCommand playlistinfo took 82 milliseconds Mar 08 18:07:52 volumio volumio[780]: info: sendMpdCommand playlistinfo took 82 milliseconds Mar 08 18:07:52 volumio volumio[780]: info: sendMpdCommand playlistinfo took 82 milliseconds Mar 08 18:07:52 volumio volumio[780]: info: sendMpdCommand playlistinfo took 81 milliseconds Mar 08 18:07:52 volumio volumio[780]: info: sendMpdCommand playlistinfo took 82 milliseconds Mar 08 18:07:52 volumio volumio[780]: verbose: ControllerMpd::parseTrackInfo Mar 08 18:07:52 volumio volumio[780]: verbose: ControllerMpd::parseTrackInfo Mar 08 18:07:52 volumio volumio[780]: info: ControllerMpd::pushState Mar 08 18:07:52 volumio volumio[780]: info: CoreCommandRouter::servicePushState Mar 08 18:07:52 volumio volumio[780]: info: CorePlayQueue::getTrack 0 Mar 08 18:07:52 volumio volumio[780]: verbose: STATE SERVICE {"status":"play","position":0,"seek":884,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Armin van Buuren x Alok x Norma Jean Martine x Lawrent - Euphoria","artist":"CHILLOUT ANTENNE","album":null,"uri":"http://stream.antenne.de:80/chillout","trackType":""} Mar 08 18:07:52 volumio volumio[780]: verbose: CURRENT POSITION 0 Mar 08 18:07:52 volumio volumio[780]: info: CoreStateMachine::syncState stateService play Mar 08 18:07:52 volumio volumio[780]: info: CoreStateMachine::syncState currentStatus play Mar 08 18:07:52 volumio volumio[780]: info: Received an update from plugin. extracting info from payload Mar 08 18:07:52 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 08 18:07:52 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:07:52 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 18:07:52 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:07:52 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:07:52 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:07:52 volumio volumio[780]: info: ControllerMpd::pushState Mar 08 18:07:52 volumio volumio[780]: info: CoreCommandRouter::servicePushState Mar 08 18:07:52 volumio volumio[780]: info: CorePlayQueue::getTrack 0 Mar 08 18:07:52 volumio volumio[780]: verbose: STATE SERVICE {"status":"play","position":0,"seek":884,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Armin van Buuren x Alok x Norma Jean Martine x Lawrent - Euphoria","artist":"CHILLOUT ANTENNE","album":null,"uri":"http://stream.antenne.de:80/chillout","trackType":""} Mar 08 18:07:52 volumio volumio[780]: verbose: CURRENT POSITION 0 Mar 08 18:07:52 volumio volumio[780]: info: CoreStateMachine::syncState stateService play Mar 08 18:07:52 volumio volumio[780]: info: CoreStateMachine::syncState currentStatus play Mar 08 18:07:52 volumio volumio[780]: info: Received an update from plugin. extracting info from payload Mar 08 18:07:52 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 08 18:07:52 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:07:52 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:07:52 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:07:52 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:07:52 volumio volumio[780]: info: ControllerMpd::pushState Mar 08 18:07:52 volumio volumio[780]: info: CoreCommandRouter::servicePushState Mar 08 18:07:52 volumio volumio[780]: info: CorePlayQueue::getTrack 0 Mar 08 18:07:52 volumio volumio[780]: verbose: STATE SERVICE {"status":"play","position":0,"seek":884,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Armin van Buuren x Alok x Norma Jean Martine x Lawrent - Euphoria","artist":"CHILLOUT ANTENNE","album":null,"uri":"http://stream.antenne.de:80/chillout","trackType":""} Mar 08 18:07:52 volumio volumio[780]: verbose: CURRENT POSITION 0 Mar 08 18:07:52 volumio volumio[780]: info: CoreStateMachine::syncState stateService play Mar 08 18:07:52 volumio volumio[780]: info: CoreStateMachine::syncState currentStatus play Mar 08 18:07:52 volumio volumio[780]: info: Received an update from plugin. extracting info from payload Mar 08 18:07:52 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 08 18:07:52 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:07:52 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:07:52 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:07:52 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:07:52 volumio volumio[780]: info: ControllerMpd::pushState Mar 08 18:07:52 volumio volumio[780]: info: CoreCommandRouter::servicePushState Mar 08 18:07:52 volumio volumio[780]: info: CorePlayQueue::getTrack 0 Mar 08 18:07:52 volumio volumio[780]: verbose: STATE SERVICE {"status":"play","position":0,"seek":987,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Armin van Buuren x Alok x Norma Jean Martine x Lawrent - Euphoria","artist":"CHILLOUT ANTENNE","album":null,"uri":"http://stream.antenne.de:80/chillout","trackType":""} Mar 08 18:07:52 volumio volumio[780]: verbose: CURRENT POSITION 0 Mar 08 18:07:52 volumio volumio[780]: info: CoreStateMachine::syncState stateService play Mar 08 18:07:52 volumio volumio[780]: info: CoreStateMachine::syncState currentStatus play Mar 08 18:07:52 volumio volumio[780]: info: Received an update from plugin. extracting info from payload Mar 08 18:07:52 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 08 18:07:52 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:07:52 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:07:52 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:07:52 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:07:52 volumio volumio[780]: info: ControllerMpd::pushState Mar 08 18:07:52 volumio volumio[780]: info: CoreCommandRouter::servicePushState Mar 08 18:07:52 volumio volumio[780]: info: CorePlayQueue::getTrack 0 Mar 08 18:07:52 volumio volumio[780]: verbose: STATE SERVICE {"status":"play","position":0,"seek":987,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Armin van Buuren x Alok x Norma Jean Martine x Lawrent - Euphoria","artist":"CHILLOUT ANTENNE","album":null,"uri":"http://stream.antenne.de:80/chillout","trackType":""} Mar 08 18:07:52 volumio volumio[780]: verbose: CURRENT POSITION 0 Mar 08 18:07:52 volumio volumio[780]: info: CoreStateMachine::syncState stateService play Mar 08 18:07:52 volumio volumio[780]: info: CoreStateMachine::syncState currentStatus play Mar 08 18:07:52 volumio volumio[780]: info: Received an update from plugin. extracting info from payload Mar 08 18:07:52 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 08 18:07:52 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:07:52 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:07:52 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:07:52 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:07:52 volumio volumio[780]: info: ------------------------------ 330ms Mar 08 18:07:52 volumio volumio[780]: info: ------------------------------ 330ms Mar 08 18:07:52 volumio volumio[780]: info: ------------------------------ 328ms Mar 08 18:07:52 volumio volumio[780]: info: ------------------------------ 291ms Mar 08 18:07:52 volumio volumio[780]: info: ------------------------------ 289ms Mar 08 18:07:52 volumio volumio[780]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Mar 08 18:07:53 volumio volumio[780]: info: Mar 08 18:07:53 volumio volumio[780]: ---------------------------- MPD announces system playlist update Mar 08 18:07:53 volumio volumio[780]: info: Ignoring MPD Status Update Mar 08 18:07:53 volumio volumio[780]: info: Mar 08 18:07:53 volumio volumio[780]: ---------------------------- MPD announces state update: player Mar 08 18:07:53 volumio volumio[780]: info: ControllerMpd::getState Mar 08 18:07:53 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand status Mar 08 18:07:53 volumio volumio[780]: info: Mar 08 18:07:53 volumio volumio[780]: ---------------------------- MPD announces system playlist update Mar 08 18:07:53 volumio volumio[780]: info: Ignoring MPD Status Update Mar 08 18:07:53 volumio volumio[780]: info: Mar 08 18:07:53 volumio volumio[780]: ---------------------------- MPD announces state update: player Mar 08 18:07:53 volumio volumio[780]: info: ControllerMpd::getState Mar 08 18:07:53 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand status Mar 08 18:07:53 volumio volumio[780]: info: Mar 08 18:07:53 volumio volumio[780]: ---------------------------- MPD announces system playlist update Mar 08 18:07:53 volumio volumio[780]: info: Ignoring MPD Status Update Mar 08 18:07:53 volumio volumio[780]: info: Mar 08 18:07:53 volumio volumio[780]: ---------------------------- MPD announces state update: player Mar 08 18:07:53 volumio volumio[780]: info: ControllerMpd::getState Mar 08 18:07:53 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand status Mar 08 18:07:53 volumio volumio[780]: info: ------------------------------ 9ms Mar 08 18:07:53 volumio volumio[780]: info: sendMpdCommand status took 7 milliseconds Mar 08 18:07:53 volumio volumio[780]: info: ------------------------------ 7ms Mar 08 18:07:53 volumio volumio[780]: info: sendMpdCommand status took 5 milliseconds Mar 08 18:07:53 volumio volumio[780]: info: ------------------------------ 5ms Mar 08 18:07:53 volumio volumio[780]: info: sendMpdCommand status took 4 milliseconds Mar 08 18:07:53 volumio volumio[780]: verbose: ControllerMpd::parseState Mar 08 18:07:53 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 18:07:53 volumio volumio[780]: verbose: ControllerMpd::parseState Mar 08 18:07:53 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 18:07:53 volumio volumio[780]: verbose: ControllerMpd::parseState Mar 08 18:07:53 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 18:07:53 volumio volumio[780]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 08 18:07:53 volumio volumio[780]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 08 18:07:53 volumio volumio[780]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 08 18:07:53 volumio volumio[780]: verbose: ControllerMpd::parseTrackInfo Mar 08 18:07:53 volumio volumio[780]: verbose: ControllerMpd::parseTrackInfo Mar 08 18:07:53 volumio volumio[780]: verbose: ControllerMpd::parseTrackInfo Mar 08 18:07:53 volumio volumio[780]: info: ControllerMpd::pushState Mar 08 18:07:53 volumio volumio[780]: info: CoreCommandRouter::servicePushState Mar 08 18:07:53 volumio volumio[780]: info: CorePlayQueue::getTrack 0 Mar 08 18:07:53 volumio volumio[780]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2279,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Armin van Buuren x Alok x Norma Jean Martine x Lawrent - Euphoria","artist":"CHILLOUT ANTENNE","album":null,"uri":"http://stream.antenne.de:80/chillout","trackType":""} Mar 08 18:07:53 volumio volumio[780]: verbose: CURRENT POSITION 0 Mar 08 18:07:53 volumio volumio[780]: info: CoreStateMachine::syncState stateService play Mar 08 18:07:53 volumio volumio[780]: info: CoreStateMachine::syncState currentStatus play Mar 08 18:07:53 volumio volumio[780]: info: Received an update from plugin. extracting info from payload Mar 08 18:07:53 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 08 18:07:53 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:07:53 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 18:07:53 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:07:53 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:07:53 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:07:53 volumio volumio[780]: info: ControllerMpd::pushState Mar 08 18:07:53 volumio volumio[780]: info: CoreCommandRouter::servicePushState Mar 08 18:07:53 volumio volumio[780]: info: CorePlayQueue::getTrack 0 Mar 08 18:07:53 volumio volumio[780]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2279,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Armin van Buuren x Alok x Norma Jean Martine x Lawrent - Euphoria","artist":"CHILLOUT ANTENNE","album":null,"uri":"http://stream.antenne.de:80/chillout","trackType":""} Mar 08 18:07:53 volumio volumio[780]: verbose: CURRENT POSITION 0 Mar 08 18:07:53 volumio volumio[780]: info: CoreStateMachine::syncState stateService play Mar 08 18:07:53 volumio volumio[780]: info: CoreStateMachine::syncState currentStatus play Mar 08 18:07:53 volumio volumio[780]: info: Received an update from plugin. extracting info from payload Mar 08 18:07:53 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 08 18:07:53 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:07:53 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:07:53 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:07:53 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:07:53 volumio volumio[780]: info: ControllerMpd::pushState Mar 08 18:07:53 volumio volumio[780]: info: CoreCommandRouter::servicePushState Mar 08 18:07:53 volumio volumio[780]: info: CorePlayQueue::getTrack 0 Mar 08 18:07:53 volumio volumio[780]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2279,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Armin van Buuren x Alok x Norma Jean Martine x Lawrent - Euphoria","artist":"CHILLOUT ANTENNE","album":null,"uri":"http://stream.antenne.de:80/chillout","trackType":""} Mar 08 18:07:53 volumio volumio[780]: verbose: CURRENT POSITION 0 Mar 08 18:07:53 volumio volumio[780]: info: CoreStateMachine::syncState stateService play Mar 08 18:07:53 volumio volumio[780]: info: CoreStateMachine::syncState currentStatus play Mar 08 18:07:53 volumio volumio[780]: info: Received an update from plugin. extracting info from payload Mar 08 18:07:53 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 08 18:07:53 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:07:53 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:07:53 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:07:53 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:07:53 volumio volumio[780]: info: ------------------------------ 56ms Mar 08 18:07:53 volumio volumio[780]: info: ------------------------------ 54ms Mar 08 18:07:53 volumio volumio[780]: info: ------------------------------ 53ms Mar 08 18:07:53 volumio volumio[780]: info: MyVolumio token set successfully Mar 08 18:07:53 volumio volumio[780]: info: MYVOLUMIO: Adding device Mar 08 18:07:53 volumio volumio[780]: info: MYVOLUMIO: Evaluating Server Mar 08 18:07:54 volumio volumio[780]: info: MyVolumio status changed Mar 08 18:07:54 volumio volumio[780]: info: Streaming services startup Mar 08 18:07:54 volumio volumio[780]: info: Starting Streaming Daemon Mar 08 18:07:54 volumio volumio[780]: info: Removing browser output: myVolumio user plan is not superstar Mar 08 18:07:54 volumio volumio[780]: info: Removing audio output: Mar 08 18:07:54 volumio volumio[780]: info: Stoppping Tunnel 1 Mar 08 18:07:54 volumio sudo[1345]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 08 18:07:54 volumio sudo[1345]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 18:07:54 volumio sudo[1348]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Mar 08 18:07:54 volumio sudo[1348]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 18:07:54 volumio sudo[1345]: pam_unix(sudo:session): session closed for user root Mar 08 18:07:54 volumio volumio[780]: error: Cannot start Volumio Streaming Daemon Mar 08 18:07:54 volumio volumio[780]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Mar 08 18:07:54 volumio volumio[780]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Mar 08 18:07:54 volumio sudo[1348]: pam_unix(sudo:session): session closed for user root Mar 08 18:07:54 volumio volumio[780]: info: Remote SSH Stopped Mar 08 18:07:54 volumio volumio[780]: info: Setting Geolocation for MyVolumio to eu6 Mar 08 18:07:54 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 18:07:54 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 18:07:54 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 18:07:55 volumio volumio[780]: info: Mar 08 18:07:55 volumio volumio[780]: ---------------------------- MPD announces system playlist update Mar 08 18:07:55 volumio volumio[780]: info: Ignoring MPD Status Update Mar 08 18:07:55 volumio volumio[780]: info: Mar 08 18:07:55 volumio volumio[780]: ---------------------------- MPD announces state update: player Mar 08 18:07:55 volumio volumio[780]: info: ControllerMpd::getState Mar 08 18:07:55 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand status Mar 08 18:07:55 volumio volumio[780]: info: Mar 08 18:07:55 volumio volumio[780]: ---------------------------- MPD announces system playlist update Mar 08 18:07:55 volumio volumio[780]: info: Ignoring MPD Status Update Mar 08 18:07:55 volumio volumio[780]: info: Mar 08 18:07:55 volumio volumio[780]: ---------------------------- MPD announces state update: player Mar 08 18:07:55 volumio volumio[780]: info: ControllerMpd::getState Mar 08 18:07:55 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand status Mar 08 18:07:55 volumio volumio[780]: info: Mar 08 18:07:55 volumio volumio[780]: ---------------------------- MPD announces system playlist update Mar 08 18:07:55 volumio volumio[780]: info: Ignoring MPD Status Update Mar 08 18:07:55 volumio volumio[780]: info: Mar 08 18:07:55 volumio volumio[780]: ---------------------------- MPD announces state update: player Mar 08 18:07:55 volumio volumio[780]: info: ControllerMpd::getState Mar 08 18:07:55 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand status Mar 08 18:07:55 volumio volumio[780]: info: ------------------------------ 8ms Mar 08 18:07:55 volumio volumio[780]: info: sendMpdCommand status took 7 milliseconds Mar 08 18:07:55 volumio volumio[780]: info: ------------------------------ 6ms Mar 08 18:07:55 volumio volumio[780]: info: sendMpdCommand status took 6 milliseconds Mar 08 18:07:55 volumio volumio[780]: info: ------------------------------ 5ms Mar 08 18:07:55 volumio volumio[780]: info: sendMpdCommand status took 3 milliseconds Mar 08 18:07:55 volumio volumio[780]: verbose: ControllerMpd::parseState Mar 08 18:07:55 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 18:07:55 volumio volumio[780]: verbose: ControllerMpd::parseState Mar 08 18:07:55 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 18:07:55 volumio volumio[780]: verbose: ControllerMpd::parseState Mar 08 18:07:55 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 18:07:55 volumio volumio[780]: info: sendMpdCommand playlistinfo took 7 milliseconds Mar 08 18:07:55 volumio volumio[780]: info: sendMpdCommand playlistinfo took 7 milliseconds Mar 08 18:07:55 volumio volumio[780]: info: sendMpdCommand playlistinfo took 7 milliseconds Mar 08 18:07:55 volumio volumio[780]: verbose: ControllerMpd::parseTrackInfo Mar 08 18:07:55 volumio volumio[780]: verbose: ControllerMpd::parseTrackInfo Mar 08 18:07:55 volumio volumio[780]: verbose: ControllerMpd::parseTrackInfo Mar 08 18:07:55 volumio volumio[780]: info: ControllerMpd::pushState Mar 08 18:07:55 volumio volumio[780]: info: CoreCommandRouter::servicePushState Mar 08 18:07:55 volumio volumio[780]: info: CorePlayQueue::getTrack 0 Mar 08 18:07:55 volumio volumio[780]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3784,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Armin van Buuren x Alok x Norma Jean Martine x Lawrent - Euphoria","artist":"CHILLOUT ANTENNE","album":null,"uri":"http://stream.antenne.de:80/chillout","trackType":""} Mar 08 18:07:55 volumio volumio[780]: verbose: CURRENT POSITION 0 Mar 08 18:07:55 volumio volumio[780]: info: CoreStateMachine::syncState stateService play Mar 08 18:07:55 volumio volumio[780]: info: CoreStateMachine::syncState currentStatus play Mar 08 18:07:55 volumio volumio[780]: info: Received an update from plugin. extracting info from payload Mar 08 18:07:55 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 08 18:07:55 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:07:55 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 18:07:55 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:07:55 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:07:55 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:07:55 volumio volumio[780]: info: ControllerMpd::pushState Mar 08 18:07:55 volumio volumio[780]: info: CoreCommandRouter::servicePushState Mar 08 18:07:55 volumio volumio[780]: info: CorePlayQueue::getTrack 0 Mar 08 18:07:55 volumio volumio[780]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3784,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Armin van Buuren x Alok x Norma Jean Martine x Lawrent - Euphoria","artist":"CHILLOUT ANTENNE","album":null,"uri":"http://stream.antenne.de:80/chillout","trackType":""} Mar 08 18:07:55 volumio volumio[780]: verbose: CURRENT POSITION 0 Mar 08 18:07:55 volumio volumio[780]: info: CoreStateMachine::syncState stateService play Mar 08 18:07:55 volumio volumio[780]: info: CoreStateMachine::syncState currentStatus play Mar 08 18:07:55 volumio volumio[780]: info: Received an update from plugin. extracting info from payload Mar 08 18:07:55 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 08 18:07:55 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:07:55 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:07:55 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:07:55 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:07:55 volumio volumio[780]: info: ControllerMpd::pushState Mar 08 18:07:55 volumio volumio[780]: info: CoreCommandRouter::servicePushState Mar 08 18:07:55 volumio volumio[780]: info: CorePlayQueue::getTrack 0 Mar 08 18:07:55 volumio volumio[780]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3784,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Armin van Buuren x Alok x Norma Jean Martine x Lawrent - Euphoria","artist":"CHILLOUT ANTENNE","album":null,"uri":"http://stream.antenne.de:80/chillout","trackType":""} Mar 08 18:07:55 volumio volumio[780]: verbose: CURRENT POSITION 0 Mar 08 18:07:55 volumio volumio[780]: info: CoreStateMachine::syncState stateService play Mar 08 18:07:55 volumio volumio[780]: info: CoreStateMachine::syncState currentStatus play Mar 08 18:07:55 volumio volumio[780]: info: Received an update from plugin. extracting info from payload Mar 08 18:07:55 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 08 18:07:55 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:07:55 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:07:55 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:07:55 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:07:55 volumio volumio[780]: info: ------------------------------ 59ms Mar 08 18:07:55 volumio volumio[780]: info: ------------------------------ 58ms Mar 08 18:07:55 volumio volumio[780]: info: ------------------------------ 56ms Mar 08 18:07:55 volumio volumio[780]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Mar 08 18:07:55 volumio volumio[780]: info: Updating MyVolumio device info Mar 08 18:07:55 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 18:07:55 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 18:07:55 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 18:07:55 volumio volumio[780]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Mar 08 18:07:56 volumio volumio[1257]: ................................................................................................................................++++ Mar 08 18:07:59 volumio volumio[1257]: .......................++++ Mar 08 18:07:59 volumio volumio[1257]: e is 65537 (0x010001) Mar 08 18:07:59 volumio volumio[1257]: writing RSA key Mar 08 18:07:59 volumio volumio[780]: info: MYVOLUMIO: Adding device Mar 08 18:07:59 volumio volumio[780]: info: MYVOLUMIO: Evaluating Server Mar 08 18:08:00 volumio volumio[780]: info: Setting Geolocation for MyVolumio to eu4 Mar 08 18:08:00 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 18:08:00 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 18:08:00 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 18:08:00 volumio volumio[780]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Mar 08 18:08:01 volumio volumio[780]: info: Updating MyVolumio device info Mar 08 18:08:01 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 18:08:01 volumio systemd[1]: systemd-timedated.service: Succeeded. Mar 08 18:08:01 volumio volumio[780]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Mar 08 18:08:03 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 08 18:08:03 volumio volumio[780]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Mar 08 18:08:03 volumio volumio[780]: info: CoreCommandRouter::volumioGetState Mar 08 18:08:04 volumio sudo[1430]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 08 18:08:04 volumio sudo[1430]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 18:08:04 volumio sudo[1430]: pam_unix(sudo:session): session closed for user root Mar 08 18:08:04 volumio sudo[1432]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 08 18:08:04 volumio sudo[1432]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 18:08:04 volumio sudo[1432]: pam_unix(sudo:session): session closed for user root Mar 08 18:08:04 volumio volumio[780]: verbose: New Socket.io Connection to 192.168.1.75 from 192.168.1.10 UA: Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:136.0) Gecko/20100101 Firefox/136.0 Engine version: 3 Transport: polling Total Clients: 5 Mar 08 18:08:04 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 08 18:08:04 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Mar 08 18:08:05 volumio sudo[1442]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 08 18:08:05 volumio sudo[1442]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 18:08:05 volumio sudo[1442]: pam_unix(sudo:session): session closed for user root Mar 08 18:08:05 volumio sudo[1444]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 08 18:08:05 volumio sudo[1444]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 18:08:05 volumio sudo[1444]: pam_unix(sudo:session): session closed for user root Mar 08 18:08:06 volumio volumio[780]: verbose: New Socket.io Connection to 192.168.1.75 from 192.168.1.10 UA: Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:136.0) Gecko/20100101 Firefox/136.0 Engine version: 3 Transport: polling Total Clients: 6 Mar 08 18:08:06 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 08 18:08:06 volumio volumio[780]: info: CoreCommandRouter::volumioGetVisibleSources Mar 08 18:08:06 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 08 18:08:06 volumio volumio[780]: info: CoreCommandRouter::volumioGetState Mar 08 18:08:06 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 08 18:08:06 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 08 18:08:06 volumio volumio[780]: info: Received Get System Info Mar 08 18:08:06 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 08 18:08:06 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 08 18:08:06 volumio volumio[780]: info: Discovery: Getting this device information Mar 08 18:08:06 volumio volumio[780]: info: CoreCommandRouter::volumioGetState Mar 08 18:08:06 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 08 18:08:06 volumio volumio[780]: info: CoreCommandRouter::volumioGetState Mar 08 18:08:06 volumio volumio[780]: info: Listing playlists Mar 08 18:08:06 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 08 18:08:06 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 08 18:08:06 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Mar 08 18:08:07 volumio volumio[780]: info: CoreCommandRouter::volumioGetState Mar 08 18:08:07 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 08 18:08:07 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 18:08:07 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 08 18:08:07 volumio volumio-remote-updater[509]: No test mode Mar 08 18:08:07 volumio volumio-remote-updater[509]: No alpha test mode Mar 08 18:08:07 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Mar 08 18:08:07 volumio volumio[780]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

    • Improved translations

 

NEW ADDITIONS

    • Add DSD-quirk for several USB DACs
    • Enable install-to-NVME on CM5 and newer RPi5 revisions
    • Fix potential issues with QOBUZ and TIDAL Streaming on slow connections

 

","title":"Update v3.795","updateavailable":true} Mar 08 18:08:07 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 08 18:08:07 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 08 18:08:07 volumio volumio[780]: info: Received Get System Info Mar 08 18:08:07 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 08 18:08:07 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 08 18:08:07 volumio volumio[780]: info: Discovery: Getting this device information Mar 08 18:08:07 volumio volumio[780]: info: CoreCommandRouter::volumioGetState Mar 08 18:08:07 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 08 18:08:07 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 08 18:08:08 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Mar 08 18:08:08 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 18:08:08 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 18:08:08 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Mar 08 18:08:08 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Mar 08 18:08:08 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Mar 08 18:08:08 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 08 18:08:08 volumio volumio[780]: info: CoreCommandRouter::volumioGetBrowseSources Mar 08 18:08:08 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 08 18:08:10 volumio volumio[780]: error: MyVolumio Plugin failed to authenticate in a timely fashion Mar 08 18:08:10 volumio volumio[780]: info: Completed starting MyVolumio Plugin Mar 08 18:08:10 volumio volumio[780]: [Metrics] CommandRouter: 43s 149.40ms Mar 08 18:08:10 volumio volumio[780]: info: CoreCommandRouter::volumiosetStartupVolume Mar 08 18:08:10 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 18:08:10 volumio volumio[780]: info: VolumeController:: Setting startup Volume 100 Mar 08 18:08:10 volumio volumio[780]: info: VolumeController::SetAlsaVolume100 Mar 08 18:08:10 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 18:08:10 volumio volumio[780]: info: CoreCommandRouter::Close All Modals sent Mar 08 18:08:10 volumio volumio[780]: info: CoreCommandRouter::Close All Modals sent Mar 08 18:08:10 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:08:10 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 18:08:10 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:08:11 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Mar 08 18:08:11 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 08 18:08:11 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Mar 08 18:08:11 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 08 18:08:11 volumio volumio[780]: info: Received Get System Info Mar 08 18:08:11 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 08 18:08:11 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 08 18:08:11 volumio volumio[780]: info: Discovery: Getting this device information Mar 08 18:08:11 volumio volumio[780]: info: CoreCommandRouter::volumioGetState Mar 08 18:08:11 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 08 18:08:13 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 08 18:08:13 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 08 18:08:16 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 08 18:08:17 volumio volumio[780]: info: BOOT COMPLETED Mar 08 18:08:18 volumio volumio[780]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 08 18:08:18 volumio volumio[780]: info: AutoStart - getUIConfig Mar 08 18:08:24 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 08 18:08:24 volumio volumio[780]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Mar 08 18:08:24 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Mar 08 18:08:24 volumio volumio[780]: info: Received Get System Version Mar 08 18:08:24 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 08 18:08:24 volumio volumio[780]: info: Received Get System Info Mar 08 18:08:24 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 08 18:08:24 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 08 18:08:24 volumio volumio[780]: info: Discovery: Getting this device information Mar 08 18:08:24 volumio volumio[780]: info: CoreCommandRouter::volumioGetState Mar 08 18:08:24 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 08 18:08:27 volumio volumio[780]: info: CALLMETHOD: system_controller autostart saveOptions [object Object] Mar 08 18:08:27 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: autostart , saveOptions Mar 08 18:08:27 volumio volumio[780]: info: AutoStart - saving settings Mar 08 18:08:27 volumio volumio[780]: info: AutoStart - settings saved Mar 08 18:08:31 volumio volumio[780]: info: CoreCommandRouter::volumioGetState Mar 08 18:08:35 volumio volumio[780]: info: CoreCommandRouter::volumioGetQueue Mar 08 18:08:35 volumio volumio[780]: info: CoreStateMachine::getQueue Mar 08 18:08:35 volumio volumio[780]: info: CorePlayQueue::getQueue Mar 08 18:08:36 volumio volumio[780]: info: Mar 08 18:08:36 volumio volumio[780]: ---------------------------- MPD announces system playlist update Mar 08 18:08:36 volumio volumio[780]: info: Ignoring MPD Status Update Mar 08 18:08:36 volumio volumio[780]: info: Mar 08 18:08:36 volumio volumio[780]: ---------------------------- MPD announces state update: player Mar 08 18:08:36 volumio volumio[780]: info: ControllerMpd::getState Mar 08 18:08:36 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand status Mar 08 18:08:36 volumio volumio[780]: info: Mar 08 18:08:36 volumio volumio[780]: ---------------------------- MPD announces system playlist update Mar 08 18:08:36 volumio volumio[780]: info: Ignoring MPD Status Update Mar 08 18:08:36 volumio volumio[780]: info: Mar 08 18:08:36 volumio volumio[780]: ---------------------------- MPD announces state update: player Mar 08 18:08:36 volumio volumio[780]: info: ControllerMpd::getState Mar 08 18:08:36 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand status Mar 08 18:08:36 volumio volumio[780]: info: Mar 08 18:08:36 volumio volumio[780]: ---------------------------- MPD announces system playlist update Mar 08 18:08:36 volumio volumio[780]: info: Ignoring MPD Status Update Mar 08 18:08:36 volumio volumio[780]: info: Mar 08 18:08:36 volumio volumio[780]: ---------------------------- MPD announces state update: player Mar 08 18:08:36 volumio volumio[780]: info: ControllerMpd::getState Mar 08 18:08:36 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand status Mar 08 18:08:36 volumio volumio[780]: info: ------------------------------ 10ms Mar 08 18:08:36 volumio volumio[780]: info: sendMpdCommand status took 9 milliseconds Mar 08 18:08:36 volumio volumio[780]: info: ------------------------------ 9ms Mar 08 18:08:36 volumio volumio[780]: info: sendMpdCommand status took 7 milliseconds Mar 08 18:08:36 volumio volumio[780]: info: ------------------------------ 7ms Mar 08 18:08:36 volumio volumio[780]: info: sendMpdCommand status took 5 milliseconds Mar 08 18:08:36 volumio volumio[780]: verbose: ControllerMpd::parseState Mar 08 18:08:36 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 18:08:36 volumio volumio[780]: verbose: ControllerMpd::parseState Mar 08 18:08:36 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 18:08:36 volumio volumio[780]: verbose: ControllerMpd::parseState Mar 08 18:08:36 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 18:08:36 volumio volumio[780]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 08 18:08:36 volumio volumio[780]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 08 18:08:36 volumio volumio[780]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 08 18:08:36 volumio volumio[780]: verbose: ControllerMpd::parseTrackInfo Mar 08 18:08:36 volumio volumio[780]: verbose: ControllerMpd::parseTrackInfo Mar 08 18:08:36 volumio volumio[780]: verbose: ControllerMpd::parseTrackInfo Mar 08 18:08:36 volumio volumio[780]: info: ControllerMpd::pushState Mar 08 18:08:36 volumio volumio[780]: info: CoreCommandRouter::servicePushState Mar 08 18:08:36 volumio volumio[780]: info: CorePlayQueue::getTrack 0 Mar 08 18:08:36 volumio volumio[780]: verbose: STATE SERVICE {"status":"play","position":0,"seek":44981,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Nokyo, Buchs - Chevrolet feat. Nokyo (Original Mix)","artist":"CHILLOUT ANTENNE","album":null,"uri":"http://stream.antenne.de:80/chillout","trackType":""} Mar 08 18:08:36 volumio volumio[780]: verbose: CURRENT POSITION 0 Mar 08 18:08:36 volumio volumio[780]: info: CoreStateMachine::syncState stateService play Mar 08 18:08:36 volumio volumio[780]: info: CoreStateMachine::syncState currentStatus play Mar 08 18:08:36 volumio volumio[780]: info: Received an update from plugin. extracting info from payload Mar 08 18:08:36 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 08 18:08:36 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:08:36 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 18:08:36 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:08:36 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:08:36 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:08:36 volumio volumio[780]: info: ControllerMpd::pushState Mar 08 18:08:36 volumio volumio[780]: info: CoreCommandRouter::servicePushState Mar 08 18:08:36 volumio volumio[780]: info: CorePlayQueue::getTrack 0 Mar 08 18:08:36 volumio volumio[780]: verbose: STATE SERVICE {"status":"play","position":0,"seek":44981,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Nokyo, Buchs - Chevrolet feat. Nokyo (Original Mix)","artist":"CHILLOUT ANTENNE","album":null,"uri":"http://stream.antenne.de:80/chillout","trackType":""} Mar 08 18:08:36 volumio volumio[780]: verbose: CURRENT POSITION 0 Mar 08 18:08:36 volumio volumio[780]: info: CoreStateMachine::syncState stateService play Mar 08 18:08:36 volumio volumio[780]: info: CoreStateMachine::syncState currentStatus play Mar 08 18:08:36 volumio volumio[780]: info: Received an update from plugin. extracting info from payload Mar 08 18:08:36 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 08 18:08:36 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:08:36 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:08:36 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:08:36 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:08:36 volumio volumio[780]: info: ControllerMpd::pushState Mar 08 18:08:36 volumio volumio[780]: info: CoreCommandRouter::servicePushState Mar 08 18:08:36 volumio volumio[780]: info: CorePlayQueue::getTrack 0 Mar 08 18:08:36 volumio volumio[780]: verbose: STATE SERVICE {"status":"play","position":0,"seek":44981,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Nokyo, Buchs - Chevrolet feat. Nokyo (Original Mix)","artist":"CHILLOUT ANTENNE","album":null,"uri":"http://stream.antenne.de:80/chillout","trackType":""} Mar 08 18:08:36 volumio volumio[780]: verbose: CURRENT POSITION 0 Mar 08 18:08:36 volumio volumio[780]: info: CoreStateMachine::syncState stateService play Mar 08 18:08:36 volumio volumio[780]: info: CoreStateMachine::syncState currentStatus play Mar 08 18:08:36 volumio volumio[780]: info: Received an update from plugin. extracting info from payload Mar 08 18:08:36 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 08 18:08:36 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:08:36 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:08:36 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:08:36 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:08:36 volumio volumio[780]: info: ------------------------------ 91ms Mar 08 18:08:36 volumio volumio[780]: info: ------------------------------ 89ms Mar 08 18:08:36 volumio volumio[780]: info: ------------------------------ 88ms Mar 08 18:08:37 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Mar 08 18:08:37 volumio volumio[780]: info: Preload queue cleared Mar 08 18:08:38 volumio volumio[780]: info: Mar 08 18:08:38 volumio volumio[780]: ---------------------------- MPD announces system playlist update Mar 08 18:08:38 volumio volumio[780]: info: Ignoring MPD Status Update Mar 08 18:08:38 volumio volumio[780]: info: Mar 08 18:08:38 volumio volumio[780]: ---------------------------- MPD announces state update: player Mar 08 18:08:38 volumio volumio[780]: info: ControllerMpd::getState Mar 08 18:08:38 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand status Mar 08 18:08:38 volumio volumio[780]: info: Mar 08 18:08:38 volumio volumio[780]: ---------------------------- MPD announces system playlist update Mar 08 18:08:38 volumio volumio[780]: info: Ignoring MPD Status Update Mar 08 18:08:38 volumio volumio[780]: info: Mar 08 18:08:38 volumio volumio[780]: ---------------------------- MPD announces state update: player Mar 08 18:08:38 volumio volumio[780]: info: ControllerMpd::getState Mar 08 18:08:38 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand status Mar 08 18:08:38 volumio volumio[780]: info: Mar 08 18:08:38 volumio volumio[780]: ---------------------------- MPD announces system playlist update Mar 08 18:08:38 volumio volumio[780]: info: Ignoring MPD Status Update Mar 08 18:08:38 volumio volumio[780]: info: Mar 08 18:08:38 volumio volumio[780]: ---------------------------- MPD announces state update: player Mar 08 18:08:38 volumio volumio[780]: info: ControllerMpd::getState Mar 08 18:08:38 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand status Mar 08 18:08:38 volumio volumio[780]: info: ------------------------------ 10ms Mar 08 18:08:38 volumio volumio[780]: info: sendMpdCommand status took 9 milliseconds Mar 08 18:08:38 volumio volumio[780]: info: ------------------------------ 8ms Mar 08 18:08:38 volumio volumio[780]: info: sendMpdCommand status took 7 milliseconds Mar 08 18:08:38 volumio volumio[780]: info: ------------------------------ 6ms Mar 08 18:08:38 volumio volumio[780]: info: sendMpdCommand status took 4 milliseconds Mar 08 18:08:38 volumio volumio[780]: verbose: ControllerMpd::parseState Mar 08 18:08:38 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 18:08:38 volumio volumio[780]: verbose: ControllerMpd::parseState Mar 08 18:08:38 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 18:08:38 volumio volumio[780]: verbose: ControllerMpd::parseState Mar 08 18:08:38 volumio volumio[780]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 18:08:38 volumio volumio[780]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 08 18:08:38 volumio volumio[780]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 08 18:08:38 volumio volumio[780]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 08 18:08:38 volumio volumio[780]: verbose: ControllerMpd::parseTrackInfo Mar 08 18:08:38 volumio volumio[780]: verbose: ControllerMpd::parseTrackInfo Mar 08 18:08:38 volumio volumio[780]: verbose: ControllerMpd::parseTrackInfo Mar 08 18:08:38 volumio volumio[780]: info: ControllerMpd::pushState Mar 08 18:08:38 volumio volumio[780]: info: CoreCommandRouter::servicePushState Mar 08 18:08:38 volumio volumio[780]: info: CorePlayQueue::getTrack 0 Mar 08 18:08:38 volumio volumio[780]: verbose: STATE SERVICE {"status":"play","position":0,"seek":47177,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Nokyo, Buchs - Chevrolet feat. Nokyo (Original Mix)","artist":"CHILLOUT ANTENNE","album":null,"uri":"http://stream.antenne.de:80/chillout","trackType":""} Mar 08 18:08:38 volumio volumio[780]: verbose: CURRENT POSITION 0 Mar 08 18:08:38 volumio volumio[780]: info: CoreStateMachine::syncState stateService play Mar 08 18:08:38 volumio volumio[780]: info: CoreStateMachine::syncState currentStatus play Mar 08 18:08:38 volumio volumio[780]: info: Received an update from plugin. extracting info from payload Mar 08 18:08:38 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 08 18:08:38 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:08:38 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 18:08:38 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:08:38 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:08:38 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:08:38 volumio volumio[780]: info: ControllerMpd::pushState Mar 08 18:08:38 volumio volumio[780]: info: CoreCommandRouter::servicePushState Mar 08 18:08:38 volumio volumio[780]: info: CorePlayQueue::getTrack 0 Mar 08 18:08:38 volumio volumio[780]: verbose: STATE SERVICE {"status":"play","position":0,"seek":47177,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Nokyo, Buchs - Chevrolet feat. Nokyo (Original Mix)","artist":"CHILLOUT ANTENNE","album":null,"uri":"http://stream.antenne.de:80/chillout","trackType":""} Mar 08 18:08:38 volumio volumio[780]: verbose: CURRENT POSITION 0 Mar 08 18:08:38 volumio volumio[780]: info: CoreStateMachine::syncState stateService play Mar 08 18:08:38 volumio volumio[780]: info: CoreStateMachine::syncState currentStatus play Mar 08 18:08:38 volumio volumio[780]: info: Received an update from plugin. extracting info from payload Mar 08 18:08:38 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 08 18:08:38 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:08:38 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:08:38 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:08:38 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:08:38 volumio volumio[780]: info: ControllerMpd::pushState Mar 08 18:08:38 volumio volumio[780]: info: CoreCommandRouter::servicePushState Mar 08 18:08:38 volumio volumio[780]: info: CorePlayQueue::getTrack 0 Mar 08 18:08:38 volumio volumio[780]: verbose: STATE SERVICE {"status":"play","position":0,"seek":47177,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Nokyo, Buchs - Chevrolet feat. Nokyo (Original Mix)","artist":"CHILLOUT ANTENNE","album":null,"uri":"http://stream.antenne.de:80/chillout","trackType":""} Mar 08 18:08:38 volumio volumio[780]: verbose: CURRENT POSITION 0 Mar 08 18:08:38 volumio volumio[780]: info: CoreStateMachine::syncState stateService play Mar 08 18:08:38 volumio volumio[780]: info: CoreStateMachine::syncState currentStatus play Mar 08 18:08:38 volumio volumio[780]: info: Received an update from plugin. extracting info from payload Mar 08 18:08:38 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 08 18:08:38 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:08:38 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:08:38 volumio volumio[780]: info: CoreStateMachine::pushState Mar 08 18:08:38 volumio volumio[780]: info: CoreCommandRouter::volumioPushState Mar 08 18:08:38 volumio volumio[780]: info: ------------------------------ 92ms Mar 08 18:08:38 volumio volumio[780]: info: ------------------------------ 90ms Mar 08 18:08:38 volumio volumio[780]: info: ------------------------------ 87ms Mar 08 18:08:40 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Mar 08 18:08:40 volumio volumio[780]: info: Preload queue cleared Mar 08 18:08:45 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Mar 08 18:08:45 volumio volumio[780]: info: Preload queue cleared Mar 08 18:08:47 volumio volumio[780]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Mar 08 18:08:47 volumio volumio[780]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 08 18:08:47 volumio volumio[780]: TypeError: Cannot read property 'length' of undefined Mar 08 18:08:47 volumio volumio[780]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Mar 08 18:08:47 volumio volumio[780]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Mar 08 18:08:47 volumio volumio[780]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Mar 08 18:08:47 volumio volumio[780]: at Parser.emit (events.js:315:20) Mar 08 18:08:47 volumio volumio[780]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Mar 08 18:08:47 volumio volumio[780]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Mar 08 18:08:47 volumio volumio[780]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Mar 08 18:08:47 volumio volumio[780]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Mar 08 18:08:47 volumio volumio[780]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Mar 08 18:08:47 volumio volumio[780]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Mar 08 18:08:47 volumio volumio[780]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Mar 08 18:08:47 volumio volumio[780]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Mar 08 18:08:47 volumio volumio[780]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Mar 08 18:08:47 volumio volumio[780]: at IncomingMessage.emit (events.js:327:22) Mar 08 18:08:47 volumio volumio[780]: at endReadableNT (internal/streams/readable.js:1327:12) Mar 08 18:08:47 volumio volumio[780]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Mar 08 18:08:47 volumio volumio[780]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 08 18:08:48 volumio sudo[1655]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-08 18:07 Mar 08 18:08:48 volumio sudo[1655]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 06:51:56 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="b9009e0280f50389e80a537357ff3961"