-- Logs begin at Thu 2019-02-14 10:12:00 UTC, end at Mon 2024-08-19 19:43:56 UTC. -- Aug 19 19:42:03 orpheus sudo[1377]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.2/\\мультимедиа\\Музыка /mnt/NAS/user-pc Aug 19 19:42:03 orpheus sudo[1377]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 19 19:42:03 orpheus sudo[1379]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.4/Downloads /mnt/NAS/home-pc Aug 19 19:42:03 orpheus sudo[1379]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 19 19:42:03 orpheus kernel: CIFS: Attempting to mount \\192.168.1.2\ Aug 19 19:42:05 orpheus volumio[964]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 19 19:42:05 orpheus volumio[964]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 19 19:42:05 orpheus volumio[964]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 19 19:42:05 orpheus volumio[964]: error: Plugin system_controller autostart failed to complete 'onStart' in a timely fashion Aug 19 19:42:05 orpheus volumio[964]: info: ------------------------------------------- Aug 19 19:42:05 orpheus volumio[964]: info: ----- MyVolumio plugins startup ---- Aug 19 19:42:05 orpheus volumio[964]: info: ------------------------------------------- Aug 19 19:42:05 orpheus volumio[964]: info: [MyVolumio PluginManager] Fetching plans data.... Aug 19 19:42:09 orpheus sudo[1377]: pam_unix(sudo:session): session closed for user root Aug 19 19:42:09 orpheus volumio[964]: info: Cannot mount NAS user-pc at system boot, trial number 4 ,retrying in 5 seconds Aug 19 19:42:09 orpheus kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Aug 19 19:42:09 orpheus kernel: CIFS: VFS: cifs_mount failed w/return code = -113 Aug 19 19:42:09 orpheus kernel: CIFS: Attempting to mount \\192.168.1.4\Downloads Aug 19 19:42:09 orpheus sudo[1379]: pam_unix(sudo:session): session closed for user root Aug 19 19:42:09 orpheus kernel: CIFS: Status code returned 0xc0000022 STATUS_ACCESS_DENIED Aug 19 19:42:09 orpheus kernel: CIFS: VFS: \\192.168.1.4 Send error in SessSetup = -13 Aug 19 19:42:09 orpheus kernel: CIFS: VFS: cifs_mount failed w/return code = -13 Aug 19 19:42:09 orpheus volumio[964]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Aug 19 19:42:10 orpheus ntpd[756]: Soliciting pool server 195.218.227.230 Aug 19 19:42:11 orpheus ntpd[756]: Soliciting pool server 185.209.85.222 Aug 19 19:42:11 orpheus ntpd[756]: Soliciting pool server 192.36.143.130 Aug 19 19:42:12 orpheus ntpd[756]: Soliciting pool server 162.159.200.1 Aug 19 19:42:12 orpheus ntpd[756]: Soliciting pool server 94.247.111.10 Aug 19 19:42:13 orpheus ntpd[756]: Soliciting pool server 162.159.200.123 Aug 19 19:42:13 orpheus ntpd[756]: Soliciting pool server 195.3.254.2 Aug 19 19:42:14 orpheus sudo[1412]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.2/\\мультимедиа\\Музыка /mnt/NAS/user-pc Aug 19 19:42:14 orpheus sudo[1412]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 19 19:42:14 orpheus kernel: CIFS: Attempting to mount \\192.168.1.2\ Aug 19 19:42:14 orpheus ntpd[756]: Soliciting pool server 188.225.9.167 Aug 19 19:42:14 orpheus ntpd[756]: Soliciting pool server 85.113.60.18 Aug 19 19:42:14 orpheus volumio[964]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Aug 19 19:42:14 orpheus volumio[964]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Aug 19 19:42:14 orpheus volumio[964]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Aug 19 19:42:14 orpheus volumio[964]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Aug 19 19:42:14 orpheus volumio[964]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Aug 19 19:42:14 orpheus volumio[964]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Aug 19 19:42:14 orpheus volumio[964]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Aug 19 19:42:14 orpheus volumio[964]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Aug 19 19:42:14 orpheus volumio[964]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Aug 19 19:42:14 orpheus volumio[964]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Aug 19 19:42:14 orpheus volumio[964]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Aug 19 19:42:14 orpheus volumio[964]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Aug 19 19:42:14 orpheus volumio[964]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Aug 19 19:42:14 orpheus volumio[964]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Aug 19 19:42:14 orpheus volumio[964]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Aug 19 19:42:14 orpheus volumio[964]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Aug 19 19:42:14 orpheus ntpd[756]: Soliciting pool server 193.192.36.3 Aug 19 19:42:14 orpheus volumio[964]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Aug 19 19:42:14 orpheus volumio[964]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Aug 19 19:42:14 orpheus volumio[964]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Aug 19 19:42:14 orpheus volumio[964]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Aug 19 19:42:14 orpheus volumio[964]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Aug 19 19:42:14 orpheus volumio[964]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Aug 19 19:42:14 orpheus volumio[964]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Aug 19 19:42:14 orpheus volumio[964]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Aug 19 19:42:14 orpheus volumio[964]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Aug 19 19:42:14 orpheus volumio[964]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Aug 19 19:42:14 orpheus volumio[964]: info: Adding plugin bluetooth to MyMusic Plugins Aug 19 19:42:14 orpheus volumio[964]: info: Adding plugin multiroom to MyMusic Plugins Aug 19 19:42:14 orpheus volumio[964]: info: Adding plugin metavolumio to MyMusic Plugins Aug 19 19:42:14 orpheus volumio[964]: info: Adding plugin cd_controller to MyMusic Plugins Aug 19 19:42:14 orpheus volumio[964]: info: Adding plugin smart_inputs to MyMusic Plugins Aug 19 19:42:14 orpheus volumio[964]: info: Adding plugin tidalconnect to MyMusic Plugins Aug 19 19:42:14 orpheus volumio[964]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Aug 19 19:42:15 orpheus ntpd[756]: Soliciting pool server 80.87.196.0 Aug 19 19:42:15 orpheus ntpd[756]: Soliciting pool server 91.209.94.10 Aug 19 19:42:15 orpheus volumio[964]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Aug 19 19:42:15 orpheus volumio[964]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Aug 19 19:42:15 orpheus volumio[964]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 19 19:42:15 orpheus volumio[964]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 19 19:42:15 orpheus volumio[964]: info: Starting MyVolumio Remote Streaming Endpoints Aug 19 19:42:15 orpheus volumio[964]: info: MyVolumio login type: Token Aug 19 19:42:15 orpheus volumio[964]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Aug 19 19:42:15 orpheus volumio[964]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Aug 19 19:42:16 orpheus ntpd[756]: Soliciting pool server 91.206.16.3 Aug 19 19:42:16 orpheus ntpd[756]: Soliciting pool server 37.79.247.8 Aug 19 19:42:17 orpheus volumio[964]: info: Starting Streaming Service Transparent Proxy Aug 19 19:42:17 orpheus volumio[964]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Aug 19 19:42:17 orpheus volumio[964]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Aug 19 19:42:17 orpheus volumio[964]: info: Streaming services startup Aug 19 19:42:17 orpheus volumio[964]: info: Starting Streaming Daemon Aug 19 19:42:17 orpheus sudo[1423]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Aug 19 19:42:17 orpheus sudo[1423]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 19 19:42:17 orpheus volumio[964]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Aug 19 19:42:17 orpheus sudo[1423]: pam_unix(sudo:session): session closed for user root Aug 19 19:42:17 orpheus volumio[964]: error: Cannot start Volumio Streaming Daemon Aug 19 19:42:17 orpheus volumio[964]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Aug 19 19:42:17 orpheus volumio[964]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Aug 19 19:42:17 orpheus volumio[964]: Upnp client error: Error: This socket has been ended by the other party Aug 19 19:42:17 orpheus ntpd[756]: Soliciting pool server 46.146.231.187 Aug 19 19:42:17 orpheus ntpd[756]: Soliciting pool server 2a03:aa00::136:55 Aug 19 19:43:43 orpheus volumio[964]: error: MyVolumio Custom Token format not valid, refreshing it Aug 19 19:43:43 orpheus volumio[964]: STREAMING PROXY: Starting server on port 3245 Aug 19 19:43:43 orpheus volumio[964]: Node JS runtime: 14 Aug 19 19:43:44 orpheus volumio[964]: info: MyVolumio login type: Token Aug 19 19:43:44 orpheus volumio[964]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Aug 19 19:43:46 orpheus sudo[1412]: pam_unix(sudo:session): session closed for user root Aug 19 19:43:46 orpheus volumio[964]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Aug 19 19:43:46 orpheus kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Aug 19 19:43:46 orpheus kernel: CIFS: VFS: cifs_mount failed w/return code = -113 Aug 19 19:43:46 orpheus volumio[964]: info: MyVolumio token set successfully Aug 19 19:43:46 orpheus volumio[964]: info: MYVOLUMIO: Adding device Aug 19 19:43:46 orpheus volumio[964]: info: MYVOLUMIO: Evaluating Server Aug 19 19:43:46 orpheus volumio[964]: info: MyVolumio status changed Aug 19 19:43:46 orpheus volumio[964]: info: Streaming services startup Aug 19 19:43:46 orpheus volumio[964]: info: Starting Streaming Daemon Aug 19 19:43:46 orpheus volumio[964]: info: Removing browser output: myVolumio user plan is not superstar Aug 19 19:43:46 orpheus volumio[964]: info: Removing audio output: Aug 19 19:43:46 orpheus volumio[964]: info: Stoppping Tunnel 1 Aug 19 19:43:46 orpheus sudo[1460]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Aug 19 19:43:46 orpheus sudo[1460]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 19 19:43:46 orpheus sudo[1460]: pam_unix(sudo:session): session closed for user root Aug 19 19:43:46 orpheus sudo[1463]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Aug 19 19:43:47 orpheus volumio[964]: error: Cannot start Volumio Streaming Daemon Aug 19 19:43:47 orpheus sudo[1463]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 19 19:43:47 orpheus volumio[964]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Aug 19 19:43:47 orpheus volumio[964]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Aug 19 19:43:47 orpheus sudo[1463]: pam_unix(sudo:session): session closed for user root Aug 19 19:43:47 orpheus volumio[964]: info: Remote SSH Stopped Aug 19 19:43:47 orpheus volumio[964]: info: Setting Geolocation for MyVolumio to eu4 Aug 19 19:43:47 orpheus volumio[964]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 19 19:43:47 orpheus volumio[964]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 19 19:43:47 orpheus volumio[964]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 19 19:43:48 orpheus volumio[964]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Aug 19 19:43:48 orpheus volumio[964]: info: Updating MyVolumio device info Aug 19 19:43:48 orpheus volumio[964]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 19 19:43:49 orpheus volumio[964]: info: Clearing queue after UPNP request Aug 19 19:43:49 orpheus volumio[964]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Aug 19 19:43:49 orpheus volumio[964]: info: CoreStateMachine::ClearQueue Aug 19 19:43:49 orpheus volumio[964]: info: CoreStateMachine::stop Aug 19 19:43:49 orpheus volumio[964]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 19 19:43:49 orpheus volumio[964]: info: CoreStateMachine::stPlaybackTimer Aug 19 19:43:49 orpheus volumio[964]: info: CoreStateMachine::updateTrackBlock Aug 19 19:43:49 orpheus volumio[964]: info: CorePlayQueue::getTrackBlock Aug 19 19:43:49 orpheus volumio[964]: info: CoreStateMachine::pushState Aug 19 19:43:49 orpheus volumio[964]: info: CorePlayQueue::getTrack 0 Aug 19 19:43:49 orpheus volumio[964]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 19 19:43:49 orpheus volumio[964]: info: CoreCommandRouter::volumioPushState Aug 19 19:43:49 orpheus volumio[964]: info: CoreStateMachine::serviceStop Aug 19 19:43:49 orpheus volumio[964]: info: CorePlayQueue::getTrack 0 Aug 19 19:43:49 orpheus volumio[964]: info: CoreCommandRouter::serviceStop Aug 19 19:43:49 orpheus volumio[964]: info: [1724096629632] ControllerWebradio::stop Aug 19 19:43:49 orpheus volumio[964]: verbose: ControllerMpd::sendMpdCommand stop Aug 19 19:43:49 orpheus volumio[964]: info: CorePlayQueue::clearPlayQueue Aug 19 19:43:49 orpheus volumio[964]: info: CorePlayQueue::saveQueue Aug 19 19:43:49 orpheus volumio[964]: info: CoreCommandRouter::volumioPushState Aug 19 19:43:49 orpheus volumio[964]: info: CoreCommandRouter::volumioPushQueue Aug 19 19:43:49 orpheus volumio[964]: info: Aug 19 19:43:49 orpheus volumio[964]: ---------------------------- MPD announces state update: player Aug 19 19:43:49 orpheus volumio[964]: info: sendMpdCommand stop took 22 milliseconds Aug 19 19:43:49 orpheus volumio[964]: info: ControllerMpd::getState Aug 19 19:43:49 orpheus volumio[964]: verbose: ControllerMpd::sendMpdCommand status Aug 19 19:43:49 orpheus volumio[964]: info: Aug 19 19:43:49 orpheus volumio[964]: ---------------------------- MPD announces system playlist update Aug 19 19:43:49 orpheus volumio[964]: info: Ignoring MPD Status Update Aug 19 19:43:49 orpheus volumio[964]: info: sendMpdCommand status took 2 milliseconds Aug 19 19:43:49 orpheus volumio[964]: verbose: ControllerMpd::parseState Aug 19 19:43:49 orpheus volumio[964]: info: ControllerMpd::pushState Aug 19 19:43:49 orpheus volumio[964]: info: CoreCommandRouter::servicePushState Aug 19 19:43:49 orpheus volumio[964]: info: CoreStateMachine::pushState Aug 19 19:43:49 orpheus volumio[964]: info: CorePlayQueue::getTrack 0 Aug 19 19:43:49 orpheus volumio[964]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 19 19:43:49 orpheus volumio[964]: info: CoreCommandRouter::volumioPushState Aug 19 19:43:49 orpheus volumio[964]: info: CorePlayQueue::getTrack 0 Aug 19 19:43:49 orpheus volumio[964]: 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} Aug 19 19:43:49 orpheus volumio[964]: verbose: CURRENT POSITION 0 Aug 19 19:43:49 orpheus volumio[964]: info: CoreStateMachine::syncState stateService stop Aug 19 19:43:49 orpheus volumio[964]: info: CoreStateMachine::syncState currentStatus stop Aug 19 19:43:49 orpheus volumio[964]: info: CoreStateMachine::pushState Aug 19 19:43:49 orpheus volumio[964]: info: CorePlayQueue::getTrack 0 Aug 19 19:43:49 orpheus volumio[964]: info: CoreCommandRouter::volumioPushState Aug 19 19:43:49 orpheus volumio[964]: info: No code Aug 19 19:43:49 orpheus volumio[964]: info: CoreStateMachine::pushState Aug 19 19:43:49 orpheus volumio[964]: info: CorePlayQueue::getTrack 0 Aug 19 19:43:49 orpheus volumio[964]: info: CoreCommandRouter::volumioPushState Aug 19 19:43:49 orpheus volumio[964]: info: ------------------------------ 26ms Aug 19 19:43:49 orpheus volumio[964]: info: Aug 19 19:43:49 orpheus volumio[964]: ---------------------------- MPD announces state update: player Aug 19 19:43:49 orpheus volumio[964]: info: ControllerMpd::getState Aug 19 19:43:49 orpheus volumio[964]: verbose: ControllerMpd::sendMpdCommand status Aug 19 19:43:49 orpheus volumio[964]: info: Aug 19 19:43:49 orpheus volumio[964]: ---------------------------- MPD announces state update: player Aug 19 19:43:49 orpheus volumio[964]: info: ControllerMpd::getState Aug 19 19:43:49 orpheus volumio[964]: verbose: ControllerMpd::sendMpdCommand status Aug 19 19:43:49 orpheus volumio[964]: error: updateQueue error: null Aug 19 19:43:49 orpheus volumio[964]: info: ------------------------------ 31ms Aug 19 19:43:49 orpheus volumio[964]: info: sendMpdCommand status took 7 milliseconds Aug 19 19:43:49 orpheus volumio[964]: info: sendMpdCommand status took 5 milliseconds Aug 19 19:43:49 orpheus volumio[964]: verbose: ControllerMpd::parseState Aug 19 19:43:49 orpheus volumio[964]: verbose: ControllerMpd::parseState Aug 19 19:43:49 orpheus volumio[964]: info: ControllerMpd::pushState Aug 19 19:43:49 orpheus volumio[964]: info: CoreCommandRouter::servicePushState Aug 19 19:43:49 orpheus volumio[964]: info: CoreStateMachine::pushState Aug 19 19:43:49 orpheus volumio[964]: info: CorePlayQueue::getTrack 0 Aug 19 19:43:49 orpheus volumio[964]: info: CoreCommandRouter::volumioPushState Aug 19 19:43:49 orpheus volumio[964]: info: CorePlayQueue::getTrack 0 Aug 19 19:43:49 orpheus volumio[964]: 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} Aug 19 19:43:49 orpheus volumio[964]: verbose: CURRENT POSITION 0 Aug 19 19:43:49 orpheus volumio[964]: info: CoreStateMachine::syncState stateService stop Aug 19 19:43:49 orpheus volumio[964]: info: CoreStateMachine::syncState currentStatus stop Aug 19 19:43:49 orpheus volumio[964]: info: CoreStateMachine::pushState Aug 19 19:43:49 orpheus volumio[964]: info: CorePlayQueue::getTrack 0 Aug 19 19:43:49 orpheus volumio[964]: info: CoreCommandRouter::volumioPushState Aug 19 19:43:49 orpheus volumio[964]: info: No code Aug 19 19:43:49 orpheus volumio[964]: info: CoreStateMachine::pushState Aug 19 19:43:49 orpheus volumio[964]: info: CorePlayQueue::getTrack 0 Aug 19 19:43:49 orpheus volumio[964]: info: CoreCommandRouter::volumioPushState Aug 19 19:43:49 orpheus volumio[964]: info: ControllerMpd::pushState Aug 19 19:43:49 orpheus volumio[964]: info: CoreCommandRouter::servicePushState Aug 19 19:43:49 orpheus volumio[964]: info: CoreStateMachine::pushState Aug 19 19:43:49 orpheus volumio[964]: info: CorePlayQueue::getTrack 0 Aug 19 19:43:49 orpheus volumio[964]: info: CoreCommandRouter::volumioPushState Aug 19 19:43:49 orpheus volumio[964]: info: CorePlayQueue::getTrack 0 Aug 19 19:43:49 orpheus volumio[964]: 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} Aug 19 19:43:49 orpheus volumio[964]: verbose: CURRENT POSITION 0 Aug 19 19:43:49 orpheus volumio[964]: info: CoreStateMachine::syncState stateService stop Aug 19 19:43:49 orpheus volumio[964]: info: CoreStateMachine::syncState currentStatus stop Aug 19 19:43:49 orpheus volumio[964]: info: CoreStateMachine::pushState Aug 19 19:43:49 orpheus volumio[964]: info: CorePlayQueue::getTrack 0 Aug 19 19:43:49 orpheus volumio[964]: info: CoreCommandRouter::volumioPushState Aug 19 19:43:49 orpheus volumio[964]: info: No code Aug 19 19:43:49 orpheus volumio[964]: info: CoreStateMachine::pushState Aug 19 19:43:49 orpheus volumio[964]: info: CorePlayQueue::getTrack 0 Aug 19 19:43:49 orpheus volumio[964]: info: CoreCommandRouter::volumioPushState Aug 19 19:43:49 orpheus volumio[964]: info: ------------------------------ 49ms Aug 19 19:43:49 orpheus volumio[964]: info: ------------------------------ 48ms Aug 19 19:43:49 orpheus volumio[964]: info: Aug 19 19:43:49 orpheus volumio[964]: ---------------------------- MPD announces system playlist update Aug 19 19:43:49 orpheus volumio[964]: info: Ignoring MPD Status Update Aug 19 19:43:49 orpheus volumio[964]: info: Aug 19 19:43:49 orpheus volumio[964]: ---------------------------- MPD announces system playlist update Aug 19 19:43:49 orpheus volumio[964]: info: Ignoring MPD Status Update Aug 19 19:43:49 orpheus volumio[964]: error: updateQueue error: null Aug 19 19:43:49 orpheus volumio[964]: error: updateQueue error: null Aug 19 19:43:49 orpheus volumio[964]: info: ------------------------------ 9ms Aug 19 19:43:49 orpheus volumio[964]: info: ------------------------------ 9ms Aug 19 19:43:49 orpheus volumio[964]: info: Starting UPNP Playback Aug 19 19:43:49 orpheus volumio[964]: info: Preparing playback through UPNP Aug 19 19:43:49 orpheus volumio[964]: info: CoreCommandRouter::volumioGetState Aug 19 19:43:49 orpheus volumio[964]: info: CorePlayQueue::getTrack 0 Aug 19 19:43:49 orpheus volumio[964]: info: CoreStateMachine::setConsumeUpdateService mpd Aug 19 19:43:50 orpheus volumio[964]: info: Aug 19 19:43:50 orpheus volumio[964]: ---------------------------- MPD announces system playlist update Aug 19 19:43:50 orpheus volumio[964]: info: Ignoring MPD Status Update Aug 19 19:43:50 orpheus volumio[964]: info: Aug 19 19:43:50 orpheus volumio[964]: ---------------------------- MPD announces system playlist update Aug 19 19:43:50 orpheus volumio[964]: info: Ignoring MPD Status Update Aug 19 19:43:50 orpheus volumio[964]: info: Aug 19 19:43:50 orpheus volumio[964]: ---------------------------- MPD announces system playlist update Aug 19 19:43:50 orpheus volumio[964]: info: Ignoring MPD Status Update Aug 19 19:43:50 orpheus volumio[964]: info: Aug 19 19:43:50 orpheus volumio[964]: ---------------------------- MPD announces system playlist update Aug 19 19:43:50 orpheus volumio[964]: info: Ignoring MPD Status Update Aug 19 19:43:50 orpheus volumio[964]: info: ------------------------------ 5ms Aug 19 19:43:50 orpheus volumio[964]: info: ------------------------------ 4ms Aug 19 19:43:50 orpheus volumio[964]: info: ------------------------------ 4ms Aug 19 19:43:50 orpheus volumio[964]: info: Aug 19 19:43:50 orpheus volumio[964]: ---------------------------- MPD announces system playlist update Aug 19 19:43:50 orpheus volumio[964]: info: Ignoring MPD Status Update Aug 19 19:43:50 orpheus volumio[964]: info: Aug 19 19:43:50 orpheus volumio[964]: ---------------------------- MPD announces system playlist update Aug 19 19:43:50 orpheus volumio[964]: info: Ignoring MPD Status Update Aug 19 19:43:50 orpheus volumio[964]: info: ------------------------------ 6ms Aug 19 19:43:50 orpheus volumio[964]: info: ------------------------------ 4ms Aug 19 19:43:50 orpheus volumio[964]: info: ------------------------------ 2ms Aug 19 19:43:50 orpheus volumio[964]: info: Aug 19 19:43:50 orpheus volumio[964]: ---------------------------- MPD announces system playlist update Aug 19 19:43:50 orpheus volumio[964]: info: Ignoring MPD Status Update Aug 19 19:43:50 orpheus volumio[964]: info: Aug 19 19:43:50 orpheus volumio[964]: ---------------------------- MPD announces system playlist update Aug 19 19:43:50 orpheus volumio[964]: info: Ignoring MPD Status Update Aug 19 19:43:50 orpheus volumio[964]: info: Aug 19 19:43:50 orpheus volumio[964]: ---------------------------- MPD announces system playlist update Aug 19 19:43:50 orpheus volumio[964]: info: Ignoring MPD Status Update Aug 19 19:43:50 orpheus volumio[964]: info: ------------------------------ 4ms Aug 19 19:43:50 orpheus volumio[964]: info: ------------------------------ 4ms Aug 19 19:43:50 orpheus volumio[964]: info: ------------------------------ 2ms Aug 19 19:43:50 orpheus volumio[964]: info: Aug 19 19:43:50 orpheus volumio[964]: ---------------------------- MPD announces system playlist update Aug 19 19:43:50 orpheus volumio[964]: info: Ignoring MPD Status Update Aug 19 19:43:50 orpheus volumio[964]: info: Aug 19 19:43:50 orpheus volumio[964]: ---------------------------- MPD announces system playlist update Aug 19 19:43:50 orpheus volumio[964]: info: Ignoring MPD Status Update Aug 19 19:43:50 orpheus volumio[964]: info: Aug 19 19:43:50 orpheus volumio[964]: ---------------------------- MPD announces system playlist update Aug 19 19:43:50 orpheus volumio[964]: info: Ignoring MPD Status Update Aug 19 19:43:50 orpheus volumio[964]: info: ------------------------------ 4ms Aug 19 19:43:50 orpheus volumio[964]: info: ------------------------------ 4ms Aug 19 19:43:50 orpheus volumio[964]: info: ------------------------------ 2ms Aug 19 19:43:50 orpheus volumio[964]: info: Aug 19 19:43:50 orpheus volumio[964]: ---------------------------- MPD announces system playlist update Aug 19 19:43:50 orpheus volumio[964]: info: Ignoring MPD Status Update Aug 19 19:43:50 orpheus volumio[964]: info: Aug 19 19:43:50 orpheus volumio[964]: ---------------------------- MPD announces system playlist update Aug 19 19:43:50 orpheus volumio[964]: info: Ignoring MPD Status Update Aug 19 19:43:50 orpheus volumio[964]: info: Aug 19 19:43:50 orpheus volumio[964]: ---------------------------- MPD announces system playlist update Aug 19 19:43:50 orpheus volumio[964]: info: Ignoring MPD Status Update Aug 19 19:43:50 orpheus volumio[964]: info: ------------------------------ 4ms Aug 19 19:43:50 orpheus volumio[964]: info: ------------------------------ 3ms Aug 19 19:43:50 orpheus volumio[964]: info: ------------------------------ 3ms Aug 19 19:43:50 orpheus volumio[964]: info: Aug 19 19:43:50 orpheus volumio[964]: ---------------------------- MPD announces system playlist update Aug 19 19:43:50 orpheus volumio[964]: info: Ignoring MPD Status Update Aug 19 19:43:50 orpheus volumio[964]: info: Aug 19 19:43:50 orpheus volumio[964]: ---------------------------- MPD announces system playlist update Aug 19 19:43:50 orpheus volumio[964]: info: Ignoring MPD Status Update Aug 19 19:43:50 orpheus volumio[964]: info: Aug 19 19:43:50 orpheus volumio[964]: ---------------------------- MPD announces system playlist update Aug 19 19:43:50 orpheus volumio[964]: info: Ignoring MPD Status Update Aug 19 19:43:50 orpheus volumio[964]: info: ------------------------------ 10ms Aug 19 19:43:50 orpheus volumio[964]: info: ------------------------------ 3ms Aug 19 19:43:50 orpheus volumio[964]: info: ------------------------------ 2ms Aug 19 19:43:52 orpheus kernel: pcm512x 1-004c: No SCLK, using BCLK: -2 Aug 19 19:43:52 orpheus volumio[964]: info: Aug 19 19:43:52 orpheus volumio[964]: ---------------------------- MPD announces state update: player Aug 19 19:43:52 orpheus volumio[964]: info: ControllerMpd::getState Aug 19 19:43:52 orpheus volumio[964]: verbose: ControllerMpd::sendMpdCommand status Aug 19 19:43:52 orpheus volumio[964]: info: Aug 19 19:43:52 orpheus volumio[964]: ---------------------------- MPD announces state update: player Aug 19 19:43:52 orpheus volumio[964]: info: ControllerMpd::getState Aug 19 19:43:52 orpheus volumio[964]: verbose: ControllerMpd::sendMpdCommand status Aug 19 19:43:52 orpheus volumio[964]: info: Aug 19 19:43:52 orpheus volumio[964]: ---------------------------- MPD announces state update: player Aug 19 19:43:52 orpheus volumio[964]: info: ControllerMpd::getState Aug 19 19:43:52 orpheus volumio[964]: verbose: ControllerMpd::sendMpdCommand status Aug 19 19:43:52 orpheus volumio[964]: info: sendMpdCommand status took 12 milliseconds Aug 19 19:43:52 orpheus volumio[964]: verbose: ControllerMpd::parseState Aug 19 19:43:52 orpheus volumio[964]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 19 19:43:52 orpheus volumio[964]: info: Aug 19 19:43:52 orpheus volumio[964]: ---------------------------- MPD announces system playlist update Aug 19 19:43:52 orpheus volumio[964]: info: Ignoring MPD Status Update Aug 19 19:43:52 orpheus volumio[964]: info: Aug 19 19:43:52 orpheus volumio[964]: ---------------------------- MPD announces state update: player Aug 19 19:43:52 orpheus volumio[964]: info: ControllerMpd::getState Aug 19 19:43:52 orpheus volumio[964]: verbose: ControllerMpd::sendMpdCommand status Aug 19 19:43:52 orpheus volumio[964]: info: sendMpdCommand status took 14 milliseconds Aug 19 19:43:52 orpheus volumio[964]: info: sendMpdCommand status took 13 milliseconds Aug 19 19:43:52 orpheus volumio[964]: info: sendMpdCommand playlistinfo took 3 milliseconds Aug 19 19:43:52 orpheus volumio[964]: verbose: ControllerMpd::parseState Aug 19 19:43:52 orpheus volumio[964]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 19 19:43:52 orpheus volumio[964]: verbose: ControllerMpd::parseState Aug 19 19:43:52 orpheus volumio[964]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 19 19:43:52 orpheus volumio[964]: verbose: ControllerMpd::parseTrackInfo Aug 19 19:43:52 orpheus volumio[964]: info: ControllerMpd::pushState Aug 19 19:43:52 orpheus volumio[964]: info: CoreCommandRouter::servicePushState Aug 19 19:43:52 orpheus volumio[964]: verbose: In UPNP mode Aug 19 19:43:52 orpheus volumio[964]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1536 Kbps","isStreaming":false,"title":"swyh.wav","artist":"swyh-rs","album":null,"uri":"http://192.168.1.4:5901/stream/swyh.wav","trackType":"wav"} Aug 19 19:43:52 orpheus volumio[964]: verbose: CURRENT POSITION 0 Aug 19 19:43:52 orpheus volumio[964]: info: CoreStateMachine::syncState stateService play Aug 19 19:43:52 orpheus volumio[964]: info: CoreStateMachine::syncState currentStatus stop Aug 19 19:43:52 orpheus volumio[964]: info: ------------------------------ 22ms Aug 19 19:43:52 orpheus volumio[964]: info: Aug 19 19:43:52 orpheus volumio[964]: ---------------------------- MPD announces system playlist update Aug 19 19:43:52 orpheus volumio[964]: info: Ignoring MPD Status Update Aug 19 19:43:52 orpheus volumio[964]: info: Aug 19 19:43:52 orpheus volumio[964]: ---------------------------- MPD announces state update: player Aug 19 19:43:52 orpheus volumio[964]: info: ControllerMpd::getState Aug 19 19:43:52 orpheus volumio[964]: verbose: ControllerMpd::sendMpdCommand status Aug 19 19:43:52 orpheus volumio[964]: info: Aug 19 19:43:52 orpheus volumio[964]: ---------------------------- MPD announces system playlist update Aug 19 19:43:52 orpheus volumio[964]: info: Ignoring MPD Status Update Aug 19 19:43:52 orpheus volumio[964]: info: Aug 19 19:43:52 orpheus volumio[964]: ---------------------------- MPD announces state update: player Aug 19 19:43:52 orpheus volumio[964]: info: ControllerMpd::getState Aug 19 19:43:52 orpheus volumio[964]: verbose: ControllerMpd::sendMpdCommand status Aug 19 19:43:52 orpheus volumio[964]: info: ------------------------------ 13ms Aug 19 19:43:52 orpheus volumio[964]: info: sendMpdCommand status took 12 milliseconds Aug 19 19:43:52 orpheus volumio[964]: info: sendMpdCommand playlistinfo took 10 milliseconds Aug 19 19:43:52 orpheus volumio[964]: info: sendMpdCommand playlistinfo took 10 milliseconds Aug 19 19:43:52 orpheus volumio[964]: info: ------------------------------ 7ms Aug 19 19:43:52 orpheus volumio[964]: info: sendMpdCommand status took 6 milliseconds Aug 19 19:43:52 orpheus volumio[964]: info: ------------------------------ 5ms Aug 19 19:43:52 orpheus volumio[964]: info: sendMpdCommand status took 4 milliseconds Aug 19 19:43:52 orpheus volumio[964]: verbose: ControllerMpd::parseState Aug 19 19:43:52 orpheus volumio[964]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 19 19:43:52 orpheus volumio[964]: verbose: ControllerMpd::parseTrackInfo Aug 19 19:43:52 orpheus volumio[964]: verbose: ControllerMpd::parseTrackInfo Aug 19 19:43:52 orpheus volumio[964]: verbose: ControllerMpd::parseState Aug 19 19:43:52 orpheus volumio[964]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 19 19:43:52 orpheus volumio[964]: verbose: ControllerMpd::parseState Aug 19 19:43:52 orpheus volumio[964]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 19 19:43:52 orpheus volumio[964]: info: ControllerMpd::pushState Aug 19 19:43:52 orpheus volumio[964]: info: CoreCommandRouter::servicePushState Aug 19 19:43:52 orpheus volumio[964]: verbose: In UPNP mode Aug 19 19:43:52 orpheus volumio[964]: verbose: STATE SERVICE {"status":"play","position":0,"seek":840,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1536 Kbps","isStreaming":false,"title":"swyh.wav","artist":"swyh-rs","album":null,"uri":"http://192.168.1.4:5901/stream/swyh.wav","trackType":"wav"} Aug 19 19:43:52 orpheus volumio[964]: verbose: CURRENT POSITION 0 Aug 19 19:43:52 orpheus volumio[964]: info: CoreStateMachine::syncState stateService play Aug 19 19:43:52 orpheus volumio[964]: info: CoreStateMachine::syncState currentStatus play Aug 19 19:43:52 orpheus volumio[964]: info: Received an update from plugin. extracting info from payload Aug 19 19:43:52 orpheus volumio[964]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 19 19:43:52 orpheus volumio[964]: info: CoreStateMachine::pushState Aug 19 19:43:52 orpheus volumio[964]: info: CorePlayQueue::getTrack 0 Aug 19 19:43:52 orpheus volumio[964]: info: ControllerMpd::pushState Aug 19 19:43:52 orpheus volumio[964]: info: CoreCommandRouter::servicePushState Aug 19 19:43:52 orpheus volumio[964]: verbose: In UPNP mode Aug 19 19:43:52 orpheus volumio[964]: verbose: STATE SERVICE {"status":"play","position":0,"seek":966,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1536 Kbps","isStreaming":false,"title":"swyh.wav","artist":"swyh-rs","album":null,"uri":"http://192.168.1.4:5901/stream/swyh.wav","trackType":"wav"} Aug 19 19:43:52 orpheus volumio[964]: verbose: CURRENT POSITION 0 Aug 19 19:43:52 orpheus volumio[964]: info: CoreStateMachine::syncState stateService play Aug 19 19:43:52 orpheus volumio[964]: info: CoreStateMachine::syncState currentStatus play Aug 19 19:43:52 orpheus volumio[964]: info: Received an update from plugin. extracting info from payload Aug 19 19:43:52 orpheus volumio[964]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 19 19:43:52 orpheus volumio[964]: info: CoreStateMachine::pushState Aug 19 19:43:52 orpheus volumio[964]: info: CorePlayQueue::getTrack 0 Aug 19 19:43:52 orpheus volumio[964]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Aug 19 19:43:52 orpheus volumio[964]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Aug 19 19:43:52 orpheus volumio[964]: info: ------------------------------ 40ms Aug 19 19:43:52 orpheus volumio[964]: info: ------------------------------ 39ms Aug 19 19:43:52 orpheus volumio[964]: info: sendMpdCommand playlistinfo took 13 milliseconds Aug 19 19:43:52 orpheus volumio[964]: info: sendMpdCommand playlistinfo took 12 milliseconds Aug 19 19:43:52 orpheus volumio[964]: info: sendMpdCommand playlistinfo took 12 milliseconds Aug 19 19:43:52 orpheus volumio[964]: verbose: ControllerMpd::parseTrackInfo Aug 19 19:43:52 orpheus volumio[964]: verbose: ControllerMpd::parseTrackInfo Aug 19 19:43:52 orpheus volumio[964]: verbose: ControllerMpd::parseTrackInfo Aug 19 19:43:52 orpheus volumio[964]: info: ControllerMpd::pushState Aug 19 19:43:52 orpheus volumio[964]: info: CoreCommandRouter::servicePushState Aug 19 19:43:52 orpheus volumio[964]: verbose: In UPNP mode Aug 19 19:43:52 orpheus volumio[964]: verbose: STATE SERVICE {"status":"play","position":0,"seek":966,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1536 Kbps","isStreaming":false,"title":"swyh.wav","artist":"swyh-rs","album":null,"uri":"http://192.168.1.4:5901/stream/swyh.wav","trackType":"wav"} Aug 19 19:43:52 orpheus volumio[964]: verbose: CURRENT POSITION 0 Aug 19 19:43:52 orpheus volumio[964]: info: CoreStateMachine::syncState stateService play Aug 19 19:43:52 orpheus volumio[964]: info: CoreStateMachine::syncState currentStatus play Aug 19 19:43:52 orpheus volumio[964]: info: Received an update from plugin. extracting info from payload Aug 19 19:43:52 orpheus volumio[964]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 19 19:43:52 orpheus volumio[964]: info: CoreStateMachine::pushState Aug 19 19:43:52 orpheus volumio[964]: info: CorePlayQueue::getTrack 0 Aug 19 19:43:52 orpheus volumio[964]: info: ControllerMpd::pushState Aug 19 19:43:52 orpheus volumio[964]: info: CoreCommandRouter::servicePushState Aug 19 19:43:52 orpheus volumio[964]: verbose: In UPNP mode Aug 19 19:43:52 orpheus volumio[964]: verbose: STATE SERVICE {"status":"play","position":0,"seek":966,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1536 Kbps","isStreaming":false,"title":"swyh.wav","artist":"swyh-rs","album":null,"uri":"http://192.168.1.4:5901/stream/swyh.wav","trackType":"wav"} Aug 19 19:43:52 orpheus volumio[964]: verbose: CURRENT POSITION 0 Aug 19 19:43:52 orpheus volumio[964]: info: CoreStateMachine::syncState stateService play Aug 19 19:43:52 orpheus volumio[964]: info: CoreStateMachine::syncState currentStatus play Aug 19 19:43:52 orpheus volumio[964]: info: Received an update from plugin. extracting info from payload Aug 19 19:43:52 orpheus volumio[964]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 19 19:43:52 orpheus volumio[964]: info: CoreStateMachine::pushState Aug 19 19:43:52 orpheus volumio[964]: info: CorePlayQueue::getTrack 0 Aug 19 19:43:52 orpheus volumio[964]: info: ControllerMpd::pushState Aug 19 19:43:52 orpheus volumio[964]: info: CoreCommandRouter::servicePushState Aug 19 19:43:52 orpheus volumio[964]: verbose: In UPNP mode Aug 19 19:43:52 orpheus volumio[964]: verbose: STATE SERVICE {"status":"play","position":0,"seek":966,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1536 Kbps","isStreaming":false,"title":"swyh.wav","artist":"swyh-rs","album":null,"uri":"http://192.168.1.4:5901/stream/swyh.wav","trackType":"wav"} Aug 19 19:43:52 orpheus volumio[964]: verbose: CURRENT POSITION 0 Aug 19 19:43:52 orpheus volumio[964]: info: CoreStateMachine::syncState stateService play Aug 19 19:43:52 orpheus volumio[964]: info: CoreStateMachine::syncState currentStatus play Aug 19 19:43:52 orpheus volumio[964]: info: Received an update from plugin. extracting info from payload Aug 19 19:43:52 orpheus volumio[964]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 19 19:43:52 orpheus volumio[964]: info: CoreStateMachine::pushState Aug 19 19:43:52 orpheus volumio[964]: info: CorePlayQueue::getTrack 0 Aug 19 19:43:52 orpheus volumio[964]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Aug 19 19:43:52 orpheus volumio[964]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Aug 19 19:43:52 orpheus volumio[964]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Aug 19 19:43:52 orpheus volumio[964]: info: ------------------------------ 45ms Aug 19 19:43:52 orpheus volumio[964]: info: ------------------------------ 38ms Aug 19 19:43:52 orpheus volumio[964]: info: ------------------------------ 36ms Aug 19 19:43:52 orpheus volumio[964]: info: MYVOLUMIO: Adding device Aug 19 19:43:52 orpheus volumio[964]: info: MYVOLUMIO: Evaluating Server Aug 19 19:43:54 orpheus volumio[964]: info: Setting Geolocation for MyVolumio to eu4 Aug 19 19:43:54 orpheus volumio[964]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 19 19:43:55 orpheus volumio[964]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Aug 19 19:43:55 orpheus volumio[964]: info: Updating MyVolumio device info Aug 19 19:43:55 orpheus volumio[964]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 19 19:43:55 orpheus volumio[964]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Aug 19 19:43:56 orpheus volumio[964]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 19 19:43:56 orpheus volumio[964]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Aug 19 19:43:56 orpheus volumio[964]: info: CoreCommandRouter::volumioGetState Aug 19 19:43:56 orpheus volumio[964]: info: CorePlayQueue::getTrack 0 Aug 19 19:43:56 orpheus volumio[964]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 19 19:43:56 orpheus volumio[964]: TypeError: Cannot read property 'name' of undefined Aug 19 19:43:56 orpheus volumio[964]: at CoreStateMachine.getState (/volumio/app/statemachine.js:126:48) Aug 19 19:43:56 orpheus volumio[964]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:107:28) Aug 19 19:43:56 orpheus volumio[964]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:58:38) Aug 19 19:43:56 orpheus volumio[964]: at Socket.emit (events.js:315:20) Aug 19 19:43:56 orpheus volumio[964]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Aug 19 19:43:56 orpheus volumio[964]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Aug 19 19:43:56 orpheus volumio[964]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 19 19:43:56 orpheus sudo[1519]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-19 19:42 Aug 19 19:43:56 orpheus sudo[1519]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"