-- Logs begin at Thu 2023-01-26 17:04:40 +07, end at Thu 2023-01-26 17:14:16 +07. --
Jan 26 17:13:00 ms-1000 sudo[2832]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2023-01-26 17:12
Jan 26 17:13:00 ms-1000 sudo[2832]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 26 17:13:00 ms-1000 sudo[2832]: pam_unix(sudo:session): session closed for user root
Jan 26 17:13:01 ms-1000 volumio-remote-updater[575]: [2023-01-26 17:13:01] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Jan 26 17:13:01 ms-1000 volumio-remote-updater[575]: [2023-01-26 17:13:01] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Jan 26 17:13:01 ms-1000 systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE
Jan 26 17:13:01 ms-1000 systemd[1]: Unit volumio.service entered failed state.
Jan 26 17:13:01 ms-1000 systemd[1]: Starting dynamicswap service...
Jan 26 17:13:01 ms-1000 systemd[1]: Started dynamicswap service.
Jan 26 17:13:01 ms-1000 systemd[1]: volumio.service holdoff time over, scheduling restart.
Jan 26 17:13:01 ms-1000 systemd[1]: Starting dynamicswap service...
Jan 26 17:13:01 ms-1000 systemd[1]: Started dynamicswap service.
Jan 26 17:13:01 ms-1000 systemd[1]: Stopping Volumio Backend Module...
Jan 26 17:13:01 ms-1000 systemd[1]: Starting Volumio Backend Module...
Jan 26 17:13:01 ms-1000 systemd[1]: Started Volumio Backend Module.
Jan 26 17:13:03 ms-1000 volumio[2857]: info: -------------------------------------------
Jan 26 17:13:03 ms-1000 volumio[2857]: info: ----- Volumio3 ----
Jan 26 17:13:03 ms-1000 volumio[2857]: info: -------------------------------------------
Jan 26 17:13:03 ms-1000 volumio[2857]: info: ----- System startup ----
Jan 26 17:13:03 ms-1000 volumio[2857]: info: -------------------------------------------
Jan 26 17:13:04 ms-1000 volumio[2857]: info: MYVOLUMIO Environment detected
Jan 26 17:13:04 ms-1000 volumio[2857]: info: Plugin folders cleanup
Jan 26 17:13:04 ms-1000 volumio[2857]: info: Scanning into folder /volumio/app/plugins/
Jan 26 17:13:04 ms-1000 volumio[2857]: info: Scanning category audio_interface
Jan 26 17:13:04 ms-1000 volumio[2857]: info: Scanning category miscellanea
Jan 26 17:13:04 ms-1000 volumio[2857]: info: Scanning category music_service
Jan 26 17:13:04 ms-1000 volumio[2857]: info: Scanning category plugins.json
Jan 26 17:13:04 ms-1000 volumio[2857]: info: Scanning category system_controller
Jan 26 17:13:04 ms-1000 volumio[2857]: info: Scanning category user_interface
Jan 26 17:13:04 ms-1000 volumio[2857]: info: Scanning into folder /data/plugins/
Jan 26 17:13:04 ms-1000 volumio[2857]: info: Scanning category miscellanea
Jan 26 17:13:04 ms-1000 volumio[2857]: info: Scanning category music_service
Jan 26 17:13:04 ms-1000 volumio[2857]: info: Scanning category system_hardware
Jan 26 17:13:04 ms-1000 volumio[2857]: info: Plugin folders cleanup completed
Jan 26 17:13:04 ms-1000 volumio[2857]: info: -------------------------------------------
Jan 26 17:13:04 ms-1000 volumio[2857]: info: ----- Core plugins startup ----
Jan 26 17:13:04 ms-1000 volumio[2857]: info: -------------------------------------------
Jan 26 17:13:04 ms-1000 volumio[2857]: info: Loading plugins from folder /volumio/app/plugins/
Jan 26 17:13:04 ms-1000 volumio[2857]: info: Adding plugin upnp to MyMusic Plugins
Jan 26 17:13:04 ms-1000 volumio[2857]: info: Adding plugin airplay_emulation to MyMusic Plugins
Jan 26 17:13:04 ms-1000 volumio[2857]: info: Adding plugin upnp_browser to MyMusic Plugins
Jan 26 17:13:04 ms-1000 volumio[2857]: info: Loading plugins from folder /data/plugins/
Jan 26 17:13:04 ms-1000 volumio[2857]: info: Loading plugin "system"...
Jan 26 17:13:04 ms-1000 volumio[2857]: info: Loading plugin "mpd_oled"...
Jan 26 17:13:04 ms-1000 volumio[2857]: info: Applying required configuration parameters for plugin mpd_oled
Jan 26 17:13:04 ms-1000 volumio[2857]: info: [MPD_OLED Plugin] Reading configuration file at: /data/configuration/miscellanea/mpd_oled/config.json
Jan 26 17:13:04 ms-1000 volumio[2857]: info: Loading plugin "appearance"...
Jan 26 17:13:06 ms-1000 volumio[2857]: info: Loading plugin "network"...
Jan 26 17:13:06 ms-1000 volumio[2857]: info: Refreshing Cached IP Addresses
Jan 26 17:13:06 ms-1000 sudo[2883]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jan 26 17:13:06 ms-1000 volumio-remote-updater[575]: [2023-01-26 17:13:06] [connect] Successful connection
Jan 26 17:13:06 ms-1000 sudo[2883]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 26 17:13:06 ms-1000 sudo[2883]: pam_unix(sudo:session): session closed for user root
Jan 26 17:13:06 ms-1000 sudo[2887]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jan 26 17:13:06 ms-1000 volumio[2857]: info: Loading plugin "services"...
Jan 26 17:13:06 ms-1000 sudo[2887]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 26 17:13:06 ms-1000 volumio[2857]: info: Loading plugin "alsa_controller"...
Jan 26 17:13:06 ms-1000 sudo[2887]: pam_unix(sudo:session): session closed for user root
Jan 26 17:13:06 ms-1000 sudo[2895]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Jan 26 17:13:06 ms-1000 sudo[2895]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 26 17:13:06 ms-1000 volumio[2857]: info: Loading plugin "wizard"...
Jan 26 17:13:06 ms-1000 volumio[2857]: info: Loading plugin "volumio_command_line_client"...
Jan 26 17:13:06 ms-1000 volumio[2857]: info: Loading plugin "upnp"...
Jan 26 17:13:06 ms-1000 volumio[2857]: info: [1674727986718] Starting Upmpd Daemon
Jan 26 17:13:06 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jan 26 17:13:06 ms-1000 volumio[2857]: info: Loading plugin "my_music"...
Jan 26 17:13:06 ms-1000 volumio[2857]: info: Loading plugin "mpd"...
Jan 26 17:13:07 ms-1000 volumio[2857]: info: Creating MPD Configuration file
Jan 26 17:13:07 ms-1000 sudo[2909]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jan 26 17:13:07 ms-1000 volumio[2857]: info: Loading plugin "upnp_browser"...
Jan 26 17:13:07 ms-1000 sudo[2909]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 26 17:13:07 ms-1000 sudo[2909]: pam_unix(sudo:session): session closed for user root
Jan 26 17:13:07 ms-1000 sudo[2912]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jan 26 17:13:07 ms-1000 sudo[2912]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 26 17:13:07 ms-1000 systemd[1]: Stopping Music Player Daemon...
Jan 26 17:13:07 ms-1000 systemd[1]: Starting Music Player Daemon...
Jan 26 17:13:07 ms-1000 volumio[2857]: info: Loading plugin "networkfs"...
Jan 26 17:13:07 ms-1000 volumio[2857]: info: Starting Udev Watcher for removable devices
Jan 26 17:13:07 ms-1000 volumio[2857]: info: Ignoring mount for partition: boot
Jan 26 17:13:07 ms-1000 volumio[2857]: info: Ignoring mount for partition: volumio
Jan 26 17:13:07 ms-1000 volumio[2857]: info: Ignoring mount for partition: volumio_data
Jan 26 17:13:07 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jan 26 17:13:07 ms-1000 volumio[2857]: info: Loading plugin "alarm-clock"...
Jan 26 17:13:07 ms-1000 systemd[1]: Started Music Player Daemon.
Jan 26 17:13:07 ms-1000 sudo[2912]: pam_unix(sudo:session): session closed for user root
Jan 26 17:13:07 ms-1000 volumio[2857]: info: Loading plugin "airplay_emulation"...
Jan 26 17:13:07 ms-1000 volumio[2857]: info: Starting Shairport Sync
Jan 26 17:13:07 ms-1000 volumio[2857]: info: Loading plugin "last_100"...
Jan 26 17:13:07 ms-1000 volumio[2857]: info: Loading plugin "webradio"...
Jan 26 17:13:07 ms-1000 volumio[2857]: info: Loading plugin "i2s_dacs"...
Jan 26 17:13:08 ms-1000 volumio[2857]: info: Loading plugin "volumiodiscovery"...
Jan 26 17:13:08 ms-1000 volumio[2857]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jan 26 17:13:08 ms-1000 node[2857]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jan 26 17:13:08 ms-1000 node[2857]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jan 26 17:13:08 ms-1000 node[2857]: *** WARNING *** For more information see
Jan 26 17:13:08 ms-1000 node[2857]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jan 26 17:13:08 ms-1000 node[2857]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jan 26 17:13:08 ms-1000 node[2857]: *** WARNING *** For more information see
Jan 26 17:13:08 ms-1000 volumio[2857]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jan 26 17:13:08 ms-1000 volumio[2857]: *** WARNING *** For more information see
Jan 26 17:13:08 ms-1000 volumio[2857]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jan 26 17:13:08 ms-1000 volumio[2857]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jan 26 17:13:08 ms-1000 volumio[2857]: *** WARNING *** For more information see
Jan 26 17:13:08 ms-1000 volumio[2857]: info: Applying required configuration parameters for plugin volumiodiscovery
Jan 26 17:13:08 ms-1000 volumio[2857]: info: Discovery: Started advertising with name: MS 1000
Jan 26 17:13:08 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jan 26 17:13:08 ms-1000 volumio[2857]: info: Loading plugin "youtube2"...
Jan 26 17:13:09 ms-1000 sudo[2895]: pam_unix(sudo:session): session closed for user root
Jan 26 17:13:11 ms-1000 volumio[2857]: info: Loading plugin "ytcr"...
Jan 26 17:13:12 ms-1000 volumio[2857]: info: Loading plugin "outputs"...
Jan 26 17:13:12 ms-1000 volumio[2857]: info: Loading plugin "albumart"...
Jan 26 17:13:12 ms-1000 volumio[2857]: info: Plugin example_plugin is not enabled
Jan 26 17:13:12 ms-1000 volumio[2857]: info: Loading plugin "inputs"...
Jan 26 17:13:12 ms-1000 volumio[2857]: info: Loading plugin "updater_comm"...
Jan 26 17:13:12 ms-1000 volumio[2857]: info: Plugin mpdemulation is not enabled
Jan 26 17:13:12 ms-1000 volumio[2857]: info: Loading plugin "rest_api"...
Jan 26 17:13:12 ms-1000 volumio[2857]: info: Loading plugin "websocket"...
Jan 26 17:13:12 ms-1000 volumio[2857]: info: Loading plugin "volspotconnect2"...
Jan 26 17:13:13 ms-1000 volumio[2857]: Forking 3 albumart workers
Jan 26 17:13:13 ms-1000 volumio[2857]: info: Loading plugin "ir_controller"...
Jan 26 17:13:13 ms-1000 volumio[2857]: info: Applying required configuration parameters for plugin ir_controller
Jan 26 17:13:13 ms-1000 volumio[2857]: info: Loading i18n strings for locale vi
Jan 26 17:13:13 ms-1000 volumio[2857]: error: ir_controller: Fetching language file: Error: i18n file complementing the system language not found.
Jan 26 17:13:13 ms-1000 volumio[2857]: Updating browse sources language
Jan 26 17:13:13 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jan 26 17:13:13 ms-1000 volumio[2857]: Starting albumart workers
Jan 26 17:13:13 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jan 26 17:13:13 ms-1000 volumio[2857]: info: CoreCommandRouter::initPlayerControls
Jan 26 17:13:13 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 26 17:13:13 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 26 17:13:13 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 26 17:13:13 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 26 17:13:13 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 26 17:13:13 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 26 17:13:13 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 26 17:13:13 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 26 17:13:13 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jan 26 17:13:13 ms-1000 volumio[2857]: Express server listening on port 3000
Jan 26 17:13:13 ms-1000 volumio[2857]: [Metrics] WebUI: 11s 34.60ms
Jan 26 17:13:14 ms-1000 volumio[2857]: Starting albumart workers
Jan 26 17:13:14 ms-1000 volumio[2857]: info: CoreStateMachine::resetVolumioState
Jan 26 17:13:14 ms-1000 volumio[2857]: info: CoreStateMachine::getcurrentVolume
Jan 26 17:13:14 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioRetrievevolume
Jan 26 17:13:14 ms-1000 volumio[2857]: Starting albumart workers
Jan 26 17:13:14 ms-1000 volumio[2857]: info: MPD Permissions set
Jan 26 17:13:14 ms-1000 volumio[2857]: verbose: New Socket.io Connection to 192.168.100.13:3000 from 192.168.100.17 UA: Dart/3.5 (dart:io) Total Clients: 1
Jan 26 17:13:14 ms-1000 volumio[2857]: verbose: New Socket.io Connection to 192.168.100.13 from 192.168.100.17 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_5 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Total Clients: 2
Jan 26 17:13:14 ms-1000 volumio[2857]: verbose: New Socket.io Connection to 192.168.100.13 from 192.168.100.17 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_5 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Total Clients: 4
Jan 26 17:13:14 ms-1000 volumio[2857]: info: MPD running with PID2924
Jan 26 17:13:14 ms-1000 volumio[2857]: ,establishing connection
Jan 26 17:13:14 ms-1000 volumio[2857]: info: CoreStateMachine::pushState
Jan 26 17:13:14 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:14 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 26 17:13:14 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioPushState
Jan 26 17:13:14 ms-1000 volumio[2857]: info: CoreStateMachine::updateTrackBlock
Jan 26 17:13:14 ms-1000 volumio[2857]: info: CorePlayQueue::getTrackBlock
Jan 26 17:13:14 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioRetrievevolume
Jan 26 17:13:14 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jan 26 17:13:14 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jan 26 17:13:14 ms-1000 volumio[2857]: info: Discovery: Getting this device information
Jan 26 17:13:14 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:14 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:14 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jan 26 17:13:14 ms-1000 volumio[2857]: error: MPD error: false == true
Jan 26 17:13:14 ms-1000 volumio[2857]: error: MPD error: false == true
Jan 26 17:13:14 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 26 17:13:14 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 26 17:13:14 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 26 17:13:14 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 26 17:13:14 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 26 17:13:14 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 26 17:13:14 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 26 17:13:14 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 26 17:13:14 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 26 17:13:14 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 26 17:13:14 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 26 17:13:14 ms-1000 volumio[2857]: info: Reloading queue from file
Jan 26 17:13:14 ms-1000 volumio[2857]: info: CoreStateMachine::pushState
Jan 26 17:13:14 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:14 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioPushState
Jan 26 17:13:14 ms-1000 volumio[2857]: info: CoreStateMachine::setRepeat true single undefined
Jan 26 17:13:14 ms-1000 volumio[2857]: info: CoreStateMachine::pushState
Jan 26 17:13:14 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:14 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 26 17:13:14 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioPushState
Jan 26 17:13:14 ms-1000 volumio[2857]: info: CoreStateMachine::setRandom true
Jan 26 17:13:14 ms-1000 volumio[2857]: info: CoreStateMachine::pushState
Jan 26 17:13:14 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:14 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 26 17:13:14 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioPushState
Jan 26 17:13:14 ms-1000 volumio[2857]: info: Setting Device type: Raspberry PI
Jan 26 17:13:14 ms-1000 volumio[2857]: error: updateQueue error: null
Jan 26 17:13:14 ms-1000 volumio[2857]: error: Failed LSINFO: Error: [50@0] {} No such directory
Jan 26 17:13:14 ms-1000 volumio[2857]: info: Completed loading Core Plugins
Jan 26 17:13:14 ms-1000 volumio[2857]: info: Preparing to generate the ALSA configuration file
Jan 26 17:13:14 ms-1000 volumio[2857]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf
Jan 26 17:13:14 ms-1000 volumio[2857]: info: Reading ALSA contributions from plugins.
Jan 26 17:13:14 ms-1000 volumio[2857]: info: Asound.conf file unchanged, so no further update is needed
Jan 26 17:13:14 ms-1000 volumio[2857]: info: Output device has changed, restarting MPD
Jan 26 17:13:14 ms-1000 sudo[3012]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jan 26 17:13:14 ms-1000 volumio[2857]: info: Output device has changed, restarting Shairport Sync
Jan 26 17:13:14 ms-1000 sudo[3012]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 26 17:13:14 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 26 17:13:14 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 26 17:13:14 ms-1000 sudo[3012]: pam_unix(sudo:session): session closed for user root
Jan 26 17:13:14 ms-1000 sudo[3016]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jan 26 17:13:14 ms-1000 sudo[3016]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 26 17:13:14 ms-1000 systemd[1]: Stopping Music Player Daemon...
Jan 26 17:13:14 ms-1000 volumio[2857]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jan 26 17:13:14 ms-1000 volumio[2857]: info: ___________ START PLUGINS ___________
Jan 26 17:13:14 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jan 26 17:13:14 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jan 26 17:13:14 ms-1000 volumio[2857]: info: [1674727994979] CoreMusicLibrary::Adding element Media Servers
Jan 26 17:13:14 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jan 26 17:13:14 ms-1000 volumio[2857]: Cannot find translation for sourceMedia Servers
Jan 26 17:13:14 ms-1000 sudo[3031]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall mpd_oled_cava
Jan 26 17:13:14 ms-1000 sudo[3030]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall cava
Jan 26 17:13:14 ms-1000 sudo[3031]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 26 17:13:14 ms-1000 sudo[3030]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 26 17:13:15 ms-1000 sudo[3031]: pam_unix(sudo:session): session closed for user root
Jan 26 17:13:15 ms-1000 sudo[3030]: pam_unix(sudo:session): session closed for user root
Jan 26 17:13:15 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 26 17:13:15 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 26 17:13:15 ms-1000 systemd[1]: Starting Music Player Daemon...
Jan 26 17:13:15 ms-1000 volumio[2857]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jan 26 17:13:15 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 26 17:13:15 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 26 17:13:15 ms-1000 volumio[2857]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jan 26 17:13:15 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jan 26 17:13:15 ms-1000 volumio[2857]: info: [1674727995132] CoreMusicLibrary::Adding element Last_100
Jan 26 17:13:15 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jan 26 17:13:15 ms-1000 volumio[2857]: Cannot find translation for sourceMedia Servers
Jan 26 17:13:15 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jan 26 17:13:15 ms-1000 volumio[2857]: info: [1674727995137] CoreMusicLibrary::Adding element Webradio
Jan 26 17:13:15 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jan 26 17:13:15 ms-1000 volumio[2857]: Cannot find translation for sourceMedia Servers
Jan 26 17:13:15 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jan 26 17:13:15 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jan 26 17:13:15 ms-1000 volumio[2857]: info: [1674727995165] CoreMusicLibrary::Adding element YouTube
Jan 26 17:13:15 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jan 26 17:13:15 ms-1000 volumio[2857]: Cannot find translation for sourceMedia Servers
Jan 26 17:13:15 ms-1000 volumio[2857]: Cannot find translation for sourceYouTube
Jan 26 17:13:15 ms-1000 volumio[2857]: [SpotifyConnect] Creating VLS config file
Jan 26 17:13:15 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 26 17:13:15 ms-1000 volumio[2857]: [SpotifyConnect] /tmp/volume: 100
Jan 26 17:13:15 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 26 17:13:15 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 26 17:13:15 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 26 17:13:15 ms-1000 volumio[2857]: [SpotifyConnect] Volumio alsa_controller configuration:
Jan 26 17:13:15 ms-1000 volumio[2857]: outdev:volumio
Jan 26 17:13:15 ms-1000 volumio[2857]: outputdevicemixer:2
Jan 26 17:13:15 ms-1000 volumio[2857]: volcurve:logarithmic
Jan 26 17:13:15 ms-1000 volumio[2857]: mixtype:Software
Jan 26 17:13:15 ms-1000 volumio[2857]: mixname:SoftMaster
Jan 26 17:13:15 ms-1000 volumio[2857]: [SpotifyConnect] MODULAR_ALSA_PIPELINE: true
Jan 26 17:13:15 ms-1000 volumio[2857]: [SpotifyConnect]
Jan 26 17:13:15 ms-1000 volumio[2857]: outdev:volumio
Jan 26 17:13:15 ms-1000 volumio[2857]: mixer:alsa
Jan 26 17:13:15 ms-1000 volumio[2857]: mixname:SoftMaster
Jan 26 17:13:15 ms-1000 volumio[2857]: mixdev:hw:2
Jan 26 17:13:15 ms-1000 volumio[2857]: mixidx:0
Jan 26 17:13:15 ms-1000 volumio[2857]: [SpotifyConnect] Starting metadata listener
Jan 26 17:13:15 ms-1000 volumio[2857]: info: Loading i18n strings for locale vi
Jan 26 17:13:15 ms-1000 volumio[2857]: error: ir_controller: Fetching language file: Error: i18n file complementing the system language not found.
Jan 26 17:13:15 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jan 26 17:13:15 ms-1000 sudo[3055]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect2.service
Jan 26 17:13:15 ms-1000 sudo[3055]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 26 17:13:15 ms-1000 systemd[1]: Started Volspotconnect2 Daemon.
Jan 26 17:13:15 ms-1000 sudo[3055]: pam_unix(sudo:session): session closed for user root
Jan 26 17:13:15 ms-1000 volumio[2857]: info: Volumio Calling Home
Jan 26 17:13:15 ms-1000 sudo[3066]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R a+rwX /etc/lirc/hardware.conf /etc/lirc/lircd.conf /etc/lirc/lircmd.conf /etc/lirc/lircrc
Jan 26 17:13:15 ms-1000 sudo[3066]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 26 17:13:15 ms-1000 sudo[3066]: pam_unix(sudo:session): session closed for user root
Jan 26 17:13:15 ms-1000 systemd[1]: Started Music Player Daemon.
Jan 26 17:13:15 ms-1000 sudo[3016]: pam_unix(sudo:session): session closed for user root
Jan 26 17:13:15 ms-1000 volumio[2857]: info: Discovery: adding d3ee9b2e-9f9c-4e4e-abbc-55748f6d18e3
Jan 26 17:13:15 ms-1000 volumio[2857]: info: mDNS: Found device MS 1000
Jan 26 17:13:15 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:15 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:15 ms-1000 volumio[2857]: info: ir_controller: File permissions successfully set on /etc/lirc/*.
Jan 26 17:13:15 ms-1000 volumio[2857]: [SpotifyConnect] Vollibrespot Daemon service started!
Jan 26 17:13:15 ms-1000 volumio[2857]: [Metrics] SpotifyConnect: 0s 381.12ms
Jan 26 17:13:15 ms-1000 volumio[2857]: info: [MPD_OLED Plugin] Disabling mpd_oled service: /usr/bin/sudo /usr/sbin/service mpd_oled status && /usr/bin/sudo /bin/systemctl disable mpd_oled
Jan 26 17:13:15 ms-1000 volumio[2857]: info: MPD Permissions set
Jan 26 17:13:15 ms-1000 sudo[3085]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/service mpd_oled status
Jan 26 17:13:15 ms-1000 sudo[3085]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 26 17:13:15 ms-1000 volumio[2857]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 4
Jan 26 17:13:15 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 26 17:13:15 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 26 17:13:15 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 26 17:13:15 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 26 17:13:15 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 26 17:13:15 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 26 17:13:15 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 26 17:13:15 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 26 17:13:15 ms-1000 sudo[3085]: pam_unix(sudo:session): session closed for user root
Jan 26 17:13:15 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 26 17:13:15 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 26 17:13:15 ms-1000 volumio[2857]: error: updateQueue error: null
Jan 26 17:13:15 ms-1000 volumio[2857]: info: [MPD_OLED Plugin] Stopping mpd_oled: /usr/bin/sudo /usr/bin/killall mpd_oled
Jan 26 17:13:15 ms-1000 volumio[2857]: info: Starting Shairport Sync
Jan 26 17:13:15 ms-1000 sudo[3100]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall mpd_oled
Jan 26 17:13:15 ms-1000 sudo[3100]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 26 17:13:15 ms-1000 volumio[2857]: info: Starting Shairport Sync
Jan 26 17:13:15 ms-1000 sudo[3100]: pam_unix(sudo:session): session closed for user root
Jan 26 17:13:15 ms-1000 sudo[3106]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jan 26 17:13:15 ms-1000 volumio[2857]: info: Starting Shairport Sync
Jan 26 17:13:15 ms-1000 sudo[3106]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 26 17:13:15 ms-1000 sudo[3113]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jan 26 17:13:15 ms-1000 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jan 26 17:13:15 ms-1000 shairport-sync[1223]: {"time":1674727798798,"response":"startAirplayPlayback Success"}
Jan 26 17:13:15 ms-1000 systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver...
Jan 26 17:13:15 ms-1000 sudo[3113]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 26 17:13:15 ms-1000 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jan 26 17:13:15 ms-1000 sudo[3106]: pam_unix(sudo:session): session closed for user root
Jan 26 17:13:15 ms-1000 sudo[3123]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jan 26 17:13:15 ms-1000 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jan 26 17:13:15 ms-1000 sudo[3123]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 26 17:13:15 ms-1000 systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver...
Jan 26 17:13:15 ms-1000 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jan 26 17:13:15 ms-1000 sudo[3113]: pam_unix(sudo:session): session closed for user root
Jan 26 17:13:15 ms-1000 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jan 26 17:13:15 ms-1000 systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver...
Jan 26 17:13:15 ms-1000 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jan 26 17:13:15 ms-1000 sudo[3123]: pam_unix(sudo:session): session closed for user root
Jan 26 17:13:15 ms-1000 volumio[2857]: [yt-cast-receiver] Listening on port 8098
Jan 26 17:13:15 ms-1000 volumio[2857]: info: ir_controller: LIRC correctly updated.
Jan 26 17:13:15 ms-1000 volumio[2857]: info: ir_controller: HAT already loaded /proc/device-tree/ir_receiver!
Jan 26 17:13:15 ms-1000 volumio[2857]: info: Completed starting Core Plugins
Jan 26 17:13:15 ms-1000 volumio[2857]: info: -------------------------------------------
Jan 26 17:13:15 ms-1000 volumio[2857]: info: ----- MyVolumio plugins startup ----
Jan 26 17:13:15 ms-1000 volumio[2857]: info: -------------------------------------------
Jan 26 17:13:15 ms-1000 volumio[2857]: info: [MyVolumio PluginManager] Fetching plans data....
Jan 26 17:13:15 ms-1000 volumio[2857]: info: BOOT COMPLETED
Jan 26 17:13:15 ms-1000 volumio[2857]: [Metrics] CommandRouter: 12s 542.10ms
Jan 26 17:13:15 ms-1000 volumio[2857]: info: CoreCommandRouter::volumiosetStartupVolume
Jan 26 17:13:15 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 26 17:13:15 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 26 17:13:15 ms-1000 volumio[2857]: info: CoreCommandRouter::Close All Modals sent
Jan 26 17:13:15 ms-1000 volumio[2857]: info: CoreCommandRouter::Close All Modals sent
Jan 26 17:13:15 ms-1000 volumio[2857]: error: Upnp client error: Error: This socket has been ended by the other party
Jan 26 17:13:16 ms-1000 volumio[2857]: info: Shairport-Sync Started
Jan 26 17:13:16 ms-1000 volumio[2857]: Error adding Membership: Error: addMembership EINVAL
Jan 26 17:13:16 ms-1000 volumio[2857]: info: Shairport-Sync Started
Jan 26 17:13:16 ms-1000 volumio[2857]: info: Shairport-Sync Started
Jan 26 17:13:16 ms-1000 volumio[2857]: info: [MPD_OLED Plugin] mpd_oled process is not running
Jan 26 17:13:16 ms-1000 volumio[2857]: info: [MPD_OLED Plugin] Starting mpd_oled: mpd_oled -o 3 -b 16 -g 1 -f 50 -s 30,5 -C 0 -P p -B 1 -r 25 -D 24 -S 0
Jan 26 17:13:16 ms-1000 volumio[2857]: info: Volumio called home
Jan 26 17:13:16 ms-1000 kernel: rc rc0: two consecutive events of type space
Jan 26 17:13:16 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:16 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:16 ms-1000 volumio[2857]: verbose: New Socket.io Connection to 192.168.100.13 from 192.168.100.17 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_5 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Total Clients: 5
Jan 26 17:13:16 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jan 26 17:13:16 ms-1000 volumio[2857]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Jan 26 17:13:16 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Jan 26 17:13:16 ms-1000 volumio[2857]: info: Received Get System Version
Jan 26 17:13:16 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jan 26 17:13:16 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetVisibleSources
Jan 26 17:13:16 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jan 26 17:13:16 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:16 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:16 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jan 26 17:13:16 ms-1000 volumio[2857]: info: Listing playlists
Jan 26 17:13:16 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:16 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:16 ms-1000 volumio[2857]: info: [MPD_OLED Plugin] mpd_oled started OK and continues to run!
Jan 26 17:13:16 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:16 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:16 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:16 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:16 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:16 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:16 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:16 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:16 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:16 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:16 ms-1000 sudo[3165]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jan 26 17:13:16 ms-1000 sudo[3165]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 26 17:13:16 ms-1000 sudo[3165]: pam_unix(sudo:session): session closed for user root
Jan 26 17:13:16 ms-1000 sudo[3170]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jan 26 17:13:16 ms-1000 sudo[3170]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 26 17:13:16 ms-1000 sudo[3170]: pam_unix(sudo:session): session closed for user root
Jan 26 17:13:16 ms-1000 sudo[3177]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Jan 26 17:13:16 ms-1000 sudo[3177]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 26 17:13:16 ms-1000 systemd[1]: Started UPnP Renderer front-end to MPD.
Jan 26 17:13:16 ms-1000 sudo[3177]: pam_unix(sudo:session): session closed for user root
Jan 26 17:13:16 ms-1000 volumio[2857]: info: Upmpdcli Daemon Started
Jan 26 17:13:16 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:16 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:16 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:16 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:16 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Jan 26 17:13:16 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Jan 26 17:13:16 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Jan 26 17:13:16 ms-1000 sudo[3192]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop lirc.service
Jan 26 17:13:17 ms-1000 sudo[3192]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 26 17:13:17 ms-1000 systemd[1]: Stopping LSB: Starts LIRC daemon....
Jan 26 17:13:17 ms-1000 lircd-0.9.0-pre1[1363]: removed client
Jan 26 17:13:17 ms-1000 lirc[3197]: Stopping execution daemon: irexec:.
Jan 26 17:13:17 ms-1000 lircd-0.9.0-pre1[1363]: caught signal
Jan 26 17:13:17 ms-1000 lirc[3197]: Stopping remote control daemon(s): LIRC:.
Jan 26 17:13:17 ms-1000 systemd[1]: Stopped LSB: Starts LIRC daemon..
Jan 26 17:13:17 ms-1000 sudo[3192]: pam_unix(sudo:session): session closed for user root
Jan 26 17:13:17 ms-1000 volumio[2857]: info: ir_controller: systemctl stop lirc.service succeeded.
Jan 26 17:13:17 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:17 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:17 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:17 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:17 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:17 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:17 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:17 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:17 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:17 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:17 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:17 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:18 ms-1000 sudo[3212]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start lirc.service
Jan 26 17:13:18 ms-1000 sudo[3212]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 26 17:13:18 ms-1000 systemd[1]: Starting LSB: Starts LIRC daemon....
Jan 26 17:13:18 ms-1000 lirc[3217]: Loading LIRC modules:.
Jan 26 17:13:18 ms-1000 lircd-0.9.0-pre1[3226]: lircd(default) ready, using /var/run/lirc/lircd
Jan 26 17:13:18 ms-1000 lirc[3217]: Starting remote control daemon(s) : LIRC :.
Jan 26 17:13:18 ms-1000 kernel: input: lircd as /devices/virtual/input/input3
Jan 26 17:13:18 ms-1000 lircd-0.9.0-pre1[3226]: accepted new client on /var/run/lirc/lircd
Jan 26 17:13:18 ms-1000 lirc[3217]: Starting execution daemon: irexec:.
Jan 26 17:13:18 ms-1000 systemd[1]: Started LSB: Starts LIRC daemon..
Jan 26 17:13:18 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:18 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:18 ms-1000 sudo[3212]: pam_unix(sudo:session): session closed for user root
Jan 26 17:13:18 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:18 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:18 ms-1000 volumio[2857]: info: ir_controller: systemctl start lirc.service succeeded.
Jan 26 17:13:18 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:18 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:18 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:18 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:18 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:18 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:18 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:18 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:19 ms-1000 volumio-remote-updater[575]: [2023-01-26 17:13:19] [connect] Successful connection
Jan 26 17:13:19 ms-1000 volumio-remote-updater[575]: [2023-01-26 17:13:19] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1674727999 101
Jan 26 17:13:19 ms-1000 volumio[2857]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.5.1 Total Clients: 6
Jan 26 17:13:19 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:19 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:19 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:19 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:19 ms-1000 volumio[2857]: error: error
Jan 26 17:13:19 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:19 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:19 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:19 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:19 ms-1000 volumio[2857]: error: MPD error: false == true
Jan 26 17:13:19 ms-1000 volumio[2857]: error: updateQueue error: null
Jan 26 17:13:19 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:19 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:19 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:19 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:20 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:20 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:20 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:20 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:20 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:20 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:20 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:20 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:20 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:20 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:20 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:20 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:21 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:21 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:21 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:21 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:21 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:21 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:21 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:21 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:21 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:21 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:21 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:21 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:22 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:22 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:22 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:22 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:22 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:22 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:22 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:22 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:22 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:22 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:22 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:22 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:22 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:22 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:22 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:22 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:23 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:23 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:23 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:23 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:23 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:23 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:23 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:23 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:23 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:23 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:23 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:23 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:24 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:24 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:24 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:24 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:24 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:24 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:24 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:24 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:24 ms-1000 volumio[2857]: error: updateQueue error: null
Jan 26 17:13:24 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:24 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:24 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:24 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:25 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:25 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:25 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:25 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:25 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:25 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:25 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:25 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:25 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:25 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:25 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:25 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:26 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:26 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:26 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:26 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:26 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:26 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:26 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:26 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:26 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:26 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:26 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:26 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:27 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:27 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:27 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:27 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:27 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:27 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:27 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:27 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:27 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:27 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:27 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:27 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:27 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:27 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:27 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:27 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:28 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:28 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:28 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:28 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:28 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:28 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:28 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:28 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:28 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:28 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:28 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:28 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:29 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:29 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:29 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:29 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:29 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:29 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:29 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:29 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:29 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:29 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:29 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:29 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:30 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:30 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:30 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:30 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:30 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:30 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:30 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:30 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:30 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:30 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:30 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:30 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:31 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:31 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:31 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:31 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:31 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:31 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:31 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:31 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:31 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:31 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:31 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:31 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:32 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:32 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:32 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:32 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:32 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:32 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:32 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:32 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:32 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:32 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:32 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:32 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:32 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:32 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:32 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:32 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:33 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:33 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:33 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:33 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:33 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:33 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:33 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:33 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:33 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:33 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:33 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:33 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:34 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:34 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:34 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:34 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:34 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:34 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:34 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:34 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:34 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:34 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:34 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:34 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:35 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:35 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:35 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:35 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:35 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:35 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:35 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:35 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:35 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:35 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:35 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:35 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:36 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:36 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:36 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:36 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:36 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:36 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:36 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:36 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:36 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:36 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:36 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:36 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:37 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:37 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:37 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:37 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:37 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:37 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:37 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:37 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:37 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:37 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:37 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:37 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:37 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:37 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:37 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:37 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:38 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:38 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:38 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:38 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:38 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:38 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:38 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:38 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:38 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:38 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:38 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:38 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:39 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:39 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:39 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:39 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:39 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:39 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:39 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:39 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:39 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:39 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:39 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:39 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreCommandRouter::servicePushState
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:40 ms-1000 volumio[2857]: verbose: STATE SERVICE {"status":"play","service":"airplay_emulation","title":"","artist":"","album":"","albumart":"/albumart","uri":"","trackType":"airplay","seek":0,"duration":0,"samplerate":"","bitdepth":"","channels":2,"disableUiControls":true}
Jan 26 17:13:40 ms-1000 volumio[2857]: verbose: CURRENT POSITION 0
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreStateMachine::syncState stateService play
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreStateMachine::syncState currentStatus stop
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreStateMachine::pushState
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioPushState
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreCommandRouter::servicePushState
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:40 ms-1000 shairport-sync[3142]: Failed to create secure directory (/home/shairport-sync/.config/pulse): No such file or directory
Jan 26 17:13:40 ms-1000 volumio[2857]: verbose: STATE SERVICE {"status":"play","service":"airplay_emulation","title":"","artist":"","album":"","albumart":"/albumart","uri":"","trackType":"airplay","seek":0,"duration":0,"samplerate":"","bitdepth":"","channels":2,"disableUiControls":true}
Jan 26 17:13:40 ms-1000 volumio[2857]: verbose: CURRENT POSITION 0
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreStateMachine::syncState stateService play
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreStateMachine::syncState currentStatus play
Jan 26 17:13:40 ms-1000 volumio[2857]: info: Received an update from plugin. extracting info from payload
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreStateMachine::pushState
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioPushState
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreStateMachine::pushState
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioPushState
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreCommandRouter::servicePushState
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:40 ms-1000 volumio[2857]: verbose: STATE SERVICE {"status":"play","service":"airplay_emulation","title":"","artist":"","album":"","albumart":"/albumart","uri":"","trackType":"airplay","seek":0,"duration":0,"samplerate":"","bitdepth":"","channels":2,"disableUiControls":true}
Jan 26 17:13:40 ms-1000 volumio[2857]: verbose: CURRENT POSITION 0
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreStateMachine::syncState stateService play
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreStateMachine::syncState currentStatus play
Jan 26 17:13:40 ms-1000 volumio[2857]: info: Received an update from plugin. extracting info from payload
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreStateMachine::pushState
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioPushState
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreStateMachine::pushState
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioPushState
Jan 26 17:13:40 ms-1000 kernel: bcm2835-i2s 3f203000.i2s: I2S SYNC error!
Jan 26 17:13:40 ms-1000 shairport-sync[3142]: % Total % Received % Xferd Average Speed Time Time Time Current
Jan 26 17:13:40 ms-1000 shairport-sync[3142]: Dload Upload Total Spent Left Speed
Jan 26 17:13:40 ms-1000 volumio[2857]: info: Airplay started streaming, receiving metadatas
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioStop
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreStateMachine::stop
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 26 17:13:40 ms-1000 volumio[2857]: verbose: UNSET VOLATILE
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreStateMachine::stPlaybackTimer
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreStateMachine::updateTrackBlock
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CorePlayQueue::getTrackBlock
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreStateMachine::pushState
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioPushState
Jan 26 17:13:40 ms-1000 shairport-sync[3142]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 % Total % Received % Xferd Average Speed Time Time Time Current
Jan 26 17:13:40 ms-1000 shairport-sync[3142]: Dload Upload Total Spent Left Speed
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreStateMachine::serviceStop
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:40 ms-1000 volumio[2857]: info: ControllerMpd::stop
Jan 26 17:13:40 ms-1000 volumio[2857]: verbose: ControllerMpd::sendMpdCommand stop
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 26 17:13:40 ms-1000 volumio[2857]: info: Airplay started streaming, receiving metadatas
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioStop
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreStateMachine::stop
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 26 17:13:40 ms-1000 volumio[2857]: verbose: UNSET VOLATILE
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 26 17:13:40 ms-1000 volumio[2857]: info: Airplay started streaming, receiving metadatas
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioStop
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreStateMachine::stop
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 26 17:13:40 ms-1000 volumio[2857]: verbose: UNSET VOLATILE
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 26 17:13:40 ms-1000 volumio[2857]: info: sendMpdCommand stop took 17 milliseconds
Jan 26 17:13:40 ms-1000 volumio[2857]: info:
Jan 26 17:13:40 ms-1000 volumio[2857]: ---------------------------- Client requests AirplayActive
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , setAirplayActive
Jan 26 17:13:40 ms-1000 shairport-sync[3142]: [155B blob data]
Jan 26 17:13:40 ms-1000 volumio[2857]: info:
Jan 26 17:13:40 ms-1000 volumio[2857]: ---------------------------- Client requests Start Airplay PlaybackRoutine
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startAirplayPlayback
Jan 26 17:13:40 ms-1000 volumio[2857]: info: Airplay playback start
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioStop
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreStateMachine::stop
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 26 17:13:40 ms-1000 volumio[2857]: verbose: UNSET VOLATILE
Jan 26 17:13:40 ms-1000 volumio[2857]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 26 17:13:40 ms-1000 shairport-sync[3142]: [136B blob data]
Jan 26 17:13:41 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:41 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:41 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:41 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:41 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:41 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:41 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:41 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:41 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:41 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:41 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:41 ms-1000 volumio[2857]: info: CorePlayQueue::getTrack 0
Jan 26 17:13:41 ms-1000 volumio[2857]: info: CoreCommandRouter::servicePushState
Jan 26 17:13:41 ms-1000 volumio[2857]: info: CoreStateMachine::pushState
Jan 26 17:13:41 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 26 17:13:41 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioPushState
Jan 26 17:13:41 ms-1000 volumio[2857]: info: CoreCommandRouter::servicePushState
Jan 26 17:13:41 ms-1000 volumio[2857]: info: CoreStateMachine::pushState
Jan 26 17:13:41 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioPushState
Jan 26 17:13:41 ms-1000 volumio[2857]: info: CoreCommandRouter::servicePushState
Jan 26 17:13:41 ms-1000 volumio[2857]: info: CoreStateMachine::pushState
Jan 26 17:13:41 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioPushState
Jan 26 17:13:41 ms-1000 volumio[2857]: info: CoreCommandRouter::servicePushState
Jan 26 17:13:41 ms-1000 volumio[2857]: info: CoreStateMachine::pushState
Jan 26 17:13:41 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioPushState
Jan 26 17:13:42 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:42 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:42 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:42 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:42 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:42 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:42 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:42 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:42 ms-1000 volumio[2857]: info: CoreCommandRouter::servicePushState
Jan 26 17:13:42 ms-1000 volumio[2857]: info: CoreStateMachine::pushState
Jan 26 17:13:42 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 26 17:13:42 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioPushState
Jan 26 17:13:42 ms-1000 volumio[2857]: info: CoreCommandRouter::servicePushState
Jan 26 17:13:42 ms-1000 volumio[2857]: info: CoreStateMachine::pushState
Jan 26 17:13:42 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioPushState
Jan 26 17:13:42 ms-1000 volumio[2857]: info: CoreCommandRouter::servicePushState
Jan 26 17:13:42 ms-1000 volumio[2857]: info: CoreStateMachine::pushState
Jan 26 17:13:42 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioPushState
Jan 26 17:13:42 ms-1000 volumio[2857]: info: CoreCommandRouter::servicePushState
Jan 26 17:13:42 ms-1000 volumio[2857]: info: CoreStateMachine::pushState
Jan 26 17:13:42 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 26 17:13:42 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioPushState
Jan 26 17:13:42 ms-1000 volumio[2857]: info: CoreCommandRouter::servicePushState
Jan 26 17:13:42 ms-1000 volumio[2857]: info: CoreStateMachine::pushState
Jan 26 17:13:42 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioPushState
Jan 26 17:13:42 ms-1000 volumio[2857]: info: CoreCommandRouter::servicePushState
Jan 26 17:13:42 ms-1000 volumio[2857]: info: CoreStateMachine::pushState
Jan 26 17:13:42 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioPushState
Jan 26 17:13:43 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:43 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:43 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:43 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:43 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:43 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:44 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:44 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:44 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:44 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:44 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:44 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:45 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:45 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:45 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jan 26 17:13:45 ms-1000 volumio[2857]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 26 17:13:45 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:45 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:45 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:45 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:46 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:46 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:46 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:46 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:46 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:46 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:47 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:47 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:47 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:47 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:47 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:47 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:47 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:47 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:48 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:48 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:48 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:48 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:48 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:48 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:49 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:49 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:49 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:49 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:49 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:49 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:50 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:50 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:50 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:50 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:50 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:50 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:51 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:51 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:51 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:51 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:51 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:51 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:52 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:52 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:52 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:52 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:52 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:52 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:52 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:52 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:53 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:53 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:53 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:53 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:53 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:53 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:54 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:54 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:54 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:54 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:55 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:55 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:55 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:55 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:55 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:55 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:56 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:56 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:56 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:56 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:56 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:56 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:57 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:57 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:57 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:57 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:57 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:57 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:58 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:58 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:58 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:58 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:58 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:58 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:59 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:59 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:59 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:59 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:59 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:59 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:59 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:13:59 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:00 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:00 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:00 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:00 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:00 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:00 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:01 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:01 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:01 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:01 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:01 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:01 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:02 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:02 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:02 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:02 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:02 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:02 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:03 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:03 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:03 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:03 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:03 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:03 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:04 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:04 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:04 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:04 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:04 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:04 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:04 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:04 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:05 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:05 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:05 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:05 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:05 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:05 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:06 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:06 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:06 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:06 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:06 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:06 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:07 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:07 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:07 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:07 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:07 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:07 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:08 ms-1000 volumio[2857]: error: error
Jan 26 17:14:08 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:08 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:08 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:08 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:08 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:08 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:09 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:09 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:09 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:09 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:09 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:09 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:09 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:09 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:10 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:10 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:10 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:10 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:10 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:10 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:11 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:11 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:11 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:11 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:11 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:11 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:12 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:12 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:12 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:12 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:12 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:12 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:13 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:13 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:13 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:13 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:13 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:13 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:14 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:14 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:14 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:14 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:14 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:14 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:14 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:14 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:15 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:15 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:15 ms-1000 volumio[2857]: info: CoreCommandRouter::volumioGetState
Jan 26 17:14:15 ms-1000 volumio[2857]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jan 26 17:14:15 ms-1000 volumio[2857]: { Error: connect ETIMEDOUT 151.101.66.79:443
Jan 26 17:14:15 ms-1000 volumio[2857]: at Object._errnoException (util.js:1022:11)
Jan 26 17:14:15 ms-1000 volumio[2857]: at _exceptionWithHostPort (util.js:1044:20)
Jan 26 17:14:15 ms-1000 volumio[2857]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14)
Jan 26 17:14:15 ms-1000 volumio[2857]: code: 'ETIMEDOUT',
Jan 26 17:14:15 ms-1000 volumio[2857]: errno: 'ETIMEDOUT',
Jan 26 17:14:15 ms-1000 volumio[2857]: syscall: 'connect',
Jan 26 17:14:15 ms-1000 volumio[2857]: address: '151.101.66.79',
Jan 26 17:14:15 ms-1000 volumio[2857]: port: 443 }
Jan 26 17:14:15 ms-1000 volumio[2857]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jan 26 17:14:16 ms-1000 sudo[3343]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2023-01-26 17:13
Jan 26 17:14:16 ms-1000 sudo[3343]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)"
NAME="Raspbian GNU/Linux"
VERSION_ID="8"
VERSION="8 (jessie)"
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03"
VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae"
VOLUMIO_BE_VERSION="fd3e37ffec12db034ec93f94dbc26e5495d5b91a"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed Oct 6 12:34:49 CEST 2021"
VOLUMIO_VERSION="2.917"
VOLUMIO_HARDWARE="pi"
VOLUMIO_HASH="98c8f08c531a6f0456f17ab17795e35f"