-- Logs begin at Fri 2020-12-11 14:53:56 UTC, end at Sat 2025-06-28 10:58:14 UTC. -- Jun 28 10:57:09 volumio dhcpcd[4994]: eth0: carrier acquired Jun 28 10:57:09 volumio kernel: libphy: stmmac-0:00 - Link is Up - 1000/Full Jun 28 10:57:09 volumio dhcpcd[4994]: eth0: rebinding lease of 192.168.1.237 Jun 28 10:57:10 volumio ifplugd(eth0)[4698]: Link beat detected. Jun 28 10:57:10 volumio ifplugd(eth0)[4698]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Jun 28 10:57:10 volumio ifplugd(eth0)[4698]: client: dhcpcd[5547]: sending commands to master dhcpcd process Jun 28 10:57:10 volumio dhcpcd[5547]: sending commands to master dhcpcd process Jun 28 10:57:10 volumio dhcpcd[4994]: control command: dhcpcd eth0 Jun 28 10:57:10 volumio ifplugd(eth0)[4698]: Program executed successfully. Jun 28 10:57:13 volumio dhcpcd[4994]: eth0: leased 192.168.1.237 for 86400 seconds Jun 28 10:57:13 volumio dhcpcd[4994]: eth0: adding host route to 192.168.1.237 via 127.0.0.1 Jun 28 10:57:13 volumio dhcpcd[4994]: eth0: adding route to 192.168.1.0/24 Jun 28 10:57:13 volumio dhcpcd[4994]: eth0: adding default route via 192.168.1.1 Jun 28 10:57:13 volumio avahi-daemon[4657]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.237. Jun 28 10:57:13 volumio avahi-daemon[4657]: New relevant interface eth0.IPv4 for mDNS. Jun 28 10:57:13 volumio avahi-daemon[4657]: Registering new address record for 192.168.1.237 on eth0.IPv4. Jun 28 10:57:14 volumio volumio[5136]: Discovery: this is already registered, 2784a459-ab5a-44c8-9455-882263df1a9d Jun 28 10:57:14 volumio volumio[5136]: info: mDNS: Found device Volumio Jun 28 10:57:14 volumio volumio[5136]: info: CoreCommandRouter::volumioGetState Jun 28 10:57:14 volumio volumio[5136]: info: CorePlayQueue::getTrack 0 Jun 28 10:57:15 volumio ntpd[4711]: Listen normally on 5 eth0 192.168.1.237 UDP 123 Jun 28 10:57:15 volumio ntpd[4711]: peers refreshed Jun 28 10:57:18 volumio volumio[5136]: verbose: ControllerMpd::sendMpdCommand status Jun 28 10:57:18 volumio volumio[5136]: info: Jun 28 10:57:18 volumio volumio[5136]: ---------------------------- MPD announces state update: update Jun 28 10:57:18 volumio volumio[5136]: info: ControllerMpd::getState Jun 28 10:57:18 volumio volumio[5136]: verbose: ControllerMpd::sendMpdCommand status Jun 28 10:57:18 volumio volumio[5136]: verbose: ControllerMpd::sendMpdCommand status Jun 28 10:57:18 volumio volumio[5136]: info: Jun 28 10:57:18 volumio volumio[5136]: ---------------------------- MPD announces state update: update Jun 28 10:57:18 volumio volumio[5136]: verbose: ControllerMpd::sendMpdCommand status Jun 28 10:57:18 volumio volumio[5136]: info: Jun 28 10:57:18 volumio volumio[5136]: ---------------------------- MPD announces state update: update Jun 28 10:57:18 volumio volumio[5136]: info: ControllerMpd::getState Jun 28 10:57:18 volumio volumio[5136]: verbose: ControllerMpd::sendMpdCommand status Jun 28 10:57:18 volumio volumio[5136]: info: ControllerMpd::getState Jun 28 10:57:18 volumio volumio[5136]: verbose: ControllerMpd::sendMpdCommand status Jun 28 10:57:18 volumio volumio[5136]: verbose: ControllerMpd::parseState Jun 28 10:57:18 volumio volumio[5136]: info: Command Router : Notfying DB Updatetrue Jun 28 10:57:18 volumio volumio[5136]: info: CoreCommandRouter::Close All Modals sent Jun 28 10:57:18 volumio volumio[5136]: verbose: ControllerMpd::parseState Jun 28 10:57:18 volumio volumio[5136]: info: ControllerMpd::pushState Jun 28 10:57:18 volumio volumio[5136]: info: CoreCommandRouter::servicePushState Jun 28 10:57:18 volumio volumio[5136]: info: CoreStateMachine::pushState Jun 28 10:57:18 volumio volumio[5136]: info: CorePlayQueue::getTrack 0 Jun 28 10:57:18 volumio volumio[5136]: info: CoreCommandRouter::volumioPushState Jun 28 10:57:18 volumio volumio[5136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 10:57:18 volumio volumio[5136]: info: CorePlayQueue::getTrack 0 Jun 28 10:57:18 volumio volumio[5136]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 28 10:57:18 volumio volumio[5136]: verbose: CURRENT POSITION 0 Jun 28 10:57:18 volumio volumio[5136]: info: CoreStateMachine::syncState stateService stop Jun 28 10:57:18 volumio volumio[5136]: info: CoreStateMachine::syncState currentStatus stop Jun 28 10:57:18 volumio volumio[5136]: info: CoreStateMachine::pushState Jun 28 10:57:18 volumio volumio[5136]: info: CorePlayQueue::getTrack 0 Jun 28 10:57:18 volumio volumio[5136]: info: CoreCommandRouter::volumioPushState Jun 28 10:57:18 volumio volumio[5136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 10:57:18 volumio volumio[5136]: info: No code Jun 28 10:57:18 volumio volumio[5136]: info: CoreStateMachine::pushState Jun 28 10:57:18 volumio volumio[5136]: info: CorePlayQueue::getTrack 0 Jun 28 10:57:18 volumio volumio[5136]: info: CoreCommandRouter::volumioPushState Jun 28 10:57:18 volumio volumio[5136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 10:57:18 volumio volumio[5136]: info: ------------------------------ 64ms Jun 28 10:57:18 volumio volumio[5136]: verbose: ControllerMpd::parseState Jun 28 10:57:18 volumio volumio[5136]: info: Command Router : Notfying DB Updatefalse Jun 28 10:57:18 volumio volumio[5136]: info: CoreCommandRouter::Close All Modals sent Jun 28 10:57:18 volumio volumio[5136]: verbose: ControllerMpd::parseState Jun 28 10:57:18 volumio volumio[5136]: info: Command Router : Notfying DB Updatefalse Jun 28 10:57:18 volumio volumio[5136]: info: CoreCommandRouter::Close All Modals sent Jun 28 10:57:18 volumio volumio[5136]: verbose: ControllerMpd::parseState Jun 28 10:57:18 volumio volumio[5136]: verbose: ControllerMpd::parseState Jun 28 10:57:18 volumio volumio[5136]: info: ControllerMpd::pushState Jun 28 10:57:18 volumio volumio[5136]: info: CoreCommandRouter::servicePushState Jun 28 10:57:18 volumio volumio[5136]: info: CoreStateMachine::pushState Jun 28 10:57:18 volumio volumio[5136]: info: CorePlayQueue::getTrack 0 Jun 28 10:57:18 volumio volumio[5136]: info: CoreCommandRouter::volumioPushState Jun 28 10:57:18 volumio volumio[5136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 10:57:18 volumio volumio[5136]: info: CorePlayQueue::getTrack 0 Jun 28 10:57:18 volumio volumio[5136]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 28 10:57:18 volumio volumio[5136]: verbose: CURRENT POSITION 0 Jun 28 10:57:18 volumio volumio[5136]: info: CoreStateMachine::syncState stateService stop Jun 28 10:57:18 volumio volumio[5136]: info: CoreStateMachine::syncState currentStatus stop Jun 28 10:57:18 volumio volumio[5136]: info: CoreStateMachine::pushState Jun 28 10:57:18 volumio volumio[5136]: info: CorePlayQueue::getTrack 0 Jun 28 10:57:18 volumio volumio[5136]: info: CoreCommandRouter::volumioPushState Jun 28 10:57:18 volumio volumio[5136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 10:57:18 volumio volumio[5136]: info: No code Jun 28 10:57:18 volumio volumio[5136]: info: CoreStateMachine::pushState Jun 28 10:57:18 volumio volumio[5136]: info: CorePlayQueue::getTrack 0 Jun 28 10:57:18 volumio volumio[5136]: info: CoreCommandRouter::volumioPushState Jun 28 10:57:18 volumio volumio[5136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 10:57:18 volumio volumio[5136]: info: ControllerMpd::pushState Jun 28 10:57:18 volumio volumio[5136]: info: CoreCommandRouter::servicePushState Jun 28 10:57:18 volumio volumio[5136]: info: CoreStateMachine::pushState Jun 28 10:57:18 volumio volumio[5136]: info: CorePlayQueue::getTrack 0 Jun 28 10:57:18 volumio volumio[5136]: info: CoreCommandRouter::volumioPushState Jun 28 10:57:18 volumio volumio[5136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 10:57:18 volumio volumio[5136]: info: CorePlayQueue::getTrack 0 Jun 28 10:57:18 volumio volumio[5136]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 28 10:57:18 volumio volumio[5136]: verbose: CURRENT POSITION 0 Jun 28 10:57:18 volumio volumio[5136]: info: CoreStateMachine::syncState stateService stop Jun 28 10:57:18 volumio volumio[5136]: info: CoreStateMachine::syncState currentStatus stop Jun 28 10:57:18 volumio volumio[5136]: info: CoreStateMachine::pushState Jun 28 10:57:18 volumio volumio[5136]: info: CorePlayQueue::getTrack 0 Jun 28 10:57:18 volumio volumio[5136]: info: CoreCommandRouter::volumioPushState Jun 28 10:57:18 volumio volumio[5136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 10:57:18 volumio volumio[5136]: info: No code Jun 28 10:57:18 volumio volumio[5136]: info: CoreStateMachine::pushState Jun 28 10:57:18 volumio volumio[5136]: info: CorePlayQueue::getTrack 0 Jun 28 10:57:18 volumio volumio[5136]: info: CoreCommandRouter::volumioPushState Jun 28 10:57:18 volumio volumio[5136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 10:57:18 volumio volumio[5136]: info: ------------------------------ 164ms Jun 28 10:57:18 volumio volumio[5136]: info: ------------------------------ 165ms Jun 28 10:57:21 volumio volumio[5136]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jun 28 10:57:21 volumio volumio[5136]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jun 28 10:57:21 volumio volumio[5136]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jun 28 10:57:21 volumio volumio[5136]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jun 28 10:57:21 volumio volumio[5136]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jun 28 10:57:21 volumio volumio[5136]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jun 28 10:57:21 volumio volumio[5136]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jun 28 10:57:21 volumio volumio[5136]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jun 28 10:57:21 volumio volumio[5136]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jun 28 10:57:21 volumio volumio[5136]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jun 28 10:57:21 volumio volumio[5136]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Jun 28 10:57:21 volumio volumio[5136]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jun 28 10:57:21 volumio volumio[5136]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jun 28 10:57:21 volumio volumio[5136]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jun 28 10:57:21 volumio volumio[5136]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jun 28 10:57:21 volumio volumio[5136]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jun 28 10:57:21 volumio volumio[5136]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jun 28 10:57:21 volumio volumio[5136]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jun 28 10:57:21 volumio volumio[5136]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jun 28 10:57:21 volumio volumio[5136]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jun 28 10:57:21 volumio volumio[5136]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jun 28 10:57:21 volumio volumio[5136]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Jun 28 10:57:21 volumio volumio[5136]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jun 28 10:57:21 volumio volumio[5136]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jun 28 10:57:21 volumio volumio[5136]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jun 28 10:57:21 volumio volumio[5136]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jun 28 10:57:21 volumio volumio[5136]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jun 28 10:57:21 volumio volumio[5136]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jun 28 10:57:21 volumio volumio[5136]: info: Adding plugin bluetooth to MyMusic Plugins Jun 28 10:57:21 volumio volumio[5136]: info: Adding plugin cd_controller to MyMusic Plugins Jun 28 10:57:21 volumio volumio[5136]: info: Adding plugin smart_inputs to MyMusic Plugins Jun 28 10:57:21 volumio volumio[5136]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jun 28 10:57:23 volumio volumio[5136]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jun 28 10:57:25 volumio volumio[5136]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jun 28 10:57:25 volumio volumio[5136]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jun 28 10:57:25 volumio volumio[5136]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 28 10:57:25 volumio volumio[5136]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 28 10:57:25 volumio volumio[5136]: info: Starting MyVolumio Remote Streaming Endpoints Jun 28 10:57:25 volumio volumio[5136]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jun 28 10:57:25 volumio volumio[5136]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jun 28 10:57:25 volumio volumio[5136]: info: Streaming services startup Jun 28 10:57:25 volumio volumio[5136]: info: Starting Streaming Daemon Jun 28 10:57:25 volumio dnsmasq[5144]: reading /etc/resolv.conf Jun 28 10:57:25 volumio dnsmasq[5144]: using nameserver 192.168.1.1#53 Jun 28 10:57:25 volumio dnsmasq[5144]: using nameserver 208.67.222.222#53 Jun 28 10:57:25 volumio dnsmasq[5144]: using nameserver 208.67.220.220#53 Jun 28 10:57:25 volumio sudo[5666]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jun 28 10:57:25 volumio sudo[5666]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 28 10:57:25 volumio systemd[1]: Stopping Volumio Streaming Daemon... Jun 28 10:57:25 volumio systemd[1]: Starting Volumio Streaming Daemon... Jun 28 10:57:25 volumio systemd[1]: Started Volumio Streaming Daemon. Jun 28 10:57:25 volumio sudo[5666]: pam_unix(sudo:session): session closed for user root Jun 28 10:57:25 volumio volumio[5136]: info: MyVolumio not started Jun 28 10:57:25 volumio volumio[5136]: info: Initializing device activation check Jun 28 10:57:25 volumio volumio-streaming-daemon[5673]: ############################ Jun 28 10:57:25 volumio volumio-streaming-daemon[5673]: # Volumio Streaming Daemon # Jun 28 10:57:25 volumio volumio-streaming-daemon[5673]: # Running on port 7777 # Jun 28 10:57:25 volumio volumio-streaming-daemon[5673]: ############################ Jun 28 10:57:25 volumio volumio-streaming-daemon[5673]: Environment: production Jun 28 10:57:25 volumio volumio[5136]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jun 28 10:57:27 volumio volumio-streaming-daemon[5673]: Environment: production Jun 28 10:57:27 volumio volumio[5136]: info: Fetching Streaming Services browse cache Jun 28 10:57:33 volumio volumio[5136]: verbose: ControllerMpd::sendMpdCommand status Jun 28 10:57:33 volumio volumio[5136]: info: Jun 28 10:57:33 volumio volumio[5136]: ---------------------------- MPD announces state update: update Jun 28 10:57:33 volumio volumio[5136]: info: ControllerMpd::getState Jun 28 10:57:33 volumio volumio[5136]: verbose: ControllerMpd::sendMpdCommand status Jun 28 10:57:33 volumio volumio[5136]: verbose: ControllerMpd::parseState Jun 28 10:57:33 volumio volumio[5136]: info: Command Router : Notfying DB Updatetrue Jun 28 10:57:33 volumio volumio[5136]: info: CoreCommandRouter::Close All Modals sent Jun 28 10:57:33 volumio volumio[5136]: verbose: ControllerMpd::parseState Jun 28 10:57:33 volumio volumio[5136]: info: ControllerMpd::pushState Jun 28 10:57:33 volumio volumio[5136]: info: CoreCommandRouter::servicePushState Jun 28 10:57:33 volumio volumio[5136]: info: CoreStateMachine::pushState Jun 28 10:57:33 volumio volumio[5136]: info: CorePlayQueue::getTrack 0 Jun 28 10:57:33 volumio volumio[5136]: info: CoreCommandRouter::volumioPushState Jun 28 10:57:33 volumio volumio[5136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 10:57:33 volumio volumio[5136]: info: CorePlayQueue::getTrack 0 Jun 28 10:57:33 volumio volumio[5136]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 28 10:57:33 volumio volumio[5136]: verbose: CURRENT POSITION 0 Jun 28 10:57:33 volumio volumio[5136]: info: CoreStateMachine::syncState stateService stop Jun 28 10:57:33 volumio volumio[5136]: info: CoreStateMachine::syncState currentStatus stop Jun 28 10:57:33 volumio volumio[5136]: info: CoreStateMachine::pushState Jun 28 10:57:33 volumio volumio[5136]: info: CorePlayQueue::getTrack 0 Jun 28 10:57:33 volumio volumio[5136]: info: CoreCommandRouter::volumioPushState Jun 28 10:57:33 volumio volumio[5136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 10:57:33 volumio volumio[5136]: info: No code Jun 28 10:57:33 volumio volumio[5136]: info: CoreStateMachine::pushState Jun 28 10:57:33 volumio volumio[5136]: info: CorePlayQueue::getTrack 0 Jun 28 10:57:33 volumio volumio[5136]: info: CoreCommandRouter::volumioPushState Jun 28 10:57:33 volumio volumio[5136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 10:57:33 volumio volumio[5136]: info: ------------------------------ 62ms Jun 28 10:57:33 volumio volumio[5136]: verbose: ControllerMpd::sendMpdCommand status Jun 28 10:57:33 volumio volumio[5136]: info: Jun 28 10:57:33 volumio volumio[5136]: ---------------------------- MPD announces state update: update Jun 28 10:57:33 volumio volumio[5136]: info: ControllerMpd::getState Jun 28 10:57:33 volumio volumio[5136]: verbose: ControllerMpd::sendMpdCommand status Jun 28 10:57:33 volumio volumio[5136]: verbose: ControllerMpd::parseState Jun 28 10:57:33 volumio volumio[5136]: info: Command Router : Notfying DB Updatefalse Jun 28 10:57:33 volumio volumio[5136]: info: CoreCommandRouter::Close All Modals sent Jun 28 10:57:33 volumio volumio[5136]: verbose: ControllerMpd::parseState Jun 28 10:57:33 volumio volumio[5136]: info: ControllerMpd::pushState Jun 28 10:57:33 volumio volumio[5136]: info: CoreCommandRouter::servicePushState Jun 28 10:57:33 volumio volumio[5136]: info: CoreStateMachine::pushState Jun 28 10:57:33 volumio volumio[5136]: info: CorePlayQueue::getTrack 0 Jun 28 10:57:33 volumio volumio[5136]: info: CoreCommandRouter::volumioPushState Jun 28 10:57:33 volumio volumio[5136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 10:57:33 volumio volumio[5136]: info: CorePlayQueue::getTrack 0 Jun 28 10:57:33 volumio volumio[5136]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 28 10:57:33 volumio volumio[5136]: verbose: CURRENT POSITION 0 Jun 28 10:57:33 volumio volumio[5136]: info: CoreStateMachine::syncState stateService stop Jun 28 10:57:33 volumio volumio[5136]: info: CoreStateMachine::syncState currentStatus stop Jun 28 10:57:33 volumio volumio[5136]: info: CoreStateMachine::pushState Jun 28 10:57:33 volumio volumio[5136]: info: CorePlayQueue::getTrack 0 Jun 28 10:57:33 volumio volumio[5136]: info: CoreCommandRouter::volumioPushState Jun 28 10:57:33 volumio volumio[5136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 10:57:33 volumio volumio[5136]: info: No code Jun 28 10:57:33 volumio volumio[5136]: info: CoreStateMachine::pushState Jun 28 10:57:33 volumio volumio[5136]: info: CorePlayQueue::getTrack 0 Jun 28 10:57:33 volumio volumio[5136]: info: CoreCommandRouter::volumioPushState Jun 28 10:57:33 volumio volumio[5136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 10:57:33 volumio volumio[5136]: info: ------------------------------ 75ms Jun 28 10:57:38 volumio sudo[5742]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 28 10:57:38 volumio sudo[5742]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 28 10:57:38 volumio sudo[5742]: pam_unix(sudo:session): session closed for user root Jun 28 10:57:38 volumio sudo[5745]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 28 10:57:38 volumio sudo[5745]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 28 10:57:38 volumio sudo[5745]: pam_unix(sudo:session): session closed for user root Jun 28 10:57:39 volumio sudo[5748]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 28 10:57:39 volumio sudo[5748]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 28 10:57:39 volumio sudo[5748]: pam_unix(sudo:session): session closed for user root Jun 28 10:57:39 volumio sudo[5750]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 28 10:57:39 volumio sudo[5750]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 28 10:57:39 volumio sudo[5750]: pam_unix(sudo:session): session closed for user root Jun 28 10:57:39 volumio volumio[5136]: info: CoreCommandRouter::volumioGetState Jun 28 10:57:39 volumio volumio[5136]: info: CorePlayQueue::getTrack 0 Jun 28 10:57:39 volumio volumio[5136]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 28 10:57:39 volumio volumio[5136]: info: CoreCommandRouter::volumioGetVisibleSources Jun 28 10:57:39 volumio volumio[5136]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 28 10:57:39 volumio volumio[5136]: info: Listing playlists Jun 28 10:57:39 volumio volumio[5136]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 28 10:57:39 volumio volumio[5136]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 28 10:57:39 volumio volumio[5136]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 28 10:57:39 volumio volumio[5136]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 28 10:57:39 volumio volumio[5136]: verbose: ControllerMpd::sendMpdCommand status Jun 28 10:57:39 volumio volumio[5136]: info: Jun 28 10:57:39 volumio volumio[5136]: ---------------------------- MPD announces state update: update Jun 28 10:57:39 volumio volumio[5136]: info: ControllerMpd::getState Jun 28 10:57:39 volumio volumio[5136]: verbose: ControllerMpd::sendMpdCommand status Jun 28 10:57:39 volumio volumio[5136]: verbose: ControllerMpd::sendMpdCommand status Jun 28 10:57:39 volumio volumio[5136]: info: Jun 28 10:57:39 volumio volumio[5136]: ---------------------------- MPD announces state update: update Jun 28 10:57:39 volumio volumio[5136]: info: ControllerMpd::getState Jun 28 10:57:39 volumio volumio[5136]: verbose: ControllerMpd::sendMpdCommand status Jun 28 10:57:39 volumio volumio[5136]: verbose: ControllerMpd::parseState Jun 28 10:57:39 volumio volumio[5136]: info: Command Router : Notfying DB Updatefalse Jun 28 10:57:39 volumio volumio[5136]: info: CoreCommandRouter::Close All Modals sent Jun 28 10:57:39 volumio volumio[5136]: verbose: ControllerMpd::parseState Jun 28 10:57:39 volumio volumio[5136]: info: ControllerMpd::pushState Jun 28 10:57:39 volumio volumio[5136]: info: CoreCommandRouter::servicePushState Jun 28 10:57:39 volumio volumio[5136]: info: CoreStateMachine::pushState Jun 28 10:57:39 volumio volumio[5136]: info: CorePlayQueue::getTrack 0 Jun 28 10:57:39 volumio volumio[5136]: info: CoreCommandRouter::volumioPushState Jun 28 10:57:39 volumio volumio[5136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 10:57:39 volumio volumio[5136]: info: CorePlayQueue::getTrack 0 Jun 28 10:57:39 volumio volumio[5136]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 28 10:57:39 volumio volumio[5136]: verbose: CURRENT POSITION 0 Jun 28 10:57:39 volumio volumio[5136]: info: CoreStateMachine::syncState stateService stop Jun 28 10:57:39 volumio volumio[5136]: info: CoreStateMachine::syncState currentStatus stop Jun 28 10:57:39 volumio volumio[5136]: info: CoreStateMachine::pushState Jun 28 10:57:39 volumio volumio[5136]: info: CorePlayQueue::getTrack 0 Jun 28 10:57:39 volumio volumio[5136]: info: CoreCommandRouter::volumioPushState Jun 28 10:57:39 volumio volumio[5136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 10:57:39 volumio volumio[5136]: info: No code Jun 28 10:57:39 volumio volumio[5136]: info: CoreStateMachine::pushState Jun 28 10:57:39 volumio volumio[5136]: info: CorePlayQueue::getTrack 0 Jun 28 10:57:39 volumio volumio[5136]: info: CoreCommandRouter::volumioPushState Jun 28 10:57:39 volumio volumio[5136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 10:57:39 volumio volumio[5136]: info: ------------------------------ 65ms Jun 28 10:57:39 volumio volumio[5136]: verbose: ControllerMpd::parseState Jun 28 10:57:39 volumio volumio[5136]: info: Command Router : Notfying DB Updatefalse Jun 28 10:57:39 volumio volumio[5136]: info: CoreCommandRouter::Close All Modals sent Jun 28 10:57:39 volumio volumio[5136]: verbose: ControllerMpd::parseState Jun 28 10:57:39 volumio volumio[5136]: info: ControllerMpd::pushState Jun 28 10:57:39 volumio volumio[5136]: info: CoreCommandRouter::servicePushState Jun 28 10:57:39 volumio volumio[5136]: info: CoreStateMachine::pushState Jun 28 10:57:39 volumio volumio[5136]: info: CorePlayQueue::getTrack 0 Jun 28 10:57:39 volumio volumio[5136]: info: CoreCommandRouter::volumioPushState Jun 28 10:57:39 volumio volumio[5136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 10:57:39 volumio volumio[5136]: info: CorePlayQueue::getTrack 0 Jun 28 10:57:39 volumio volumio[5136]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 28 10:57:39 volumio volumio[5136]: verbose: CURRENT POSITION 0 Jun 28 10:57:39 volumio volumio[5136]: info: CoreStateMachine::syncState stateService stop Jun 28 10:57:39 volumio volumio[5136]: info: CoreStateMachine::syncState currentStatus stop Jun 28 10:57:39 volumio volumio[5136]: info: CoreStateMachine::pushState Jun 28 10:57:39 volumio volumio[5136]: info: CorePlayQueue::getTrack 0 Jun 28 10:57:39 volumio volumio[5136]: info: CoreCommandRouter::volumioPushState Jun 28 10:57:39 volumio volumio[5136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 10:57:39 volumio volumio[5136]: info: No code Jun 28 10:57:39 volumio volumio[5136]: info: CoreStateMachine::pushState Jun 28 10:57:39 volumio volumio[5136]: info: CorePlayQueue::getTrack 0 Jun 28 10:57:39 volumio volumio[5136]: info: CoreCommandRouter::volumioPushState Jun 28 10:57:39 volumio volumio[5136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 10:57:39 volumio volumio[5136]: info: ------------------------------ 115ms Jun 28 10:57:41 volumio volumio[5136]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 28 10:57:43 volumio volumio[5136]: info: CoreCommandRouter::volumioNext Jun 28 10:57:43 volumio volumio[5136]: info: CoreStateMachine::next Jun 28 10:57:43 volumio volumio[5136]: info: CoreStateMachine::stop Jun 28 10:57:43 volumio volumio[5136]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 28 10:57:43 volumio volumio[5136]: UNSET VOLATILE Jun 28 10:57:43 volumio volumio[5136]: info: CoreStateMachine::play index undefined Jun 28 10:57:43 volumio volumio[5136]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 28 10:57:43 volumio volumio[5136]: info: CorePlayQueue::getTrack 1 Jun 28 10:57:43 volumio volumio[5136]: info: CoreStateMachine::startPlaybackTimer Jun 28 10:57:43 volumio volumio[5136]: info: CorePlayQueue::getTrack 1 Jun 28 10:57:43 volumio volumio[5136]: verbose: ControllerMpd::clearAddPlayTracks USB/MUSIC/02 - Lady.mp3 Jun 28 10:57:43 volumio volumio[5136]: verbose: ControllerMpd::sendMpdCommand stop Jun 28 10:57:43 volumio volumio[5136]: info: CoreStateMachine::updateTrackBlock Jun 28 10:57:43 volumio volumio[5136]: info: CorePlayQueue::getTrackBlock Jun 28 10:57:43 volumio volumio[5136]: verbose: ControllerMpd::sendMpdCommand clear Jun 28 10:57:43 volumio volumio[5136]: info: Jun 28 10:57:43 volumio volumio[5136]: ---------------------------- MPD announces system playlist update Jun 28 10:57:43 volumio volumio[5136]: info: Ignoring MPD Status Update Jun 28 10:57:43 volumio volumio[5136]: verbose: ControllerMpd::sendMpdCommand add "USB/MUSIC/02 - Lady.mp3" Jun 28 10:57:43 volumio volumio[5136]: error: updateQueue error: null Jun 28 10:57:43 volumio volumio[5136]: info: Jun 28 10:57:43 volumio volumio[5136]: ---------------------------- MPD announces system playlist update Jun 28 10:57:43 volumio volumio[5136]: info: Ignoring MPD Status Update Jun 28 10:57:43 volumio volumio[5136]: info: ------------------------------ 7ms Jun 28 10:57:43 volumio volumio[5136]: verbose: ControllerMpd::sendMpdCommand play Jun 28 10:57:43 volumio volumio[5136]: info: ------------------------------ 6ms Jun 28 10:57:43 volumio volumio[5136]: info: Jun 28 10:57:43 volumio volumio[5136]: ---------------------------- MPD announces state update: player Jun 28 10:57:43 volumio volumio[5136]: info: ControllerMpd::getState Jun 28 10:57:43 volumio volumio[5136]: verbose: ControllerMpd::sendMpdCommand status Jun 28 10:57:43 volumio volumio[5136]: info: Jun 28 10:57:43 volumio volumio[5136]: ---------------------------- MPD announces state update: player Jun 28 10:57:43 volumio volumio[5136]: info: ControllerMpd::getState Jun 28 10:57:43 volumio volumio[5136]: verbose: ControllerMpd::sendMpdCommand status Jun 28 10:57:43 volumio volumio[5136]: verbose: ControllerMpd::parseState Jun 28 10:57:43 volumio volumio[5136]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 28 10:57:43 volumio volumio[5136]: verbose: ControllerMpd::parseState Jun 28 10:57:43 volumio volumio[5136]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 28 10:57:43 volumio volumio[5136]: verbose: ControllerMpd::parseTrackInfo Jun 28 10:57:43 volumio volumio[5136]: info: ControllerMpd::pushState Jun 28 10:57:43 volumio volumio[5136]: info: CoreCommandRouter::servicePushState Jun 28 10:57:43 volumio volumio[5136]: info: CorePlayQueue::getTrack 1 Jun 28 10:57:43 volumio volumio[5136]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":233,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"02 - Lady.mp3","artist":null,"album":null,"uri":"USB/MUSIC/02 - Lady.mp3","trackType":"mp3"} Jun 28 10:57:43 volumio volumio[5136]: verbose: CURRENT POSITION 1 Jun 28 10:57:43 volumio volumio[5136]: info: CoreStateMachine::syncState stateService play Jun 28 10:57:43 volumio volumio[5136]: info: CoreStateMachine::syncState currentStatus stop Jun 28 10:57:43 volumio volumio[5136]: info: CoreStateMachine::pushState Jun 28 10:57:43 volumio volumio[5136]: info: CorePlayQueue::getTrack 1 Jun 28 10:57:43 volumio volumio[5136]: info: CoreCommandRouter::volumioPushState Jun 28 10:57:43 volumio volumio[5136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 10:57:43 volumio volumio[5136]: info: ------------------------------ 34ms Jun 28 10:57:43 volumio volumio[5136]: verbose: ControllerMpd::parseTrackInfo Jun 28 10:57:43 volumio volumio[5136]: info: ControllerMpd::pushState Jun 28 10:57:43 volumio volumio[5136]: info: CoreCommandRouter::servicePushState Jun 28 10:57:43 volumio volumio[5136]: info: CorePlayQueue::getTrack 1 Jun 28 10:57:43 volumio volumio[5136]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":233,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"02 - Lady.mp3","artist":null,"album":null,"uri":"USB/MUSIC/02 - Lady.mp3","trackType":"mp3"} Jun 28 10:57:43 volumio volumio[5136]: verbose: CURRENT POSITION 1 Jun 28 10:57:43 volumio volumio[5136]: info: CoreStateMachine::syncState stateService play Jun 28 10:57:43 volumio volumio[5136]: info: CoreStateMachine::syncState currentStatus play Jun 28 10:57:43 volumio volumio[5136]: info: Received an update from plugin. extracting info from payload Jun 28 10:57:43 volumio volumio[5136]: info: CoreStateMachine::pushState Jun 28 10:57:43 volumio volumio[5136]: info: CorePlayQueue::getTrack 1 Jun 28 10:57:43 volumio volumio[5136]: info: CoreCommandRouter::volumioPushState Jun 28 10:57:43 volumio volumio[5136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 10:57:43 volumio volumio[5136]: info: CoreStateMachine::pushState Jun 28 10:57:43 volumio volumio[5136]: info: CorePlayQueue::getTrack 1 Jun 28 10:57:43 volumio volumio[5136]: info: CoreCommandRouter::volumioPushState Jun 28 10:57:43 volumio volumio[5136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 10:57:43 volumio volumio[5136]: info: ------------------------------ 55ms Jun 28 10:57:56 volumio volumio[5136]: info: CoreCommandRouter::volumioGetQueue Jun 28 10:57:56 volumio volumio[5136]: info: CoreStateMachine::getQueue Jun 28 10:57:56 volumio volumio[5136]: info: CorePlayQueue::getQueue Jun 28 10:57:57 volumio volumio[5136]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%96%B0%E8%B0%B7%E8%89%AF%E5%AD%90/%E3%80%8C%E3%83%A1%E3%83%AD%E3%83%BC%E3%83%8D%E3%83%BB%E3%83%9E%E3%83%AB%E3%82%B7%E3%83%A5%E3%80%8D/3ef05f1e-cce7-46d1-bf00-fc56b8a9e661.jpg' Jun 28 10:57:57 volumio volumio[5136]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%8B%9C%E9%87%91%E5%B0%8F%E5%A7%90/2005%E6%8B%9C%E9%87%91%E5%B0%8F%E5%A7%90%20%E7%AC%AC%E4%BA%8C%E5%BC%B9/ce2fce0b-a139-43ea-8823-abed82970e2a.jpg' Jun 28 10:57:57 volumio volumio[5136]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E9%99%88%E5%A5%95%E8%BF%85/1997-2007%20%E8%B7%A8%E4%B8%96%E7%BA%AA%E5%9B%BD%E8%AF%AD%E7%B2%BE%E9%80%89/80ceb916-95ca-452c-8c1d-5ce79b68380c.jpg' Jun 28 10:58:02 volumio dhcpd[5152]: DHCPDISCOVER from 00:90:4c:c5:12:38 (volumio) via wlan0 Jun 28 10:58:03 volumio dhcpd[5152]: DHCPOFFER on 192.168.211.2 to 00:90:4c:c5:12:38 (volumio) via wlan0 Jun 28 10:58:05 volumio volumio[5136]: info: CoreCommandRouter::volumioPlay Jun 28 10:58:05 volumio volumio[5136]: UNSET VOLATILE Jun 28 10:58:05 volumio volumio[5136]: info: CoreStateMachine::play index 53 Jun 28 10:58:05 volumio volumio[5136]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 28 10:58:05 volumio volumio[5136]: info: CoreStateMachine::stop Jun 28 10:58:05 volumio volumio[5136]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 28 10:58:05 volumio volumio[5136]: UNSET VOLATILE Jun 28 10:58:05 volumio volumio[5136]: info: CoreStateMachine::stPlaybackTimer Jun 28 10:58:05 volumio volumio[5136]: info: CoreStateMachine::updateTrackBlock Jun 28 10:58:05 volumio volumio[5136]: info: CorePlayQueue::getTrackBlock Jun 28 10:58:05 volumio volumio[5136]: info: CoreStateMachine::pushState Jun 28 10:58:05 volumio volumio[5136]: info: CorePlayQueue::getTrack 1 Jun 28 10:58:05 volumio volumio[5136]: info: CoreCommandRouter::volumioPushState Jun 28 10:58:05 volumio volumio[5136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 10:58:05 volumio volumio[5136]: info: CoreStateMachine::serviceStop Jun 28 10:58:05 volumio volumio[5136]: info: CorePlayQueue::getTrack 1 Jun 28 10:58:05 volumio volumio[5136]: info: CoreCommandRouter::serviceStop Jun 28 10:58:05 volumio volumio[5136]: info: ControllerMpd::stop Jun 28 10:58:05 volumio volumio[5136]: verbose: ControllerMpd::sendMpdCommand stop Jun 28 10:58:05 volumio volumio[5136]: info: Jun 28 10:58:05 volumio volumio[5136]: ---------------------------- MPD announces state update: player Jun 28 10:58:05 volumio volumio[5136]: info: ControllerMpd::getState Jun 28 10:58:05 volumio volumio[5136]: verbose: ControllerMpd::sendMpdCommand status Jun 28 10:58:05 volumio volumio[5136]: info: CoreStateMachine::play index undefined Jun 28 10:58:05 volumio volumio[5136]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 28 10:58:05 volumio volumio[5136]: info: CorePlayQueue::getTrack 53 Jun 28 10:58:05 volumio volumio[5136]: info: CoreStateMachine::startPlaybackTimer Jun 28 10:58:05 volumio volumio[5136]: info: CorePlayQueue::getTrack 53 Jun 28 10:58:05 volumio volumio[5136]: verbose: ControllerMpd::clearAddPlayTracks USB/MUSIC/02 - You're Beautiful.mp3 Jun 28 10:58:05 volumio volumio[5136]: verbose: ControllerMpd::sendMpdCommand stop Jun 28 10:58:05 volumio volumio[5136]: verbose: ControllerMpd::parseState Jun 28 10:58:05 volumio volumio[5136]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 28 10:58:05 volumio volumio[5136]: verbose: ControllerMpd::sendMpdCommand clear Jun 28 10:58:05 volumio volumio[5136]: info: Jun 28 10:58:05 volumio volumio[5136]: ---------------------------- MPD announces system playlist update Jun 28 10:58:05 volumio volumio[5136]: info: Ignoring MPD Status Update Jun 28 10:58:05 volumio volumio[5136]: verbose: ControllerMpd::parseTrackInfo Jun 28 10:58:05 volumio volumio[5136]: verbose: ControllerMpd::sendMpdCommand add "USB/MUSIC/02 - You're Beautiful.mp3" Jun 28 10:58:05 volumio volumio[5136]: info: ControllerMpd::pushState Jun 28 10:58:05 volumio volumio[5136]: info: CoreCommandRouter::servicePushState Jun 28 10:58:05 volumio volumio[5136]: info: CoreStateMachine::pushState Jun 28 10:58:05 volumio volumio[5136]: info: CorePlayQueue::getTrack 53 Jun 28 10:58:05 volumio volumio[5136]: info: CoreCommandRouter::volumioPushState Jun 28 10:58:05 volumio volumio[5136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 10:58:05 volumio volumio[5136]: info: CorePlayQueue::getTrack 53 Jun 28 10:58:05 volumio volumio[5136]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 - Lady.mp3","artist":null,"album":null,"uri":"USB/MUSIC/02 - Lady.mp3","trackType":"mp3"} Jun 28 10:58:05 volumio volumio[5136]: verbose: CURRENT POSITION 53 Jun 28 10:58:05 volumio volumio[5136]: info: CoreStateMachine::syncState stateService stop Jun 28 10:58:05 volumio volumio[5136]: info: CoreStateMachine::syncState currentStatus stop Jun 28 10:58:05 volumio volumio[5136]: info: CoreStateMachine::pushState Jun 28 10:58:05 volumio volumio[5136]: info: CorePlayQueue::getTrack 53 Jun 28 10:58:05 volumio volumio[5136]: info: CoreCommandRouter::volumioPushState Jun 28 10:58:05 volumio volumio[5136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 10:58:05 volumio volumio[5136]: info: No code Jun 28 10:58:05 volumio volumio[5136]: info: CoreStateMachine::pushState Jun 28 10:58:05 volumio volumio[5136]: info: CorePlayQueue::getTrack 53 Jun 28 10:58:05 volumio volumio[5136]: info: CoreCommandRouter::volumioPushState Jun 28 10:58:05 volumio volumio[5136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 10:58:05 volumio volumio[5136]: info: ------------------------------ 62ms Jun 28 10:58:05 volumio volumio[5136]: error: updateQueue error: null Jun 28 10:58:05 volumio volumio[5136]: info: Jun 28 10:58:05 volumio volumio[5136]: ---------------------------- MPD announces system playlist update Jun 28 10:58:05 volumio volumio[5136]: info: Ignoring MPD Status Update Jun 28 10:58:05 volumio volumio[5136]: info: ------------------------------ 47ms Jun 28 10:58:05 volumio volumio[5136]: verbose: ControllerMpd::sendMpdCommand play Jun 28 10:58:05 volumio volumio[5136]: info: ------------------------------ 17ms Jun 28 10:58:05 volumio volumio[5136]: info: Jun 28 10:58:05 volumio volumio[5136]: ---------------------------- MPD announces state update: player Jun 28 10:58:05 volumio volumio[5136]: info: ControllerMpd::getState Jun 28 10:58:05 volumio volumio[5136]: verbose: ControllerMpd::sendMpdCommand status Jun 28 10:58:05 volumio volumio[5136]: info: Jun 28 10:58:05 volumio volumio[5136]: ---------------------------- MPD announces state update: player Jun 28 10:58:05 volumio volumio[5136]: info: ControllerMpd::getState Jun 28 10:58:05 volumio volumio[5136]: verbose: ControllerMpd::sendMpdCommand status Jun 28 10:58:05 volumio volumio[5136]: verbose: ControllerMpd::parseState Jun 28 10:58:05 volumio volumio[5136]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 28 10:58:05 volumio volumio[5136]: verbose: ControllerMpd::parseState Jun 28 10:58:05 volumio volumio[5136]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 28 10:58:05 volumio volumio[5136]: verbose: ControllerMpd::parseTrackInfo Jun 28 10:58:05 volumio volumio[5136]: info: ControllerMpd::pushState Jun 28 10:58:06 volumio volumio[5136]: info: CoreCommandRouter::servicePushState Jun 28 10:58:06 volumio volumio[5136]: info: CorePlayQueue::getTrack 53 Jun 28 10:58:06 volumio volumio[5136]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":213,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"You're Beautiful","artist":"James Blunt","album":"Back to Bedlam","uri":"USB/MUSIC/02 - You're Beautiful.mp3","trackType":"mp3"} Jun 28 10:58:06 volumio volumio[5136]: verbose: CURRENT POSITION 53 Jun 28 10:58:06 volumio volumio[5136]: info: CoreStateMachine::syncState stateService play Jun 28 10:58:06 volumio volumio[5136]: info: CoreStateMachine::syncState currentStatus stop Jun 28 10:58:06 volumio volumio[5136]: info: CoreStateMachine::pushState Jun 28 10:58:06 volumio volumio[5136]: info: CorePlayQueue::getTrack 53 Jun 28 10:58:06 volumio volumio[5136]: info: CoreCommandRouter::volumioPushState Jun 28 10:58:06 volumio volumio[5136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 10:58:06 volumio volumio[5136]: info: ------------------------------ 40ms Jun 28 10:58:06 volumio volumio[5136]: verbose: ControllerMpd::parseTrackInfo Jun 28 10:58:06 volumio volumio[5136]: info: ControllerMpd::pushState Jun 28 10:58:06 volumio volumio[5136]: info: CoreCommandRouter::servicePushState Jun 28 10:58:06 volumio volumio[5136]: info: CorePlayQueue::getTrack 53 Jun 28 10:58:06 volumio volumio[5136]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":213,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"You're Beautiful","artist":"James Blunt","album":"Back to Bedlam","uri":"USB/MUSIC/02 - You're Beautiful.mp3","trackType":"mp3"} Jun 28 10:58:06 volumio volumio[5136]: verbose: CURRENT POSITION 53 Jun 28 10:58:06 volumio volumio[5136]: info: CoreStateMachine::syncState stateService play Jun 28 10:58:06 volumio volumio[5136]: info: CoreStateMachine::syncState currentStatus play Jun 28 10:58:06 volumio volumio[5136]: info: Received an update from plugin. extracting info from payload Jun 28 10:58:06 volumio volumio[5136]: info: CoreStateMachine::pushState Jun 28 10:58:06 volumio volumio[5136]: info: CorePlayQueue::getTrack 53 Jun 28 10:58:06 volumio volumio[5136]: info: CoreCommandRouter::volumioPushState Jun 28 10:58:06 volumio volumio[5136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 10:58:06 volumio volumio[5136]: info: CoreStateMachine::pushState Jun 28 10:58:06 volumio volumio[5136]: info: CorePlayQueue::getTrack 53 Jun 28 10:58:06 volumio volumio[5136]: info: CoreCommandRouter::volumioPushState Jun 28 10:58:06 volumio volumio[5136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 10:58:06 volumio volumio[5136]: info: ------------------------------ 58ms Jun 28 10:58:14 volumio volumio[5136]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 28 10:58:14 volumio volumio[5136]: { Error: connect ECONNREFUSED 103.246.246.144:443 Jun 28 10:58:14 volumio volumio[5136]: at Object._errnoException (util.js:1022:11) Jun 28 10:58:14 volumio volumio[5136]: at _exceptionWithHostPort (util.js:1044:20) Jun 28 10:58:14 volumio volumio[5136]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Jun 28 10:58:14 volumio volumio[5136]: code: 'ECONNREFUSED', Jun 28 10:58:14 volumio volumio[5136]: errno: 'ECONNREFUSED', Jun 28 10:58:14 volumio volumio[5136]: syscall: 'connect', Jun 28 10:58:14 volumio volumio[5136]: address: '103.246.246.144', Jun 28 10:58:14 volumio volumio[5136]: port: 443 } Jun 28 10:58:14 volumio volumio[5136]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 28 10:58:14 volumio sudo[5872]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-28 10:57 Jun 28 10:58:14 volumio sudo[5872]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 8 (jessie)" NAME="Debian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=debian HOME_URL="http://www.debian.org/" SUPPORT_URL="http://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="168ba7444df98cd868db72f24faec0b6346489cc" VOLUMIO_FE_VERSION="847a48ecf32d35cc502a0053d585d1a69236e391" VOLUMIO_BE_VERSION="99dfb342fe07851f1e26bd1d8046d0234eda91dd" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 11 15:53:56 CET 2020" VOLUMIO_VERSION="2.857" VOLUMIO_HARDWARE="aml9xxxarmv7" VOLUMIO_HASH="5e595833ee6075a27fef1ba35f928abb"