-- Logs begin at Thu 2024-10-03 10:13:01 UTC, end at Sat 2024-10-12 01:35:39 UTC. -- Oct 12 01:34:51 volumio volumio[880]: info: Oct 12 01:34:51 volumio volumio[880]: ---------------------------- MPD announces state update: player Oct 12 01:34:51 volumio volumio[880]: info: ControllerMpd::getState Oct 12 01:34:51 volumio volumio[880]: verbose: ControllerMpd::sendMpdCommand status Oct 12 01:34:51 volumio volumio[880]: info: sendMpdCommand status took 0 milliseconds Oct 12 01:34:51 volumio volumio[880]: verbose: ControllerMpd::parseState Oct 12 01:34:51 volumio volumio[880]: info: ControllerMpd::pushState Oct 12 01:34:51 volumio volumio[880]: info: CoreCommandRouter::servicePushState Oct 12 01:34:51 volumio volumio[880]: info: CoreStateMachine::pushState Oct 12 01:34:51 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Oct 12 01:34:51 volumio volumio[880]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Oct 12 01:34:51 volumio volumio[880]: info: ------------------------------ 5ms Oct 12 01:34:59 volumio volumio[880]: info: Clearing queue after UPNP request Oct 12 01:34:59 volumio volumio[880]: info: CoreStateMachine::ClearQueue Oct 12 01:34:59 volumio volumio[880]: info: CoreStateMachine::stop Oct 12 01:34:59 volumio volumio[880]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 01:34:59 volumio volumio[880]: UNSET VOLATILE Oct 12 01:34:59 volumio volumio[880]: info: CoreStateMachine::stPlaybackTimer Oct 12 01:34:59 volumio volumio[880]: info: CoreStateMachine::updateTrackBlock Oct 12 01:34:59 volumio volumio[880]: info: CorePlayQueue::getTrackBlock Oct 12 01:34:59 volumio volumio[880]: info: CoreStateMachine::pushState Oct 12 01:34:59 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Oct 12 01:34:59 volumio volumio[880]: info: CoreCommandRouter::volumioPushState Oct 12 01:34:59 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 01:34:59 volumio volumio[880]: info: CoreStateMachine::serviceStop Oct 12 01:34:59 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Oct 12 01:34:59 volumio volumio[880]: info: ControllerMpd::stop Oct 12 01:34:59 volumio volumio[880]: verbose: ControllerMpd::sendMpdCommand stop Oct 12 01:34:59 volumio volumio[880]: info: CorePlayQueue::clearPlayQueue Oct 12 01:34:59 volumio volumio[880]: info: CorePlayQueue::saveQueue Oct 12 01:34:59 volumio volumio[880]: info: CoreCommandRouter::volumioPushState Oct 12 01:34:59 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 01:34:59 volumio volumio[880]: info: CoreCommandRouter::volumioPushQueue Oct 12 01:34:59 volumio volumio[880]: info: Oct 12 01:34:59 volumio volumio[880]: ---------------------------- MPD announces system playlist update Oct 12 01:34:59 volumio volumio[880]: info: Ignoring MPD Status Update Oct 12 01:34:59 volumio volumio[880]: info: sendMpdCommand stop took 8 milliseconds Oct 12 01:34:59 volumio volumio[880]: error: updateQueue error: null Oct 12 01:34:59 volumio volumio[880]: info: ------------------------------ 1ms Oct 12 01:34:59 volumio volumio[880]: info: Starting UPNP Playback Oct 12 01:34:59 volumio volumio[880]: info: Preparing playback through UPNP Oct 12 01:34:59 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Oct 12 01:34:59 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Oct 12 01:34:59 volumio volumio[880]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 12 01:34:59 volumio volumio[880]: info: Oct 12 01:34:59 volumio volumio[880]: ---------------------------- MPD announces system playlist update Oct 12 01:34:59 volumio volumio[880]: info: Ignoring MPD Status Update Oct 12 01:34:59 volumio volumio[880]: info: ------------------------------ 1ms Oct 12 01:34:59 volumio volumio[880]: info: Oct 12 01:34:59 volumio volumio[880]: ---------------------------- MPD announces system playlist update Oct 12 01:34:59 volumio volumio[880]: info: Ignoring MPD Status Update Oct 12 01:34:59 volumio volumio[880]: info: ------------------------------ 1ms Oct 12 01:34:59 volumio volumio[880]: info: Oct 12 01:34:59 volumio volumio[880]: ---------------------------- MPD announces system playlist update Oct 12 01:34:59 volumio volumio[880]: info: Ignoring MPD Status Update Oct 12 01:34:59 volumio volumio[880]: info: ------------------------------ 1ms Oct 12 01:34:59 volumio volumio[880]: info: Oct 12 01:34:59 volumio volumio[880]: ---------------------------- MPD announces system playlist update Oct 12 01:34:59 volumio volumio[880]: info: Ignoring MPD Status Update Oct 12 01:34:59 volumio volumio[880]: info: ------------------------------ 1ms Oct 12 01:34:59 volumio volumio[880]: info: Oct 12 01:34:59 volumio volumio[880]: ---------------------------- MPD announces system playlist update Oct 12 01:34:59 volumio volumio[880]: info: Ignoring MPD Status Update Oct 12 01:34:59 volumio volumio[880]: info: ------------------------------ 1ms Oct 12 01:34:59 volumio volumio[880]: info: Oct 12 01:34:59 volumio volumio[880]: ---------------------------- MPD announces system playlist update Oct 12 01:34:59 volumio volumio[880]: info: Ignoring MPD Status Update Oct 12 01:34:59 volumio volumio[880]: info: ------------------------------ 0ms Oct 12 01:35:03 volumio volumio[880]: info: Oct 12 01:35:03 volumio volumio[880]: ---------------------------- MPD announces state update: player Oct 12 01:35:03 volumio volumio[880]: info: ControllerMpd::getState Oct 12 01:35:03 volumio volumio[880]: verbose: ControllerMpd::sendMpdCommand status Oct 12 01:35:03 volumio pulseaudio[30121]: [pulseaudio] server-lookup.c: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Oct 12 01:35:03 volumio pulseaudio[30121]: [pulseaudio] main.c: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Oct 12 01:35:03 volumio pulseaudio[30121]: [pulseaudio] bluez4-util.c: org.bluez.Manager.GetProperties() failed: org.freedesktop.DBus.Error.UnknownMethod: Method "GetProperties" with signature "" on interface "org.bluez.Manager" doesn't exist Oct 12 01:35:03 volumio bluetoothd[787]: Endpoint registered: sender=:1.62 path=/MediaEndpoint/A2DPSource Oct 12 01:35:03 volumio bluetoothd[787]: Endpoint registered: sender=:1.62 path=/MediaEndpoint/A2DPSink Oct 12 01:35:03 volumio volumio[880]: info: Oct 12 01:35:03 volumio volumio[880]: ---------------------------- MPD announces state update: player Oct 12 01:35:03 volumio volumio[880]: info: sendMpdCommand status took 181 milliseconds Oct 12 01:35:03 volumio volumio[880]: info: ControllerMpd::getState Oct 12 01:35:03 volumio volumio[880]: verbose: ControllerMpd::sendMpdCommand status Oct 12 01:35:03 volumio volumio[880]: verbose: ControllerMpd::parseState Oct 12 01:35:03 volumio volumio[880]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 01:35:03 volumio volumio[880]: info: sendMpdCommand status took 3 milliseconds Oct 12 01:35:03 volumio volumio[880]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 12 01:35:03 volumio volumio[880]: verbose: ControllerMpd::parseState Oct 12 01:35:03 volumio volumio[880]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 01:35:03 volumio volumio[880]: verbose: ControllerMpd::parseTrackInfo Oct 12 01:35:03 volumio volumio[880]: info: ControllerMpd::pushState Oct 12 01:35:03 volumio volumio[880]: info: CoreCommandRouter::servicePushState Oct 12 01:35:03 volumio volumio[880]: In UPNP mode Oct 12 01:35:03 volumio volumio[880]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":481,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Take The \"A\" Train (Vocal By Betty Roche)","artist":"Duke Ellington(듀크 엘링턴)","album":"Ellington Uptown [Limited Edition]","uri":"http://192.168.0.12:4718/dlna/366800","trackType":""} Oct 12 01:35:03 volumio volumio[880]: verbose: CURRENT POSITION 0 Oct 12 01:35:03 volumio volumio[880]: info: CoreStateMachine::syncState stateService play Oct 12 01:35:03 volumio volumio[880]: info: CoreStateMachine::syncState currentStatus stop Oct 12 01:35:03 volumio volumio[880]: info: CoreStateMachine::pushState Oct 12 01:35:03 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Oct 12 01:35:03 volumio volumio[880]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Oct 12 01:35:03 volumio volumio[880]: info: ------------------------------ 189ms Oct 12 01:35:03 volumio volumio[880]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 12 01:35:03 volumio volumio[880]: verbose: ControllerMpd::parseTrackInfo Oct 12 01:35:03 volumio volumio[880]: info: ControllerMpd::pushState Oct 12 01:35:03 volumio volumio[880]: info: CoreCommandRouter::servicePushState Oct 12 01:35:03 volumio volumio[880]: In UPNP mode Oct 12 01:35:03 volumio volumio[880]: verbose: STATE SERVICE {"status":"play","position":0,"seek":69,"duration":481,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Take The \"A\" Train (Vocal By Betty Roche)","artist":"Duke Ellington(듀크 엘링턴)","album":"Ellington Uptown [Limited Edition]","uri":"http://192.168.0.12:4718/dlna/366800","trackType":""} Oct 12 01:35:03 volumio volumio[880]: verbose: CURRENT POSITION 0 Oct 12 01:35:03 volumio volumio[880]: info: CoreStateMachine::syncState stateService play Oct 12 01:35:03 volumio volumio[880]: info: CoreStateMachine::syncState currentStatus play Oct 12 01:35:03 volumio volumio[880]: info: Received an update from plugin. extracting info from payload Oct 12 01:35:03 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 12 01:35:03 volumio volumio[880]: info: CoreStateMachine::pushState Oct 12 01:35:03 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Oct 12 01:35:03 volumio volumio[880]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Oct 12 01:35:03 volumio volumio[880]: info: ------------------------------ 10ms Oct 12 01:35:23 volumio bluetoothd[787]: Endpoint unregistered: sender=:1.62 path=/MediaEndpoint/A2DPSource Oct 12 01:35:23 volumio bluetoothd[787]: Endpoint unregistered: sender=:1.62 path=/MediaEndpoint/A2DPSink Oct 12 01:35:38 volumio sudo[30501]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 12 01:35:38 volumio sudo[30501]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 12 01:35:38 volumio sudo[30503]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 12 01:35:38 volumio sudo[30501]: pam_unix(sudo:session): session closed for user root Oct 12 01:35:38 volumio sudo[30503]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 12 01:35:38 volumio sudo[30503]: pam_unix(sudo:session): session closed for user root Oct 12 01:35:39 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Oct 12 01:35:39 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Oct 12 01:35:39 volumio volumio[880]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 01:35:39 volumio volumio[880]: TypeError: Cannot read property 'name' of undefined Oct 12 01:35:39 volumio volumio[880]: at CoreStateMachine.getState (/volumio/app/statemachine.js:127:20) Oct 12 01:35:39 volumio volumio[880]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:99:28) Oct 12 01:35:39 volumio volumio[880]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:43:38) Oct 12 01:35:39 volumio volumio[880]: at emitTwo (events.js:126:13) Oct 12 01:35:39 volumio volumio[880]: at Socket.emit (events.js:214:7) Oct 12 01:35:39 volumio volumio[880]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Oct 12 01:35:39 volumio volumio[880]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Oct 12 01:35:39 volumio volumio[880]: at process._tickCallback (internal/process/next_tick.js:180:9) Oct 12 01:35:39 volumio volumio[880]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 01:35:39 volumio sudo[30530]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-12 01:34 Oct 12 01:35:39 volumio sudo[30530]: 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="14acf028cf46278bd3fd3dd02523424a9bc825bf" VOLUMIO_FE_VERSION="9dfacc3084ddf8378a0a2ba052bab3e7aa2ae345" VOLUMIO_BE_VERSION="40a5d4b5232c61241c1a813b8652ad2b0cbd8a2c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed May 5 14:48:15 UTC 2021" VOLUMIO_VERSION="2.882" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="f911710eb3a296dbaa3280d30d30bab2"