-- Logs begin at Tue 2024-04-23 15:12:12 UTC, end at Tue 2024-04-23 16:20:42 UTC. --
Apr 23 16:19:05 onkymio volumio[648]: info:
Apr 23 16:19:05 onkymio volumio[648]: ---------------------------- MPD announces system playlist update
Apr 23 16:19:05 onkymio volumio[648]: info: Ignoring MPD Status Update
Apr 23 16:19:05 onkymio volumio[648]: info:
Apr 23 16:19:05 onkymio volumio[648]: ---------------------------- MPD announces state update: player
Apr 23 16:19:05 onkymio volumio[648]: info: ControllerMpd::getState
Apr 23 16:19:05 onkymio volumio[648]: verbose: ControllerMpd::sendMpdCommand status
Apr 23 16:19:05 onkymio volumio[648]: error: updateQueue error: null
Apr 23 16:19:05 onkymio volumio[648]: info: ------------------------------ 0ms
Apr 23 16:19:05 onkymio volumio[648]: info: sendMpdCommand status took 0 milliseconds
Apr 23 16:19:05 onkymio volumio[648]: verbose: ControllerMpd::parseState
Apr 23 16:19:05 onkymio volumio[648]: info: ControllerMpd::pushState
Apr 23 16:19:05 onkymio volumio[648]: info: CoreCommandRouter::servicePushState
Apr 23 16:19:05 onkymio volumio[648]: info: CoreStateMachine::pushState
Apr 23 16:19:05 onkymio volumio[648]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 23 16:19:05 onkymio volumio[648]: info: CoreCommandRouter::volumioPushState
Apr 23 16:19:05 onkymio volumio[648]: info: MRS: Pushing multiroomSync output update for this device
Apr 23 16:19:05 onkymio volumio[648]: info: MRS: Pushing multiroomSync output
Apr 23 16:19:05 onkymio volumio[648]: info: CorePlayQueue::getTrack 14
Apr 23 16:19:05 onkymio volumio[648]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Apr 23 16:19:05 onkymio volumio[648]: verbose: CURRENT POSITION 14
Apr 23 16:19:05 onkymio volumio[648]: info: CoreStateMachine::syncState   stateService stop
Apr 23 16:19:05 onkymio volumio[648]: info: CoreStateMachine::syncState   currentStatus play
Apr 23 16:19:05 onkymio volumio[648]: info: CoreCommandRouter::volumioPushState
Apr 23 16:19:05 onkymio volumio[648]: info: MRS: Pushing multiroomSync output update for this device
Apr 23 16:19:05 onkymio volumio[648]: info: MRS: Pushing multiroomSync output
Apr 23 16:19:05 onkymio volumio[648]: info: CoreStateMachine::stPlaybackTimer
Apr 23 16:19:05 onkymio volumio[648]: info: ------------------------------ 4ms
Apr 23 16:19:05 onkymio volumio[648]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 23 16:19:05 onkymio volumio[648]: info: CURURI: playlists
Apr 23 16:19:05 onkymio volumio[648]: info: Listing playlists
Apr 23 16:19:05 onkymio volumio[648]: info: Preload queue cleared
Apr 23 16:19:08 onkymio volumio[648]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 23 16:19:08 onkymio volumio[648]: info: CURURI: playlists/justanotherPL
Apr 23 16:19:08 onkymio volumio[648]: info: Preload queue cleared
Apr 23 16:19:08 onkymio volumio[648]: info: Preloading song: qobuz://song/91838024
Apr 23 16:19:08 onkymio volumio[648]: info: Preloading song: NAS/NAS-MUSIC/1975  Murray Head - Say It Ain t So  2017   24-96/01. Say It Ain't So.flac
Apr 23 16:19:08 onkymio volumio[648]: info: Preloading song: NAS/NAS-MUSIC/1976 Genesis - A Trick Of The Tail-DSD/05 - Robbery, Assault And Battery.dsf
Apr 23 16:19:08 onkymio volumio[648]: info: Preloading song: NAS/NAS-MUSIC/1976 Genesis - A Trick Of The Tail-DSD/06 - Ripples.dsf
Apr 23 16:19:08 onkymio volumio[648]: info: Preloading song: cue://NAS/NAS-MUSIC/1977 - Fleetwood Mac - Rumours (1988, Warner-Pioneer, Japan, 20P2-2036)/Fleetwood Mac - Rumours.cue@4
Apr 23 16:19:08 onkymio volumio[648]: info: Preloading song: NAS/NAS-MUSIC/1980  Eric Clapton - Just One Night  2014   24-192/04 - Wonderful Tonight.flac
Apr 23 16:19:08 onkymio volumio[648]: info: Preloading song: NAS/NAS-MUSIC/1984  Bruce Springsteen - Born In The U S A   2014   24-96/10. Glory Days.flac
Apr 23 16:19:08 onkymio volumio[648]: info: Preloading song: NAS/NAS-MUSIC/Ben Harper - Fight For Your Mind (2016) [24bit Hi-Res]/06. Burn One Down.flac
Apr 23 16:19:08 onkymio volumio[648]: info: Preloading song: NAS/NAS-MUSIC/Bill_Withers_-_Bill_Withers__Greatest_Hits__1981___SACD___2016_MFSL_Remaster_ISO/03 - BILL WITHERS - Ain't No Sunshine.dsf
Apr 23 16:19:08 onkymio volumio[648]: info: Preloading song: NAS/NAS-MUSIC/Bill_Withers_-_Bill_Withers__Greatest_Hits__1981___SACD___2016_MFSL_Remaster_ISO/04 - BILL WITHERS - Lovely Day.dsf
Apr 23 16:19:08 onkymio volumio[648]: info: Preloading song: NAS/NAS-MUSIC/Bill_Withers_-_Bill_Withers__Greatest_Hits__1981___SACD___2016_MFSL_Remaster_ISO/01 - BILL WITHERS - Just The Two Of Us.dsf
Apr 23 16:19:08 onkymio volumio[648]: info: Preloading song: NAS/NAS-MUSIC/Billy Paul - 360 Degrees of Billy Paul/04 Billy Paul - Me and Mrs. Jones.flac
Apr 23 16:19:08 onkymio volumio[648]: info: Exploding uri qobuz://song/91838024 in service qobuz
Apr 23 16:19:08 onkymio volumio[648]: info: Exploding uri NAS/NAS-MUSIC/1975  Murray Head - Say It Ain t So  2017   24-96/01. Say It Ain't So.flac in service mpd
Apr 23 16:19:08 onkymio volumio[648]: error: scanFolder - failure to stat '/mnt/NAS/NAS-MUSIC/1975  Murray Head - Say It Ain t So  2017   24-96/01. Say It Ain't So.flac'
Apr 23 16:19:08 onkymio volumio[648]: info: Exploding uri NAS/NAS-MUSIC/1976 Genesis - A Trick Of The Tail-DSD/05 - Robbery, Assault And Battery.dsf in service mpd
Apr 23 16:19:08 onkymio volumio[648]: error: scanFolder - failure to stat '/mnt/NAS/NAS-MUSIC/1976 Genesis - A Trick Of The Tail-DSD/05 - Robbery, Assault And Battery.dsf'
Apr 23 16:19:08 onkymio volumio[648]: info: Exploding uri NAS/NAS-MUSIC/1976 Genesis - A Trick Of The Tail-DSD/06 - Ripples.dsf in service mpd
Apr 23 16:19:08 onkymio volumio[648]: error: scanFolder - failure to stat '/mnt/NAS/NAS-MUSIC/1976 Genesis - A Trick Of The Tail-DSD/06 - Ripples.dsf'
Apr 23 16:19:08 onkymio volumio[648]: info: Exploding uri cue://NAS/NAS-MUSIC/1977 - Fleetwood Mac - Rumours (1988, Warner-Pioneer, Japan, 20P2-2036)/Fleetwood Mac - Rumours.cue@4 in service mpd
Apr 23 16:19:08 onkymio volumio[648]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 23 16:19:08 onkymio volumio[648]: Error: file /mnt/NAS/NAS-MUSIC/1977 - Fleetwood Mac - Rumours (1988, Warner-Pioneer, Japan, 20P2-2036)/Fleetwood Mac - Rumours.cue does not exist
Apr 23 16:19:08 onkymio volumio[648]:     at Object.parse (/volumio/node_modules/cue-parser/lib/cue.js:37:15)
Apr 23 16:19:08 onkymio volumio[648]:     at ControllerMpd.explodeUri (/volumio/app/plugins/music_service/mpd/index.js:1924:27)
Apr 23 16:19:08 onkymio volumio[648]:     at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1359:16)
Apr 23 16:19:08 onkymio volumio[648]:     at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24)
Apr 23 16:19:08 onkymio volumio[648]:     at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19)
Apr 23 16:19:08 onkymio volumio[648]:     at Timeout._onTimeout (/volumio/app/playqueue.js:146:100)
Apr 23 16:19:08 onkymio volumio[648]:     at listOnTimeout (internal/timers.js:557:17)
Apr 23 16:19:08 onkymio volumio[648]:     at processTimers (internal/timers.js:500:7)
Apr 23 16:19:08 onkymio volumio[648]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 23 16:19:08 onkymio sudo[4930]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-23 16:18
Apr 23 16:19:08 onkymio sudo[4930]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:08 onkymio sudo[4930]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:08 onkymio volumio-remote-updater[525]: [2024-04-23 16:19:08] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Apr 23 16:19:08 onkymio volumio-remote-updater[525]: [2024-04-23 16:19:08] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Apr 23 16:19:08 onkymio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Apr 23 16:19:08 onkymio systemd[1]: volumio.service: Failed with result 'exit-code'.
Apr 23 16:19:08 onkymio systemd[1]: Started dynamicswap service.
Apr 23 16:19:08 onkymio systemd[1]: dynamicswap.service: Succeeded.
Apr 23 16:19:08 onkymio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
Apr 23 16:19:08 onkymio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1.
Apr 23 16:19:08 onkymio systemd[1]: Stopped Volumio Backend Module.
Apr 23 16:19:08 onkymio systemd[1]: Started Volumio Backend Module.
Apr 23 16:19:08 onkymio systemd[1]: Started dynamicswap service.
Apr 23 16:19:08 onkymio systemd[1]: dynamicswap.service: Succeeded.
Apr 23 16:19:09 onkymio volumio[4944]: info: -------------------------------------------
Apr 23 16:19:09 onkymio volumio[4944]: info: -----            Volumio3              ----
Apr 23 16:19:09 onkymio volumio[4944]: info: -------------------------------------------
Apr 23 16:19:09 onkymio volumio[4944]: info: -----          System startup          ----
Apr 23 16:19:09 onkymio volumio[4944]: info: -------------------------------------------
Apr 23 16:19:09 onkymio volumio[4944]: info: MYVOLUMIO Environment detected
Apr 23 16:19:09 onkymio volumio[4944]: info: Plugin folders cleanup
Apr 23 16:19:09 onkymio volumio[4944]: info: Scanning into folder /volumio/app/plugins/
Apr 23 16:19:09 onkymio volumio[4944]: info: Scanning category audio_interface
Apr 23 16:19:09 onkymio volumio[4944]: info: Scanning category miscellanea
Apr 23 16:19:09 onkymio volumio[4944]: info: Scanning category music_service
Apr 23 16:19:09 onkymio volumio[4944]: info: Scanning category plugins.json
Apr 23 16:19:09 onkymio volumio[4944]: info: Scanning category system_controller
Apr 23 16:19:09 onkymio volumio[4944]: info: Scanning category user_interface
Apr 23 16:19:09 onkymio volumio[4944]: info: Scanning into folder /data/plugins/
Apr 23 16:19:09 onkymio volumio[4944]: info: Scanning category audio_interface
Apr 23 16:19:09 onkymio volumio[4944]: info: Scanning category music_service
Apr 23 16:19:09 onkymio volumio[4944]: info: Scanning category user_interface
Apr 23 16:19:09 onkymio volumio[4944]: info: Plugin folders cleanup completed
Apr 23 16:19:09 onkymio volumio[4944]: info: -------------------------------------------
Apr 23 16:19:09 onkymio volumio[4944]: info: -----      Core plugins startup        ----
Apr 23 16:19:09 onkymio volumio[4944]: info: -------------------------------------------
Apr 23 16:19:09 onkymio volumio[4944]: info: Loading plugins from folder /volumio/app/plugins/
Apr 23 16:19:09 onkymio volumio[4944]: info: Adding plugin upnp to MyMusic Plugins
Apr 23 16:19:09 onkymio volumio[4944]: info: Adding plugin airplay_emulation to MyMusic Plugins
Apr 23 16:19:09 onkymio volumio[4944]: info: Adding plugin upnp_browser to MyMusic Plugins
Apr 23 16:19:09 onkymio volumio[4944]: info: Loading plugins from folder /data/plugins/
Apr 23 16:19:09 onkymio volumio[4944]: info: Loading plugin "system"...
Apr 23 16:19:09 onkymio volumio[4944]: info: Loading plugin "appearance"...
Apr 23 16:19:09 onkymio volumio[4944]: info: Loading plugin "network"...
Apr 23 16:19:09 onkymio volumio[4944]: info: Refreshing Cached IP Addresses
Apr 23 16:19:09 onkymio sudo[4971]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 23 16:19:09 onkymio sudo[4971]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:09 onkymio sudo[4971]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:09 onkymio sudo[4973]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 23 16:19:09 onkymio sudo[4973]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:09 onkymio volumio[4944]: info: Loading plugin "services"...
Apr 23 16:19:09 onkymio volumio[4944]: info: Loading plugin "alsa_controller"...
Apr 23 16:19:09 onkymio sudo[4973]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:09 onkymio sudo[4976]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Apr 23 16:19:09 onkymio sudo[4976]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:09 onkymio sudo[4976]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:09 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 23 16:19:09 onkymio volumio[4944]: info: Loading plugin "wizard"...
Apr 23 16:19:09 onkymio volumio[4944]: info: Loading plugin "networkfs"...
Apr 23 16:19:09 onkymio volumio[4944]: info: Cannot mount NAS NAS at system boot, trial number 1 ,retrying in 5 seconds
Apr 23 16:19:09 onkymio volumio[4944]: info: Starting Udev Watcher for removable devices
Apr 23 16:19:09 onkymio volumio[4944]: info: Ignoring mount for partition: boot
Apr 23 16:19:09 onkymio volumio[4944]: info: Ignoring mount for partition: volumio
Apr 23 16:19:09 onkymio volumio[4944]: info: Ignoring mount for partition: volumio_data
Apr 23 16:19:09 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 23 16:19:09 onkymio volumio[4944]: info: Loading plugin "volumio_command_line_client"...
Apr 23 16:19:09 onkymio volumio[4944]: info: Loading plugin "upnp"...
Apr 23 16:19:09 onkymio volumio[4944]: info: [1713889149413] Starting Upmpd Daemon
Apr 23 16:19:09 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 23 16:19:09 onkymio volumio[4944]: info: Loading plugin "my_music"...
Apr 23 16:19:09 onkymio volumio[4944]: info: Loading plugin "mpd"...
Apr 23 16:19:09 onkymio volumio[4944]: info: Loading plugin "upnp_browser"...
Apr 23 16:19:09 onkymio volumio[4944]: info: Loading plugin "alarm-clock"...
Apr 23 16:19:09 onkymio volumio[4944]: info: Loading plugin "airplay_emulation"...
Apr 23 16:19:09 onkymio volumio[4944]: info: Starting Shairport Sync
Apr 23 16:19:09 onkymio volumio[4944]: info: Loading plugin "last_100"...
Apr 23 16:19:09 onkymio volumio[4944]: info: Loading plugin "webradio"...
Apr 23 16:19:09 onkymio volumio[4944]: info: Loading plugin "i2s_dacs"...
Apr 23 16:19:09 onkymio volumio[4944]: info: I2S DAC not set, start Auto-detection
Apr 23 16:19:09 onkymio volumio[4944]: info: Loading plugin "volumiodiscovery"...
Apr 23 16:19:09 onkymio volumio[4944]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 23 16:19:09 onkymio volumio[4944]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 23 16:19:09 onkymio volumio[4944]: *** WARNING *** For more information see 
Apr 23 16:19:09 onkymio volumio[4944]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 23 16:19:09 onkymio volumio[4944]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 23 16:19:09 onkymio volumio[4944]: *** WARNING *** For more information see 
Apr 23 16:19:09 onkymio node[4944]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 23 16:19:09 onkymio node[4944]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 23 16:19:09 onkymio node[4944]: *** WARNING *** For more information see 
Apr 23 16:19:09 onkymio node[4944]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 23 16:19:09 onkymio node[4944]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 23 16:19:09 onkymio node[4944]: *** WARNING *** For more information see 
Apr 23 16:19:09 onkymio volumio[4944]: info: Applying required configuration parameters for plugin volumiodiscovery
Apr 23 16:19:09 onkymio volumio[4944]: info: Discovery: Started advertising with name: onkymio
Apr 23 16:19:09 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 23 16:19:09 onkymio volumio[4944]: info: Loading plugin "youtube2"...
Apr 23 16:19:09 onkymio volumio[4944]: info: Loading plugin "now_playing"...
Apr 23 16:19:09 onkymio volumio[4944]: info: Loading plugin "outputs"...
Apr 23 16:19:09 onkymio volumio[4944]: info: Loading plugin "albumart"...
Apr 23 16:19:09 onkymio volumio[4944]: info: Plugin example_plugin is not enabled
Apr 23 16:19:09 onkymio volumio[4944]: info: Loading plugin "inputs"...
Apr 23 16:19:09 onkymio volumio[4944]: info: Loading plugin "updater_comm"...
Apr 23 16:19:09 onkymio volumio[4944]: info: Plugin mpdemulation is not enabled
Apr 23 16:19:09 onkymio volumio[4944]: info: Loading plugin "rest_api"...
Apr 23 16:19:09 onkymio volumio[4944]: info: Loading plugin "websocket"...
Apr 23 16:19:09 onkymio volumio[4944]: info: Plugin fusiondsp is not enabled
Apr 23 16:19:09 onkymio volumio[4944]: info: Loading plugin "Systeminfo"...
Apr 23 16:19:09 onkymio volumio[4944]: Forking 3 albumart workers
Apr 23 16:19:09 onkymio volumio[4944]: info: Loading plugin "randomizer"...
Apr 23 16:19:09 onkymio volumio[4944]: info: Applying required configuration parameters for plugin randomizer
Apr 23 16:19:09 onkymio volumio[4944]: Starting albumart workers
Apr 23 16:19:10 onkymio volumio[4944]: Starting albumart workers
Apr 23 16:19:10 onkymio volumio[4944]: info: Loading i18n strings for locale fr
Apr 23 16:19:10 onkymio volumio[4944]: Updating browse sources language
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 23 16:19:10 onkymio volumio[4944]: Starting albumart workers
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::initPlayerControls
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 23 16:19:10 onkymio volumio[4944]: Express server listening on port 3000
Apr 23 16:19:10 onkymio volumio[4944]:  [Metrics]  WebUI:  0s 998.38ms 
Apr 23 16:19:10 onkymio volumio[4944]: info: Setting Device type: x86
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreStateMachine::resetVolumioState
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreStateMachine::getcurrentVolume
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::volumioRetrievevolume
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 16:19:10 onkymio volumio[4944]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt'
Apr 23 16:19:10 onkymio volumio[4944]: info: Completed loading Core Plugins
Apr 23 16:19:10 onkymio volumio[4944]: info: Preparing to generate the ALSA configuration file
Apr 23 16:19:10 onkymio volumio[4944]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan
Apr 23 16:19:10 onkymio volumio[4944]: wlan0     Interface doesn't support scanning.
Apr 23 16:19:10 onkymio volumio[4944]: info: Cannot use regular scanning, forcing with ap-force
Apr 23 16:19:10 onkymio sudo[5035]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force
Apr 23 16:19:10 onkymio sudo[5035]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:10 onkymio sudo[5035]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:10 onkymio volumio[4944]: command failed: No such device (-19)
Apr 23 16:19:10 onkymio volumio[4944]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force
Apr 23 16:19:10 onkymio volumio[4944]: command failed: No such device (-19)
Apr 23 16:19:10 onkymio volumio[4944]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision
Apr 23 16:19:10 onkymio volumio[4944]: verbose: New Socket.io Connection to 192.168.1.18 from 192.168.1.1 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Safari/537.36 Total Clients: 1
Apr 23 16:19:10 onkymio volumio[4944]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Total Clients: 2
Apr 23 16:19:10 onkymio volumio[4944]: info: Reloading queue from file
Apr 23 16:19:10 onkymio volumio[4944]: info: VolumeController:: Volume=100 Mute =false
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreStateMachine::pushState
Apr 23 16:19:10 onkymio volumio[4944]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::volumioPushState
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreStateMachine::updateTrackBlock
Apr 23 16:19:10 onkymio volumio[4944]: info: CorePlayQueue::getTrackBlock
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::volumioRetrievevolume
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreStateMachine::setRepeat null single undefined
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreStateMachine::pushState
Apr 23 16:19:10 onkymio volumio[4944]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::volumioPushState
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreStateMachine::setRandom null
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreStateMachine::pushState
Apr 23 16:19:10 onkymio volumio[4944]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::volumioPushState
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 23 16:19:10 onkymio volumio[4944]: info: Discovery: A device disappeared from network
Apr 23 16:19:10 onkymio volumio[4944]: info: Discovery: Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:10 onkymio volumio[4944]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:10 onkymio volumio[4944]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Apr 23 16:19:10 onkymio volumio[4944]: info: Received Get System Info
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 23 16:19:10 onkymio volumio[4944]: info: Discovery: Getting this device information
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:10 onkymio volumio[4944]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:10 onkymio volumio[4944]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:10 onkymio volumio[4944]: info: Listing playlists
Apr 23 16:19:10 onkymio volumio[4944]: info: Asound.conf file written
Apr 23 16:19:10 onkymio sudo[5057]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Apr 23 16:19:10 onkymio sudo[5057]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:10 onkymio sudo[5057]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:10 onkymio volumio[4944]: info: Output device has changed, restarting MPD
Apr 23 16:19:10 onkymio sudo[5062]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 23 16:19:10 onkymio sudo[5062]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:10 onkymio sudo[5062]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:10 onkymio volumio[4944]: info: Output device has changed, restarting Shairport Sync
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 16:19:10 onkymio sudo[5065]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 23 16:19:10 onkymio sudo[5065]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:10 onkymio systemd[1]: Stopping Music Player Daemon...
Apr 23 16:19:10 onkymio volumio[4944]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 23 16:19:10 onkymio volumio[4944]: info: ___________ START PLUGINS ___________
Apr 23 16:19:10 onkymio volumio[4944]: info: ControllerMpd::onStart: Initializing MPD
Apr 23 16:19:10 onkymio volumio[4944]: info: Creating MPD Configuration file
Apr 23 16:19:10 onkymio sudo[5071]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 23 16:19:10 onkymio sudo[5071]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:10 onkymio sudo[5071]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 23 16:19:10 onkymio volumio[4944]: info: [1713889150294] CoreMusicLibrary::Adding element Serveurs Média
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 23 16:19:10 onkymio sudo[5074]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 23 16:19:10 onkymio sudo[5074]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 16:19:10 onkymio systemd[1]: mpd.service: Succeeded.
Apr 23 16:19:10 onkymio systemd[1]: Stopped Music Player Daemon.
Apr 23 16:19:10 onkymio volumio[4944]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 16:19:10 onkymio volumio[4944]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 23 16:19:10 onkymio volumio[4944]: info: [1713889150319] CoreMusicLibrary::Adding element Last_100
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 23 16:19:10 onkymio systemd[1]: Starting Music Player Daemon...
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 23 16:19:10 onkymio volumio[4944]: info: [1713889150320] CoreMusicLibrary::Adding element Webradio
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 23 16:19:10 onkymio volumio[4944]: info: [1713889150322] CoreMusicLibrary::Adding element YouTube2
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 23 16:19:10 onkymio volumio[4944]: Cannot find translation for source YouTube2
Apr 23 16:19:10 onkymio volumio[4944]: info: [now-playing-config] Config is up to date.
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 23 16:19:10 onkymio volumio[4944]: info: Discovery: Getting this device information
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:10 onkymio volumio[4944]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 23 16:19:10 onkymio volumio[4944]: info: [1713889150332] CoreMusicLibrary::Adding element Randomizer
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 23 16:19:10 onkymio volumio[4944]: Cannot find translation for source YouTube2
Apr 23 16:19:10 onkymio volumio[4944]: Cannot find translation for source Randomizer
Apr 23 16:19:10 onkymio volumio[4944]: info: Volumio Calling Home
Apr 23 16:19:10 onkymio volumio[4944]: info: [now-playing-app] App is listening on port 4004.
Apr 23 16:19:10 onkymio volumio[4944]: info: VolumeController:: Volume=100 Mute =false
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreStateMachine::pushState
Apr 23 16:19:10 onkymio volumio[4944]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::volumioPushState
Apr 23 16:19:10 onkymio volumio[4944]: info: MPD Permissions set
Apr 23 16:19:10 onkymio volumio[4944]: info: MPD Permissions set
Apr 23 16:19:10 onkymio volumio[4944]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 3
Apr 23 16:19:10 onkymio volumio[4944]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 4
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:10 onkymio volumio[4944]: info: Discovery: adding 6fb6de89-7df4-4f83-a1e7-db4f383d3a13
Apr 23 16:19:10 onkymio volumio[4944]: info: Discovery: Found device accuphasumio
Apr 23 16:19:10 onkymio volumio[4944]: info: Discovery: Connecting to remote: 192.168.1.15
Apr 23 16:19:10 onkymio volumio[4944]: info: Discovery: adding 75b29887-8e71-4b40-85d3-7da7e3e6402a
Apr 23 16:19:10 onkymio volumio[4944]: info: Discovery: Found device onkymio
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:10 onkymio volumio[4944]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:10 onkymio volumio[4944]: info: Volumio called home
Apr 23 16:19:10 onkymio volumio[4944]: verbose: New Socket.io Connection to 192.168.1.18:3000 from 192.168.1.15 UA: node-XMLHttpRequest Total Clients: 5
Apr 23 16:19:10 onkymio volumio[4944]: info: Starting Shairport Sync
Apr 23 16:19:10 onkymio volumio[4944]: info: Starting Shairport Sync
Apr 23 16:19:10 onkymio sudo[5100]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 23 16:19:10 onkymio sudo[5100]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:10 onkymio volumio[4944]: info: Starting Shairport Sync
Apr 23 16:19:10 onkymio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Apr 23 16:19:10 onkymio sudo[5103]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 23 16:19:10 onkymio sudo[5103]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:10 onkymio systemd[1]: shairport-sync.service: Succeeded.
Apr 23 16:19:10 onkymio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Apr 23 16:19:10 onkymio volumio[4944]: info: Discovery: this is already registered,  75b29887-8e71-4b40-85d3-7da7e3e6402a
Apr 23 16:19:10 onkymio sudo[5107]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 23 16:19:10 onkymio sudo[5107]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:10 onkymio volumio[4944]: info: Discovery: Found device onkymio
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:10 onkymio volumio[4944]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:10 onkymio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Apr 23 16:19:10 onkymio sudo[5100]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:10 onkymio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Apr 23 16:19:10 onkymio systemd[1]: shairport-sync.service: Succeeded.
Apr 23 16:19:10 onkymio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Apr 23 16:19:10 onkymio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Apr 23 16:19:10 onkymio volumio[4944]: info: Shairport-Sync Started
Apr 23 16:19:10 onkymio sudo[5103]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:10 onkymio volumio[4944]: Error adding Membership: Error: addMembership EINVAL
Apr 23 16:19:10 onkymio sudo[5107]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:10 onkymio volumio[4944]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:10 onkymio volumio[4944]: info: Shairport-Sync Started
Apr 23 16:19:10 onkymio volumio[4944]: info: Shairport-Sync Started
Apr 23 16:19:10 onkymio volumio[4944]: info: Discovery: Connected to remote: 192.168.1.15
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket
Apr 23 16:19:10 onkymio volumio[4944]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:10 onkymio volumio[4944]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:10 onkymio mpd[5077]: Apr 23 16:19 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Apr 23 16:19:10 onkymio systemd[1]: Started Music Player Daemon.
Apr 23 16:19:10 onkymio sudo[5065]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:10 onkymio sudo[5074]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:11 onkymio volumio[4944]: info: Completed starting Core Plugins
Apr 23 16:19:11 onkymio volumio[4944]: info: -------------------------------------------
Apr 23 16:19:11 onkymio volumio[4944]: info: -----    MyVolumio plugins startup     ----
Apr 23 16:19:11 onkymio volumio[4944]: info: -------------------------------------------
Apr 23 16:19:11 onkymio volumio[4944]: info: [MyVolumio PluginManager] Fetching plans data....
Apr 23 16:19:11 onkymio volumio[4944]: error: MPD error: The expression evaluated to a falsy value:
Apr 23 16:19:11 onkymio volumio[4944]:   assert.ok(self.idling)
Apr 23 16:19:11 onkymio volumio[4944]: error: The expression evaluated to a falsy value:
Apr 23 16:19:11 onkymio volumio[4944]:   assert.ok(self.idling)
Apr 23 16:19:11 onkymio volumio[4944]: error: updateQueue error: null
Apr 23 16:19:11 onkymio volumio[4944]: info: MPD running with PID5077
Apr 23 16:19:11 onkymio volumio[4944]:  ,establishing connection
Apr 23 16:19:11 onkymio volumio[4944]: error: updateQueue error: null
Apr 23 16:19:11 onkymio volumio[4944]: verbose: New Socket.io Connection to 192.168.1.18 from 192.168.1.1 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Safari/537.36 Total Clients: 6
Apr 23 16:19:11 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 23 16:19:11 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Apr 23 16:19:11 onkymio volumio[4944]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 23 16:19:11 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 23 16:19:11 onkymio volumio[4944]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:11 onkymio volumio[4944]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:11 onkymio volumio[4944]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:11 onkymio volumio[4944]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:11 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Apr 23 16:19:11 onkymio volumio[4944]: info: CoreCommandRouter::volumioGetQueue
Apr 23 16:19:11 onkymio volumio[4944]: info: CoreStateMachine::getQueue
Apr 23 16:19:11 onkymio volumio[4944]: info: CorePlayQueue::getQueue
Apr 23 16:19:11 onkymio volumio[4944]: info: Listing playlists
Apr 23 16:19:11 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Apr 23 16:19:11 onkymio volumio[4944]: info: Received Get System Info
Apr 23 16:19:11 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 23 16:19:11 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 23 16:19:11 onkymio volumio[4944]: info: Discovery: Getting this device information
Apr 23 16:19:11 onkymio volumio[4944]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:11 onkymio volumio[4944]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:11 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 23 16:19:11 onkymio volumio[4944]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:11 onkymio volumio[4944]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:11 onkymio volumio[4944]: verbose: New Socket.io Connection to 192.168.1.18 from 192.168.1.175 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Safari/537.36 Total Clients: 7
Apr 23 16:19:11 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 23 16:19:11 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Apr 23 16:19:11 onkymio volumio[4944]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 23 16:19:11 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 23 16:19:11 onkymio volumio[4944]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:11 onkymio volumio[4944]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:11 onkymio volumio[4944]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:11 onkymio volumio[4944]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:11 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Apr 23 16:19:11 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Apr 23 16:19:11 onkymio volumio[4944]: info: Received Get System Info
Apr 23 16:19:11 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 23 16:19:11 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 23 16:19:11 onkymio volumio[4944]: info: Discovery: Getting this device information
Apr 23 16:19:11 onkymio volumio[4944]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:11 onkymio volumio[4944]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:11 onkymio volumio[4944]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 23 16:19:11 onkymio volumio[4944]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:11 onkymio volumio[4944]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:11 onkymio volumio[4944]: info: Listing playlists
Apr 23 16:19:11 onkymio volumio[4944]: info: CoreCommandRouter::volumioGetQueue
Apr 23 16:19:11 onkymio volumio[4944]: info: CoreStateMachine::getQueue
Apr 23 16:19:11 onkymio volumio[4944]: info: CorePlayQueue::getQueue
Apr 23 16:19:13 onkymio volumio-remote-updater[525]: [2024-04-23 16:19:13] [connect] Successful connection
Apr 23 16:19:13 onkymio volumio-remote-updater[525]: [2024-04-23 16:19:13] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1713889153 101
Apr 23 16:19:13 onkymio volumio[4944]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 8
Apr 23 16:19:14 onkymio volumio[4944]: info: Cannot mount NAS NAS at system boot, trial number 2 ,retrying in 5 seconds
Apr 23 16:19:14 onkymio volumio[4944]: info: Preload queue cleared
Apr 23 16:19:14 onkymio volumio[4944]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 23 16:19:14 onkymio volumio[4944]: info: CoreStateMachine::ClearQueue
Apr 23 16:19:14 onkymio volumio[4944]: info: CoreStateMachine::stop
Apr 23 16:19:14 onkymio volumio[4944]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 23 16:19:14 onkymio volumio[4944]: info: CorePlayQueue::clearPlayQueue
Apr 23 16:19:14 onkymio volumio[4944]: info: CorePlayQueue::saveQueue
Apr 23 16:19:14 onkymio volumio[4944]: info: CoreCommandRouter::volumioPushQueue
Apr 23 16:19:14 onkymio volumio[4944]: info: CoreStateMachine::addQueueItems
Apr 23 16:19:14 onkymio volumio[4944]: info: CorePlayQueue::addQueueItems
Apr 23 16:19:14 onkymio volumio[4944]: info: Preload queue cleared
Apr 23 16:19:14 onkymio volumio[4944]: info: Adding Item to queue: qobuz://song/91838024
Apr 23 16:19:14 onkymio volumio[4944]: info: Exploding uri qobuz://song/91838024 in service qobuz
Apr 23 16:19:14 onkymio volumio[4944]: info: Adding Item to queue: NAS/NAS-MUSIC/1975  Murray Head - Say It Ain t So  2017   24-96/01. Say It Ain't So.flac
Apr 23 16:19:14 onkymio volumio[4944]: info: Exploding uri NAS/NAS-MUSIC/1975  Murray Head - Say It Ain t So  2017   24-96/01. Say It Ain't So.flac in service mpd
Apr 23 16:19:14 onkymio volumio[4944]: error: scanFolder - failure to stat '/mnt/NAS/NAS-MUSIC/1975  Murray Head - Say It Ain t So  2017   24-96/01. Say It Ain't So.flac'
Apr 23 16:19:14 onkymio volumio[4944]: info: Adding Item to queue: NAS/NAS-MUSIC/1976 Genesis - A Trick Of The Tail-DSD/05 - Robbery, Assault And Battery.dsf
Apr 23 16:19:14 onkymio volumio[4944]: info: Exploding uri NAS/NAS-MUSIC/1976 Genesis - A Trick Of The Tail-DSD/05 - Robbery, Assault And Battery.dsf in service mpd
Apr 23 16:19:14 onkymio volumio[4944]: error: scanFolder - failure to stat '/mnt/NAS/NAS-MUSIC/1976 Genesis - A Trick Of The Tail-DSD/05 - Robbery, Assault And Battery.dsf'
Apr 23 16:19:14 onkymio volumio[4944]: info: Adding Item to queue: NAS/NAS-MUSIC/1976 Genesis - A Trick Of The Tail-DSD/06 - Ripples.dsf
Apr 23 16:19:14 onkymio volumio[4944]: info: Exploding uri NAS/NAS-MUSIC/1976 Genesis - A Trick Of The Tail-DSD/06 - Ripples.dsf in service mpd
Apr 23 16:19:14 onkymio volumio[4944]: error: scanFolder - failure to stat '/mnt/NAS/NAS-MUSIC/1976 Genesis - A Trick Of The Tail-DSD/06 - Ripples.dsf'
Apr 23 16:19:14 onkymio volumio[4944]: info: Adding Item to queue: cue://NAS/NAS-MUSIC/1977 - Fleetwood Mac - Rumours (1988, Warner-Pioneer, Japan, 20P2-2036)/Fleetwood Mac - Rumours.cue@4
Apr 23 16:19:14 onkymio volumio[4944]: info: Exploding uri cue://NAS/NAS-MUSIC/1977 - Fleetwood Mac - Rumours (1988, Warner-Pioneer, Japan, 20P2-2036)/Fleetwood Mac - Rumours.cue@4 in service mpd
Apr 23 16:19:14 onkymio volumio[4944]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 23 16:19:14 onkymio volumio[4944]: Error: file /mnt/NAS/NAS-MUSIC/1977 - Fleetwood Mac - Rumours (1988, Warner-Pioneer, Japan, 20P2-2036)/Fleetwood Mac - Rumours.cue does not exist
Apr 23 16:19:14 onkymio volumio[4944]:     at Object.parse (/volumio/node_modules/cue-parser/lib/cue.js:37:15)
Apr 23 16:19:14 onkymio volumio[4944]:     at ControllerMpd.explodeUri (/volumio/app/plugins/music_service/mpd/index.js:1924:27)
Apr 23 16:19:14 onkymio volumio[4944]:     at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1359:16)
Apr 23 16:19:14 onkymio volumio[4944]:     at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24)
Apr 23 16:19:14 onkymio volumio[4944]:     at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19)
Apr 23 16:19:14 onkymio volumio[4944]:     at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:223:30)
Apr 23 16:19:14 onkymio volumio[4944]:     at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:247:25)
Apr 23 16:19:14 onkymio volumio[4944]:     at CoreCommandRouter.replaceAndPlay (/volumio/app/index.js:501:23)
Apr 23 16:19:14 onkymio volumio[4944]:     at CoreCommandRouter.playItemsList (/volumio/app/index.js:477:17)
Apr 23 16:19:14 onkymio volumio[4944]:     at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:118:33)
Apr 23 16:19:14 onkymio volumio[4944]:     at Socket.emit (events.js:400:28)
Apr 23 16:19:14 onkymio volumio[4944]:     at /volumio/node_modules/socket.io/lib/socket.js:503:12
Apr 23 16:19:14 onkymio volumio[4944]:     at processTicksAndRejections (internal/process/task_queues.js:77:11)
Apr 23 16:19:14 onkymio volumio[4944]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 23 16:19:14 onkymio sudo[5128]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-23 16:18
Apr 23 16:19:14 onkymio sudo[5128]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:14 onkymio sudo[5128]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:14 onkymio volumio-remote-updater[525]: [2024-04-23 16:19:14] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Apr 23 16:19:14 onkymio volumio-remote-updater[525]: [2024-04-23 16:19:14] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Apr 23 16:19:14 onkymio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Apr 23 16:19:14 onkymio systemd[1]: volumio.service: Failed with result 'exit-code'.
Apr 23 16:19:14 onkymio systemd[1]: Started dynamicswap service.
Apr 23 16:19:14 onkymio systemd[1]: dynamicswap.service: Succeeded.
Apr 23 16:19:14 onkymio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
Apr 23 16:19:14 onkymio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 2.
Apr 23 16:19:14 onkymio systemd[1]: Stopped Volumio Backend Module.
Apr 23 16:19:14 onkymio systemd[1]: Started Volumio Backend Module.
Apr 23 16:19:14 onkymio systemd[1]: Started dynamicswap service.
Apr 23 16:19:14 onkymio systemd[1]: dynamicswap.service: Succeeded.
Apr 23 16:19:15 onkymio volumio[5138]: info: -------------------------------------------
Apr 23 16:19:15 onkymio volumio[5138]: info: -----            Volumio3              ----
Apr 23 16:19:15 onkymio volumio[5138]: info: -------------------------------------------
Apr 23 16:19:15 onkymio volumio[5138]: info: -----          System startup          ----
Apr 23 16:19:15 onkymio volumio[5138]: info: -------------------------------------------
Apr 23 16:19:15 onkymio volumio[5138]: info: MYVOLUMIO Environment detected
Apr 23 16:19:15 onkymio volumio[5138]: info: Plugin folders cleanup
Apr 23 16:19:15 onkymio volumio[5138]: info: Scanning into folder /volumio/app/plugins/
Apr 23 16:19:15 onkymio volumio[5138]: info: Scanning category audio_interface
Apr 23 16:19:15 onkymio volumio[5138]: info: Scanning category miscellanea
Apr 23 16:19:15 onkymio volumio[5138]: info: Scanning category music_service
Apr 23 16:19:15 onkymio volumio[5138]: info: Scanning category plugins.json
Apr 23 16:19:15 onkymio volumio[5138]: info: Scanning category system_controller
Apr 23 16:19:15 onkymio volumio[5138]: info: Scanning category user_interface
Apr 23 16:19:15 onkymio volumio[5138]: info: Scanning into folder /data/plugins/
Apr 23 16:19:15 onkymio volumio[5138]: info: Scanning category audio_interface
Apr 23 16:19:15 onkymio volumio[5138]: info: Scanning category music_service
Apr 23 16:19:15 onkymio volumio[5138]: info: Scanning category user_interface
Apr 23 16:19:15 onkymio volumio[5138]: info: Plugin folders cleanup completed
Apr 23 16:19:15 onkymio volumio[5138]: info: -------------------------------------------
Apr 23 16:19:15 onkymio volumio[5138]: info: -----      Core plugins startup        ----
Apr 23 16:19:15 onkymio volumio[5138]: info: -------------------------------------------
Apr 23 16:19:15 onkymio volumio[5138]: info: Loading plugins from folder /volumio/app/plugins/
Apr 23 16:19:15 onkymio volumio[5138]: info: Adding plugin upnp to MyMusic Plugins
Apr 23 16:19:15 onkymio volumio[5138]: info: Adding plugin airplay_emulation to MyMusic Plugins
Apr 23 16:19:15 onkymio volumio[5138]: info: Adding plugin upnp_browser to MyMusic Plugins
Apr 23 16:19:15 onkymio volumio[5138]: info: Loading plugins from folder /data/plugins/
Apr 23 16:19:15 onkymio volumio[5138]: info: Loading plugin "system"...
Apr 23 16:19:15 onkymio volumio[5138]: info: Loading plugin "appearance"...
Apr 23 16:19:15 onkymio volumio[5138]: info: Loading plugin "network"...
Apr 23 16:19:15 onkymio volumio[5138]: info: Refreshing Cached IP Addresses
Apr 23 16:19:15 onkymio sudo[5165]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 23 16:19:15 onkymio sudo[5165]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:15 onkymio sudo[5165]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:15 onkymio sudo[5167]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 23 16:19:15 onkymio sudo[5167]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:15 onkymio volumio[5138]: info: Loading plugin "services"...
Apr 23 16:19:15 onkymio volumio[5138]: info: Loading plugin "alsa_controller"...
Apr 23 16:19:15 onkymio sudo[5170]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Apr 23 16:19:15 onkymio sudo[5170]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:15 onkymio sudo[5167]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:15 onkymio sudo[5170]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:15 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 23 16:19:15 onkymio volumio[5138]: info: Loading plugin "wizard"...
Apr 23 16:19:15 onkymio volumio[5138]: info: Loading plugin "networkfs"...
Apr 23 16:19:15 onkymio volumio[5138]: info: Cannot mount NAS NAS at system boot, trial number 1 ,retrying in 5 seconds
Apr 23 16:19:15 onkymio volumio[5138]: info: Starting Udev Watcher for removable devices
Apr 23 16:19:15 onkymio volumio[5138]: info: Ignoring mount for partition: boot
Apr 23 16:19:15 onkymio volumio[5138]: info: Ignoring mount for partition: volumio
Apr 23 16:19:15 onkymio volumio[5138]: info: Ignoring mount for partition: volumio_data
Apr 23 16:19:15 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 23 16:19:15 onkymio volumio[5138]: info: Loading plugin "volumio_command_line_client"...
Apr 23 16:19:15 onkymio volumio[5138]: info: Loading plugin "upnp"...
Apr 23 16:19:15 onkymio volumio[5138]: info: [1713889155395] Starting Upmpd Daemon
Apr 23 16:19:15 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 23 16:19:15 onkymio volumio[5138]: info: Loading plugin "my_music"...
Apr 23 16:19:15 onkymio volumio[5138]: info: Loading plugin "mpd"...
Apr 23 16:19:15 onkymio volumio[5138]: info: Loading plugin "upnp_browser"...
Apr 23 16:19:15 onkymio volumio[5138]: info: Loading plugin "alarm-clock"...
Apr 23 16:19:15 onkymio volumio[5138]: info: Loading plugin "airplay_emulation"...
Apr 23 16:19:15 onkymio volumio[5138]: info: Starting Shairport Sync
Apr 23 16:19:15 onkymio volumio[5138]: info: Loading plugin "last_100"...
Apr 23 16:19:15 onkymio volumio[5138]: info: Loading plugin "webradio"...
Apr 23 16:19:15 onkymio volumio[5138]: info: Loading plugin "i2s_dacs"...
Apr 23 16:19:15 onkymio volumio[5138]: info: I2S DAC not set, start Auto-detection
Apr 23 16:19:15 onkymio volumio[5138]: info: Loading plugin "volumiodiscovery"...
Apr 23 16:19:15 onkymio volumio[5138]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 23 16:19:15 onkymio volumio[5138]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 23 16:19:15 onkymio volumio[5138]: *** WARNING *** For more information see 
Apr 23 16:19:15 onkymio volumio[5138]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 23 16:19:15 onkymio volumio[5138]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 23 16:19:15 onkymio volumio[5138]: *** WARNING *** For more information see 
Apr 23 16:19:15 onkymio node[5138]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 23 16:19:15 onkymio node[5138]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 23 16:19:15 onkymio node[5138]: *** WARNING *** For more information see 
Apr 23 16:19:15 onkymio node[5138]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 23 16:19:15 onkymio node[5138]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 23 16:19:15 onkymio node[5138]: *** WARNING *** For more information see 
Apr 23 16:19:15 onkymio volumio[5138]: info: Applying required configuration parameters for plugin volumiodiscovery
Apr 23 16:19:15 onkymio volumio[5138]: info: Discovery: Started advertising with name: onkymio
Apr 23 16:19:15 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 23 16:19:15 onkymio volumio[5138]: info: Loading plugin "youtube2"...
Apr 23 16:19:15 onkymio volumio[5138]: info: Loading plugin "now_playing"...
Apr 23 16:19:15 onkymio volumio[5138]: info: Loading plugin "outputs"...
Apr 23 16:19:15 onkymio volumio[5138]: info: Loading plugin "albumart"...
Apr 23 16:19:15 onkymio volumio[5138]: info: Plugin example_plugin is not enabled
Apr 23 16:19:15 onkymio volumio[5138]: info: Loading plugin "inputs"...
Apr 23 16:19:15 onkymio volumio[5138]: info: Loading plugin "updater_comm"...
Apr 23 16:19:15 onkymio volumio[5138]: info: Plugin mpdemulation is not enabled
Apr 23 16:19:15 onkymio volumio[5138]: info: Loading plugin "rest_api"...
Apr 23 16:19:15 onkymio volumio[5138]: Forking 3 albumart workers
Apr 23 16:19:15 onkymio volumio[5138]: info: Loading plugin "websocket"...
Apr 23 16:19:15 onkymio volumio[5138]: info: Plugin fusiondsp is not enabled
Apr 23 16:19:15 onkymio volumio[5138]: info: Loading plugin "Systeminfo"...
Apr 23 16:19:15 onkymio volumio[5138]: info: Loading plugin "randomizer"...
Apr 23 16:19:15 onkymio volumio[5138]: Starting albumart workers
Apr 23 16:19:15 onkymio volumio[5138]: Starting albumart workers
Apr 23 16:19:15 onkymio volumio[5138]: info: Applying required configuration parameters for plugin randomizer
Apr 23 16:19:15 onkymio volumio[5138]: Starting albumart workers
Apr 23 16:19:16 onkymio volumio[5138]: info: Loading i18n strings for locale fr
Apr 23 16:19:16 onkymio volumio[5138]: Updating browse sources language
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::initPlayerControls
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 23 16:19:16 onkymio volumio[5138]: Express server listening on port 3000
Apr 23 16:19:16 onkymio volumio[5138]:  [Metrics]  WebUI:  1s 22.21ms 
Apr 23 16:19:16 onkymio volumio[5138]: info: Setting Device type: x86
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreStateMachine::resetVolumioState
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreStateMachine::getcurrentVolume
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::volumioRetrievevolume
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 16:19:16 onkymio volumio[5138]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt'
Apr 23 16:19:16 onkymio volumio[5138]: info: Completed loading Core Plugins
Apr 23 16:19:16 onkymio volumio[5138]: info: Preparing to generate the ALSA configuration file
Apr 23 16:19:16 onkymio volumio[5138]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan
Apr 23 16:19:16 onkymio volumio[5138]: wlan0     Interface doesn't support scanning.
Apr 23 16:19:16 onkymio volumio[5138]: info: Cannot use regular scanning, forcing with ap-force
Apr 23 16:19:16 onkymio sudo[5281]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force
Apr 23 16:19:16 onkymio sudo[5281]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:16 onkymio sudo[5281]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:16 onkymio volumio[5138]: command failed: No such device (-19)
Apr 23 16:19:16 onkymio volumio[5138]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force
Apr 23 16:19:16 onkymio volumio[5138]: command failed: No such device (-19)
Apr 23 16:19:16 onkymio volumio[5138]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision
Apr 23 16:19:16 onkymio volumio[5138]: verbose: New Socket.io Connection to 192.168.1.18 from 192.168.1.1 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Safari/537.36 Total Clients: 1
Apr 23 16:19:16 onkymio volumio[5138]: verbose: New Socket.io Connection to 192.168.1.18 from 192.168.1.175 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Safari/537.36 Total Clients: 2
Apr 23 16:19:16 onkymio volumio[5138]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Total Clients: 3
Apr 23 16:19:16 onkymio volumio[5138]: info: Reloading queue from file
Apr 23 16:19:16 onkymio volumio[5138]: info: Asound.conf file unchanged, so no further update is needed
Apr 23 16:19:16 onkymio volumio[5138]: info: Output device has changed, restarting MPD
Apr 23 16:19:16 onkymio sudo[5293]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 23 16:19:16 onkymio sudo[5293]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:16 onkymio sudo[5293]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:16 onkymio volumio[5138]: info: Output device has changed, restarting Shairport Sync
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 16:19:16 onkymio sudo[5296]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 23 16:19:16 onkymio sudo[5296]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:16 onkymio systemd[1]: Stopping Music Player Daemon...
Apr 23 16:19:16 onkymio volumio[5138]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 23 16:19:16 onkymio volumio[5138]: info: ___________ START PLUGINS ___________
Apr 23 16:19:16 onkymio volumio[5138]: info: ControllerMpd::onStart: Initializing MPD
Apr 23 16:19:16 onkymio volumio[5138]: info: Creating MPD Configuration file
Apr 23 16:19:16 onkymio sudo[5302]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 23 16:19:16 onkymio sudo[5302]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:16 onkymio sudo[5302]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 23 16:19:16 onkymio volumio[5138]: info: [1713889156235] CoreMusicLibrary::Adding element Serveurs Média
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 23 16:19:16 onkymio sudo[5305]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 23 16:19:16 onkymio sudo[5305]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:16 onkymio systemd[1]: mpd.service: Succeeded.
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:16 onkymio systemd[1]: Stopped Music Player Daemon.
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 16:19:16 onkymio volumio[5138]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 16:19:16 onkymio volumio[5138]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 23 16:19:16 onkymio volumio[5138]: info: [1713889156261] CoreMusicLibrary::Adding element Last_100
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 23 16:19:16 onkymio volumio[5138]: info: [1713889156262] CoreMusicLibrary::Adding element Webradio
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 23 16:19:16 onkymio systemd[1]: Starting Music Player Daemon...
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 23 16:19:16 onkymio volumio[5138]: info: [1713889156264] CoreMusicLibrary::Adding element YouTube2
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 23 16:19:16 onkymio volumio[5138]: Cannot find translation for source YouTube2
Apr 23 16:19:16 onkymio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Apr 23 16:19:16 onkymio systemd[1]: mpd.service: Succeeded.
Apr 23 16:19:16 onkymio systemd[1]: Stopped Music Player Daemon.
Apr 23 16:19:16 onkymio systemd[1]: Starting Music Player Daemon...
Apr 23 16:19:16 onkymio volumio[5138]: info: [now-playing-config] Config is up to date.
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 23 16:19:16 onkymio volumio[5138]: info: Discovery: Getting this device information
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:16 onkymio volumio[5138]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 23 16:19:16 onkymio volumio[5138]: info: [1713889156278] CoreMusicLibrary::Adding element Randomizer
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 23 16:19:16 onkymio volumio[5138]: Cannot find translation for source YouTube2
Apr 23 16:19:16 onkymio volumio[5138]: Cannot find translation for source Randomizer
Apr 23 16:19:16 onkymio volumio[5138]: info: Volumio Calling Home
Apr 23 16:19:16 onkymio volumio[5138]: info: [now-playing-app] App is listening on port 4004.
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreStateMachine::setRepeat null single undefined
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreStateMachine::pushState
Apr 23 16:19:16 onkymio volumio[5138]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::volumioPushState
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreStateMachine::setRandom null
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreStateMachine::pushState
Apr 23 16:19:16 onkymio volumio[5138]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::volumioPushState
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 23 16:19:16 onkymio volumio[5138]: info: VolumeController:: Volume=100 Mute =false
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreStateMachine::pushState
Apr 23 16:19:16 onkymio volumio[5138]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::volumioPushState
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreStateMachine::updateTrackBlock
Apr 23 16:19:16 onkymio volumio[5138]: info: CorePlayQueue::getTrackBlock
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::volumioRetrievevolume
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:16 onkymio volumio[5138]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:16 onkymio volumio[5138]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Apr 23 16:19:16 onkymio volumio[5138]: info: Received Get System Info
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 23 16:19:16 onkymio volumio[5138]: info: Discovery: Getting this device information
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:16 onkymio volumio[5138]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:16 onkymio volumio[5138]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:16 onkymio volumio[5138]: info: Listing playlists
Apr 23 16:19:16 onkymio volumio[5138]: info: MPD Permissions set
Apr 23 16:19:16 onkymio volumio[5138]: info: MPD Permissions set
Apr 23 16:19:16 onkymio volumio[5138]: info: Discovery: A device disappeared from network
Apr 23 16:19:16 onkymio volumio[5138]: info: Discovery: Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined
Apr 23 16:19:16 onkymio volumio[5138]: verbose: New Socket.io Connection to 192.168.1.18:3000 from 192.168.1.15 UA: node-XMLHttpRequest Total Clients: 4
Apr 23 16:19:16 onkymio volumio[5138]: info: Volumio called home
Apr 23 16:19:16 onkymio volumio[5138]: info: Discovery: adding 75b29887-8e71-4b40-85d3-7da7e3e6402a
Apr 23 16:19:16 onkymio volumio[5138]: info: Discovery: Found device onkymio
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:16 onkymio volumio[5138]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:16 onkymio volumio[5138]: info: Discovery: adding 6fb6de89-7df4-4f83-a1e7-db4f383d3a13
Apr 23 16:19:16 onkymio volumio[5138]: info: Discovery: Found device accuphasumio
Apr 23 16:19:16 onkymio volumio[5138]: info: Discovery: Connecting to remote: 192.168.1.15
Apr 23 16:19:16 onkymio volumio[5138]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 5
Apr 23 16:19:16 onkymio volumio[5138]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 6
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:16 onkymio volumio[5138]: info: VolumeController:: Volume=100 Mute =false
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreStateMachine::pushState
Apr 23 16:19:16 onkymio volumio[5138]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::volumioPushState
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:16 onkymio volumio[5138]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:16 onkymio volumio[5138]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Apr 23 16:19:16 onkymio volumio[5138]: info: Received Get System Info
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 23 16:19:16 onkymio volumio[5138]: info: Discovery: Getting this device information
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:16 onkymio volumio[5138]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:16 onkymio volumio[5138]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:16 onkymio volumio[5138]: info: Listing playlists
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::volumioGetQueue
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreStateMachine::getQueue
Apr 23 16:19:16 onkymio volumio[5138]: info: CorePlayQueue::getQueue
Apr 23 16:19:16 onkymio volumio[5138]: info: Starting Shairport Sync
Apr 23 16:19:16 onkymio volumio[5138]: info: Starting Shairport Sync
Apr 23 16:19:16 onkymio sudo[5335]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 23 16:19:16 onkymio sudo[5335]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:16 onkymio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Apr 23 16:19:16 onkymio systemd[1]: shairport-sync.service: Succeeded.
Apr 23 16:19:16 onkymio volumio[5138]: info: Starting Shairport Sync
Apr 23 16:19:16 onkymio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Apr 23 16:19:16 onkymio sudo[5338]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 23 16:19:16 onkymio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Apr 23 16:19:16 onkymio sudo[5338]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:16 onkymio sudo[5342]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 23 16:19:16 onkymio sudo[5342]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:16 onkymio mpd[5314]: Apr 23 16:19 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Apr 23 16:19:16 onkymio sudo[5335]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:16 onkymio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Apr 23 16:19:16 onkymio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM
Apr 23 16:19:16 onkymio systemd[1]: shairport-sync.service: Succeeded.
Apr 23 16:19:16 onkymio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Apr 23 16:19:16 onkymio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Apr 23 16:19:16 onkymio sudo[5342]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:16 onkymio sudo[5338]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:16 onkymio volumio[5138]: info: Shairport-Sync Started
Apr 23 16:19:16 onkymio volumio[5138]: Error adding Membership: Error: addMembership EINVAL
Apr 23 16:19:16 onkymio volumio[5138]: info: Discovery: this is already registered,  75b29887-8e71-4b40-85d3-7da7e3e6402a
Apr 23 16:19:16 onkymio volumio[5138]: info: Discovery: Found device onkymio
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:16 onkymio volumio[5138]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:16 onkymio volumio[5138]: info: Discovery: Connected to remote: 192.168.1.15
Apr 23 16:19:16 onkymio volumio[5138]: info: Shairport-Sync Started
Apr 23 16:19:16 onkymio volumio[5138]: info: Shairport-Sync Started
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:16 onkymio volumio[5138]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:16 onkymio volumio[5138]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:16 onkymio volumio[5138]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:16 onkymio systemd[1]: Started Music Player Daemon.
Apr 23 16:19:16 onkymio sudo[5305]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:16 onkymio sudo[5296]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:16 onkymio volumio[5138]: info: Completed starting Core Plugins
Apr 23 16:19:16 onkymio volumio[5138]: info: -------------------------------------------
Apr 23 16:19:16 onkymio volumio[5138]: info: -----    MyVolumio plugins startup     ----
Apr 23 16:19:16 onkymio volumio[5138]: info: -------------------------------------------
Apr 23 16:19:16 onkymio volumio[5138]: info: [MyVolumio PluginManager] Fetching plans data....
Apr 23 16:19:16 onkymio volumio[5138]: error: MPD error: The expression evaluated to a falsy value:
Apr 23 16:19:16 onkymio volumio[5138]:   assert.ok(self.idling)
Apr 23 16:19:16 onkymio volumio[5138]: error: The expression evaluated to a falsy value:
Apr 23 16:19:16 onkymio volumio[5138]:   assert.ok(self.idling)
Apr 23 16:19:16 onkymio volumio[5138]: info: MPD running with PID5314
Apr 23 16:19:16 onkymio volumio[5138]:  ,establishing connection
Apr 23 16:19:16 onkymio volumio[5138]: error: updateQueue error: null
Apr 23 16:19:16 onkymio volumio[5138]: error: updateQueue error: null
Apr 23 16:19:17 onkymio volumio[5138]: verbose: New Socket.io Connection to 192.168.1.18 from 192.168.1.1 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Safari/537.36 Total Clients: 7
Apr 23 16:19:18 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 23 16:19:18 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Apr 23 16:19:18 onkymio volumio[5138]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 23 16:19:18 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 23 16:19:18 onkymio volumio[5138]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:18 onkymio volumio[5138]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:18 onkymio volumio[5138]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:18 onkymio volumio[5138]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:18 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Apr 23 16:19:18 onkymio volumio[5138]: info: CoreCommandRouter::volumioGetQueue
Apr 23 16:19:18 onkymio volumio[5138]: info: CoreStateMachine::getQueue
Apr 23 16:19:18 onkymio volumio[5138]: info: CorePlayQueue::getQueue
Apr 23 16:19:18 onkymio volumio[5138]: info: Listing playlists
Apr 23 16:19:18 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Apr 23 16:19:18 onkymio volumio[5138]: info: Received Get System Info
Apr 23 16:19:18 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 23 16:19:18 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 23 16:19:18 onkymio volumio[5138]: info: Discovery: Getting this device information
Apr 23 16:19:18 onkymio volumio[5138]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:18 onkymio volumio[5138]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:18 onkymio volumio[5138]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 23 16:19:18 onkymio volumio[5138]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:18 onkymio volumio[5138]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:19 onkymio volumio-remote-updater[525]: [2024-04-23 16:19:19] [connect] Successful connection
Apr 23 16:19:19 onkymio volumio-remote-updater[525]: [2024-04-23 16:19:19] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1713889159 101
Apr 23 16:19:19 onkymio volumio[5138]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 8
Apr 23 16:19:20 onkymio volumio[5138]: info: Cannot mount NAS NAS at system boot, trial number 2 ,retrying in 5 seconds
Apr 23 16:19:21 onkymio volumio[5138]: info: Preload queue cleared
Apr 23 16:19:21 onkymio volumio[5138]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 23 16:19:21 onkymio volumio[5138]: info: CoreStateMachine::ClearQueue
Apr 23 16:19:21 onkymio volumio[5138]: info: CoreStateMachine::stop
Apr 23 16:19:21 onkymio volumio[5138]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 23 16:19:21 onkymio volumio[5138]: info: CorePlayQueue::clearPlayQueue
Apr 23 16:19:21 onkymio volumio[5138]: info: CorePlayQueue::saveQueue
Apr 23 16:19:21 onkymio volumio[5138]: info: CoreCommandRouter::volumioPushQueue
Apr 23 16:19:21 onkymio volumio[5138]: info: CoreStateMachine::addQueueItems
Apr 23 16:19:21 onkymio volumio[5138]: info: CorePlayQueue::addQueueItems
Apr 23 16:19:21 onkymio volumio[5138]: info: Preload queue cleared
Apr 23 16:19:21 onkymio volumio[5138]: info: Adding Item to queue: qobuz://song/91838024
Apr 23 16:19:21 onkymio volumio[5138]: info: Exploding uri qobuz://song/91838024 in service qobuz
Apr 23 16:19:21 onkymio volumio[5138]: info: Adding Item to queue: NAS/NAS-MUSIC/1975  Murray Head - Say It Ain t So  2017   24-96/01. Say It Ain't So.flac
Apr 23 16:19:21 onkymio volumio[5138]: info: Exploding uri NAS/NAS-MUSIC/1975  Murray Head - Say It Ain t So  2017   24-96/01. Say It Ain't So.flac in service mpd
Apr 23 16:19:21 onkymio volumio[5138]: error: scanFolder - failure to stat '/mnt/NAS/NAS-MUSIC/1975  Murray Head - Say It Ain t So  2017   24-96/01. Say It Ain't So.flac'
Apr 23 16:19:21 onkymio volumio[5138]: info: Adding Item to queue: NAS/NAS-MUSIC/1976 Genesis - A Trick Of The Tail-DSD/05 - Robbery, Assault And Battery.dsf
Apr 23 16:19:21 onkymio volumio[5138]: info: Exploding uri NAS/NAS-MUSIC/1976 Genesis - A Trick Of The Tail-DSD/05 - Robbery, Assault And Battery.dsf in service mpd
Apr 23 16:19:21 onkymio volumio[5138]: error: scanFolder - failure to stat '/mnt/NAS/NAS-MUSIC/1976 Genesis - A Trick Of The Tail-DSD/05 - Robbery, Assault And Battery.dsf'
Apr 23 16:19:21 onkymio volumio[5138]: info: Adding Item to queue: NAS/NAS-MUSIC/1976 Genesis - A Trick Of The Tail-DSD/06 - Ripples.dsf
Apr 23 16:19:21 onkymio volumio[5138]: info: Exploding uri NAS/NAS-MUSIC/1976 Genesis - A Trick Of The Tail-DSD/06 - Ripples.dsf in service mpd
Apr 23 16:19:21 onkymio volumio[5138]: error: scanFolder - failure to stat '/mnt/NAS/NAS-MUSIC/1976 Genesis - A Trick Of The Tail-DSD/06 - Ripples.dsf'
Apr 23 16:19:21 onkymio volumio[5138]: info: Adding Item to queue: cue://NAS/NAS-MUSIC/1977 - Fleetwood Mac - Rumours (1988, Warner-Pioneer, Japan, 20P2-2036)/Fleetwood Mac - Rumours.cue@4
Apr 23 16:19:21 onkymio volumio[5138]: info: Exploding uri cue://NAS/NAS-MUSIC/1977 - Fleetwood Mac - Rumours (1988, Warner-Pioneer, Japan, 20P2-2036)/Fleetwood Mac - Rumours.cue@4 in service mpd
Apr 23 16:19:21 onkymio volumio[5138]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 23 16:19:21 onkymio volumio[5138]: Error: file /mnt/NAS/NAS-MUSIC/1977 - Fleetwood Mac - Rumours (1988, Warner-Pioneer, Japan, 20P2-2036)/Fleetwood Mac - Rumours.cue does not exist
Apr 23 16:19:21 onkymio volumio[5138]:     at Object.parse (/volumio/node_modules/cue-parser/lib/cue.js:37:15)
Apr 23 16:19:21 onkymio volumio[5138]:     at ControllerMpd.explodeUri (/volumio/app/plugins/music_service/mpd/index.js:1924:27)
Apr 23 16:19:21 onkymio volumio[5138]:     at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1359:16)
Apr 23 16:19:21 onkymio volumio[5138]:     at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24)
Apr 23 16:19:21 onkymio volumio[5138]:     at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19)
Apr 23 16:19:21 onkymio volumio[5138]:     at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:223:30)
Apr 23 16:19:21 onkymio volumio[5138]:     at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:247:25)
Apr 23 16:19:21 onkymio volumio[5138]:     at CoreCommandRouter.replaceAndPlay (/volumio/app/index.js:501:23)
Apr 23 16:19:21 onkymio volumio[5138]:     at CoreCommandRouter.playItemsList (/volumio/app/index.js:477:17)
Apr 23 16:19:21 onkymio volumio[5138]:     at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:118:33)
Apr 23 16:19:21 onkymio volumio[5138]:     at Socket.emit (events.js:400:28)
Apr 23 16:19:21 onkymio volumio[5138]:     at /volumio/node_modules/socket.io/lib/socket.js:503:12
Apr 23 16:19:21 onkymio volumio[5138]:     at processTicksAndRejections (internal/process/task_queues.js:77:11)
Apr 23 16:19:21 onkymio volumio[5138]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 23 16:19:21 onkymio sudo[5361]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-23 16:18
Apr 23 16:19:21 onkymio sudo[5361]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:21 onkymio sudo[5361]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:21 onkymio volumio-remote-updater[525]: [2024-04-23 16:19:21] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Apr 23 16:19:21 onkymio volumio-remote-updater[525]: [2024-04-23 16:19:21] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Apr 23 16:19:21 onkymio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Apr 23 16:19:21 onkymio systemd[1]: volumio.service: Failed with result 'exit-code'.
Apr 23 16:19:21 onkymio systemd[1]: Started dynamicswap service.
Apr 23 16:19:21 onkymio systemd[1]: dynamicswap.service: Succeeded.
Apr 23 16:19:22 onkymio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
Apr 23 16:19:22 onkymio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 3.
Apr 23 16:19:22 onkymio systemd[1]: Started dynamicswap service.
Apr 23 16:19:22 onkymio systemd[1]: Stopped Volumio Backend Module.
Apr 23 16:19:22 onkymio systemd[1]: Started Volumio Backend Module.
Apr 23 16:19:22 onkymio systemd[1]: dynamicswap.service: Succeeded.
Apr 23 16:19:22 onkymio volumio[5372]: info: -------------------------------------------
Apr 23 16:19:22 onkymio volumio[5372]: info: -----            Volumio3              ----
Apr 23 16:19:22 onkymio volumio[5372]: info: -------------------------------------------
Apr 23 16:19:22 onkymio volumio[5372]: info: -----          System startup          ----
Apr 23 16:19:22 onkymio volumio[5372]: info: -------------------------------------------
Apr 23 16:19:22 onkymio volumio[5372]: info: MYVOLUMIO Environment detected
Apr 23 16:19:22 onkymio volumio[5372]: info: Plugin folders cleanup
Apr 23 16:19:22 onkymio volumio[5372]: info: Scanning into folder /volumio/app/plugins/
Apr 23 16:19:22 onkymio volumio[5372]: info: Scanning category audio_interface
Apr 23 16:19:22 onkymio volumio[5372]: info: Scanning category miscellanea
Apr 23 16:19:22 onkymio volumio[5372]: info: Scanning category music_service
Apr 23 16:19:22 onkymio volumio[5372]: info: Scanning category plugins.json
Apr 23 16:19:22 onkymio volumio[5372]: info: Scanning category system_controller
Apr 23 16:19:22 onkymio volumio[5372]: info: Scanning category user_interface
Apr 23 16:19:22 onkymio volumio[5372]: info: Scanning into folder /data/plugins/
Apr 23 16:19:22 onkymio volumio[5372]: info: Scanning category audio_interface
Apr 23 16:19:22 onkymio volumio[5372]: info: Scanning category music_service
Apr 23 16:19:22 onkymio volumio[5372]: info: Scanning category user_interface
Apr 23 16:19:22 onkymio volumio[5372]: info: Plugin folders cleanup completed
Apr 23 16:19:22 onkymio volumio[5372]: info: -------------------------------------------
Apr 23 16:19:22 onkymio volumio[5372]: info: -----      Core plugins startup        ----
Apr 23 16:19:22 onkymio volumio[5372]: info: -------------------------------------------
Apr 23 16:19:22 onkymio volumio[5372]: info: Loading plugins from folder /volumio/app/plugins/
Apr 23 16:19:22 onkymio volumio[5372]: info: Adding plugin upnp to MyMusic Plugins
Apr 23 16:19:22 onkymio volumio[5372]: info: Adding plugin airplay_emulation to MyMusic Plugins
Apr 23 16:19:22 onkymio volumio[5372]: info: Adding plugin upnp_browser to MyMusic Plugins
Apr 23 16:19:22 onkymio volumio[5372]: info: Loading plugins from folder /data/plugins/
Apr 23 16:19:22 onkymio volumio[5372]: info: Loading plugin "system"...
Apr 23 16:19:22 onkymio volumio[5372]: info: Loading plugin "appearance"...
Apr 23 16:19:22 onkymio volumio[5372]: info: Loading plugin "network"...
Apr 23 16:19:22 onkymio volumio[5372]: info: Refreshing Cached IP Addresses
Apr 23 16:19:22 onkymio sudo[5398]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 23 16:19:22 onkymio sudo[5398]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:22 onkymio sudo[5398]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:22 onkymio sudo[5400]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 23 16:19:22 onkymio sudo[5400]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:22 onkymio volumio[5372]: info: Loading plugin "services"...
Apr 23 16:19:22 onkymio volumio[5372]: info: Loading plugin "alsa_controller"...
Apr 23 16:19:22 onkymio sudo[5403]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Apr 23 16:19:22 onkymio sudo[5403]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:22 onkymio sudo[5400]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:22 onkymio sudo[5403]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:22 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 23 16:19:22 onkymio volumio[5372]: info: Loading plugin "wizard"...
Apr 23 16:19:22 onkymio volumio[5372]: info: Loading plugin "networkfs"...
Apr 23 16:19:22 onkymio volumio[5372]: info: Cannot mount NAS NAS at system boot, trial number 1 ,retrying in 5 seconds
Apr 23 16:19:22 onkymio volumio[5372]: info: Starting Udev Watcher for removable devices
Apr 23 16:19:22 onkymio volumio[5372]: info: Ignoring mount for partition: boot
Apr 23 16:19:22 onkymio volumio[5372]: info: Ignoring mount for partition: volumio
Apr 23 16:19:22 onkymio volumio[5372]: info: Ignoring mount for partition: volumio_data
Apr 23 16:19:22 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 23 16:19:22 onkymio volumio[5372]: info: Loading plugin "volumio_command_line_client"...
Apr 23 16:19:22 onkymio volumio[5372]: info: Loading plugin "upnp"...
Apr 23 16:19:22 onkymio volumio[5372]: info: [1713889162661] Starting Upmpd Daemon
Apr 23 16:19:22 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 23 16:19:22 onkymio volumio[5372]: info: Loading plugin "my_music"...
Apr 23 16:19:22 onkymio volumio[5372]: info: Loading plugin "mpd"...
Apr 23 16:19:22 onkymio volumio[5372]: info: Loading plugin "upnp_browser"...
Apr 23 16:19:22 onkymio volumio[5372]: info: Loading plugin "alarm-clock"...
Apr 23 16:19:22 onkymio volumio[5372]: info: Loading plugin "airplay_emulation"...
Apr 23 16:19:22 onkymio volumio[5372]: info: Starting Shairport Sync
Apr 23 16:19:22 onkymio volumio[5372]: info: Loading plugin "last_100"...
Apr 23 16:19:22 onkymio volumio[5372]: info: Loading plugin "webradio"...
Apr 23 16:19:22 onkymio volumio[5372]: info: Loading plugin "i2s_dacs"...
Apr 23 16:19:22 onkymio volumio[5372]: info: I2S DAC not set, start Auto-detection
Apr 23 16:19:22 onkymio volumio[5372]: info: Loading plugin "volumiodiscovery"...
Apr 23 16:19:22 onkymio volumio[5372]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 23 16:19:22 onkymio volumio[5372]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 23 16:19:22 onkymio volumio[5372]: *** WARNING *** For more information see 
Apr 23 16:19:22 onkymio volumio[5372]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 23 16:19:22 onkymio volumio[5372]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 23 16:19:22 onkymio volumio[5372]: *** WARNING *** For more information see 
Apr 23 16:19:22 onkymio node[5372]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 23 16:19:22 onkymio node[5372]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 23 16:19:22 onkymio node[5372]: *** WARNING *** For more information see 
Apr 23 16:19:22 onkymio node[5372]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 23 16:19:22 onkymio node[5372]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 23 16:19:22 onkymio node[5372]: *** WARNING *** For more information see 
Apr 23 16:19:22 onkymio volumio[5372]: info: Applying required configuration parameters for plugin volumiodiscovery
Apr 23 16:19:22 onkymio volumio[5372]: info: Discovery: Started advertising with name: onkymio
Apr 23 16:19:22 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 23 16:19:22 onkymio volumio[5372]: info: Loading plugin "youtube2"...
Apr 23 16:19:22 onkymio volumio[5372]: info: Loading plugin "now_playing"...
Apr 23 16:19:23 onkymio volumio[5372]: info: Loading plugin "outputs"...
Apr 23 16:19:23 onkymio volumio[5372]: info: Loading plugin "albumart"...
Apr 23 16:19:23 onkymio volumio[5372]: info: Plugin example_plugin is not enabled
Apr 23 16:19:23 onkymio volumio[5372]: info: Loading plugin "inputs"...
Apr 23 16:19:23 onkymio volumio[5372]: info: Loading plugin "updater_comm"...
Apr 23 16:19:23 onkymio volumio[5372]: info: Plugin mpdemulation is not enabled
Apr 23 16:19:23 onkymio volumio[5372]: info: Loading plugin "rest_api"...
Apr 23 16:19:23 onkymio volumio[5372]: info: Loading plugin "websocket"...
Apr 23 16:19:23 onkymio volumio[5372]: Forking 3 albumart workers
Apr 23 16:19:23 onkymio volumio[5372]: info: Plugin fusiondsp is not enabled
Apr 23 16:19:23 onkymio volumio[5372]: info: Loading plugin "Systeminfo"...
Apr 23 16:19:23 onkymio volumio[5372]: info: Loading plugin "randomizer"...
Apr 23 16:19:23 onkymio volumio[5372]: Starting albumart workers
Apr 23 16:19:23 onkymio volumio[5372]: Starting albumart workers
Apr 23 16:19:23 onkymio volumio[5372]: Starting albumart workers
Apr 23 16:19:23 onkymio volumio[5372]: info: Applying required configuration parameters for plugin randomizer
Apr 23 16:19:23 onkymio volumio[5372]: info: Loading i18n strings for locale fr
Apr 23 16:19:23 onkymio volumio[5372]: Updating browse sources language
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::initPlayerControls
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 23 16:19:23 onkymio volumio[5372]: Express server listening on port 3000
Apr 23 16:19:23 onkymio volumio[5372]:  [Metrics]  WebUI:  1s 20.27ms 
Apr 23 16:19:23 onkymio volumio[5372]: info: Setting Device type: x86
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreStateMachine::resetVolumioState
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreStateMachine::getcurrentVolume
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::volumioRetrievevolume
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 16:19:23 onkymio volumio[5372]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt'
Apr 23 16:19:23 onkymio volumio[5372]: info: Completed loading Core Plugins
Apr 23 16:19:23 onkymio volumio[5372]: info: Preparing to generate the ALSA configuration file
Apr 23 16:19:23 onkymio volumio[5372]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan
Apr 23 16:19:23 onkymio volumio[5372]: wlan0     Interface doesn't support scanning.
Apr 23 16:19:23 onkymio volumio[5372]: info: Cannot use regular scanning, forcing with ap-force
Apr 23 16:19:23 onkymio sudo[5466]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force
Apr 23 16:19:23 onkymio sudo[5466]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:23 onkymio sudo[5466]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:23 onkymio volumio[5372]: command failed: No such device (-19)
Apr 23 16:19:23 onkymio volumio[5372]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force
Apr 23 16:19:23 onkymio volumio[5372]: command failed: No such device (-19)
Apr 23 16:19:23 onkymio volumio[5372]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision
Apr 23 16:19:23 onkymio volumio[5372]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Total Clients: 1
Apr 23 16:19:23 onkymio volumio[5372]: verbose: New Socket.io Connection to 192.168.1.18 from 192.168.1.175 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Safari/537.36 Total Clients: 2
Apr 23 16:19:23 onkymio volumio[5372]: verbose: New Socket.io Connection to 192.168.1.18 from 192.168.1.1 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Safari/537.36 Total Clients: 3
Apr 23 16:19:23 onkymio volumio[5372]: info: Reloading queue from file
Apr 23 16:19:23 onkymio volumio[5372]: info: Asound.conf file unchanged, so no further update is needed
Apr 23 16:19:23 onkymio volumio[5372]: info: Output device has changed, restarting MPD
Apr 23 16:19:23 onkymio sudo[5482]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 23 16:19:23 onkymio sudo[5482]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:23 onkymio sudo[5482]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:23 onkymio volumio[5372]: info: Output device has changed, restarting Shairport Sync
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 16:19:23 onkymio sudo[5485]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 23 16:19:23 onkymio sudo[5485]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:23 onkymio systemd[1]: Stopping Music Player Daemon...
Apr 23 16:19:23 onkymio volumio[5372]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 23 16:19:23 onkymio volumio[5372]: info: ___________ START PLUGINS ___________
Apr 23 16:19:23 onkymio volumio[5372]: info: ControllerMpd::onStart: Initializing MPD
Apr 23 16:19:23 onkymio volumio[5372]: info: Creating MPD Configuration file
Apr 23 16:19:23 onkymio sudo[5491]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 23 16:19:23 onkymio sudo[5491]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:23 onkymio sudo[5491]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 23 16:19:23 onkymio volumio[5372]: info: [1713889163483] CoreMusicLibrary::Adding element Serveurs Média
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 23 16:19:23 onkymio sudo[5494]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 23 16:19:23 onkymio sudo[5494]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 16:19:23 onkymio systemd[1]: mpd.service: Succeeded.
Apr 23 16:19:23 onkymio systemd[1]: Stopped Music Player Daemon.
Apr 23 16:19:23 onkymio volumio[5372]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 16:19:23 onkymio volumio[5372]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 23 16:19:23 onkymio volumio[5372]: info: [1713889163509] CoreMusicLibrary::Adding element Last_100
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 23 16:19:23 onkymio volumio[5372]: info: [1713889163510] CoreMusicLibrary::Adding element Webradio
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 23 16:19:23 onkymio volumio[5372]: info: [1713889163512] CoreMusicLibrary::Adding element YouTube2
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 23 16:19:23 onkymio volumio[5372]: Cannot find translation for source YouTube2
Apr 23 16:19:23 onkymio systemd[1]: Starting Music Player Daemon...
Apr 23 16:19:23 onkymio volumio[5372]: info: [now-playing-config] Config is up to date.
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 23 16:19:23 onkymio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Apr 23 16:19:23 onkymio systemd[1]: mpd.service: Succeeded.
Apr 23 16:19:23 onkymio volumio[5372]: info: Discovery: Getting this device information
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:23 onkymio systemd[1]: Stopped Music Player Daemon.
Apr 23 16:19:23 onkymio volumio[5372]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 23 16:19:23 onkymio systemd[1]: Starting Music Player Daemon...
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 23 16:19:23 onkymio volumio[5372]: info: [1713889163526] CoreMusicLibrary::Adding element Randomizer
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 23 16:19:23 onkymio volumio[5372]: Cannot find translation for source YouTube2
Apr 23 16:19:23 onkymio volumio[5372]: Cannot find translation for source Randomizer
Apr 23 16:19:23 onkymio volumio[5372]: info: Volumio Calling Home
Apr 23 16:19:23 onkymio volumio[5372]: info: [now-playing-app] App is listening on port 4004.
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreStateMachine::setRepeat null single undefined
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreStateMachine::pushState
Apr 23 16:19:23 onkymio volumio[5372]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::volumioPushState
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreStateMachine::setRandom null
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreStateMachine::pushState
Apr 23 16:19:23 onkymio volumio[5372]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::volumioPushState
Apr 23 16:19:23 onkymio volumio[5372]: info: VolumeController:: Volume=100 Mute =false
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreStateMachine::pushState
Apr 23 16:19:23 onkymio volumio[5372]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::volumioPushState
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreStateMachine::updateTrackBlock
Apr 23 16:19:23 onkymio volumio[5372]: info: CorePlayQueue::getTrackBlock
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::volumioRetrievevolume
Apr 23 16:19:23 onkymio volumio[5372]: info: MPD Permissions set
Apr 23 16:19:23 onkymio volumio[5372]: info: MPD Permissions set
Apr 23 16:19:23 onkymio volumio[5372]: info: Discovery: adding 6fb6de89-7df4-4f83-a1e7-db4f383d3a13
Apr 23 16:19:23 onkymio volumio[5372]: info: Discovery: Found device accuphasumio
Apr 23 16:19:23 onkymio volumio[5372]: info: Discovery: Connecting to remote: 192.168.1.15
Apr 23 16:19:23 onkymio volumio[5372]: info: Discovery: A device disappeared from network
Apr 23 16:19:23 onkymio volumio[5372]: info: Discovery: Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined
Apr 23 16:19:23 onkymio volumio[5372]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 4
Apr 23 16:19:23 onkymio volumio[5372]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 5
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 23 16:19:23 onkymio volumio[5372]: info: VolumeController:: Volume=100 Mute =false
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreStateMachine::pushState
Apr 23 16:19:23 onkymio volumio[5372]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::volumioPushState
Apr 23 16:19:23 onkymio volumio[5372]: info: Volumio called home
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:23 onkymio volumio[5372]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:23 onkymio volumio[5372]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Apr 23 16:19:23 onkymio volumio[5372]: info: Received Get System Info
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 23 16:19:23 onkymio volumio[5372]: info: Discovery: Getting this device information
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:23 onkymio volumio[5372]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:23 onkymio volumio[5372]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:23 onkymio volumio[5372]: info: Listing playlists
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::volumioGetQueue
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreStateMachine::getQueue
Apr 23 16:19:23 onkymio volumio[5372]: info: CorePlayQueue::getQueue
Apr 23 16:19:23 onkymio volumio[5372]: info: Discovery: adding 75b29887-8e71-4b40-85d3-7da7e3e6402a
Apr 23 16:19:23 onkymio volumio[5372]: info: Discovery: Found device onkymio
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:23 onkymio volumio[5372]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:23 onkymio volumio[5372]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:23 onkymio volumio[5372]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::volumioGetQueue
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreStateMachine::getQueue
Apr 23 16:19:23 onkymio volumio[5372]: info: CorePlayQueue::getQueue
Apr 23 16:19:23 onkymio volumio[5372]: info: Listing playlists
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Apr 23 16:19:23 onkymio volumio[5372]: info: Received Get System Info
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 23 16:19:23 onkymio volumio[5372]: info: Discovery: Getting this device information
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:23 onkymio volumio[5372]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:23 onkymio volumio[5372]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:23 onkymio volumio[5372]: verbose: New Socket.io Connection to 192.168.1.18:3000 from 192.168.1.15 UA: node-XMLHttpRequest Total Clients: 6
Apr 23 16:19:23 onkymio volumio[5372]: info: Starting Shairport Sync
Apr 23 16:19:23 onkymio volumio[5372]: info: Starting Shairport Sync
Apr 23 16:19:23 onkymio sudo[5523]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 23 16:19:23 onkymio sudo[5523]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:23 onkymio volumio[5372]: info: Starting Shairport Sync
Apr 23 16:19:23 onkymio sudo[5526]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 23 16:19:23 onkymio sudo[5526]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:23 onkymio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Apr 23 16:19:23 onkymio systemd[1]: shairport-sync.service: Succeeded.
Apr 23 16:19:23 onkymio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Apr 23 16:19:23 onkymio sudo[5530]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 23 16:19:23 onkymio sudo[5530]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:23 onkymio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Apr 23 16:19:23 onkymio volumio[5372]: info: Discovery: Connected to remote: 192.168.1.15
Apr 23 16:19:23 onkymio sudo[5523]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:23 onkymio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Apr 23 16:19:23 onkymio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM
Apr 23 16:19:23 onkymio systemd[1]: shairport-sync.service: Succeeded.
Apr 23 16:19:23 onkymio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Apr 23 16:19:23 onkymio mpd[5504]: Apr 23 16:19 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Apr 23 16:19:23 onkymio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Apr 23 16:19:23 onkymio sudo[5530]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:23 onkymio sudo[5526]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:23 onkymio volumio[5372]: info: Shairport-Sync Started
Apr 23 16:19:23 onkymio volumio[5372]: Error adding Membership: Error: addMembership EINVAL
Apr 23 16:19:23 onkymio volumio[5372]: info: Shairport-Sync Started
Apr 23 16:19:23 onkymio volumio[5372]: info: Shairport-Sync Started
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:23 onkymio volumio[5372]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:23 onkymio volumio[5372]: info: Discovery: this is already registered,  75b29887-8e71-4b40-85d3-7da7e3e6402a
Apr 23 16:19:23 onkymio volumio[5372]: info: Discovery: Found device onkymio
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:23 onkymio volumio[5372]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket
Apr 23 16:19:23 onkymio volumio[5372]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:23 onkymio volumio[5372]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:24 onkymio systemd[1]: Started Music Player Daemon.
Apr 23 16:19:24 onkymio sudo[5494]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:24 onkymio sudo[5485]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:24 onkymio volumio[5372]: info: Completed starting Core Plugins
Apr 23 16:19:24 onkymio volumio[5372]: info: -------------------------------------------
Apr 23 16:19:24 onkymio volumio[5372]: info: -----    MyVolumio plugins startup     ----
Apr 23 16:19:24 onkymio volumio[5372]: info: -------------------------------------------
Apr 23 16:19:24 onkymio volumio[5372]: info: [MyVolumio PluginManager] Fetching plans data....
Apr 23 16:19:24 onkymio volumio[5372]: info: MPD running with PID5504
Apr 23 16:19:24 onkymio volumio[5372]:  ,establishing connection
Apr 23 16:19:24 onkymio volumio[5372]: error: MPD error: The expression evaluated to a falsy value:
Apr 23 16:19:24 onkymio volumio[5372]:   assert.ok(self.idling)
Apr 23 16:19:24 onkymio volumio[5372]: error: The expression evaluated to a falsy value:
Apr 23 16:19:24 onkymio volumio[5372]:   assert.ok(self.idling)
Apr 23 16:19:24 onkymio volumio[5372]: error: MPD error: The expression evaluated to a falsy value:
Apr 23 16:19:24 onkymio volumio[5372]:   assert.ok(self.idling)
Apr 23 16:19:24 onkymio volumio[5372]: error: The expression evaluated to a falsy value:
Apr 23 16:19:24 onkymio volumio[5372]:   assert.ok(self.idling)
Apr 23 16:19:24 onkymio volumio[5372]: error: updateQueue error: null
Apr 23 16:19:24 onkymio volumio[5372]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Total Clients: 7
Apr 23 16:19:24 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 23 16:19:24 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Apr 23 16:19:24 onkymio volumio[5372]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 23 16:19:24 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 23 16:19:24 onkymio volumio[5372]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:24 onkymio volumio[5372]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:24 onkymio volumio[5372]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:24 onkymio volumio[5372]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:24 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Apr 23 16:19:24 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Apr 23 16:19:24 onkymio volumio[5372]: info: Received Get System Info
Apr 23 16:19:24 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 23 16:19:24 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 23 16:19:24 onkymio volumio[5372]: info: Discovery: Getting this device information
Apr 23 16:19:24 onkymio volumio[5372]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:24 onkymio volumio[5372]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:24 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 23 16:19:24 onkymio volumio[5372]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:24 onkymio volumio[5372]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:24 onkymio volumio[5372]: info: Listing playlists
Apr 23 16:19:26 onkymio volumio-remote-updater[525]: [2024-04-23 16:19:26] [connect] Successful connection
Apr 23 16:19:26 onkymio volumio-remote-updater[525]: [2024-04-23 16:19:26] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1713889166 101
Apr 23 16:19:26 onkymio volumio[5372]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 8
Apr 23 16:19:27 onkymio volumio[5372]: info: Cannot mount NAS NAS at system boot, trial number 2 ,retrying in 5 seconds
Apr 23 16:19:29 onkymio volumio[5372]: error: Failed LSINFO: Error:  [50@0] {lsinfo} No such directory
Apr 23 16:19:31 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 23 16:19:31 onkymio volumio[5372]: info: CURURI: playlists
Apr 23 16:19:31 onkymio volumio[5372]: info: Listing playlists
Apr 23 16:19:32 onkymio volumio[5372]: info: Preload queue cleared
Apr 23 16:19:32 onkymio volumio[5372]: info: Cannot mount NAS NAS at system boot, trial number 3 ,retrying in 5 seconds
Apr 23 16:19:32 onkymio sudo[5541]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 23 16:19:32 onkymio sudo[5541]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:32 onkymio sudo[5541]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:32 onkymio sudo[5544]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 23 16:19:32 onkymio sudo[5544]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:32 onkymio sudo[5544]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:34 onkymio sudo[5549]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Apr 23 16:19:34 onkymio sudo[5549]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:34 onkymio volumio[5372]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
Apr 23 16:19:34 onkymio volumio[5372]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
Apr 23 16:19:34 onkymio volumio[5372]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
Apr 23 16:19:34 onkymio volumio[5372]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
Apr 23 16:19:34 onkymio volumio[5372]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
Apr 23 16:19:34 onkymio volumio[5372]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
Apr 23 16:19:34 onkymio volumio[5372]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
Apr 23 16:19:34 onkymio volumio[5372]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
Apr 23 16:19:34 onkymio volumio[5372]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
Apr 23 16:19:34 onkymio volumio[5372]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
Apr 23 16:19:34 onkymio volumio[5372]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
Apr 23 16:19:34 onkymio volumio[5372]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
Apr 23 16:19:34 onkymio volumio[5372]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
Apr 23 16:19:34 onkymio volumio[5372]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
Apr 23 16:19:34 onkymio volumio[5372]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
Apr 23 16:19:34 onkymio volumio[5372]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
Apr 23 16:19:34 onkymio volumio[5372]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
Apr 23 16:19:34 onkymio volumio[5372]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
Apr 23 16:19:34 onkymio volumio[5372]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
Apr 23 16:19:34 onkymio volumio[5372]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
Apr 23 16:19:34 onkymio volumio[5372]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
Apr 23 16:19:34 onkymio volumio[5372]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
Apr 23 16:19:34 onkymio volumio[5372]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
Apr 23 16:19:34 onkymio volumio[5372]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
Apr 23 16:19:34 onkymio volumio[5372]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
Apr 23 16:19:34 onkymio volumio[5372]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
Apr 23 16:19:34 onkymio sudo[5549]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:34 onkymio volumio[5372]: info: Adding plugin bluetooth to MyMusic Plugins
Apr 23 16:19:34 onkymio volumio[5372]: info: Adding plugin multiroom to MyMusic Plugins
Apr 23 16:19:34 onkymio volumio[5372]: info: Adding plugin metavolumio to MyMusic Plugins
Apr 23 16:19:34 onkymio volumio[5372]: info: Adding plugin cd_controller to MyMusic Plugins
Apr 23 16:19:34 onkymio volumio[5372]: info: Adding plugin smart_inputs to MyMusic Plugins
Apr 23 16:19:34 onkymio volumio[5372]: info: Adding plugin tidalconnect to MyMusic Plugins
Apr 23 16:19:34 onkymio volumio[5372]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
Apr 23 16:19:34 onkymio volumio[5372]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
Apr 23 16:19:34 onkymio volumio[5372]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
Apr 23 16:19:34 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 16:19:34 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 16:19:34 onkymio volumio[5372]: info: Starting MyVolumio Remote Streaming Endpoints
Apr 23 16:19:34 onkymio volumio[5372]: info: MyVolumio login type: Token
Apr 23 16:19:34 onkymio volumio[5372]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
Apr 23 16:19:34 onkymio volumio[5372]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
Apr 23 16:19:34 onkymio volumio[5372]: info: Starting Streaming Service Transparent Proxy
Apr 23 16:19:34 onkymio volumio[5372]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Apr 23 16:19:34 onkymio volumio[5372]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Apr 23 16:19:34 onkymio volumio[5372]: info: Streaming services startup
Apr 23 16:19:34 onkymio volumio[5372]: info: Starting Streaming Daemon
Apr 23 16:19:34 onkymio sudo[5559]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Apr 23 16:19:34 onkymio sudo[5559]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:34 onkymio sudo[5559]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:35 onkymio volumio[5372]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
Apr 23 16:19:35 onkymio volumio[5372]: STREAMING PROXY: Starting server on port 3245
Apr 23 16:19:35 onkymio volumio[5372]: Node JS runtime: 14
Apr 23 16:19:35 onkymio volumio[5372]: error: Cannot start Volumio Streaming Daemon
Apr 23 16:19:35 onkymio volumio[5372]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Apr 23 16:19:35 onkymio volumio[5372]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Apr 23 16:19:35 onkymio volumio[5372]: info: Upmpdcli Daemon Started
Apr 23 16:19:35 onkymio volumio[5372]: Cannot compose Albumart path
Apr 23 16:19:36 onkymio volumio[5372]: error: MyVolumio Custom Token format not valid, refreshing it
Apr 23 16:19:36 onkymio volumio[5372]: info: MyVolumio login type: Token
Apr 23 16:19:37 onkymio volumio[5372]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN
Apr 23 16:19:37 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 23 16:19:37 onkymio volumio[5372]: info: CURURI: playlists/qobuzz-70s
Apr 23 16:19:37 onkymio volumio[5372]: info: Preload queue cleared
Apr 23 16:19:37 onkymio volumio[5372]: info: Preloading song: qobuz://song/3376705
Apr 23 16:19:37 onkymio volumio[5372]: info: Preloading song: qobuz://song/12359320
Apr 23 16:19:37 onkymio volumio[5372]: info: Preloading song: qobuz://song/103457739
Apr 23 16:19:37 onkymio volumio[5372]: info: Preloading song: qobuz://song/21733124
Apr 23 16:19:37 onkymio volumio[5372]: info: Preloading song: qobuz://song/137387
Apr 23 16:19:37 onkymio volumio[5372]: info: Preloading song: qobuz://song/26740
Apr 23 16:19:37 onkymio volumio[5372]: info: Preloading song: qobuz://song/3376705
Apr 23 16:19:37 onkymio volumio[5372]: info: Preloading song: qobuz://song/775014
Apr 23 16:19:37 onkymio volumio[5372]: info: Preloading song: qobuz://song/765404
Apr 23 16:19:37 onkymio volumio[5372]: info: Preloading song: qobuz://song/48893312
Apr 23 16:19:37 onkymio volumio[5372]: info: Preloading song: qobuz://song/2177583
Apr 23 16:19:37 onkymio volumio[5372]: info: Exploding uri qobuz://song/3376705 in service qobuz
Apr 23 16:19:37 onkymio volumio[5372]: info: MyVolumio token set successfully
Apr 23 16:19:37 onkymio volumio[5372]: info: MYVOLUMIO: Adding device
Apr 23 16:19:37 onkymio volumio[5372]: info: MYVOLUMIO: Evaluating Server
Apr 23 16:19:37 onkymio volumio[5372]: info: Exploding uri qobuz://song/12359320 in service qobuz
Apr 23 16:19:37 onkymio volumio[5372]: info: Exploding uri qobuz://song/103457739 in service qobuz
Apr 23 16:19:37 onkymio volumio[5372]: info: MyVolumio Plan changed: premium
Apr 23 16:19:37 onkymio volumio[5372]: info: [MyVolumio PluginManager] Subscribed plan changed to premium
Apr 23 16:19:37 onkymio volumio[5372]: info: Removing browser output: myVolumio user plan is not superstar
Apr 23 16:19:37 onkymio volumio[5372]: info: Removing audio output:
Apr 23 16:19:37 onkymio volumio[5372]: info: MYVOLUMIO: Adding device
Apr 23 16:19:37 onkymio volumio[5372]: info: MYVOLUMIO: Evaluating Server
Apr 23 16:19:37 onkymio volumio[5372]: info: Exploding uri qobuz://song/21733124 in service qobuz
Apr 23 16:19:37 onkymio volumio[5372]: info: Cannot mount NAS NAS at system boot, trial number 4 ,retrying in 5 seconds
Apr 23 16:19:37 onkymio volumio[5372]: info: Exploding uri qobuz://song/137387 in service qobuz
Apr 23 16:19:37 onkymio volumio[5372]: info: Exploding uri qobuz://song/26740 in service qobuz
Apr 23 16:19:37 onkymio volumio[5372]: info: Exploding uri qobuz://song/3376705 in service qobuz
Apr 23 16:19:37 onkymio volumio[5372]: info: Remote config written successfully
Apr 23 16:19:37 onkymio volumio[5372]: info: Starting Tunnel 1
Apr 23 16:19:37 onkymio volumio[5372]: info: Starting Tunnel Connection Checker
Apr 23 16:19:37 onkymio volumio[5372]: info: Completed starting MyVolumio Plugin
Apr 23 16:19:37 onkymio volumio[5372]: info: Exploding uri qobuz://song/775014 in service qobuz
Apr 23 16:19:37 onkymio volumio[5372]: info: Exploding uri qobuz://song/765404 in service qobuz
Apr 23 16:19:38 onkymio volumio[5372]: info: Exploding uri qobuz://song/48893312 in service qobuz
Apr 23 16:19:38 onkymio volumio[5372]: info: Exploding uri qobuz://song/2177583 in service qobuz
Apr 23 16:19:38 onkymio volumio[5372]: info: MYVolumio Device enabled
Apr 23 16:19:38 onkymio volumio[5372]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins...
Apr 23 16:19:38 onkymio volumio[5372]: info: MyVolumio status changed
Apr 23 16:19:38 onkymio volumio[5372]: info: Streaming services startup
Apr 23 16:19:38 onkymio volumio[5372]: info: Starting Streaming Daemon
Apr 23 16:19:38 onkymio sudo[5598]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Apr 23 16:19:38 onkymio sudo[5598]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:38 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid
Apr 23 16:19:38 onkymio sudo[5598]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:38 onkymio volumio[5372]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"...
Apr 23 16:19:38 onkymio volumio[5372]: info: [1713889178193] Starting BluetoothController
Apr 23 16:19:38 onkymio volumio[5372]: info: [MyVolumio PluginManager] Loading plugin "multiroom"...
Apr 23 16:19:38 onkymio volumio[5372]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom
Apr 23 16:19:38 onkymio sudo[5601]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom
Apr 23 16:19:38 onkymio sudo[5601]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:38 onkymio sudo[5601]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:38 onkymio volumio[5372]: /bin/mkdir: cannot create directory ‘/tmp/hls’: File exists
Apr 23 16:19:38 onkymio volumio[5372]: info: MRS: MultiRoom plugin initialized
Apr 23 16:19:38 onkymio volumio[5372]: info: MRS: STOPPING SNAPCLIENT
Apr 23 16:19:38 onkymio volumio[5372]: info: MRS: Snap server stop
Apr 23 16:19:38 onkymio sudo[5617]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient
Apr 23 16:19:38 onkymio sudo[5617]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:38 onkymio sudo[5617]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:38 onkymio volumio[5372]: info: MRS: STOPPING volumioStreaming
Apr 23 16:19:38 onkymio sudo[5620]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver
Apr 23 16:19:38 onkymio sudo[5620]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:38 onkymio sudo[5620]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:38 onkymio sudo[5623]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming
Apr 23 16:19:38 onkymio sudo[5623]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:38 onkymio sudo[5623]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:38 onkymio volumio[5372]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"...
Apr 23 16:19:38 onkymio sudo[5626]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/*
Apr 23 16:19:38 onkymio sudo[5626]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:38 onkymio sudo[5626]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:38 onkymio volumio[5372]: info: [MyVolumio PluginManager] Loading plugin "manifestui"...
Apr 23 16:19:38 onkymio volumio[5372]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"...
Apr 23 16:19:38 onkymio volumio[5372]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"...
Apr 23 16:19:38 onkymio volumio[5372]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"...
Apr 23 16:19:38 onkymio volumio[5372]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio
Apr 23 16:19:38 onkymio volumio[5372]: info: [MyVolumio PluginManager] Loading plugin "tidal"...
Apr 23 16:19:38 onkymio volumio[5372]: info: [MyVolumio PluginManager] Loading plugin "qobuz"...
Apr 23 16:19:38 onkymio volumio[5372]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"...
Apr 23 16:19:38 onkymio volumio[5372]: info: Preparing to generate the ALSA configuration file
Apr 23 16:19:38 onkymio volumio[5372]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Apr 23 16:19:38 onkymio volumio[5372]: info: Reading ALSA contributions from plugins.
Apr 23 16:19:38 onkymio volumio[5372]: info: MRS: Removed streaming files
Apr 23 16:19:38 onkymio volumio[5372]: info: MRS: volumioStreaming STOPPED
Apr 23 16:19:38 onkymio volumio[5372]: info: MRS: SNAPSERVER STOPPED
Apr 23 16:19:38 onkymio volumio[5372]: info: MRS: SNAPCLIENT STOPPED
Apr 23 16:19:38 onkymio volumio[5372]: error: Cannot start Volumio Streaming Daemon
Apr 23 16:19:38 onkymio volumio[5372]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Apr 23 16:19:38 onkymio volumio[5372]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Apr 23 16:19:38 onkymio volumio[5372]: info: Setting Geolocation for MyVolumio to eu4
Apr 23 16:19:38 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 16:19:38 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 16:19:38 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 16:19:38 onkymio volumio[5372]: info: Asound.conf file written
Apr 23 16:19:38 onkymio sudo[5629]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Apr 23 16:19:38 onkymio sudo[5629]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:38 onkymio sudo[5629]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:38 onkymio volumio[5372]: info: Output device has changed, restarting MPD
Apr 23 16:19:38 onkymio sudo[5634]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 23 16:19:38 onkymio sudo[5634]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:38 onkymio sudo[5634]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:38 onkymio volumio[5372]: info: Output device has changed, restarting Shairport Sync
Apr 23 16:19:38 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:38 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 16:19:38 onkymio sudo[5637]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 23 16:19:38 onkymio sudo[5637]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:38 onkymio systemd[1]: Stopping Music Player Daemon...
Apr 23 16:19:38 onkymio volumio[5372]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 23 16:19:38 onkymio volumio[5372]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Apr 23 16:19:38 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:38 onkymio systemd[1]: mpd.service: Succeeded.
Apr 23 16:19:38 onkymio systemd[1]: Stopped Music Player Daemon.
Apr 23 16:19:38 onkymio volumio[5372]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth
Apr 23 16:19:38 onkymio volumio[5372]: info: [MyVolumio PluginManager] Plugin bluetooth disabled by user. Not starting
Apr 23 16:19:38 onkymio volumio[5372]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom
Apr 23 16:19:38 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus
Apr 23 16:19:38 onkymio volumio[5372]: info: MRS: Pushing multiroomSync output for this device
Apr 23 16:19:38 onkymio volumio[5372]: info: MRS: Pushing multiroomSync output
Apr 23 16:19:38 onkymio volumio[5372]: info: Adding audio output:
Apr 23 16:19:38 onkymio volumio[5372]: info: Adding audio output:
Apr 23 16:19:38 onkymio volumio[5372]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Apr 23 16:19:38 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:38 onkymio volumio[5372]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio
Apr 23 16:19:38 onkymio volumio[5372]: info: Adding METAVOLUMIO REST API Endpoints
Apr 23 16:19:38 onkymio volumio[5372]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio
Apr 23 16:19:38 onkymio volumio[5372]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio
Apr 23 16:19:38 onkymio volumio[5372]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio
Apr 23 16:19:38 onkymio volumio[5372]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio
Apr 23 16:19:38 onkymio volumio[5372]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui
Apr 23 16:19:38 onkymio volumio[5372]: info: Adding Manifest REST API Endpoints
Apr 23 16:19:38 onkymio volumio[5372]: info: Adding manifestui REST Endpoint for plugin: miscellanea/manifestui
Apr 23 16:19:38 onkymio volumio[5372]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller
Apr 23 16:19:38 onkymio volumio[5372]: info: [MyVolumio PluginManager] Plugin cd_controller disabled by user. Not starting
Apr 23 16:19:38 onkymio volumio[5372]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs
Apr 23 16:19:38 onkymio volumio[5372]: info: Adding inputs REST Endpoints
Apr 23 16:19:38 onkymio volumio[5372]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs
Apr 23 16:19:38 onkymio volumio[5372]: info: Scanning Audio Inputs
Apr 23 16:19:38 onkymio systemd[1]: Starting Music Player Daemon...
Apr 23 16:19:38 onkymio volumio[5372]: info: Checking against Known Cards name
Apr 23 16:19:38 onkymio volumio[5372]: info: Adding Server instance for streaming
Apr 23 16:19:38 onkymio volumio[5372]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio
Apr 23 16:19:38 onkymio volumio[5372]: error: Hi Res Audio Failed Login: Missing Login Data
Apr 23 16:19:38 onkymio volumio[5372]: info: Adding HIGHRESAUDIO REST API Endpoints
Apr 23 16:19:38 onkymio volumio[5372]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio
Apr 23 16:19:38 onkymio volumio[5372]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal
Apr 23 16:19:38 onkymio volumio[5372]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz
Apr 23 16:19:38 onkymio volumio[5372]: info: Refreshing QOBUZ token
Apr 23 16:19:38 onkymio volumio[5372]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect
Apr 23 16:19:38 onkymio volumio[5372]: info: [MyVolumio PluginManager] Plugin tidalconnect disabled by user. Not starting
Apr 23 16:19:38 onkymio volumio[5372]: info: Stopping AccessToken refresher cron
Apr 23 16:19:38 onkymio volumio[5372]: info: AccessToken refresher cron started
Apr 23 16:19:38 onkymio volumio[5372]: info: Adding TIDAL REST API Endpoints
Apr 23 16:19:38 onkymio volumio[5372]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal
Apr 23 16:19:38 onkymio volumio[5372]: info: MPD Permissions set
Apr 23 16:19:38 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:38 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:38 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:38 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:38 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:38 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:38 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:38 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:38 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 16:19:38 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Apr 23 16:19:38 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:38 onkymio volumio[5372]: info: MRS: Adding multiroomSync output
Apr 23 16:19:38 onkymio volumio[5372]: info: Adding audio output:
Apr 23 16:19:38 onkymio volumio[5372]: info: MRS: Pushing multiroomSync output
Apr 23 16:19:38 onkymio volumio[5372]: info: Starting Shairport Sync
Apr 23 16:19:38 onkymio sudo[5657]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 23 16:19:38 onkymio sudo[5657]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:38 onkymio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Apr 23 16:19:38 onkymio systemd[1]: shairport-sync.service: Succeeded.
Apr 23 16:19:38 onkymio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Apr 23 16:19:38 onkymio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Apr 23 16:19:38 onkymio sudo[5657]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:38 onkymio volumio[5372]: info: Shairport-Sync Started
Apr 23 16:19:38 onkymio volumio[5372]: info: Access Token successfully retrieved
Apr 23 16:19:38 onkymio volumio[5372]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 23 16:19:38 onkymio volumio[5372]: info: [1713889178753] CoreMusicLibrary::Adding element QOBUZ
Apr 23 16:19:38 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 23 16:19:38 onkymio volumio[5372]: Cannot find translation for source YouTube2
Apr 23 16:19:38 onkymio volumio[5372]: Cannot find translation for source Randomizer
Apr 23 16:19:38 onkymio volumio[5372]: Cannot find translation for source QOBUZ
Apr 23 16:19:38 onkymio volumio[5372]: info: Stopping AccessToken refresher cron for QOBUZ
Apr 23 16:19:38 onkymio volumio[5372]: info: AccessToken refresher cron started for QOBUZ
Apr 23 16:19:38 onkymio volumio[5372]: info: Adding QOBUZ REST API Endpoints
Apr 23 16:19:38 onkymio volumio[5372]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz
Apr 23 16:19:38 onkymio volumio[5372]: info: BOOT COMPLETED
Apr 23 16:19:38 onkymio volumio[5372]:  [Metrics]  CommandRouter:  16s 383.42ms 
Apr 23 16:19:38 onkymio volumio[5372]: info: CoreCommandRouter::volumiosetStartupVolume
Apr 23 16:19:38 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:38 onkymio volumio[5372]: info: VolumeController:: Setting startup Volume 100
Apr 23 16:19:38 onkymio volumio[5372]: info: VolumeController::SetAlsaVolume100
Apr 23 16:19:38 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 16:19:38 onkymio volumio[5372]: info: CoreCommandRouter::Close All Modals sent
Apr 23 16:19:38 onkymio volumio[5372]: info: CoreStateMachine::pushState
Apr 23 16:19:38 onkymio volumio[5372]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:38 onkymio volumio[5372]: info: CoreCommandRouter::volumioPushState
Apr 23 16:19:38 onkymio volumio[5372]: info: MRS: Pushing multiroomSync output update for this device
Apr 23 16:19:38 onkymio volumio[5372]: info: MRS: Pushing multiroomSync output
Apr 23 16:19:38 onkymio mpd[5643]: Apr 23 16:19 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Apr 23 16:19:39 onkymio volumio[5372]: info: Preload queue cleared
Apr 23 16:19:39 onkymio volumio[5372]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 23 16:19:39 onkymio volumio[5372]: info: CoreStateMachine::ClearQueue
Apr 23 16:19:39 onkymio volumio[5372]: info: CoreStateMachine::stop
Apr 23 16:19:39 onkymio volumio[5372]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 23 16:19:39 onkymio volumio[5372]: info: CorePlayQueue::clearPlayQueue
Apr 23 16:19:39 onkymio volumio[5372]: info: CorePlayQueue::saveQueue
Apr 23 16:19:39 onkymio volumio[5372]: info: CoreCommandRouter::volumioPushQueue
Apr 23 16:19:39 onkymio volumio[5372]: info: CoreStateMachine::addQueueItems
Apr 23 16:19:39 onkymio volumio[5372]: info: CorePlayQueue::addQueueItems
Apr 23 16:19:39 onkymio volumio[5372]: info: Preload queue cleared
Apr 23 16:19:39 onkymio volumio[5372]: info: Adding Item to queue: qobuz://song/3376705
Apr 23 16:19:39 onkymio volumio[5372]: info: Exploding uri qobuz://song/3376705 in service qobuz
Apr 23 16:19:39 onkymio volumio[5372]: info: Adding Item to queue: qobuz://song/12359320
Apr 23 16:19:39 onkymio volumio[5372]: info: Exploding uri qobuz://song/12359320 in service qobuz
Apr 23 16:19:39 onkymio volumio[5372]: info: Adding Item to queue: qobuz://song/103457739
Apr 23 16:19:39 onkymio volumio[5372]: info: Exploding uri qobuz://song/103457739 in service qobuz
Apr 23 16:19:39 onkymio volumio[5372]: info: Adding Item to queue: qobuz://song/21733124
Apr 23 16:19:39 onkymio volumio[5372]: info: Exploding uri qobuz://song/21733124 in service qobuz
Apr 23 16:19:39 onkymio volumio[5372]: info: Adding Item to queue: qobuz://song/137387
Apr 23 16:19:39 onkymio volumio[5372]: info: Exploding uri qobuz://song/137387 in service qobuz
Apr 23 16:19:39 onkymio volumio[5372]: info: Adding Item to queue: qobuz://song/26740
Apr 23 16:19:39 onkymio volumio[5372]: info: Exploding uri qobuz://song/26740 in service qobuz
Apr 23 16:19:39 onkymio volumio[5372]: info: Adding Item to queue: qobuz://song/3376705
Apr 23 16:19:39 onkymio volumio[5372]: info: Exploding uri qobuz://song/3376705 in service qobuz
Apr 23 16:19:39 onkymio volumio[5372]: info: Adding Item to queue: qobuz://song/775014
Apr 23 16:19:39 onkymio volumio[5372]: info: Exploding uri qobuz://song/775014 in service qobuz
Apr 23 16:19:39 onkymio volumio[5372]: info: Adding Item to queue: qobuz://song/765404
Apr 23 16:19:39 onkymio volumio[5372]: info: Exploding uri qobuz://song/765404 in service qobuz
Apr 23 16:19:39 onkymio volumio[5372]: info: Adding Item to queue: qobuz://song/48893312
Apr 23 16:19:39 onkymio volumio[5372]: info: Exploding uri qobuz://song/48893312 in service qobuz
Apr 23 16:19:39 onkymio volumio[5372]: info: Adding Item to queue: qobuz://song/2177583
Apr 23 16:19:39 onkymio volumio[5372]: info: Exploding uri qobuz://song/2177583 in service qobuz
Apr 23 16:19:39 onkymio volumio[5372]: info: Successfully Added MyVolumio device
Apr 23 16:19:39 onkymio volumio[5372]: info: Setting Geolocation for MyVolumio to eu4
Apr 23 16:19:39 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 16:19:39 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 16:19:39 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 16:19:39 onkymio systemd[1]: Started Music Player Daemon.
Apr 23 16:19:39 onkymio sudo[5637]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:39 onkymio volumio[5372]: error: updateQueue error: null
Apr 23 16:19:39 onkymio volumio[5372]: info: explodeUri took 369 milliseconds
Apr 23 16:19:39 onkymio volumio[5372]: info: explodeUri took 409 milliseconds
Apr 23 16:19:39 onkymio volumio[5372]: error: Commandrouter: Cannot explode uri qobuz://song/21733124 from service qobuz:
Apr 23 16:19:39 onkymio volumio[5372]: info: explodeUri took 409 milliseconds
Apr 23 16:19:39 onkymio volumio[5372]: info: explodeUri took 424 milliseconds
Apr 23 16:19:39 onkymio volumio[5372]: info: explodeUri took 459 milliseconds
Apr 23 16:19:39 onkymio volumio[5372]: info: Updating MyVolumio device info
Apr 23 16:19:39 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 16:19:39 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 16:19:39 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 16:19:39 onkymio volumio[5372]: info: explodeUri took 479 milliseconds
Apr 23 16:19:39 onkymio volumio[5372]: info: explodeUri took 483 milliseconds
Apr 23 16:19:39 onkymio volumio[5372]: info: explodeUri took 529 milliseconds
Apr 23 16:19:39 onkymio volumio[5372]: info: explodeUri took 562 milliseconds
Apr 23 16:19:39 onkymio volumio[5372]: info: explodeUri took 588 milliseconds
Apr 23 16:19:39 onkymio volumio[5372]: info: explodeUri took 625 milliseconds
Apr 23 16:19:39 onkymio volumio[5372]: info: CoreCommandRouter::volumioPushQueue
Apr 23 16:19:39 onkymio volumio[5372]: info: CorePlayQueue::saveQueue
Apr 23 16:19:39 onkymio volumio[5372]: info: CoreStateMachine::updateTrackBlock
Apr 23 16:19:39 onkymio volumio[5372]: info: CorePlayQueue::getTrackBlock
Apr 23 16:19:39 onkymio volumio[5372]: info: CoreCommandRouter::volumioPlay
Apr 23 16:19:39 onkymio volumio[5372]: info: CoreStateMachine::play index 0
Apr 23 16:19:39 onkymio volumio[5372]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 23 16:19:39 onkymio volumio[5372]: info: CoreStateMachine::stop
Apr 23 16:19:39 onkymio volumio[5372]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 23 16:19:39 onkymio volumio[5372]: info: CoreStateMachine::play index undefined
Apr 23 16:19:39 onkymio volumio[5372]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 23 16:19:39 onkymio volumio[5372]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:39 onkymio volumio[5372]: info: CoreStateMachine::startPlaybackTimer
Apr 23 16:19:39 onkymio volumio[5372]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:39 onkymio volumio[5372]: info: [1713889179652] ControllerQobuz::clearAddPlayTrack
Apr 23 16:19:39 onkymio volumio[5372]: verbose: ControllerMpd::sendMpdCommand stop
Apr 23 16:19:39 onkymio volumio[5372]: info: sendMpdCommand stop took 0 milliseconds
Apr 23 16:19:39 onkymio volumio[5372]: verbose: ControllerMpd::sendMpdCommand clear
Apr 23 16:19:39 onkymio volumio[5372]: info:
Apr 23 16:19:39 onkymio volumio[5372]: ---------------------------- MPD announces system playlist update
Apr 23 16:19:39 onkymio volumio[5372]: info: Ignoring MPD Status Update
Apr 23 16:19:39 onkymio volumio[5372]: info: sendMpdCommand clear took 2 milliseconds
Apr 23 16:19:39 onkymio volumio[5372]: verbose: ControllerMpd::sendMpdCommand load "http://127.0.0.1:3245?data=qobuz://song/3376705"
Apr 23 16:19:39 onkymio volumio[5372]: error: updateQueue error: null
Apr 23 16:19:39 onkymio volumio[5372]: info: ------------------------------ 3ms
Apr 23 16:19:39 onkymio volumio[5372]: STREAMING PROXY: Handling url /?data=qobuz://song/3376705
Apr 23 16:19:39 onkymio volumio[5372]: info: Executing endpoint getStreamUrlqobuz
Apr 23 16:19:39 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI
Apr 23 16:19:39 onkymio volumio[5372]: info: Successfully Added MyVolumio device
Apr 23 16:19:39 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Apr 23 16:19:39 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Apr 23 16:19:39 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Apr 23 16:19:39 onkymio volumio[5372]: info: Successfully Updated MyVolumio device
Apr 23 16:19:40 onkymio volumio[5372]: info: getStreamUrl took 325 milliseconds
Apr 23 16:19:40 onkymio volumio[5372]: STREAMING PROXY: Got real url: http://streaming-qobuz-std.akamaized.net:80/file?uid=243890&eid=3376705&fmt=6&profile=raw&app_id=539451548&cid=1362678&etsp=1713892779&hmac=epdyxVUw2nLZFVq0WPi2wagMqLg
Apr 23 16:19:40 onkymio volumio[5372]: info: Updating MyVolumio device info
Apr 23 16:19:40 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 16:19:40 onkymio volumio[5372]: STREAMING PROXY: Response: 200, length: 22373473
Apr 23 16:19:40 onkymio volumio[5372]: STREAMING PROXY: Client dropped request, destroying
Apr 23 16:19:40 onkymio volumio[5372]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/3376705"
Apr 23 16:19:40 onkymio volumio[5372]: info:
Apr 23 16:19:40 onkymio volumio[5372]: ---------------------------- MPD announces system playlist update
Apr 23 16:19:40 onkymio volumio[5372]: info: Ignoring MPD Status Update
Apr 23 16:19:40 onkymio volumio[5372]: info: sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/3376705" took 1 milliseconds
Apr 23 16:19:40 onkymio volumio[5372]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 23 16:19:40 onkymio volumio[5372]: verbose: ControllerMpd::sendMpdCommand play
Apr 23 16:19:40 onkymio volumio[5372]: info: ------------------------------ 0ms
Apr 23 16:19:40 onkymio volumio[5372]: info: sendMpdCommand play took 0 milliseconds
Apr 23 16:19:40 onkymio volumio[5372]: STREAMING PROXY: Handling url /?data=qobuz://song/3376705
Apr 23 16:19:40 onkymio volumio[5372]: info: Executing endpoint getStreamUrlqobuz
Apr 23 16:19:40 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI
Apr 23 16:19:40 onkymio volumio[5372]: info: getStreamUrl took 330 milliseconds
Apr 23 16:19:40 onkymio volumio[5372]: STREAMING PROXY: Got real url: http://streaming-qobuz-std.akamaized.net:80/file?uid=243890&eid=3376705&fmt=6&profile=raw&app_id=539451548&cid=1362678&etsp=1713892780&hmac=4U-pVd2B3TIeVj3-O60wOJSn7xQ
Apr 23 16:19:40 onkymio volumio[5372]: STREAMING PROXY: Response: 200, length: 22373473
Apr 23 16:19:40 onkymio volumio[5372]: info:
Apr 23 16:19:40 onkymio volumio[5372]: ---------------------------- MPD announces state update: player
Apr 23 16:19:40 onkymio volumio[5372]: info: ControllerMpd::getState
Apr 23 16:19:40 onkymio volumio[5372]: verbose: ControllerMpd::sendMpdCommand status
Apr 23 16:19:40 onkymio volumio[5372]: info:
Apr 23 16:19:40 onkymio volumio[5372]: ---------------------------- MPD announces state update: player
Apr 23 16:19:40 onkymio volumio[5372]: verbose: ControllerMpd::sendMpdCommand clearerror
Apr 23 16:19:40 onkymio volumio[5372]: info: sendMpdCommand status took 3 milliseconds
Apr 23 16:19:40 onkymio volumio[5372]: info: ControllerMpd::getState
Apr 23 16:19:40 onkymio volumio[5372]: verbose: ControllerMpd::sendMpdCommand status
Apr 23 16:19:40 onkymio volumio[5372]: verbose: ControllerMpd::parseState
Apr 23 16:19:40 onkymio volumio[5372]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 23 16:19:40 onkymio volumio[5372]: info: sendMpdCommand clearerror took 1 milliseconds
Apr 23 16:19:40 onkymio volumio[5372]: info: sendMpdCommand status took 2 milliseconds
Apr 23 16:19:40 onkymio volumio[5372]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 23 16:19:40 onkymio volumio[5372]: verbose: ControllerMpd::parseState
Apr 23 16:19:40 onkymio volumio[5372]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 23 16:19:40 onkymio volumio[5372]: verbose: ControllerMpd::parseTrackInfo
Apr 23 16:19:40 onkymio volumio[5372]: info: ControllerMpd::pushState
Apr 23 16:19:40 onkymio volumio[5372]: info: CoreCommandRouter::servicePushState
Apr 23 16:19:40 onkymio volumio[5372]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:40 onkymio volumio[5372]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":203,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"3376705","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/3376705","trackType":"qobuz"}
Apr 23 16:19:40 onkymio volumio[5372]: verbose: CURRENT POSITION 0
Apr 23 16:19:40 onkymio volumio[5372]: info: CoreStateMachine::syncState   stateService pause
Apr 23 16:19:40 onkymio volumio[5372]: info: CoreStateMachine::syncState   currentStatus stop
Apr 23 16:19:40 onkymio volumio[5372]: info: CoreStateMachine::pushState
Apr 23 16:19:40 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 23 16:19:40 onkymio volumio[5372]: info: CoreCommandRouter::volumioPushState
Apr 23 16:19:40 onkymio volumio[5372]: info: MRS: Pushing multiroomSync output update for this device
Apr 23 16:19:40 onkymio volumio[5372]: info: MRS: Pushing multiroomSync output
Apr 23 16:19:40 onkymio volumio[5372]: info: ------------------------------ 12ms
Apr 23 16:19:40 onkymio volumio[5372]: info: sendMpdCommand playlistinfo took 7 milliseconds
Apr 23 16:19:40 onkymio volumio[5372]: verbose: ControllerMpd::parseTrackInfo
Apr 23 16:19:40 onkymio volumio[5372]: info: ControllerMpd::pushState
Apr 23 16:19:40 onkymio volumio[5372]: info: CoreCommandRouter::servicePushState
Apr 23 16:19:40 onkymio volumio[5372]: info: CorePlayQueue::getTrack 0
Apr 23 16:19:40 onkymio volumio[5372]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":203,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"3376705","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/3376705","trackType":"qobuz"}
Apr 23 16:19:40 onkymio volumio[5372]: verbose: CURRENT POSITION 0
Apr 23 16:19:40 onkymio volumio[5372]: info: CoreStateMachine::syncState   stateService pause
Apr 23 16:19:40 onkymio volumio[5372]: info: CoreStateMachine::syncState   currentStatus stop
Apr 23 16:19:40 onkymio volumio[5372]: info: CoreStateMachine::pushState
Apr 23 16:19:40 onkymio volumio[5372]: info: CoreCommandRouter::volumioPushState
Apr 23 16:19:40 onkymio volumio[5372]: info: MRS: Pushing multiroomSync output update for this device
Apr 23 16:19:40 onkymio volumio[5372]: info: MRS: Pushing multiroomSync output
Apr 23 16:19:40 onkymio volumio[5372]: info: ------------------------------ 12ms
Apr 23 16:19:40 onkymio volumio[5372]: info: Successfully Updated MyVolumio device
Apr 23 16:19:40 onkymio volumio[5372]: STREAMING PROXY: Client dropped request, destroying
Apr 23 16:19:42 onkymio volumio[5372]: info: Executing endpoint metavolumio
Apr 23 16:19:42 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Apr 23 16:19:42 onkymio volumio[5372]: info: Cannot mount NAS at system boot, trial number 4 ,stopping
Apr 23 16:19:42 onkymio sudo[5683]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service
Apr 23 16:19:42 onkymio sudo[5683]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 23 16:19:42 onkymio autossh[1640]: received signal to exit (15)
Apr 23 16:19:42 onkymio systemd[1]: Stopping MyVolumio SSH Tunnel...
Apr 23 16:19:42 onkymio systemd[1]: sshtunnel.service: Main process exited, code=killed, status=15/TERM
Apr 23 16:19:42 onkymio systemd[1]: sshtunnel.service: Succeeded.
Apr 23 16:19:42 onkymio systemd[1]: Stopped MyVolumio SSH Tunnel.
Apr 23 16:19:42 onkymio systemd[1]: Started MyVolumio SSH Tunnel.
Apr 23 16:19:42 onkymio sudo[5683]: pam_unix(sudo:session): session closed for user root
Apr 23 16:19:42 onkymio volumio[5372]: info: Remote SSH Started
Apr 23 16:19:42 onkymio autossh[5686]: port set to 0, monitoring disabled
Apr 23 16:19:42 onkymio autossh[5686]: starting ssh (count 1)
Apr 23 16:19:42 onkymio autossh[5686]: ssh child pid is 5689
Apr 23 16:19:42 onkymio volumio[5372]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 9
Apr 23 16:19:42 onkymio volumio[5372]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:42 onkymio volumio[5372]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.L85j8Xqv1QMTYNPdNjFuI8HqGap1.65a510bf426ca819dbfc2136c10c2268.state.status'
Apr 23 16:19:43 onkymio volumiossh-tunnel[5685]: Warning: Permanently added '[eu4.myvolumio.org]:2222,[167.172.103.77]:2222' (RSA) to the list of known hosts.
Apr 23 16:19:43 onkymio volumio[5372]: info: MRS: Getting audio outputs on start
Apr 23 16:19:43 onkymio volumio[5372]: info: MRS: Requesting all other devices output
Apr 23 16:19:46 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: youtube2 , handleBrowseUri
Apr 23 16:19:46 onkymio volumio[5372]: info: [youtube2-browse] browseUri: youtube2
Apr 23 16:19:46 onkymio volumio[5372]: info: [youtube2] InnertubeLoader: creating Innertube instance...
Apr 23 16:19:46 onkymio volumio[5372]: info: [youtube2] InnertubeLoader: creating Auth instance...
Apr 23 16:19:46 onkymio volumio[5372]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 23 16:19:46 onkymio volumio[5372]: error: [youtube2] Error in ConfigModel.#fetchAccountMenu():  Request to https://www.youtube.com/youtubei/vtrue/account/account_menu?key=AIzaSyAO_FJ2SlqU8Q4STEHLGCilw_Y9_11qcW8&prettyPrint=false&alt=json failed with status 400 Error: Request to https://www.youtube.com/youtubei/vtrue/account/account_menu?key=AIzaSyAO_FJ2SlqU8Q4STEHLGCilw_Y9_11qcW8&prettyPrint=false&alt=json failed with status 400
Apr 23 16:19:46 onkymio volumio[5372]:     at HTTPClient. (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:22010:13)
Apr 23 16:19:46 onkymio volumio[5372]:     at Generator.next ()
Apr 23 16:19:46 onkymio volumio[5372]:     at fulfilled (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:215:30)
Apr 23 16:19:46 onkymio volumio[5372]:     at runMicrotasks ()
Apr 23 16:19:46 onkymio volumio[5372]:     at processTicksAndRejections (internal/process/task_queues.js:95:5)
Apr 23 16:19:46 onkymio volumio[5372]: (node:5372) UnhandledPromiseRejectionWarning: TypeError: Cannot convert undefined or null to object
Apr 23 16:19:46 onkymio volumio[5372]:     at Function.entries ()
Apr 23 16:19:46 onkymio volumio[5372]:     at findInObject (/data/plugins/music_service/youtube2/dist/lib/util/index.js:27:43)
Apr 23 16:19:46 onkymio volumio[5372]:     at ConfigModel.getI18nOptions (/data/plugins/music_service/youtube2/dist/lib/model/ConfigModel.js:84:54)
Apr 23 16:19:46 onkymio volumio[5372]:     at runMicrotasks ()
Apr 23 16:19:46 onkymio volumio[5372]:     at processTicksAndRejections (internal/process/task_queues.js:95:5)
Apr 23 16:19:46 onkymio volumio[5372]: (Use `node --trace-warnings ...` to show where the warning was created)
Apr 23 16:19:46 onkymio volumio[5372]: (node:5372) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 1)
Apr 23 16:19:46 onkymio volumio[5372]: (node:5372) [DEP0018] DeprecationWarning: Unhandled promise rejections are deprecated. In the future, promise rejections that are not handled will terminate the Node.js process with a non-zero exit code.
Apr 23 16:19:49 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Apr 23 16:19:49 onkymio volumio[5372]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 10
Apr 23 16:19:49 onkymio volumio[5372]: info: CoreCommandRouter::volumioGetState
Apr 23 16:19:53 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 23 16:19:53 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 16:19:53 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Apr 23 16:19:53 onkymio volumio-remote-updater[525]: Test mode enabled
Apr 23 16:19:53 onkymio volumio-remote-updater[525]: No alpha test mode
Apr 23 16:19:53 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Apr 23 16:19:53 onkymio volumio[5372]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES
\n\nFix for mpd crashing with wrongly formatted cue files
\nRestore install-to-disk on x86 and ThinkerBoard
\nFix for Waveshare 11.9inch DSI Display touch panel on RPi
\nFix for missing metadata on CD playback
\nFix for metadata with Classic and Modern UI
\nFix for factory-reset from USB on Motivo
\nFix for Volumio logo on boot on Motivo
\nVarious fixes for TIDAL Connect
\n
\nNEW ADDITIONS
\n\nBump MPD to 0.23.15-3
\nAdd support for Waveshare 4.0inch DSI Display on RPi
\nImprovements for reducing boot time
\nAdd patched driver for ax88179 on RPi
\nUNSTABLE ALPHA BUILD - DO NOT INSTALL
\n\n","title":"Update v3.649","updateavailable":true}
Apr 23 16:19:53 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Apr 23 16:19:54 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:54 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 16:19:54 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Apr 23 16:19:54 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Apr 23 16:19:54 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Apr 23 16:19:54 onkymio volumio[5372]: info: CoreCommandRouter::volumioGetBrowseSources
Apr 23 16:19:54 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 23 16:19:59 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 23 16:19:59 onkymio volumio[5372]: info: CURURI: music-library
Apr 23 16:19:59 onkymio volumio[5372]: info: Preload queue cleared
Apr 23 16:20:01 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 23 16:20:01 onkymio volumio[5372]: info: CURURI: music-library/NAS
Apr 23 16:20:01 onkymio volumio[5372]: info: Preload queue cleared
Apr 23 16:20:01 onkymio volumio[5372]: info: MRS: Found cast device: SHIELD-Android-TV-78449cc05fb93be91dea1a59db799139
Apr 23 16:20:01 onkymio volumio[5372]: info: Adding audio output:
Apr 23 16:20:02 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 23 16:20:02 onkymio volumio[5372]: info: CURURI: music-library/NAS/NAS
Apr 23 16:20:02 onkymio volumio[5372]: info: Preload queue cleared
Apr 23 16:20:23 onkymio volumio[5372]: info: UPDATER: Scheduling automatic update
Apr 23 16:20:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: system , getAutoUpdateWindowStartTime
Apr 23 16:20:23 onkymio volumio[5372]: info: CoreCommandRouter::executeOnPlugin: system , getAutoUpdateWindowStopTime
Apr 23 16:20:23 onkymio volumio[5372]: info: UPDATER: Auto update will take place at: Wed Apr 24 2024 03:30:50 GMT+0000 (Coordinated Universal Time)
Apr 23 16:20:42 onkymio volumio[5372]: info: Preload queue cleared
Apr 23 16:20:42 onkymio volumio[5372]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 23 16:20:42 onkymio volumio[5372]: info: CoreStateMachine::ClearQueue
Apr 23 16:20:42 onkymio volumio[5372]: info: CoreStateMachine::stop
Apr 23 16:20:42 onkymio volumio[5372]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 23 16:20:42 onkymio volumio[5372]: info: CorePlayQueue::clearPlayQueue
Apr 23 16:20:42 onkymio volumio[5372]: info: CorePlayQueue::saveQueue
Apr 23 16:20:42 onkymio volumio[5372]: info: CoreCommandRouter::volumioPushQueue
Apr 23 16:20:42 onkymio volumio[5372]: info: CoreStateMachine::addQueueItems
Apr 23 16:20:42 onkymio volumio[5372]: info: CorePlayQueue::addQueueItems
Apr 23 16:20:42 onkymio volumio[5372]: info: Preload queue cleared
Apr 23 16:20:42 onkymio volumio[5372]: info: Adding Item to queue: music-library/NAS/NAS/Phil_Collins_-_Hello__I_Must_Be_Going___2CD_Deluxe___2016___FLAC_
Apr 23 16:20:42 onkymio volumio[5372]: info: Exploding uri music-library/NAS/NAS/Phil_Collins_-_Hello__I_Must_Be_Going___2CD_Deluxe___2016___FLAC_ in service mpd
Apr 23 16:20:42 onkymio volumio[5372]: info: ALBUMART /albumart?cacheid=713&web=//extralarge&path=%2Fmnt%2FNAS%2FNAS%2FPhil_Collins_-_Hello__I_Must_Be_Going___2CD_Deluxe___2016___FLAC_%2FDisc%201%2FPhil%20Collins%20-%20Hello%2C%20I%20Must%20Be%20Going!%20(CD1).flac&metadata=false
Apr 23 16:20:42 onkymio volumio[5372]: info: URI /mnt/NAS/NAS/Phil_Collins_-_Hello__I_Must_Be_Going___2CD_Deluxe___2016___FLAC_/Disc 1/Phil Collins - Hello, I Must Be Going! (CD1).flac
Apr 23 16:20:42 onkymio volumio[5372]: info: ALBUMART /albumart?cacheid=713&web=Phil%20Collins/Hello%2C%20I%20Must%20Be%20Going!%20(CD1)/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FPhil_Collins_-_Hello__I_Must_Be_Going___2CD_Deluxe___2016___FLAC_%2FDisc%201%2FPhil%20Collins%20-%20Hello%2C%20I%20Must%20Be%20Going!%20(CD1).flac.cue&metadata=false
Apr 23 16:20:42 onkymio volumio[5372]: info: URI /mnt/NAS/NAS/Phil_Collins_-_Hello__I_Must_Be_Going___2CD_Deluxe___2016___FLAC_/Disc 1/Phil Collins - Hello, I Must Be Going! (CD1).flac.cue
Apr 23 16:20:42 onkymio volumio[5372]: info: ALBUMART /albumart?cacheid=713&web=Phil%20Collins/Hello%2C%20I%20Must%20Be%20Going!%20(CD1)/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FPhil_Collins_-_Hello__I_Must_Be_Going___2CD_Deluxe___2016___FLAC_%2FDisc%201%2FPhil%20Collins%20-%20Hello%2C%20I%20Must%20Be%20Going!%20(CD1).flac.cue&metadata=false
Apr 23 16:20:42 onkymio volumio[5372]: info: URI /mnt/NAS/NAS/Phil_Collins_-_Hello__I_Must_Be_Going___2CD_Deluxe___2016___FLAC_/Disc 1/Phil Collins - Hello, I Must Be Going! (CD1).flac.cue
Apr 23 16:20:42 onkymio volumio[5372]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 23 16:20:42 onkymio volumio[5372]: Error: Unable to resolve or reject the same promise twice
Apr 23 16:20:42 onkymio volumio[5372]:     at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43)
Apr 23 16:20:42 onkymio volumio[5372]:     at /volumio/app/plugins/music_service/mpd/index.js:2568:21
Apr 23 16:20:42 onkymio volumio[5372]:     at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3)
Apr 23 16:20:42 onkymio volumio[5372]:     at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12)
Apr 23 16:20:42 onkymio volumio[5372]:     at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12)
Apr 23 16:20:42 onkymio volumio[5372]:     at Socket.emit (events.js:400:28)
Apr 23 16:20:42 onkymio volumio[5372]:     at addChunk (internal/streams/readable.js:293:12)
Apr 23 16:20:42 onkymio volumio[5372]:     at readableAddChunk (internal/streams/readable.js:263:11)
Apr 23 16:20:42 onkymio volumio[5372]:     at Socket.Readable.push (internal/streams/readable.js:206:10)
Apr 23 16:20:42 onkymio volumio[5372]:     at Pipe.onStreamRead (internal/stream_base_commons.js:188:23)
Apr 23 16:20:42 onkymio volumio[5372]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 23 16:20:42 onkymio sudo[5751]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-23 16:19
Apr 23 16:20:42 onkymio sudo[5751]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 10 (buster)"
NAME="Debian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="17fcb754ddd6bd152b01008c46cc4ba1ca48bf35"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="a641dd71dd22f560f71c5c8af897751297274d11"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed 13 Mar 2024 11:15:53 PM CET"
VOLUMIO_VERSION="3.636"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="ff45c26321d67979996787ce73e1fd1a"