-- Logs begin at Fri 2020-12-11 14:53:56 UTC, end at Fri 2020-12-11 15:14:19 UTC. -- Dec 11 15:13:01 volumio volumio[9252]: info: ------------------------------------------- Dec 11 15:13:01 volumio volumio[9252]: info: ----- Volumio2 ---- Dec 11 15:13:01 volumio volumio[9252]: info: ------------------------------------------- Dec 11 15:13:01 volumio volumio[9252]: info: ----- System startup ---- Dec 11 15:13:01 volumio volumio[9252]: info: ------------------------------------------- Dec 11 15:13:02 volumio volumio[9252]: info: MYVOLUMIO Environment detected Dec 11 15:13:02 volumio volumio[9252]: info: Plugin folders cleanup Dec 11 15:13:02 volumio volumio[9252]: info: Scanning into folder /volumio/app/plugins/ Dec 11 15:13:02 volumio volumio[9252]: info: Scanning category audio_interface Dec 11 15:13:02 volumio volumio[9252]: info: Scanning category miscellanea Dec 11 15:13:02 volumio volumio[9252]: info: Scanning category music_service Dec 11 15:13:02 volumio volumio[9252]: info: Scanning category plugins.json Dec 11 15:13:02 volumio volumio[9252]: info: Scanning category system_controller Dec 11 15:13:02 volumio volumio[9252]: info: Scanning category user_interface Dec 11 15:13:02 volumio volumio[9252]: info: Scanning into folder /data/plugins/ Dec 11 15:13:02 volumio volumio[9252]: info: Scanning category accessory Dec 11 15:13:02 volumio volumio[9252]: info: Scanning category miscellanea Dec 11 15:13:02 volumio volumio[9252]: info: Scanning category music_service Dec 11 15:13:02 volumio volumio[9252]: info: Plugin folders cleanup completed Dec 11 15:13:02 volumio volumio[9252]: info: ------------------------------------------- Dec 11 15:13:02 volumio volumio[9252]: info: ----- Core plugins startup ---- Dec 11 15:13:02 volumio volumio[9252]: info: ------------------------------------------- Dec 11 15:13:02 volumio volumio[9252]: info: Loading plugins from folder /volumio/app/plugins/ Dec 11 15:13:02 volumio volumio[9252]: info: Adding plugin upnp to MyMusic Plugins Dec 11 15:13:02 volumio volumio[9252]: info: Adding plugin airplay_emulation to MyMusic Plugins Dec 11 15:13:02 volumio volumio[9252]: info: Adding plugin upnp_browser to MyMusic Plugins Dec 11 15:13:02 volumio volumio[9252]: info: Loading plugins from folder /data/plugins/ Dec 11 15:13:02 volumio volumio[9252]: info: Loading plugin "system"... Dec 11 15:13:02 volumio volumio[9252]: info: Loading plugin "appearance"... Dec 11 15:13:04 volumio volumio[9252]: info: Loading plugin "network"... Dec 11 15:13:04 volumio volumio[9252]: info: Refreshing Cached IP Addresses Dec 11 15:13:04 volumio sudo[9287]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 11 15:13:04 volumio sudo[9287]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 15:13:04 volumio sudo[9287]: pam_unix(sudo:session): session closed for user root Dec 11 15:13:04 volumio volumio[9252]: info: Loading plugin "services"... Dec 11 15:13:04 volumio volumio[9252]: info: Loading plugin "alsa_controller"... Dec 11 15:13:04 volumio sudo[9290]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 11 15:13:04 volumio sudo[9290]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 15:13:04 volumio sudo[9290]: pam_unix(sudo:session): session closed for user root Dec 11 15:13:04 volumio volumio[9252]: info: Loading plugin "wizard"... Dec 11 15:13:04 volumio volumio[9252]: info: Loading plugin "volumio_command_line_client"... Dec 11 15:13:04 volumio volumio[9252]: info: Loading plugin "upnp"... Dec 11 15:13:04 volumio volumio[9252]: info: [1607699584488] Starting Upmpd Daemon Dec 11 15:13:04 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 11 15:13:04 volumio volumio[9252]: info: Loading plugin "my_music"... Dec 11 15:13:04 volumio volumio[9252]: info: Loading plugin "mpd"... Dec 11 15:13:04 volumio volumio-remote-updater[4536]: [2020-12-11 15:13:04] [connect] Successful connection Dec 11 15:13:04 volumio volumio[9252]: info: Loading plugin "upnp_browser"... Dec 11 15:13:05 volumio volumio[9252]: info: Loading plugin "networkfs"... Dec 11 15:13:05 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 11 15:13:05 volumio volumio[9252]: info: Loading plugin "alarm-clock"... Dec 11 15:13:05 volumio sudo[9301]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto 192.168.1.193:mnt /mnt/NAS/FNOS Dec 11 15:13:05 volumio sudo[9301]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 15:13:05 volumio volumio[9252]: info: Loading plugin "airplay_emulation"... Dec 11 15:13:05 volumio volumio[9252]: info: Starting Shairport Sync Dec 11 15:13:05 volumio volumio[9252]: info: Loading plugin "last_100"... Dec 11 15:13:05 volumio volumio[9252]: info: Loading plugin "webradio"... Dec 11 15:13:05 volumio volumio[9252]: info: Loading plugin "i2s_dacs"... Dec 11 15:13:05 volumio volumio[9252]: info: I2S DAC not set, start Auto-detection Dec 11 15:13:05 volumio volumio[9252]: info: Loading plugin "volumiodiscovery"... Dec 11 15:13:06 volumio volumio[9252]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 11 15:13:06 volumio node[9252]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 11 15:13:06 volumio node[9252]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 11 15:13:06 volumio node[9252]: *** WARNING *** For more information see Dec 11 15:13:06 volumio node[9252]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 11 15:13:06 volumio node[9252]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 11 15:13:06 volumio node[9252]: *** WARNING *** For more information see Dec 11 15:13:06 volumio volumio[9252]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 11 15:13:06 volumio volumio[9252]: *** WARNING *** For more information see Dec 11 15:13:06 volumio volumio[9252]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 11 15:13:06 volumio volumio[9252]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 11 15:13:06 volumio volumio[9252]: *** WARNING *** For more information see Dec 11 15:13:06 volumio volumio[9252]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 11 15:13:06 volumio volumio[9252]: Discovery: StartAdv! undefined Dec 11 15:13:06 volumio volumio[9252]: Discovery: Started advertising... Volumio - undefined Dec 11 15:13:06 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 11 15:13:06 volumio volumio[9252]: info: Loading plugin "autostart"... Dec 11 15:13:06 volumio volumio[9252]: info: Applying required configuration parameters for plugin autostart Dec 11 15:13:06 volumio volumio[9252]: info: Loading plugin "outputs"... Dec 11 15:13:06 volumio volumio[9252]: info: Loading plugin "albumart"... Dec 11 15:13:06 volumio volumio[9252]: info: Plugin example_plugin is not enabled Dec 11 15:13:06 volumio volumio[9252]: info: Loading plugin "inputs"... Dec 11 15:13:06 volumio volumio[9252]: info: Loading plugin "updater_comm"... Dec 11 15:13:06 volumio volumio[9252]: info: Plugin mpdemulation is not enabled Dec 11 15:13:06 volumio volumio[9252]: info: Loading plugin "rest_api"... Dec 11 15:13:06 volumio volumio[9252]: info: Loading plugin "websocket"... Dec 11 15:13:06 volumio volumio[9252]: info: Loading plugin "ir_controller"... Dec 11 15:13:06 volumio volumio[9252]: Forking 3 albumart workers Dec 11 15:13:06 volumio volumio[9252]: info: Applying required configuration parameters for plugin ir_controller Dec 11 15:13:06 volumio volumio[9252]: info: Loading plugin "RoonBridge"... Dec 11 15:13:07 volumio sudo[9301]: pam_unix(sudo:session): session closed for user root Dec 11 15:13:07 volumio volumio[9252]: info: Applying required configuration parameters for plugin RoonBridge Dec 11 15:13:07 volumio volumio[9252]: info: ___________ START PLUGINS ___________ Dec 11 15:13:07 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 11 15:13:07 volumio volumio[9252]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 11 15:13:07 volumio volumio[9252]: info: [1607699587289] CoreMusicLibrary::Adding element Media Servers Dec 11 15:13:07 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 11 15:13:07 volumio volumio[9252]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 11 15:13:07 volumio volumio[9252]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 11 15:13:07 volumio volumio[9252]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 11 15:13:07 volumio volumio[9252]: info: [1607699587450] CoreMusicLibrary::Adding element Last_100 Dec 11 15:13:07 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 11 15:13:07 volumio volumio[9252]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 11 15:13:07 volumio volumio[9252]: info: [1607699587458] CoreMusicLibrary::Adding element Webradio Dec 11 15:13:07 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 11 15:13:07 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 11 15:13:07 volumio volumio[9252]: info: Loading i18n strings for locale zh Dec 11 15:13:07 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 11 15:13:07 volumio volumio[9252]: info: ------------------------------------------- Dec 11 15:13:07 volumio volumio[9252]: info: ----- MyVolumio plugins startup ---- Dec 11 15:13:07 volumio volumio[9252]: info: ------------------------------------------- Dec 11 15:13:07 volumio volumio[9252]: info: [MyVolumio PluginManager] Fetching plans data.... Dec 11 15:13:07 volumio volumio[9252]: info: Loading i18n strings for locale zh Dec 11 15:13:07 volumio sudo[9348]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R a+rwX /etc/lirc/hardware.conf /etc/lirc/lircd.conf /etc/lirc/lircmd.conf /etc/lirc/lircrc Dec 11 15:13:07 volumio sudo[9348]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 15:13:07 volumio sudo[9348]: pam_unix(sudo:session): session closed for user root Dec 11 15:13:07 volumio volumio[9252]: Updating browse sources language Dec 11 15:13:07 volumio volumio[9252]: Cannot find translation for sourceMedia Servers Dec 11 15:13:07 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 11 15:13:07 volumio sudo[9349]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service Dec 11 15:13:07 volumio sudo[9349]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 15:13:07 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 11 15:13:07 volumio volumio[9252]: info: CoreCommandRouter::initPlayerControls Dec 11 15:13:07 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 15:13:07 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Dec 11 15:13:07 volumio sudo[9349]: pam_unix(sudo:session): session closed for user root Dec 11 15:13:07 volumio volumio[9252]: Starting albumart workers Dec 11 15:13:07 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 15:13:07 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 15:13:07 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 15:13:07 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 15:13:07 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 15:13:07 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 11 15:13:07 volumio volumio[9252]: info: BOOT COMPLETED Dec 11 15:13:07 volumio volumio[9252]: [Metrics] CommandRouter: 5s 846.95ms Dec 11 15:13:07 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 11 15:13:07 volumio volumio[9252]: Starting albumart workers Dec 11 15:13:07 volumio kernel: aml_spdif_dai: aml_hw_iec958_init,runtime->rate=44100, same source mode(0) Dec 11 15:13:07 volumio kernel: aml_spdif_dai: set normal 512 fs /4 fs Dec 11 15:13:07 volumio kernel: aml_spdif_dai: iec958 mode PCM16 Dec 11 15:13:07 volumio kernel: aml_audio_hw: IEC958 16bit Dec 11 15:13:07 volumio kernel: hdmitx: audio: aout notify rate 44100 Dec 11 15:13:07 volumio kernel: hdmitx: audio: aout notify size 16 Dec 11 15:13:07 volumio kernel: hdmitx: audio: no update Dec 11 15:13:07 volumio kernel: aml_spdif_dai: aiu 958 playback enable Dec 11 15:13:07 volumio volumio[9252]: Starting albumart workers Dec 11 15:13:13 volumio kernel: aml_spdif_dai: aiu 958 playback disable Dec 11 15:13:13 volumio volumio[9252]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Dec 11 15:13:13 volumio volumio[9252]: info: CoreCommandRouter::Close All Modals sent Dec 11 15:13:13 volumio volumio[9252]: info: CoreCommandRouter::Close All Modals sent Dec 11 15:13:13 volumio volumio[9252]: Express server listening on port 3000 Dec 11 15:13:13 volumio volumio[9252]: [Metrics] WebUI: 11s 693.32ms Dec 11 15:13:13 volumio volumio[9252]: Volumio Calling Home Dec 11 15:13:13 volumio volumio[9252]: info: CoreStateMachine::resetVolumioState Dec 11 15:13:13 volumio volumio[9252]: info: CoreStateMachine::getcurrentVolume Dec 11 15:13:13 volumio volumio[9252]: info: CoreCommandRouter::volumioRetrievevolume Dec 11 15:13:13 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 11 15:13:13 volumio volumio[9252]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Dec 11 15:13:13 volumio volumio[9252]: Unable to parse: Dec 11 15:13:13 volumio volumio[9252]: Simple mixer control 'Audio i2s mute',0 Dec 11 15:13:13 volumio volumio[9252]: Capabilities: pswitch pswitch-joined Dec 11 15:13:13 volumio volumio[9252]: Playback channels: Mono Dec 11 15:13:13 volumio volumio[9252]: Mono: Playback [on] Dec 11 15:13:13 volumio volumio[9252]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Dec 11 15:13:13 volumio volumio[9252]: info: Setting Device type: Amlogic Dec 11 15:13:13 volumio volumio[9252]: error: Cannot start Roon Bridge Error: Command failed: /usr/bin/sudo /bin/systemctl start roonbridge.service Dec 11 15:13:13 volumio volumio[9252]: Failed to start roonbridge.service: Unit roonbridge.service failed to load: No such file or directory. Dec 11 15:13:13 volumio volumio[9252]: info: ir_controller: File permissions successfully set on /etc/lirc/*. Dec 11 15:13:13 volumio volumio[9252]: info: MPD running with PID5957 Dec 11 15:13:13 volumio volumio[9252]: ,establishing connection Dec 11 15:13:13 volumio sudo[9393]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Dec 11 15:13:13 volumio sudo[9393]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 15:13:13 volumio sudo[9393]: pam_unix(sudo:session): session closed for user root Dec 11 15:13:13 volumio volumio[9252]: Unable to parse: Dec 11 15:13:13 volumio volumio[9252]: Simple mixer control 'Audio i2s mute',0 Dec 11 15:13:13 volumio volumio[9252]: Capabilities: pswitch pswitch-joined Dec 11 15:13:13 volumio volumio[9252]: Playback channels: Mono Dec 11 15:13:13 volumio volumio[9252]: Mono: Playback [on] Dec 11 15:13:13 volumio volumio[9252]: info: VolumeController:: Volume=undefined Mute =false Dec 11 15:13:13 volumio volumio[9252]: info: CoreStateMachine::pushState Dec 11 15:13:13 volumio volumio[9252]: info: CorePlayQueue::getTrack 0 Dec 11 15:13:13 volumio volumio[9252]: info: CoreCommandRouter::volumioPushState Dec 11 15:13:13 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 15:13:13 volumio volumio[9252]: info: CoreStateMachine::updateTrackBlock Dec 11 15:13:13 volumio volumio[9252]: info: CorePlayQueue::getTrackBlock Dec 11 15:13:13 volumio volumio[9252]: info: CoreCommandRouter::volumioRetrievevolume Dec 11 15:13:13 volumio volumio[9252]: info: Cannot read I2C interface or I2C interface not presentError: Command failed: /usr/bin/sudo /usr/sbin/i2cdetect -y 1 Dec 11 15:13:13 volumio volumio[9252]: Error: Could not open file `/dev/i2c-1' or `/dev/i2c/1': No such file or directory Dec 11 15:13:13 volumio volumio[9252]: info: Reloading queue from file Dec 11 15:13:13 volumio volumio[9252]: error: updateQueue error: null Dec 11 15:13:13 volumio volumio[9252]: error: Failed LSINFO: Error: [50@0] {} No such directory Dec 11 15:13:13 volumio volumio[9252]: Unable to parse: Dec 11 15:13:13 volumio volumio[9252]: Simple mixer control 'Audio i2s mute',0 Dec 11 15:13:13 volumio volumio[9252]: Capabilities: pswitch pswitch-joined Dec 11 15:13:13 volumio volumio[9252]: Playback channels: Mono Dec 11 15:13:13 volumio volumio[9252]: Mono: Playback [on] Dec 11 15:13:13 volumio volumio[9252]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Dec 11 15:13:13 volumio volumio[9252]: info: CoreStateMachine::setRepeat null single undefined Dec 11 15:13:13 volumio volumio[9252]: info: CoreStateMachine::pushState Dec 11 15:13:13 volumio volumio[9252]: info: CorePlayQueue::getTrack 0 Dec 11 15:13:13 volumio volumio[9252]: info: CoreCommandRouter::volumioPushState Dec 11 15:13:13 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 15:13:13 volumio volumio[9252]: info: CoreStateMachine::setRandom null Dec 11 15:13:13 volumio volumio[9252]: info: CoreStateMachine::pushState Dec 11 15:13:13 volumio volumio[9252]: info: CorePlayQueue::getTrack 0 Dec 11 15:13:13 volumio volumio[9252]: info: CoreCommandRouter::volumioPushState Dec 11 15:13:13 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 15:13:14 volumio volumio[9252]: Unable to parse: Dec 11 15:13:14 volumio volumio[9252]: Simple mixer control 'Audio i2s mute',0 Dec 11 15:13:14 volumio volumio[9252]: Capabilities: pswitch pswitch-joined Dec 11 15:13:14 volumio volumio[9252]: Playback channels: Mono Dec 11 15:13:14 volumio volumio[9252]: Mono: Playback [on] Dec 11 15:13:14 volumio volumio[9252]: info: VolumeController:: Volume=undefined Mute =false Dec 11 15:13:14 volumio volumio[9252]: info: CoreStateMachine::pushState Dec 11 15:13:14 volumio volumio[9252]: info: CorePlayQueue::getTrack 0 Dec 11 15:13:14 volumio volumio[9252]: info: CoreCommandRouter::volumioPushState Dec 11 15:13:14 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 15:13:14 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Dec 11 15:13:14 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 11 15:13:14 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Dec 11 15:13:14 volumio volumio[9252]: info: Starting Shairport Sync Dec 11 15:13:14 volumio volumio[9252]: info: Starting Shairport Sync Dec 11 15:13:14 volumio sudo[9403]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 11 15:13:14 volumio sudo[9403]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 15:13:14 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 11 15:13:14 volumio sudo[9405]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 11 15:13:14 volumio sudo[9405]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 15:13:14 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Dec 11 15:13:14 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 11 15:13:14 volumio sudo[9403]: pam_unix(sudo:session): session closed for user root Dec 11 15:13:14 volumio sudo[9405]: pam_unix(sudo:session): session closed for user root Dec 11 15:13:14 volumio volumio[9252]: info: ir_controller: LIRC correctly updated. Dec 11 15:13:14 volumio volumio[9252]: info: Shairport-Sync Started Dec 11 15:13:14 volumio volumio[9252]: Error adding Membership: Error: addMembership EINVAL Dec 11 15:13:14 volumio volumio[9252]: info: Shairport-Sync Started Dec 11 15:13:14 volumio volumio[9252]: Discovery: adding 79bfc2c3-d29c-4839-9b52-f907310bef76 Dec 11 15:13:14 volumio volumio[9252]: info: mDNS: Found device Volumio Dec 11 15:13:14 volumio volumio[9252]: info: CoreCommandRouter::volumioGetState Dec 11 15:13:14 volumio volumio[9252]: info: CorePlayQueue::getTrack 0 Dec 11 15:13:14 volumio sudo[9420]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 11 15:13:14 volumio sudo[9420]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 15:13:14 volumio sudo[9420]: pam_unix(sudo:session): session closed for user root Dec 11 15:13:14 volumio sudo[9422]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 11 15:13:14 volumio sudo[9422]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 15:13:14 volumio sudo[9422]: pam_unix(sudo:session): session closed for user root Dec 11 15:13:14 volumio volumio[9252]: info: CoreCommandRouter::volumioGetState Dec 11 15:13:14 volumio volumio[9252]: info: CorePlayQueue::getTrack 0 Dec 11 15:13:14 volumio sudo[9426]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 11 15:13:14 volumio sudo[9426]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 15:13:14 volumio sudo[9426]: pam_unix(sudo:session): session closed for user root Dec 11 15:13:14 volumio sudo[9428]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 11 15:13:14 volumio sudo[9428]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 15:13:14 volumio sudo[9428]: pam_unix(sudo:session): session closed for user root Dec 11 15:13:14 volumio sudo[9432]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Dec 11 15:13:14 volumio sudo[9432]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 15:13:14 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Dec 11 15:13:14 volumio sudo[9432]: pam_unix(sudo:session): session closed for user root Dec 11 15:13:14 volumio volumio[9252]: info: Upmpdcli Daemon Started Dec 11 15:13:14 volumio volumio[9252]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 11 15:13:14 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 11 15:13:14 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 11 15:13:14 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 11 15:13:14 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 11 15:13:14 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 11 15:13:14 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 11 15:13:14 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 11 15:13:14 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 11 15:13:14 volumio volumio[9252]: info: CoreCommandRouter::volumioGetBrowseSources Dec 11 15:13:15 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 11 15:13:15 volumio volumio[9252]: info: CoreCommandRouter::volumioGetState Dec 11 15:13:15 volumio volumio[9252]: info: CorePlayQueue::getTrack 0 Dec 11 15:13:15 volumio volumio[9252]: info: CoreCommandRouter::volumioGetVisibleSources Dec 11 15:13:15 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 11 15:13:15 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 11 15:13:15 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 11 15:13:15 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 11 15:13:15 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 11 15:13:15 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 11 15:13:15 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Dec 11 15:13:15 volumio sudo[9444]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop lirc.service Dec 11 15:13:15 volumio sudo[9444]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 15:13:15 volumio systemd[1]: Stopping LSB: Starts LIRC daemon.... Dec 11 15:13:15 volumio lircd-0.9.0-pre1[5174]: removed client Dec 11 15:13:15 volumio lirc[9446]: Stopping execution daemon: irexec:. Dec 11 15:13:15 volumio lircd-0.9.0-pre1[5174]: caught signal Dec 11 15:13:15 volumio lirc[9446]: Stopping remote control daemon(s): LIRC:. Dec 11 15:13:15 volumio systemd[1]: Stopped LSB: Starts LIRC daemon.. Dec 11 15:13:15 volumio sudo[9444]: pam_unix(sudo:session): session closed for user root Dec 11 15:13:15 volumio volumio[9252]: info: ir_controller: systemctl stop lirc.service succeeded. Dec 11 15:13:16 volumio sudo[9463]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start lirc.service Dec 11 15:13:16 volumio sudo[9463]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 15:13:16 volumio systemd[1]: Starting LSB: Starts LIRC daemon.... Dec 11 15:13:16 volumio lirc[9465]: Loading LIRC modules:. Dec 11 15:13:16 volumio kernel: input: lircd as /devices/virtual/input/input5 Dec 11 15:13:16 volumio lircd-0.9.0-pre1[9476]: lircd(default) ready, using /var/run/lirc/lircd Dec 11 15:13:16 volumio lirc[9465]: Starting remote control daemon(s) : LIRC :. Dec 11 15:13:16 volumio lircd-0.9.0-pre1[9476]: accepted new client on /var/run/lirc/lircd Dec 11 15:13:16 volumio lirc[9465]: Starting execution daemon: irexec:. Dec 11 15:13:16 volumio systemd[1]: Started LSB: Starts LIRC daemon.. Dec 11 15:13:16 volumio sudo[9463]: pam_unix(sudo:session): session closed for user root Dec 11 15:13:16 volumio volumio[9252]: info: ir_controller: systemctl start lirc.service succeeded. Dec 11 15:13:17 volumio volumio-remote-updater[4536]: [2020-12-11 15:13:17] [connect] Successful connection Dec 11 15:13:17 volumio volumio-remote-updater[4536]: [2020-12-11 15:13:17] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1607699597 101 Dec 11 15:13:17 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 11 15:13:19 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 11 15:13:21 volumio avahi-daemon[4634]: Invalid response packet from host 192.168.1.115. Dec 11 15:13:21 volumio avahi-daemon[4634]: Invalid response packet from host 192.168.1.115. Dec 11 15:13:22 volumio avahi-daemon[4634]: Invalid response packet from host 192.168.1.115. Dec 11 15:13:23 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 11 15:13:23 volumio volumio[9252]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=aml9xxxarmv7&variante=volumio&version=2.857&uuid=a487c6ed8a8db06c5ffb65c3b3fa3670" http://updates.volumio.org:7070/downloader-v1/track-device Dec 11 15:13:23 volumio volumio[9252]: % Total % Received % Xferd Average Speed Time Time Time Current Dec 11 15:13:23 volumio volumio[9252]: Dload Upload Total Spent Left Speed Dec 11 15:13:23 volumio volumio[9252]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused Dec 11 15:13:23 volumio volumio[9252]: retrying in 5 seconds, trial 0 Dec 11 15:13:23 volumio volumio[9252]: Volumio Calling Home Dec 11 15:13:26 volumio avahi-daemon[4634]: Invalid response packet from host 192.168.1.115. Dec 11 15:13:26 volumio volumio[9252]: info: AutoStart - getting queue Dec 11 15:13:26 volumio volumio[9252]: info: CoreCommandRouter::volumioGetQueue Dec 11 15:13:26 volumio volumio[9252]: info: CoreStateMachine::getQueue Dec 11 15:13:26 volumio volumio[9252]: info: CorePlayQueue::getQueue Dec 11 15:13:26 volumio volumio[9252]: info: AutoStart - start playing -> queue is not empty Dec 11 15:13:26 volumio volumio[9252]: info: CoreCommandRouter::volumioPlay Dec 11 15:13:26 volumio volumio[9252]: UNSET VOLATILE Dec 11 15:13:26 volumio volumio[9252]: info: CoreStateMachine::play index undefined Dec 11 15:13:26 volumio volumio[9252]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 15:13:26 volumio volumio[9252]: info: CorePlayQueue::getTrack 0 Dec 11 15:13:26 volumio volumio[9252]: info: CoreStateMachine::startPlaybackTimer Dec 11 15:13:26 volumio volumio[9252]: info: CorePlayQueue::getTrack 0 Dec 11 15:13:26 volumio volumio[9252]: info: [1607699606227] ControllerWebradio::clearAddPlayTrack Dec 11 15:13:26 volumio volumio[9252]: verbose: ControllerMpd::sendMpdCommand stop Dec 11 15:13:26 volumio volumio[9252]: verbose: ControllerMpd::sendMpdCommand clear Dec 11 15:13:26 volumio volumio[9252]: info: Dec 11 15:13:26 volumio volumio[9252]: ---------------------------- MPD announces system playlist update Dec 11 15:13:26 volumio volumio[9252]: info: Ignoring MPD Status Update Dec 11 15:13:26 volumio volumio[9252]: verbose: ControllerMpd::sendMpdCommand load "https://edge56.live-sm.absolutradio.de/absolut-relax/stream/mp3" Dec 11 15:13:26 volumio volumio[9252]: error: updateQueue error: null Dec 11 15:13:26 volumio volumio[9252]: info: ------------------------------ 8ms Dec 11 15:13:26 volumio avahi-daemon[4634]: Invalid response packet from host 192.168.1.115. Dec 11 15:13:26 volumio avahi-daemon[4634]: Invalid response packet from host 192.168.1.115. Dec 11 15:13:27 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 11 15:13:31 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 11 15:13:34 volumio volumio[9252]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=aml9xxxarmv7&variante=volumio&version=2.857&uuid=a487c6ed8a8db06c5ffb65c3b3fa3670" http://updates.volumio.org:7070/downloader-v1/track-device Dec 11 15:13:34 volumio volumio[9252]: % Total % Received % Xferd Average Speed Time Time Time Current Dec 11 15:13:34 volumio volumio[9252]: Dload Upload Total Spent Left Speed Dec 11 15:13:34 volumio volumio[9252]: [235B blob data] Dec 11 15:13:34 volumio volumio[9252]: retrying in 5 seconds, trial 1 Dec 11 15:13:34 volumio volumio[9252]: Volumio Calling Home Dec 11 15:13:35 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 11 15:13:35 volumio volumio[9252]: info: CoreCommandRouter::executeOnPlugin: networkfs , editShare Dec 11 15:13:35 volumio sudo[9525]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /mnt/NAS/FNOS Dec 11 15:13:35 volumio sudo[9525]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 15:13:35 volumio sudo[9525]: pam_unix(sudo:session): session closed for user root Dec 11 15:13:35 volumio volumio[9252]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 11 15:13:35 volumio volumio[9252]: { Error: EBUSY: resource busy or locked, rmdir '/mnt/NAS/FNOS' Dec 11 15:13:35 volumio volumio[9252]: at Object.fs.rmdirSync (fs.js:846:18) Dec 11 15:13:35 volumio volumio[9252]: at /volumio/node_modules/linux-mountutils/mountutils.js:178:12 Dec 11 15:13:35 volumio volumio[9252]: at ChildProcess.exithandler (child_process.js:267:7) Dec 11 15:13:35 volumio volumio[9252]: at emitTwo (events.js:126:13) Dec 11 15:13:35 volumio volumio[9252]: at ChildProcess.emit (events.js:214:7) Dec 11 15:13:35 volumio volumio[9252]: at maybeClose (internal/child_process.js:925:16) Dec 11 15:13:35 volumio volumio[9252]: at Socket.stream.socket.on (internal/child_process.js:346:11) Dec 11 15:13:35 volumio volumio[9252]: at emitOne (events.js:116:13) Dec 11 15:13:35 volumio volumio[9252]: at Socket.emit (events.js:211:7) Dec 11 15:13:35 volumio volumio[9252]: at Pipe._handle.close [as _onclose] (net.js:567:12) Dec 11 15:13:35 volumio volumio[9252]: errno: -16, Dec 11 15:13:35 volumio volumio[9252]: code: 'EBUSY', Dec 11 15:13:35 volumio volumio[9252]: syscall: 'rmdir', Dec 11 15:13:35 volumio volumio[9252]: path: '/mnt/NAS/FNOS' } Dec 11 15:13:35 volumio volumio[9252]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 11 15:13:36 volumio sudo[9538]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2020-12-11 15:12 Dec 11 15:13:36 volumio sudo[9538]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 15:13:36 volumio sudo[9538]: pam_unix(sudo:session): session closed for user root Dec 11 15:13:36 volumio volumio-remote-updater[4536]: [2020-12-11 15:13:36] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Dec 11 15:13:36 volumio volumio-remote-updater[4536]: [2020-12-11 15:13:36] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Dec 11 15:13:36 volumio systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE Dec 11 15:13:36 volumio systemd[1]: Unit volumio.service entered failed state. Dec 11 15:13:36 volumio systemd[1]: Starting dynamicswap service... Dec 11 15:13:36 volumio systemd[1]: Started dynamicswap service. Dec 11 15:13:36 volumio systemd[1]: volumio.service holdoff time over, scheduling restart. Dec 11 15:13:36 volumio systemd[1]: Starting dynamicswap service... Dec 11 15:13:36 volumio systemd[1]: Started dynamicswap service. Dec 11 15:13:36 volumio systemd[1]: Stopping Volumio Backend Module... Dec 11 15:13:36 volumio systemd[1]: Starting Volumio Backend Module... Dec 11 15:13:36 volumio systemd[1]: Started Volumio Backend Module. Dec 11 15:13:38 volumio volumio[9558]: info: ------------------------------------------- Dec 11 15:13:38 volumio volumio[9558]: info: ----- Volumio2 ---- Dec 11 15:13:38 volumio volumio[9558]: info: ------------------------------------------- Dec 11 15:13:38 volumio volumio[9558]: info: ----- System startup ---- Dec 11 15:13:38 volumio volumio[9558]: info: ------------------------------------------- Dec 11 15:13:39 volumio volumio[9558]: info: MYVOLUMIO Environment detected Dec 11 15:13:39 volumio volumio[9558]: info: Plugin folders cleanup Dec 11 15:13:39 volumio volumio[9558]: info: Scanning into folder /volumio/app/plugins/ Dec 11 15:13:39 volumio volumio[9558]: info: Scanning category audio_interface Dec 11 15:13:39 volumio volumio[9558]: info: Scanning category miscellanea Dec 11 15:13:39 volumio volumio[9558]: info: Scanning category music_service Dec 11 15:13:39 volumio volumio[9558]: info: Scanning category plugins.json Dec 11 15:13:39 volumio volumio[9558]: info: Scanning category system_controller Dec 11 15:13:39 volumio volumio[9558]: info: Scanning category user_interface Dec 11 15:13:39 volumio volumio[9558]: info: Scanning into folder /data/plugins/ Dec 11 15:13:39 volumio volumio[9558]: info: Scanning category accessory Dec 11 15:13:39 volumio volumio[9558]: info: Scanning category miscellanea Dec 11 15:13:39 volumio volumio[9558]: info: Scanning category music_service Dec 11 15:13:39 volumio volumio[9558]: info: Plugin folders cleanup completed Dec 11 15:13:39 volumio volumio[9558]: info: ------------------------------------------- Dec 11 15:13:39 volumio volumio[9558]: info: ----- Core plugins startup ---- Dec 11 15:13:39 volumio volumio[9558]: info: ------------------------------------------- Dec 11 15:13:39 volumio volumio[9558]: info: Loading plugins from folder /volumio/app/plugins/ Dec 11 15:13:39 volumio volumio[9558]: info: Adding plugin upnp to MyMusic Plugins Dec 11 15:13:39 volumio volumio[9558]: info: Adding plugin airplay_emulation to MyMusic Plugins Dec 11 15:13:39 volumio volumio[9558]: info: Adding plugin upnp_browser to MyMusic Plugins Dec 11 15:13:39 volumio volumio[9558]: info: Loading plugins from folder /data/plugins/ Dec 11 15:13:39 volumio volumio[9558]: info: Loading plugin "system"... Dec 11 15:13:39 volumio volumio[9558]: info: Loading plugin "appearance"... Dec 11 15:13:40 volumio volumio[9558]: info: Loading plugin "network"... Dec 11 15:13:40 volumio volumio[9558]: info: Refreshing Cached IP Addresses Dec 11 15:13:40 volumio sudo[9582]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 11 15:13:40 volumio sudo[9582]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 15:13:40 volumio sudo[9582]: pam_unix(sudo:session): session closed for user root Dec 11 15:13:41 volumio volumio[9558]: info: Loading plugin "services"... Dec 11 15:13:41 volumio volumio[9558]: info: Loading plugin "alsa_controller"... Dec 11 15:13:41 volumio sudo[9585]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 11 15:13:41 volumio sudo[9585]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 15:13:41 volumio sudo[9585]: pam_unix(sudo:session): session closed for user root Dec 11 15:13:41 volumio volumio[9558]: info: Loading plugin "wizard"... Dec 11 15:13:41 volumio volumio[9558]: info: Loading plugin "volumio_command_line_client"... Dec 11 15:13:41 volumio volumio[9558]: info: Loading plugin "upnp"... Dec 11 15:13:41 volumio volumio[9558]: info: [1607699621185] Starting Upmpd Daemon Dec 11 15:13:41 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 11 15:13:41 volumio volumio[9558]: info: Loading plugin "my_music"... Dec 11 15:13:41 volumio volumio[9558]: info: Loading plugin "mpd"... Dec 11 15:13:41 volumio volumio-remote-updater[4536]: [2020-12-11 15:13:41] [connect] Successful connection Dec 11 15:13:41 volumio volumio[9558]: info: Loading plugin "upnp_browser"... Dec 11 15:13:42 volumio volumio[9558]: info: Loading plugin "networkfs"... Dec 11 15:13:42 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 11 15:13:42 volumio volumio[9558]: info: Loading plugin "alarm-clock"... Dec 11 15:13:42 volumio sudo[9597]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto 192.168.1.193:mnt /mnt/NAS/FNOS Dec 11 15:13:42 volumio sudo[9597]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 15:13:42 volumio volumio[9558]: info: Loading plugin "airplay_emulation"... Dec 11 15:13:42 volumio volumio[9558]: info: Starting Shairport Sync Dec 11 15:13:42 volumio volumio[9558]: info: Loading plugin "last_100"... Dec 11 15:13:42 volumio volumio[9558]: info: Loading plugin "webradio"... Dec 11 15:13:42 volumio volumio[9558]: info: Loading plugin "i2s_dacs"... Dec 11 15:13:42 volumio volumio[9558]: info: I2S DAC not set, start Auto-detection Dec 11 15:13:42 volumio volumio[9558]: info: Loading plugin "volumiodiscovery"... Dec 11 15:13:42 volumio volumio[9558]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 11 15:13:42 volumio node[9558]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 11 15:13:42 volumio node[9558]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 11 15:13:42 volumio node[9558]: *** WARNING *** For more information see Dec 11 15:13:42 volumio node[9558]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 11 15:13:42 volumio node[9558]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 11 15:13:42 volumio node[9558]: *** WARNING *** For more information see Dec 11 15:13:42 volumio volumio[9558]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 11 15:13:42 volumio volumio[9558]: *** WARNING *** For more information see Dec 11 15:13:42 volumio volumio[9558]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 11 15:13:42 volumio volumio[9558]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 11 15:13:42 volumio volumio[9558]: *** WARNING *** For more information see Dec 11 15:13:42 volumio volumio[9558]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 11 15:13:42 volumio volumio[9558]: Discovery: StartAdv! undefined Dec 11 15:13:42 volumio volumio[9558]: Discovery: Started advertising... Volumio - undefined Dec 11 15:13:42 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 11 15:13:42 volumio volumio[9558]: info: Loading plugin "autostart"... Dec 11 15:13:42 volumio volumio[9558]: info: Applying required configuration parameters for plugin autostart Dec 11 15:13:42 volumio volumio[9558]: info: Loading plugin "outputs"... Dec 11 15:13:42 volumio volumio[9558]: info: Loading plugin "albumart"... Dec 11 15:13:42 volumio volumio[9558]: info: Plugin example_plugin is not enabled Dec 11 15:13:42 volumio volumio[9558]: info: Loading plugin "inputs"... Dec 11 15:13:42 volumio volumio[9558]: info: Loading plugin "updater_comm"... Dec 11 15:13:43 volumio volumio[9558]: info: Plugin mpdemulation is not enabled Dec 11 15:13:43 volumio volumio[9558]: info: Loading plugin "rest_api"... Dec 11 15:13:43 volumio volumio[9558]: info: Loading plugin "websocket"... Dec 11 15:13:43 volumio volumio[9558]: info: Loading plugin "ir_controller"... Dec 11 15:13:43 volumio volumio[9558]: Forking 3 albumart workers Dec 11 15:13:43 volumio sudo[9597]: pam_unix(sudo:session): session closed for user root Dec 11 15:13:43 volumio volumio[9558]: info: Applying required configuration parameters for plugin ir_controller Dec 11 15:13:43 volumio volumio[9558]: info: Loading plugin "RoonBridge"... Dec 11 15:13:43 volumio volumio[9558]: info: Applying required configuration parameters for plugin RoonBridge Dec 11 15:13:43 volumio volumio[9558]: info: ___________ START PLUGINS ___________ Dec 11 15:13:43 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 11 15:13:43 volumio volumio[9558]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 11 15:13:44 volumio volumio[9558]: info: [1607699624000] CoreMusicLibrary::Adding element Media Servers Dec 11 15:13:44 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 11 15:13:44 volumio volumio[9558]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 11 15:13:44 volumio volumio[9558]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 11 15:13:44 volumio volumio[9558]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 11 15:13:44 volumio volumio[9558]: info: [1607699624159] CoreMusicLibrary::Adding element Last_100 Dec 11 15:13:44 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 11 15:13:44 volumio volumio[9558]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 11 15:13:44 volumio volumio[9558]: info: [1607699624169] CoreMusicLibrary::Adding element Webradio Dec 11 15:13:44 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 11 15:13:44 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 11 15:13:44 volumio volumio[9558]: info: Loading i18n strings for locale zh Dec 11 15:13:44 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 11 15:13:44 volumio volumio[9558]: Starting albumart workers Dec 11 15:13:44 volumio volumio[9558]: info: ------------------------------------------- Dec 11 15:13:44 volumio volumio[9558]: info: ----- MyVolumio plugins startup ---- Dec 11 15:13:44 volumio volumio[9558]: info: ------------------------------------------- Dec 11 15:13:44 volumio volumio[9558]: info: [MyVolumio PluginManager] Fetching plans data.... Dec 11 15:13:44 volumio volumio[9558]: info: Loading i18n strings for locale zh Dec 11 15:13:44 volumio sudo[9643]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R a+rwX /etc/lirc/hardware.conf /etc/lirc/lircd.conf /etc/lirc/lircmd.conf /etc/lirc/lircrc Dec 11 15:13:44 volumio volumio[9558]: Updating browse sources language Dec 11 15:13:44 volumio volumio[9558]: Cannot find translation for sourceMedia Servers Dec 11 15:13:44 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 11 15:13:44 volumio sudo[9643]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 15:13:44 volumio sudo[9644]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service Dec 11 15:13:44 volumio sudo[9644]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 15:13:44 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 11 15:13:44 volumio sudo[9643]: pam_unix(sudo:session): session closed for user root Dec 11 15:13:44 volumio sudo[9644]: pam_unix(sudo:session): session closed for user root Dec 11 15:13:44 volumio volumio[9558]: info: CoreCommandRouter::initPlayerControls Dec 11 15:13:44 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 15:13:44 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Dec 11 15:13:44 volumio volumio[9558]: Starting albumart workers Dec 11 15:13:44 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 15:13:44 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 15:13:44 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 15:13:44 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 15:13:44 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 15:13:44 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 11 15:13:44 volumio volumio[9558]: info: BOOT COMPLETED Dec 11 15:13:44 volumio volumio[9558]: [Metrics] CommandRouter: 5s 722.48ms Dec 11 15:13:44 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 11 15:13:44 volumio kernel: aml_spdif_dai: aml_hw_iec958_init,runtime->rate=44100, same source mode(0) Dec 11 15:13:44 volumio kernel: aml_spdif_dai: set normal 512 fs /4 fs Dec 11 15:13:44 volumio kernel: aml_spdif_dai: iec958 mode PCM16 Dec 11 15:13:44 volumio kernel: aml_audio_hw: IEC958 16bit Dec 11 15:13:44 volumio kernel: hdmitx: audio: aout notify rate 44100 Dec 11 15:13:44 volumio kernel: hdmitx: audio: aout notify size 16 Dec 11 15:13:44 volumio kernel: hdmitx: audio: no update Dec 11 15:13:44 volumio kernel: aml_spdif_dai: aiu 958 playback enable Dec 11 15:13:44 volumio volumio[9558]: Starting albumart workers Dec 11 15:13:49 volumio kernel: aml_spdif_dai: aiu 958 playback disable Dec 11 15:13:49 volumio volumio[9558]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Dec 11 15:13:49 volumio volumio[9558]: info: CoreCommandRouter::Close All Modals sent Dec 11 15:13:49 volumio volumio[9558]: info: CoreCommandRouter::Close All Modals sent Dec 11 15:13:49 volumio volumio[9558]: Express server listening on port 3000 Dec 11 15:13:49 volumio volumio[9558]: [Metrics] WebUI: 11s 573.86ms Dec 11 15:13:49 volumio volumio[9558]: Volumio Calling Home Dec 11 15:13:49 volumio volumio[9558]: info: CoreStateMachine::resetVolumioState Dec 11 15:13:49 volumio volumio[9558]: info: CoreStateMachine::getcurrentVolume Dec 11 15:13:49 volumio volumio[9558]: info: CoreCommandRouter::volumioRetrievevolume Dec 11 15:13:49 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 11 15:13:49 volumio volumio[9558]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Dec 11 15:13:50 volumio volumio[9558]: Unable to parse: Dec 11 15:13:50 volumio volumio[9558]: Simple mixer control 'Audio i2s mute',0 Dec 11 15:13:50 volumio volumio[9558]: Capabilities: pswitch pswitch-joined Dec 11 15:13:50 volumio volumio[9558]: Playback channels: Mono Dec 11 15:13:50 volumio volumio[9558]: Mono: Playback [on] Dec 11 15:13:50 volumio volumio[9558]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Dec 11 15:13:50 volumio volumio[9558]: info: Setting Device type: Amlogic Dec 11 15:13:50 volumio volumio[9558]: error: Cannot start Roon Bridge Error: Command failed: /usr/bin/sudo /bin/systemctl start roonbridge.service Dec 11 15:13:50 volumio volumio[9558]: Failed to start roonbridge.service: Unit roonbridge.service failed to load: No such file or directory. Dec 11 15:13:50 volumio volumio[9558]: info: ir_controller: File permissions successfully set on /etc/lirc/*. Dec 11 15:13:50 volumio volumio[9558]: info: MPD running with PID5957 Dec 11 15:13:50 volumio volumio[9558]: ,establishing connection Dec 11 15:13:50 volumio sudo[9691]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Dec 11 15:13:50 volumio sudo[9691]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 15:13:50 volumio sudo[9691]: pam_unix(sudo:session): session closed for user root Dec 11 15:13:50 volumio volumio[9558]: Unable to parse: Dec 11 15:13:50 volumio volumio[9558]: Simple mixer control 'Audio i2s mute',0 Dec 11 15:13:50 volumio volumio[9558]: Capabilities: pswitch pswitch-joined Dec 11 15:13:50 volumio volumio[9558]: Playback channels: Mono Dec 11 15:13:50 volumio volumio[9558]: Mono: Playback [on] Dec 11 15:13:50 volumio volumio[9558]: info: VolumeController:: Volume=undefined Mute =false Dec 11 15:13:50 volumio volumio[9558]: info: CoreStateMachine::pushState Dec 11 15:13:50 volumio volumio[9558]: info: CorePlayQueue::getTrack 0 Dec 11 15:13:50 volumio volumio[9558]: info: CoreCommandRouter::volumioPushState Dec 11 15:13:50 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 15:13:50 volumio volumio[9558]: info: CoreStateMachine::updateTrackBlock Dec 11 15:13:50 volumio volumio[9558]: info: CorePlayQueue::getTrackBlock Dec 11 15:13:50 volumio volumio[9558]: info: CoreCommandRouter::volumioRetrievevolume Dec 11 15:13:50 volumio volumio[9558]: info: Cannot read I2C interface or I2C interface not presentError: Command failed: /usr/bin/sudo /usr/sbin/i2cdetect -y 1 Dec 11 15:13:50 volumio volumio[9558]: Error: Could not open file `/dev/i2c-1' or `/dev/i2c/1': No such file or directory Dec 11 15:13:50 volumio volumio[9558]: info: Reloading queue from file Dec 11 15:13:50 volumio volumio[9558]: error: updateQueue error: null Dec 11 15:13:50 volumio volumio[9558]: error: Failed LSINFO: Error: [50@0] {} No such directory Dec 11 15:13:50 volumio volumio[9558]: Unable to parse: Dec 11 15:13:50 volumio volumio[9558]: Simple mixer control 'Audio i2s mute',0 Dec 11 15:13:50 volumio volumio[9558]: Capabilities: pswitch pswitch-joined Dec 11 15:13:50 volumio volumio[9558]: Playback channels: Mono Dec 11 15:13:50 volumio volumio[9558]: Mono: Playback [on] Dec 11 15:13:50 volumio volumio[9558]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Dec 11 15:13:50 volumio volumio[9558]: info: CoreStateMachine::setRepeat null single undefined Dec 11 15:13:50 volumio volumio[9558]: info: CoreStateMachine::pushState Dec 11 15:13:50 volumio volumio[9558]: info: CorePlayQueue::getTrack 0 Dec 11 15:13:50 volumio volumio[9558]: info: CoreCommandRouter::volumioPushState Dec 11 15:13:50 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 15:13:50 volumio volumio[9558]: info: CoreStateMachine::setRandom null Dec 11 15:13:50 volumio volumio[9558]: info: CoreStateMachine::pushState Dec 11 15:13:50 volumio volumio[9558]: info: CorePlayQueue::getTrack 0 Dec 11 15:13:50 volumio volumio[9558]: info: CoreCommandRouter::volumioPushState Dec 11 15:13:50 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 15:13:50 volumio volumio[9558]: Unable to parse: Dec 11 15:13:50 volumio volumio[9558]: Simple mixer control 'Audio i2s mute',0 Dec 11 15:13:50 volumio volumio[9558]: Capabilities: pswitch pswitch-joined Dec 11 15:13:50 volumio volumio[9558]: Playback channels: Mono Dec 11 15:13:50 volumio volumio[9558]: Mono: Playback [on] Dec 11 15:13:50 volumio volumio[9558]: info: VolumeController:: Volume=undefined Mute =false Dec 11 15:13:50 volumio volumio[9558]: info: CoreStateMachine::pushState Dec 11 15:13:50 volumio volumio[9558]: info: CorePlayQueue::getTrack 0 Dec 11 15:13:50 volumio volumio[9558]: info: CoreCommandRouter::volumioPushState Dec 11 15:13:50 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 15:13:50 volumio volumio[9558]: info: Starting Shairport Sync Dec 11 15:13:50 volumio volumio[9558]: info: Starting Shairport Sync Dec 11 15:13:50 volumio sudo[9697]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 11 15:13:50 volumio sudo[9697]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 15:13:50 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 11 15:13:50 volumio sudo[9699]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 11 15:13:50 volumio sudo[9699]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 15:13:50 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Dec 11 15:13:50 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 11 15:13:50 volumio sudo[9697]: pam_unix(sudo:session): session closed for user root Dec 11 15:13:50 volumio sudo[9699]: pam_unix(sudo:session): session closed for user root Dec 11 15:13:50 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Dec 11 15:13:50 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 11 15:13:50 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Dec 11 15:13:50 volumio volumio[9558]: info: ir_controller: LIRC correctly updated. Dec 11 15:13:51 volumio volumio[9558]: info: Shairport-Sync Started Dec 11 15:13:51 volumio volumio[9558]: Error adding Membership: Error: addMembership EINVAL Dec 11 15:13:51 volumio volumio[9558]: info: Shairport-Sync Started Dec 11 15:13:51 volumio volumio[9558]: Discovery: adding 79bfc2c3-d29c-4839-9b52-f907310bef76 Dec 11 15:13:51 volumio volumio[9558]: info: mDNS: Found device Volumio Dec 11 15:13:51 volumio volumio[9558]: info: CoreCommandRouter::volumioGetState Dec 11 15:13:51 volumio volumio[9558]: info: CorePlayQueue::getTrack 0 Dec 11 15:13:51 volumio volumio[9558]: info: CoreCommandRouter::volumioGetState Dec 11 15:13:51 volumio volumio[9558]: info: CorePlayQueue::getTrack 0 Dec 11 15:13:51 volumio sudo[9716]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 11 15:13:51 volumio sudo[9716]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 15:13:51 volumio sudo[9716]: pam_unix(sudo:session): session closed for user root Dec 11 15:13:51 volumio sudo[9719]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 11 15:13:51 volumio sudo[9719]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 15:13:51 volumio sudo[9719]: pam_unix(sudo:session): session closed for user root Dec 11 15:13:51 volumio sudo[9722]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Dec 11 15:13:51 volumio sudo[9722]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 15:13:51 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Dec 11 15:13:51 volumio sudo[9722]: pam_unix(sudo:session): session closed for user root Dec 11 15:13:51 volumio volumio[9558]: info: Upmpdcli Daemon Started Dec 11 15:13:51 volumio avahi-daemon[4634]: Invalid response packet from host 192.168.1.115. Dec 11 15:13:51 volumio avahi-daemon[4634]: Invalid response packet from host 192.168.1.115. Dec 11 15:13:51 volumio sudo[9728]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 11 15:13:51 volumio sudo[9728]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 15:13:51 volumio sudo[9729]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 11 15:13:51 volumio sudo[9729]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 15:13:51 volumio sudo[9728]: pam_unix(sudo:session): session closed for user root Dec 11 15:13:51 volumio sudo[9729]: pam_unix(sudo:session): session closed for user root Dec 11 15:13:51 volumio sudo[9733]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop lirc.service Dec 11 15:13:51 volumio sudo[9733]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 15:13:51 volumio systemd[1]: Stopping LSB: Starts LIRC daemon.... Dec 11 15:13:52 volumio lircd-0.9.0-pre1[9476]: removed client Dec 11 15:13:52 volumio lirc[9736]: Stopping execution daemon: irexec:. Dec 11 15:13:52 volumio lircd-0.9.0-pre1[9476]: caught signal Dec 11 15:13:52 volumio lirc[9736]: Stopping remote control daemon(s): LIRC:. Dec 11 15:13:52 volumio systemd[1]: Stopped LSB: Starts LIRC daemon.. Dec 11 15:13:52 volumio sudo[9733]: pam_unix(sudo:session): session closed for user root Dec 11 15:13:52 volumio volumio[9558]: info: ir_controller: systemctl stop lirc.service succeeded. Dec 11 15:13:52 volumio volumio[9558]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 11 15:13:52 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 11 15:13:52 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 11 15:13:52 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 11 15:13:52 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 11 15:13:52 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 11 15:13:52 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 11 15:13:52 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 11 15:13:52 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 11 15:13:52 volumio volumio[9558]: info: CoreCommandRouter::volumioGetBrowseSources Dec 11 15:13:52 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 11 15:13:52 volumio volumio[9558]: info: CoreCommandRouter::volumioGetState Dec 11 15:13:52 volumio volumio[9558]: info: CorePlayQueue::getTrack 0 Dec 11 15:13:52 volumio volumio[9558]: info: CoreCommandRouter::volumioGetVisibleSources Dec 11 15:13:52 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 11 15:13:52 volumio avahi-daemon[4634]: Invalid response packet from host 192.168.1.115. Dec 11 15:13:52 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 11 15:13:52 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 11 15:13:52 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 11 15:13:52 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 11 15:13:52 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 11 15:13:52 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Dec 11 15:13:53 volumio sudo[9760]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start lirc.service Dec 11 15:13:53 volumio sudo[9760]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 15:13:53 volumio systemd[1]: Starting LSB: Starts LIRC daemon.... Dec 11 15:13:53 volumio lirc[9762]: Loading LIRC modules:. Dec 11 15:13:53 volumio lircd-0.9.0-pre1[9773]: lircd(default) ready, using /var/run/lirc/lircd Dec 11 15:13:53 volumio lirc[9762]: Starting remote control daemon(s) : LIRC :. Dec 11 15:13:53 volumio kernel: input: lircd as /devices/virtual/input/input6 Dec 11 15:13:53 volumio lirc[9762]: Starting execution daemon: irexec:. Dec 11 15:13:53 volumio lircd-0.9.0-pre1[9773]: accepted new client on /var/run/lirc/lircd Dec 11 15:13:53 volumio systemd[1]: Started LSB: Starts LIRC daemon.. Dec 11 15:13:53 volumio sudo[9760]: pam_unix(sudo:session): session closed for user root Dec 11 15:13:53 volumio volumio[9558]: info: ir_controller: systemctl start lirc.service succeeded. Dec 11 15:13:53 volumio volumio-remote-updater[4536]: [2020-12-11 15:13:53] [connect] Successful connection Dec 11 15:13:53 volumio volumio-remote-updater[4536]: [2020-12-11 15:13:53] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1607699633 101 Dec 11 15:13:54 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 11 15:13:56 volumio avahi-daemon[4634]: Invalid response packet from host 192.168.1.115. Dec 11 15:13:56 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 11 15:13:56 volumio avahi-daemon[4634]: Invalid response packet from host 192.168.1.115. Dec 11 15:13:56 volumio avahi-daemon[4634]: Invalid response packet from host 192.168.1.115. Dec 11 15:13:58 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 11 15:13:58 volumio volumio[9558]: info: CURURI: artists:// Dec 11 15:13:58 volumio volumio[9558]: info: CoreCommandRouter::volumioGetQueue Dec 11 15:13:58 volumio volumio[9558]: info: CoreStateMachine::getQueue Dec 11 15:13:58 volumio volumio[9558]: info: CorePlayQueue::getQueue Dec 11 15:13:58 volumio volumio[9558]: info: Listing playlists Dec 11 15:14:00 volumio volumio[9558]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=aml9xxxarmv7&variante=volumio&version=2.857&uuid=a487c6ed8a8db06c5ffb65c3b3fa3670" http://updates.volumio.org:7070/downloader-v1/track-device Dec 11 15:14:00 volumio volumio[9558]: % Total % Received % Xferd Average Speed Time Time Time Current Dec 11 15:14:00 volumio volumio[9558]: Dload Upload Total Spent Left Speed Dec 11 15:14:00 volumio volumio[9558]: [235B blob data] Dec 11 15:14:00 volumio volumio[9558]: retrying in 5 seconds, trial 0 Dec 11 15:14:00 volumio volumio[9558]: Volumio Calling Home Dec 11 15:14:00 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 11 15:14:00 volumio volumio[9558]: info: CURURI: artists://%E5%91%A8%E6%85%A7%E6%95%8F Dec 11 15:14:04 volumio volumio[9558]: info: AutoStart - getting queue Dec 11 15:14:04 volumio volumio[9558]: info: CoreCommandRouter::volumioGetQueue Dec 11 15:14:04 volumio volumio[9558]: info: CoreStateMachine::getQueue Dec 11 15:14:04 volumio volumio[9558]: info: CorePlayQueue::getQueue Dec 11 15:14:04 volumio volumio[9558]: info: AutoStart - start playing -> queue is not empty Dec 11 15:14:04 volumio volumio[9558]: info: CoreCommandRouter::volumioPlay Dec 11 15:14:04 volumio volumio[9558]: UNSET VOLATILE Dec 11 15:14:04 volumio volumio[9558]: info: CoreStateMachine::play index undefined Dec 11 15:14:04 volumio volumio[9558]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 15:14:04 volumio volumio[9558]: info: CorePlayQueue::getTrack 0 Dec 11 15:14:04 volumio volumio[9558]: info: CoreStateMachine::startPlaybackTimer Dec 11 15:14:04 volumio volumio[9558]: info: CorePlayQueue::getTrack 0 Dec 11 15:14:04 volumio volumio[9558]: info: [1607699644698] ControllerWebradio::clearAddPlayTrack Dec 11 15:14:04 volumio volumio[9558]: verbose: ControllerMpd::sendMpdCommand stop Dec 11 15:14:04 volumio volumio[9558]: verbose: ControllerMpd::sendMpdCommand clear Dec 11 15:14:04 volumio volumio[9558]: info: Dec 11 15:14:04 volumio volumio[9558]: ---------------------------- MPD announces system playlist update Dec 11 15:14:04 volumio volumio[9558]: info: Ignoring MPD Status Update Dec 11 15:14:04 volumio volumio[9558]: verbose: ControllerMpd::sendMpdCommand load "https://edge56.live-sm.absolutradio.de/absolut-relax/stream/mp3" Dec 11 15:14:04 volumio volumio[9558]: error: updateQueue error: null Dec 11 15:14:04 volumio volumio[9558]: info: ------------------------------ 22ms Dec 11 15:14:04 volumio volumio[9558]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 11 15:14:04 volumio volumio[9558]: info: CoreStateMachine::ClearQueue Dec 11 15:14:04 volumio volumio[9558]: info: CoreStateMachine::stop Dec 11 15:14:04 volumio volumio[9558]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 15:14:04 volumio volumio[9558]: UNSET VOLATILE Dec 11 15:14:04 volumio volumio[9558]: info: CorePlayQueue::clearPlayQueue Dec 11 15:14:04 volumio volumio[9558]: info: CorePlayQueue::saveQueue Dec 11 15:14:04 volumio volumio[9558]: info: CoreCommandRouter::volumioPushState Dec 11 15:14:04 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 15:14:04 volumio volumio[9558]: info: CoreCommandRouter::volumioPushQueue Dec 11 15:14:04 volumio volumio[9558]: info: CoreStateMachine::addQueueItems Dec 11 15:14:04 volumio volumio[9558]: info: CorePlayQueue::addQueueItems Dec 11 15:14:04 volumio volumio[9558]: info: Adding Item to queue: music-library/NAS/FNOS/user/music/周慧敏/最爱/周慧敏 - 最爱.flac Dec 11 15:14:04 volumio volumio[9558]: info: Exploding uri music-library/NAS/FNOS/user/music/周慧敏/最爱/周慧敏 - 最爱.flac in service mpd Dec 11 15:14:10 volumio volumio[9558]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=aml9xxxarmv7&variante=volumio&version=2.857&uuid=a487c6ed8a8db06c5ffb65c3b3fa3670" http://updates.volumio.org:7070/downloader-v1/track-device Dec 11 15:14:10 volumio volumio[9558]: % Total % Received % Xferd Average Speed Time Time Time Current Dec 11 15:14:10 volumio volumio[9558]: Dload Upload Total Spent Left Speed Dec 11 15:14:10 volumio volumio[9558]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused Dec 11 15:14:10 volumio volumio[9558]: retrying in 5 seconds, trial 1 Dec 11 15:14:10 volumio volumio[9558]: Volumio Calling Home Dec 11 15:14:12 volumio volumio[9558]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 11 15:14:12 volumio volumio[9558]: info: CoreStateMachine::ClearQueue Dec 11 15:14:12 volumio volumio[9558]: info: CoreStateMachine::stop Dec 11 15:14:12 volumio volumio[9558]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 15:14:12 volumio volumio[9558]: UNSET VOLATILE Dec 11 15:14:12 volumio volumio[9558]: info: CorePlayQueue::clearPlayQueue Dec 11 15:14:12 volumio volumio[9558]: info: CorePlayQueue::saveQueue Dec 11 15:14:12 volumio volumio[9558]: info: CoreCommandRouter::volumioPushState Dec 11 15:14:12 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 15:14:12 volumio volumio[9558]: info: CoreCommandRouter::volumioPushQueue Dec 11 15:14:12 volumio volumio[9558]: info: CoreStateMachine::addQueueItems Dec 11 15:14:12 volumio volumio[9558]: info: CorePlayQueue::addQueueItems Dec 11 15:14:12 volumio volumio[9558]: info: Adding Item to queue: music-library/NAS/FNOS/user/music/周慧敏/最爱/周慧敏 - 最爱.flac Dec 11 15:14:12 volumio volumio[9558]: info: Exploding uri music-library/NAS/FNOS/user/music/周慧敏/最爱/周慧敏 - 最爱.flac in service mpd Dec 11 15:14:14 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 11 15:14:14 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 11 15:14:14 volumio volumio[9558]: verbose: ControllerMpd::sendMpdCommand add "https://edge56.live-sm.absolutradio.de/absolut-relax/stream/mp3" Dec 11 15:14:14 volumio volumio[9558]: info: ALBUMART /albumart?cacheid=642&web=%E5%91%A8%E6%85%A7%E6%95%8F/%E6%9C%80%E7%88%B1/extralarge&path=%2Fmnt%2FNAS%2FFNOS%2Fuser%2Fmusic%2F%E5%91%A8%E6%85%A7%E6%95%8F%2F%E6%9C%80%E7%88%B1%2F%E5%91%A8%E6%85%A7%E6%95%8F%20-%20%E6%9C%80%E7%88%B1.flac&metadata=false Dec 11 15:14:14 volumio volumio[9558]: info: URI /mnt/NAS/FNOS/user/music/周慧敏/最爱/周慧敏 - 最爱.flac Dec 11 15:14:14 volumio volumio[9558]: info: ALBUMART /albumart?cacheid=642&web=%E5%91%A8%E6%85%A7%E6%95%8F/%E6%9C%80%E7%88%B1/extralarge&path=%2Fmnt%2FNAS%2FFNOS%2Fuser%2Fmusic%2F%E5%91%A8%E6%85%A7%E6%95%8F%2F%E6%9C%80%E7%88%B1%2F%E5%91%A8%E6%85%A7%E6%95%8F%20-%20%E6%9C%80%E7%88%B1.flac&metadata=false Dec 11 15:14:14 volumio volumio[9558]: info: URI /mnt/NAS/FNOS/user/music/周慧敏/最爱/周慧敏 - 最爱.flac Dec 11 15:14:14 volumio volumio[9558]: info: Dec 11 15:14:14 volumio volumio[9558]: ---------------------------- MPD announces system playlist update Dec 11 15:14:14 volumio volumio[9558]: info: Ignoring MPD Status Update Dec 11 15:14:14 volumio volumio[9558]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 11 15:14:14 volumio volumio[9558]: verbose: ControllerMpd::sendMpdCommand play Dec 11 15:14:14 volumio volumio[9558]: info: CorePlayQueue::saveQueue Dec 11 15:14:14 volumio volumio[9558]: info: CoreCommandRouter::volumioPushQueue Dec 11 15:14:14 volumio volumio[9558]: info: CorePlayQueue::saveQueue Dec 11 15:14:14 volumio volumio[9558]: info: CoreCommandRouter::volumioPushQueue Dec 11 15:14:14 volumio volumio[9558]: info: CoreStateMachine::updateTrackBlock Dec 11 15:14:14 volumio volumio[9558]: info: CorePlayQueue::getTrackBlock Dec 11 15:14:14 volumio volumio[9558]: info: CoreStateMachine::updateTrackBlock Dec 11 15:14:14 volumio volumio[9558]: info: CorePlayQueue::getTrackBlock Dec 11 15:14:14 volumio volumio[9558]: info: CoreCommandRouter::volumioPlay Dec 11 15:14:14 volumio volumio[9558]: UNSET VOLATILE Dec 11 15:14:14 volumio volumio[9558]: info: CoreStateMachine::play index 0 Dec 11 15:14:14 volumio volumio[9558]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 15:14:14 volumio volumio[9558]: info: CoreCommandRouter::volumioPlay Dec 11 15:14:14 volumio volumio[9558]: UNSET VOLATILE Dec 11 15:14:14 volumio volumio[9558]: info: CoreStateMachine::play index 0 Dec 11 15:14:14 volumio volumio[9558]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 15:14:14 volumio volumio[9558]: info: CoreStateMachine::stop Dec 11 15:14:14 volumio volumio[9558]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 15:14:14 volumio volumio[9558]: UNSET VOLATILE Dec 11 15:14:14 volumio volumio[9558]: info: CoreStateMachine::stop Dec 11 15:14:14 volumio volumio[9558]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 15:14:14 volumio volumio[9558]: UNSET VOLATILE Dec 11 15:14:14 volumio volumio[9558]: info: CoreStateMachine::play index undefined Dec 11 15:14:14 volumio volumio[9558]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 15:14:14 volumio volumio[9558]: info: CoreStateMachine::play index undefined Dec 11 15:14:14 volumio volumio[9558]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 15:14:14 volumio volumio[9558]: info: CorePlayQueue::getTrack 0 Dec 11 15:14:14 volumio volumio[9558]: info: CoreStateMachine::startPlaybackTimer Dec 11 15:14:14 volumio volumio[9558]: info: CorePlayQueue::getTrack 0 Dec 11 15:14:14 volumio volumio[9558]: verbose: ControllerMpd::clearAddPlayTracks NAS/FNOS/user/music/周慧敏/最爱/周慧敏 - 最爱.flac Dec 11 15:14:14 volumio volumio[9558]: verbose: ControllerMpd::sendMpdCommand stop Dec 11 15:14:14 volumio volumio[9558]: info: CorePlayQueue::getTrack 0 Dec 11 15:14:14 volumio volumio[9558]: info: CoreStateMachine::startPlaybackTimer Dec 11 15:14:14 volumio volumio[9558]: info: CorePlayQueue::getTrack 0 Dec 11 15:14:14 volumio volumio[9558]: verbose: ControllerMpd::clearAddPlayTracks NAS/FNOS/user/music/周慧敏/最爱/周慧敏 - 最爱.flac Dec 11 15:14:14 volumio volumio[9558]: verbose: ControllerMpd::sendMpdCommand stop Dec 11 15:14:14 volumio volumio[9558]: info: Dec 11 15:14:14 volumio volumio[9558]: ---------------------------- MPD announces state update: player Dec 11 15:14:14 volumio volumio[9558]: info: ------------------------------ 63ms Dec 11 15:14:14 volumio volumio[9558]: info: ControllerMpd::getState Dec 11 15:14:14 volumio volumio[9558]: verbose: ControllerMpd::sendMpdCommand status Dec 11 15:14:14 volumio volumio[9558]: verbose: ControllerMpd::sendMpdCommand clear Dec 11 15:14:14 volumio volumio[9558]: verbose: ControllerMpd::sendMpdCommand clear Dec 11 15:14:14 volumio volumio[9558]: info: Dec 11 15:14:14 volumio volumio[9558]: ---------------------------- MPD announces system playlist update Dec 11 15:14:14 volumio volumio[9558]: info: Ignoring MPD Status Update Dec 11 15:14:14 volumio volumio[9558]: info: Dec 11 15:14:14 volumio volumio[9558]: ---------------------------- MPD announces system playlist update Dec 11 15:14:14 volumio volumio[9558]: info: Ignoring MPD Status Update Dec 11 15:14:14 volumio volumio[9558]: verbose: ControllerMpd::parseState Dec 11 15:14:14 volumio volumio[9558]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 11 15:14:14 volumio volumio[9558]: verbose: ControllerMpd::sendMpdCommand add "NAS/FNOS/user/music/周慧敏/最爱/周慧敏 - 最爱.flac" Dec 11 15:14:14 volumio volumio[9558]: verbose: ControllerMpd::sendMpdCommand add "NAS/FNOS/user/music/周慧敏/最爱/周慧敏 - 最爱.flac" Dec 11 15:14:14 volumio volumio[9558]: error: updateQueue error: null Dec 11 15:14:14 volumio volumio[9558]: error: updateQueue error: null Dec 11 15:14:14 volumio volumio[9558]: info: Dec 11 15:14:14 volumio volumio[9558]: ---------------------------- MPD announces system playlist update Dec 11 15:14:14 volumio volumio[9558]: info: Ignoring MPD Status Update Dec 11 15:14:14 volumio volumio[9558]: info: Dec 11 15:14:14 volumio volumio[9558]: ---------------------------- MPD announces system playlist update Dec 11 15:14:14 volumio volumio[9558]: info: Ignoring MPD Status Update Dec 11 15:14:14 volumio volumio[9558]: info: ------------------------------ 21ms Dec 11 15:14:14 volumio volumio[9558]: info: ------------------------------ 20ms Dec 11 15:14:14 volumio volumio[9558]: verbose: ControllerMpd::parseTrackInfo Dec 11 15:14:14 volumio volumio[9558]: verbose: ControllerMpd::sendMpdCommand play Dec 11 15:14:14 volumio volumio[9558]: verbose: ControllerMpd::sendMpdCommand play Dec 11 15:14:14 volumio volumio[9558]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Dec 11 15:14:14 volumio volumio[9558]: info: ------------------------------ 48ms Dec 11 15:14:14 volumio volumio[9558]: info: ------------------------------ 17ms Dec 11 15:14:14 volumio volumio[9558]: info: ------------------------------ 15ms Dec 11 15:14:15 volumio volumio[9558]: info: Dec 11 15:14:15 volumio volumio[9558]: ---------------------------- MPD announces state update: player Dec 11 15:14:15 volumio volumio[9558]: info: ControllerMpd::getState Dec 11 15:14:15 volumio volumio[9558]: verbose: ControllerMpd::sendMpdCommand status Dec 11 15:14:15 volumio volumio[9558]: info: Dec 11 15:14:15 volumio volumio[9558]: ---------------------------- MPD announces state update: player Dec 11 15:14:15 volumio volumio[9558]: verbose: ControllerMpd::sendMpdCommand clearerror Dec 11 15:14:15 volumio volumio[9558]: info: ControllerMpd::getState Dec 11 15:14:15 volumio volumio[9558]: verbose: ControllerMpd::sendMpdCommand status Dec 11 15:14:15 volumio volumio[9558]: verbose: ControllerMpd::parseState Dec 11 15:14:15 volumio volumio[9558]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 11 15:14:15 volumio volumio[9558]: verbose: ControllerMpd::parseState Dec 11 15:14:15 volumio volumio[9558]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 11 15:14:15 volumio volumio[9558]: verbose: ControllerMpd::parseTrackInfo Dec 11 15:14:15 volumio volumio[9558]: info: ControllerMpd::pushState Dec 11 15:14:15 volumio volumio[9558]: info: CoreCommandRouter::servicePushState Dec 11 15:14:15 volumio volumio[9558]: info: CorePlayQueue::getTrack 0 Dec 11 15:14:15 volumio volumio[9558]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"最爱","artist":"周慧敏","album":"最爱","uri":"NAS/FNOS/user/music/周慧敏/最爱/周慧敏 - 最爱.flac","trackType":"flac"} Dec 11 15:14:15 volumio volumio[9558]: verbose: CURRENT POSITION 0 Dec 11 15:14:15 volumio volumio[9558]: info: CoreStateMachine::syncState stateService pause Dec 11 15:14:15 volumio volumio[9558]: info: CoreStateMachine::syncState currentStatus stop Dec 11 15:14:15 volumio volumio[9558]: info: CoreStateMachine::pushState Dec 11 15:14:15 volumio volumio[9558]: info: CorePlayQueue::getTrack 0 Dec 11 15:14:15 volumio volumio[9558]: info: CoreCommandRouter::volumioPushState Dec 11 15:14:15 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 15:14:15 volumio volumio[9558]: info: ------------------------------ 50ms Dec 11 15:14:15 volumio volumio[9558]: verbose: ControllerMpd::parseTrackInfo Dec 11 15:14:15 volumio volumio[9558]: info: ControllerMpd::pushState Dec 11 15:14:15 volumio volumio[9558]: info: CoreCommandRouter::servicePushState Dec 11 15:14:15 volumio volumio[9558]: info: CorePlayQueue::getTrack 0 Dec 11 15:14:15 volumio volumio[9558]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"最爱","artist":"周慧敏","album":"最爱","uri":"NAS/FNOS/user/music/周慧敏/最爱/周慧敏 - 最爱.flac","trackType":"flac"} Dec 11 15:14:15 volumio volumio[9558]: verbose: CURRENT POSITION 0 Dec 11 15:14:15 volumio volumio[9558]: info: CoreStateMachine::syncState stateService pause Dec 11 15:14:15 volumio volumio[9558]: info: CoreStateMachine::syncState currentStatus stop Dec 11 15:14:15 volumio volumio[9558]: info: CoreStateMachine::pushState Dec 11 15:14:15 volumio volumio[9558]: info: CorePlayQueue::getTrack 0 Dec 11 15:14:15 volumio volumio[9558]: info: CoreCommandRouter::volumioPushState Dec 11 15:14:15 volumio volumio[9558]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 15:14:15 volumio volumio[9558]: info: ------------------------------ 66ms Dec 11 15:14:19 volumio volumio[9558]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 11 15:14:19 volumio volumio[9558]: { Error: certificate is not yet valid Dec 11 15:14:19 volumio volumio[9558]: at TLSSocket. (_tls_wrap.js:1105:38) Dec 11 15:14:19 volumio volumio[9558]: at emitNone (events.js:106:13) Dec 11 15:14:19 volumio volumio[9558]: at TLSSocket.emit (events.js:208:7) Dec 11 15:14:19 volumio volumio[9558]: at TLSSocket._finishInit (_tls_wrap.js:639:8) Dec 11 15:14:19 volumio volumio[9558]: at TLSWrap.ssl.onhandshakedone (_tls_wrap.js:469:38) code: 'CERT_NOT_YET_VALID' } Dec 11 15:14:19 volumio volumio[9558]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 11 15:14:19 volumio sudo[9854]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2020-12-11 15:13 Dec 11 15:14:19 volumio sudo[9854]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 8 (jessie)" NAME="Debian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=debian HOME_URL="http://www.debian.org/" SUPPORT_URL="http://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="168ba7444df98cd868db72f24faec0b6346489cc" VOLUMIO_FE_VERSION="847a48ecf32d35cc502a0053d585d1a69236e391" VOLUMIO_BE_VERSION="99dfb342fe07851f1e26bd1d8046d0234eda91dd" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 11 15:53:56 CET 2020" VOLUMIO_VERSION="2.857" VOLUMIO_HARDWARE="aml9xxxarmv7" VOLUMIO_HASH="5e595833ee6075a27fef1ba35f928abb"