-- Logs begin at Sat 2017-07-29 21:30:30 UTC. --
Jul 31 19:01:37 volumio sudo[7612]: volumio : TTY=pts/0 ; PWD=/home/volumio ; USER=root ; COMMAND=/bin/journalctl -f
Jul 31 19:01:37 volumio sudo[7612]: pam_unix(sudo:session): session opened for user root by volumio(uid=0)
Jul 31 19:01:42 volumio volumio[5003]: info: [{"prettyName":"Autoplay","name":"auto_play","category":"miscellanea","version":"1.0.0","icon":"fa-play-circle-o","enabled":false,"active":false}]
Jul 31 19:01:43 volumio volumio[5003]: info: Enabling plugin auto_play
Jul 31 19:01:43 volumio volumio[5003]: info: Loading plugin "auto_play"...
Jul 31 19:01:44 volumio volumio[5003]: info: ControllerAutoPlay - connecting mpd on host: localhost; port: 6600
Jul 31 19:01:44 volumio volumio[5003]: info: PLUGIN START: auto_play
Jul 31 19:01:44 volumio volumio[5003]: info: Done.
Jul 31 19:01:44 volumio volumio[5003]: /data/plugins/miscellanea/auto_play/node_modules/node-mpd/src/mpd.js:189
Jul 31 19:01:44 volumio volumio[5003]: if(err) { throw err; }
Jul 31 19:01:44 volumio volumio[5003]: ^
Jul 31 19:01:44 volumio volumio[5003]: Error: Non okay return status: "Title: Be OK"
Jul 31 19:01:44 volumio volumio[5003]: at MPD._checkReturn (/data/plugins/miscellanea/auto_play/node_modules/node-mpd/src/mpd.js:353:10)
Jul 31 19:01:44 volumio volumio[5003]: at MPD.<anonymous> (/data/plugins/miscellanea/auto_play/node_modules/node-mpd/src/mpd.js:188:18)
Jul 31 19:01:44 volumio volumio[5003]: at MPD._handleResponse (/data/plugins/miscellanea/auto_play/node_modules/node-mpd/src/mpd.js:450:3)
Jul 31 19:01:44 volumio volumio[5003]: at MPD._onData (/data/plugins/miscellanea/auto_play/node_modules/node-mpd/src/mpd.js:344:10)
Jul 31 19:01:44 volumio volumio[5003]: at emitOne (events.js:101:20)
Jul 31 19:01:44 volumio volumio[5003]: at Socket.emit (events.js:188:7)
Jul 31 19:01:44 volumio volumio[5003]: at readableAddChunk (_stream_readable.js:176:18)
Jul 31 19:01:44 volumio volumio[5003]: at Socket.Readable.push (_stream_readable.js:134:10)
Jul 31 19:01:44 volumio volumio[5003]: at TCP.onread (net.js:547:20)
Jul 31 19:01:44 volumio volumio-remote-updater[568]: [2017-07-31 19:01:44] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Jul 31 19:01:44 volumio volumio-remote-updater[568]: [2017-07-31 19:01:44] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Jul 31 19:01:44 volumio systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE
Jul 31 19:01:44 volumio bluetoothd[854]: Endpoint unregistered: sender=:1.105 path=/MediaEndpoint/A2DPSource
Jul 31 19:01:44 volumio bluetoothd[854]: Endpoint unregistered: sender=:1.105 path=/MediaEndpoint/A2DPSink
Jul 31 19:01:44 volumio systemd[1]: Unit volumio.service entered failed state.
Jul 31 19:01:44 volumio systemd[1]: Starting dynamicswap.service...
Jul 31 19:01:44 volumio systemd[1]: Started dynamicswap.service.
Jul 31 19:01:44 volumio systemd[1]: volumio.service holdoff time over, scheduling restart.
Jul 31 19:01:44 volumio systemd[1]: Starting dynamicswap.service...
Jul 31 19:01:44 volumio systemd[1]: Started dynamicswap.service.
Jul 31 19:01:44 volumio systemd[1]: Stopping Volumio Backend Module...
Jul 31 19:01:44 volumio systemd[1]: Starting Volumio Backend Module...
Jul 31 19:01:44 volumio systemd[1]: Started Volumio Backend Module.
Jul 31 19:01:46 volumio volumio[7681]: info: -------------------------------------------
Jul 31 19:01:46 volumio volumio[7681]: info: -----            Volumio2              ----
Jul 31 19:01:46 volumio volumio[7681]: info: -------------------------------------------
Jul 31 19:01:46 volumio volumio[7681]: info: -----          System startup          ----
Jul 31 19:01:46 volumio volumio[7681]: info: -------------------------------------------
Jul 31 19:01:46 volumio volumio[7681]: info: Plugin folders cleanup
Jul 31 19:01:46 volumio volumio[7681]: info: Scanning into folder /volumio/app/plugins/
Jul 31 19:01:46 volumio volumio[7681]: info: Scanning category audio_interface
Jul 31 19:01:46 volumio volumio[7681]: info: Scanning category miscellanea
Jul 31 19:01:46 volumio volumio[7681]: info: Scanning category music_service
Jul 31 19:01:46 volumio volumio[7681]: info: Scanning category plugins.json
Jul 31 19:01:46 volumio volumio[7681]: info: Scanning category system_controller
Jul 31 19:01:46 volumio volumio[7681]: info: Scanning category user_interface
Jul 31 19:01:46 volumio volumio[7681]: info: Scanning into folder /data/plugins/
Jul 31 19:01:46 volumio volumio[7681]: info: Scanning category miscellanea
Jul 31 19:01:46 volumio volumio[7681]: info: Plugin folders cleanup completed
Jul 31 19:01:46 volumio volumio[7681]: info: Loading plugins from folder /volumio/app/plugins/
Jul 31 19:01:46 volumio volumio[7681]: info: Loading plugins from folder /data/plugins/
Jul 31 19:01:46 volumio volumio[7681]: info: Loading plugin "system"...
Jul 31 19:01:47 volumio volumio[7681]: info: Loading plugin "appearance"...
Jul 31 19:01:48 volumio volumio[7681]: info: Loading plugin "network"...
Jul 31 19:01:48 volumio volumio[7681]: info: Loading plugin "services"...
Jul 31 19:01:48 volumio volumio[7681]: info: Loading plugin "alsa_controller"...
Jul 31 19:01:48 volumio rtkit-daemon[970]: Supervising 0 threads of 0 processes of 1 users.
Jul 31 19:01:48 volumio rtkit-daemon[970]: Supervising 0 threads of 0 processes of 1 users.
Jul 31 19:01:48 volumio rtkit-daemon[970]: Supervising 0 threads of 0 processes of 1 users.
Jul 31 19:01:48 volumio rtkit-daemon[970]: Supervising 0 threads of 0 processes of 1 users.
Jul 31 19:01:48 volumio rtkit-daemon[970]: Supervising 0 threads of 0 processes of 1 users.
Jul 31 19:01:48 volumio rtkit-daemon[970]: Supervising 0 threads of 0 processes of 1 users.
Jul 31 19:01:48 volumio rtkit-daemon[970]: Supervising 0 threads of 0 processes of 1 users.
Jul 31 19:01:48 volumio rtkit-daemon[970]: Supervising 0 threads of 0 processes of 1 users.
Jul 31 19:01:48 volumio rtkit-daemon[970]: Supervising 0 threads of 0 processes of 1 users.
Jul 31 19:01:48 volumio rtkit-daemon[970]: Supervising 0 threads of 0 processes of 1 users.
Jul 31 19:01:48 volumio rtkit-daemon[970]: Supervising 0 threads of 0 processes of 1 users.
Jul 31 19:01:48 volumio rtkit-daemon[970]: Supervising 0 threads of 0 processes of 1 users.
Jul 31 19:01:48 volumio rtkit-daemon[970]: Supervising 0 threads of 0 processes of 1 users.
Jul 31 19:01:48 volumio rtkit-daemon[970]: Supervising 0 threads of 0 processes of 1 users.
Jul 31 19:01:49 volumio rtkit-daemon[970]: Supervising 0 threads of 0 processes of 1 users.
Jul 31 19:01:49 volumio pulseaudio[7710]: [pulseaudio] server-lookup.c: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11
Jul 31 19:01:49 volumio pulseaudio[7710]: [pulseaudio] main.c: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11
Jul 31 19:01:49 volumio pulseaudio[7710]: [pulseaudio] bluez4-util.c: org.bluez.Manager.GetProperties() failed: org.freedesktop.DBus.Error.UnknownMethod: Method "GetProperties" with signature "" on interface "org.bluez.Manager" doesn't exist
Jul 31 19:01:49 volumio bluetoothd[854]: Endpoint registered: sender=:1.127 path=/MediaEndpoint/A2DPSource
Jul 31 19:01:49 volumio bluetoothd[854]: Endpoint registered: sender=:1.127 path=/MediaEndpoint/A2DPSink
Jul 31 19:01:49 volumio volumio[7681]: info: Loading plugin "volumio_command_line_client"...
Jul 31 19:01:49 volumio volumio[7681]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 31 19:01:49 volumio volumio[7681]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 31 19:01:49 volumio volumio[7681]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 31 19:01:49 volumio volumio-remote-updater[568]: [2017-07-31 19:01:49] [connect] Successful connection
Jul 31 19:01:49 volumio volumio[7681]: info: Loading plugin "upnp"...
Jul 31 19:01:49 volumio volumio[7681]: info: [1501527709192] Starting Upmpd Daemon
Jul 31 19:01:49 volumio volumio[7681]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jul 31 19:01:49 volumio volumio[7681]: info: Loading plugin "mpd"...
Jul 31 19:01:49 volumio volumio[7681]: info: Plugin upnp_browser is not enabled
Jul 31 19:01:49 volumio volumio[7681]: info: Loading plugin "networkfs"...
Jul 31 19:01:49 volumio volumio[7681]: info: Cannot mount NAS Torck at system boot, trial number 1 ,retrying in 5 seconds
Jul 31 19:01:49 volumio volumio[7681]: info: Loading plugin "alarm-clock"...
Jul 31 19:01:49 volumio volumio[7681]: info: Loading plugin "airplay_emulation"...
Jul 31 19:01:49 volumio volumio[7681]: info: [1501527709689] Starting Shairport Sync
Jul 31 19:01:49 volumio volumio[7681]: info: Loading plugin "last_100"...
Jul 31 19:01:49 volumio volumio[7681]: info: Loading plugin "webradio"...
Jul 31 19:01:50 volumio volumio[7681]: info: Loading plugin "i2s_dacs"...
Jul 31 19:01:50 volumio volumio[7681]: info: I2S DAC not set, start Auto-detection
Jul 31 19:01:50 volumio volumio[7681]: info: Loading plugin "my_volumio"...
Jul 31 19:01:50 volumio volumio[7681]: info: Loading plugin "volumiodiscovery"...
Jul 31 19:01:50 volumio volumio[7681]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jul 31 19:01:50 volumio node[7681]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jul 31 19:01:50 volumio node[7681]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jul 31 19:01:50 volumio node[7681]: *** WARNING *** For more information see <http://0pointer.de/avahi-compat?s=libdns_sd&e=node>
Jul 31 19:01:50 volumio node[7681]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jul 31 19:01:50 volumio node[7681]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jul 31 19:01:50 volumio node[7681]: *** WARNING *** For more information see <http://0pointer.de/avahi-compat?s=libdns_sd&e=node&f=DNSServiceRegister>
Jul 31 19:01:50 volumio volumio[7681]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jul 31 19:01:50 volumio volumio[7681]: *** WARNING *** For more information see <http://0pointer.de/avahi-compat?s=libdns_sd&e=node>
Jul 31 19:01:50 volumio volumio[7681]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jul 31 19:01:50 volumio volumio[7681]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jul 31 19:01:50 volumio volumio[7681]: *** WARNING *** For more information see <http://0pointer.de/avahi-compat?s=libdns_sd&e=node&f=DNSServiceRegister>
Jul 31 19:01:50 volumio volumio[7681]: info: Applying required configuration parameters for plugin volumiodiscovery
Jul 31 19:01:50 volumio volumio[7681]: Discovery: StartAdv! undefined
Jul 31 19:01:50 volumio volumio[7681]: Discovery: Started advertising... Volumio - undefined
Jul 31 19:01:50 volumio volumio[7681]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jul 31 19:01:50 volumio volumio[7681]: info: Plugin auto_play is not enabled
Jul 31 19:01:50 volumio volumio[7681]: info: Loading plugin "albumart"...
Jul 31 19:01:50 volumio volumio[7681]: info: Plugin example_plugin is not enabled
Jul 31 19:01:50 volumio volumio[7681]: info: Loading plugin "updater_comm"...
Jul 31 19:01:50 volumio volumio[7681]: info: Plugin mpdemulation is not enabled
Jul 31 19:01:50 volumio volumio[7681]: info: Loading plugin "rest_api"...
Jul 31 19:01:50 volumio volumio[7681]: info: Loading plugin "websocket"...
Jul 31 19:01:50 volumio volumio[7681]: info: ___________ START PLUGINS ___________
Jul 31 19:01:50 volumio volumio[7681]: info: PLUGIN START: appearance
Jul 31 19:01:50 volumio volumio[7681]: info: PLUGIN START: last_100
Jul 31 19:01:50 volumio volumio[7681]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jul 31 19:01:50 volumio volumio[7681]: info: [1501527710624] CoreMusicLibrary::Adding element Last_100
Jul 31 19:01:50 volumio volumio[7681]: info: PLUGIN START: webradio
Jul 31 19:01:50 volumio volumio[7681]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jul 31 19:01:50 volumio volumio[7681]: info: [1501527710637] CoreMusicLibrary::Adding element Webradio
Jul 31 19:01:50 volumio volumio[7681]: info: PLUGIN START: my_volumio
Jul 31 19:01:50 volumio volumio[7681]: info: Loading i18n strings for locale de
Jul 31 19:01:50 volumio volumio[7681]: Updating browse sources language
Jul 31 19:01:50 volumio volumio[7681]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 31 19:01:50 volumio volumio[7681]: info: CoreCommandRouter::initPlayerControls
Jul 31 19:01:50 volumio volumio[7681]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 31 19:01:50 volumio volumio[7681]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards
Jul 31 19:01:50 volumio volumio[7681]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 31 19:01:50 volumio volumio[7681]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 31 19:01:50 volumio volumio[7681]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 31 19:01:50 volumio volumio[7681]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 31 19:01:50 volumio volumio[7681]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 31 19:01:50 volumio volumio[7681]: info: BOOT COMPLETED
Jul 31 19:01:50 volumio volumio[7681]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 31 19:01:50 volumio volumio[7681]: Express server listening on port 3000
Jul 31 19:01:50 volumio volumio[7681]: Volumio Calling Home
Jul 31 19:01:50 volumio volumio[7681]: info: [1501527710857] CoreStateMachine::resetVolumioState
Jul 31 19:01:50 volumio volumio[7681]: info: [1501527710859] CoreStateMachine::getcurrentVolume
Jul 31 19:01:50 volumio volumio[7681]: info: CoreCommandRouter::volumioRetrievevolume
Jul 31 19:01:50 volumio volumio[7681]: info: [1501527710920] CoreStateMachine::updateTrackBlock
Jul 31 19:01:50 volumio volumio[7681]: info: [1501527710922] CorePlayQueue::getTrackBlock
Jul 31 19:01:51 volumio volumio[7681]: { Error: Command failed: /usr/bin/aplay --device=plughw:5,0 /volumio/app/startup.wav
Jul 31 19:01:51 volumio volumio[7681]: aplay: main:722: audio open error: Device or resource busy
Jul 31 19:01:51 volumio volumio[7681]: at ChildProcess.exithandler (child_process.js:204:12)
Jul 31 19:01:51 volumio volumio[7681]: at emitTwo (events.js:106:13)
Jul 31 19:01:51 volumio volumio[7681]: at ChildProcess.emit (events.js:191:7)
Jul 31 19:01:51 volumio volumio[7681]: at maybeClose (internal/child_process.js:891:16)
Jul 31 19:01:51 volumio volumio[7681]: at Socket.<anonymous> (internal/child_process.js:342:11)
Jul 31 19:01:51 volumio volumio[7681]: at emitOne (events.js:96:13)
Jul 31 19:01:51 volumio volumio[7681]: at Socket.emit (events.js:188:7)
Jul 31 19:01:51 volumio volumio[7681]: at Pipe._handle.close [as _onclose] (net.js:497:12)
Jul 31 19:01:51 volumio volumio[7681]: killed: false,
Jul 31 19:01:51 volumio volumio[7681]: code: 1,
Jul 31 19:01:51 volumio volumio[7681]: signal: null,
Jul 31 19:01:51 volumio volumio[7681]: cmd: '/usr/bin/aplay --device=plughw:5,0 /volumio/app/startup.wav' }
Jul 31 19:01:51 volumio volumio[7681]: info: MPD running with PID668 ,establishing connection
Jul 31 19:01:51 volumio volumio[7681]: info: Setting Device type: Raspberry PI
Jul 31 19:01:51 volumio sudo[7758]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1
Jul 31 19:01:51 volumio sudo[7758]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 31 19:01:51 volumio sudo[7758]: pam_unix(sudo:session): session closed for user root
Jul 31 19:01:51 volumio volumio-remote-updater[568]: [2017-07-31 19:01:51] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1501527709 101
Jul 31 19:01:51 volumio volumio[7681]: info: Volumio called home
Jul 31 19:01:51 volumio volumio[7681]: info: Reloading queue from file
Jul 31 19:01:51 volumio volumio[7681]: info: [1501527711912] VolumeController:: Volume=57 Mute =false
Jul 31 19:01:51 volumio volumio[7681]: info: [1501527711917] CoreStateMachine::pushState
Jul 31 19:01:51 volumio volumio[7681]: info: [1501527711922] CoreStateMachine::getState
Jul 31 19:01:51 volumio volumio[7681]: info: [1501527711924] CorePlayQueue::getTrack 0
Jul 31 19:01:51 volumio volumio[7681]: info: CoreCommandRouter::volumioPushState
Jul 31 19:01:51 volumio volumio[7681]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 31 19:01:51 volumio volumio[7681]: info: [1501527711936] interfaceApi::pushState
Jul 31 19:01:51 volumio volumio[7681]: info: [1501527711940] InterfaceWebUI::pushState
Jul 31 19:01:51 volumio volumio[7681]: info: [1501527711971] CoreStateMachine::setRepeat null single undefined
Jul 31 19:01:51 volumio volumio[7681]: info: [1501527711973] CoreStateMachine::pushState
Jul 31 19:01:51 volumio volumio[7681]: info: [1501527711974] CoreStateMachine::getState
Jul 31 19:01:51 volumio volumio[7681]: info: [1501527711975] CorePlayQueue::getTrack 0
Jul 31 19:01:51 volumio volumio[7681]: info: CoreCommandRouter::volumioPushState
Jul 31 19:01:51 volumio volumio[7681]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 31 19:01:51 volumio volumio[7681]: info: [1501527711979] interfaceApi::pushState
Jul 31 19:01:51 volumio volumio[7681]: info: [1501527711981] InterfaceWebUI::pushState
Jul 31 19:01:51 volumio volumio[7681]: info: [1501527711986] CoreStateMachine::setRandom true
Jul 31 19:01:51 volumio volumio[7681]: info: [1501527711988] CoreStateMachine::pushState
Jul 31 19:01:51 volumio volumio[7681]: info: [1501527711989] CoreStateMachine::getState
Jul 31 19:01:51 volumio volumio[7681]: info: [1501527711989] CorePlayQueue::getTrack 0
Jul 31 19:01:51 volumio volumio[7681]: info: CoreCommandRouter::volumioPushState
Jul 31 19:01:51 volumio volumio[7681]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 31 19:01:51 volumio volumio[7681]: info: [1501527711994] interfaceApi::pushState
Jul 31 19:01:51 volumio volumio[7681]: info: [1501527711995] InterfaceWebUI::pushState
Jul 31 19:01:52 volumio volumio[7681]: Discovery: adding 6d55e550-dce7-434d-b318-59253c25a3f4
Jul 31 19:01:52 volumio volumio[7681]: info: mDNS: Found device Volumio-2
Jul 31 19:01:52 volumio sudo[7770]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay
Jul 31 19:01:52 volumio sudo[7770]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 31 19:01:52 volumio systemd[1]: Stopping ShairportSync AirTunes receiver...
Jul 31 19:01:52 volumio systemd[1]: Starting ShairportSync AirTunes receiver...
Jul 31 19:01:52 volumio volumio[7681]: info: Pushing Favourites {"service":"mpd","uri":"mnt/NAS/Torck/Enrique Iglesias ft. Descemer Bueno, Zion & Lennox - Subeme la Radio.mp3","favourite":false}
Jul 31 19:01:52 volumio systemd[1]: Started ShairportSync AirTunes receiver.
Jul 31 19:01:52 volumio volumio[7681]: Discovery: adding 2336d836-387d-4cf2-aa6d-696eef0dc71b
Jul 31 19:01:52 volumio volumio[7681]: info: mDNS: Found device Volumio
Jul 31 19:01:52 volumio sudo[7770]: pam_unix(sudo:session): session closed for user root
Jul 31 19:01:52 volumio shairport-sync[7776]: Successful Startup
Jul 31 19:01:52 volumio volumio[7681]: info: Pushing Favourites {"service":"mpd","uri":"mnt/NAS/Torck/Enrique Iglesias ft. Descemer Bueno, Zion & Lennox - Subeme la Radio.mp3","favourite":false}
Jul 31 19:01:52 volumio volumio[7681]: info: Pushing Favourites {"service":"mpd","uri":"mnt/NAS/Torck/Enrique Iglesias ft. Descemer Bueno, Zion & Lennox - Subeme la Radio.mp3","favourite":false}
Jul 31 19:01:52 volumio volumio[7681]: info: [1501527712492] Shairport-Sync Started
Jul 31 19:01:53 volumio volumio[7681]: info: CoreCommandRouter::volumioGetState
Jul 31 19:01:53 volumio volumio[7681]: info: [1501527713746] CoreStateMachine::getState
Jul 31 19:01:53 volumio volumio[7681]: info: [1501527713747] CorePlayQueue::getTrack 0
Jul 31 19:01:53 volumio volumio[7681]: info:
Jul 31 19:01:53 volumio volumio[7681]: [1501527713748] ---------------------------- Client requests Volumio state
Jul 31 19:01:53 volumio volumio[7681]: info: [1501527713750] InterfaceWebUI::pushState
Jul 31 19:01:53 volumio volumio[7681]: info: [1501527713770] ------------------------------ 25ms
Jul 31 19:01:54 volumio volumio[7681]: info: Cannot mount NAS Torck at system boot, trial number 2 ,retrying in 5 seconds
Jul 31 19:01:55 volumio volumio[7681]: info: CoreCommandRouter::volumioGetState
Jul 31 19:01:55 volumio volumio[7681]: info: [1501527715752] CoreStateMachine::getState
Jul 31 19:01:55 volumio volumio[7681]: info: [1501527715753] CorePlayQueue::getTrack 0
Jul 31 19:01:55 volumio volumio[7681]: info:
Jul 31 19:01:55 volumio volumio[7681]: [1501527715754] ---------------------------- Client requests Volumio state
Jul 31 19:01:55 volumio volumio[7681]: info: [1501527715756] InterfaceWebUI::pushState
Jul 31 19:01:55 volumio volumio[7681]: info: [1501527715790] ------------------------------ 39ms
Jul 31 19:01:55 volumio volumio[7681]: info:
Jul 31 19:01:55 volumio volumio[7681]: [1501527715801] ---------------------------- Client requests Menu Items
Jul 31 19:01:55 volumio volumio[7681]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jul 31 19:01:55 volumio volumio[7681]: Plugin multiroom or method getMultiroom not found
Jul 31 19:01:55 volumio volumio[7681]: info: [1501527715836] Listing playlists
Jul 31 19:01:55 volumio volumio[7681]: info: CoreCommandRouter::volumioGetQueue
Jul 31 19:01:55 volumio volumio[7681]: info: [1501527715841] CoreStateMachine::getQueue
Jul 31 19:01:55 volumio volumio[7681]: info: [1501527715842] CorePlayQueue::getQueue
Jul 31 19:01:55 volumio volumio[7681]: info:
Jul 31 19:01:55 volumio volumio[7681]: [1501527715857] ---------------------------- Client requests Volumio queue
Jul 31 19:01:55 volumio volumio[7681]: info: [1501527715869] InterfaceWebUI::pushQueue
Jul 31 19:01:55 volumio volumio[7681]: info: [1501527715920] ------------------------------ 81ms
Jul 31 19:01:56 volumio volumio[7681]: info: [1501527716124] ------------------------------ 323ms