-- Logs begin at Wed 2021-10-06 10:20:30 UTC, end at Fri 2024-07-26 23:11:09 UTC. -- Jul 26 23:10:16 volumio volumio[998]: info: CorePlayQueue::getTrack 7 Jul 26 23:10:16 volumio volumio[998]: info: CorePlayQueue::getTrack 8 Jul 26 23:10:16 volumio volumio[998]: info: Prefetching next song Jul 26 23:10:16 volumio volumio[998]: info: DOING PREFETCH IN MPD Jul 26 23:10:16 volumio volumio[998]: verbose: ControllerMpd::sendMpdCommand add "USB/My Passport/Classic/25 Romantic Classics/09 Debussy_ Reverie, L 68.wav" Jul 26 23:10:16 volumio volumio[998]: info: Jul 26 23:10:16 volumio volumio[998]: ---------------------------- MPD announces system playlist update Jul 26 23:10:16 volumio volumio[998]: info: Ignoring MPD Status Update Jul 26 23:10:16 volumio volumio[998]: info: sendMpdCommand add "USB/My Passport/Classic/25 Romantic Classics/09 Debussy_ Reverie, L 68.wav" took 2 milliseconds Jul 26 23:10:16 volumio volumio[998]: verbose: ControllerMpd::sendMpdCommand consume 1 Jul 26 23:10:16 volumio volumio[998]: info: ------------------------------ 3ms Jul 26 23:10:16 volumio volumio[998]: info: sendMpdCommand consume 1 took 1 milliseconds Jul 26 23:10:21 volumio volumio[998]: info: CoreStateMachine::startPlaybackTimer Jul 26 23:10:21 volumio volumio[998]: info: CorePlayQueue::getTrack 8 Jul 26 23:10:21 volumio volumio[998]: info: Jul 26 23:10:21 volumio volumio[998]: ---------------------------- MPD announces system playlist update Jul 26 23:10:21 volumio volumio[998]: info: Ignoring MPD Status Update Jul 26 23:10:21 volumio volumio[998]: info: Jul 26 23:10:21 volumio volumio[998]: ---------------------------- MPD announces state update: player Jul 26 23:10:21 volumio volumio[998]: info: ControllerMpd::getState Jul 26 23:10:21 volumio volumio[998]: verbose: ControllerMpd::sendMpdCommand status Jul 26 23:10:21 volumio volumio[998]: info: ------------------------------ 3ms Jul 26 23:10:21 volumio volumio[998]: info: sendMpdCommand status took 1 milliseconds Jul 26 23:10:21 volumio volumio[998]: verbose: ControllerMpd::parseState Jul 26 23:10:21 volumio volumio[998]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 23:10:21 volumio volumio[998]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 26 23:10:21 volumio volumio[998]: verbose: ControllerMpd::parseTrackInfo Jul 26 23:10:21 volumio volumio[998]: info: ControllerMpd::pushState Jul 26 23:10:21 volumio volumio[998]: info: CoreCommandRouter::servicePushState Jul 26 23:10:21 volumio volumio[998]: info: CorePlayQueue::getTrack 8 Jul 26 23:10:21 volumio volumio[998]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":305,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"09 Debussy_ Reverie, L 68.wav","artist":null,"album":null,"uri":"USB/My Passport/Classic/25 Romantic Classics/09 Debussy_ Reverie, L 68.wav","trackType":"wav"} Jul 26 23:10:21 volumio volumio[998]: verbose: CURRENT POSITION 8 Jul 26 23:10:21 volumio volumio[998]: info: CoreStateMachine::syncState stateService play Jul 26 23:10:21 volumio volumio[998]: info: CoreStateMachine::syncState currentStatus play Jul 26 23:10:21 volumio volumio[998]: info: Received an update from plugin. extracting info from payload Jul 26 23:10:21 volumio volumio[998]: info: CoreStateMachine::pushState Jul 26 23:10:21 volumio volumio[998]: info: CorePlayQueue::getTrack 8 Jul 26 23:10:21 volumio volumio[998]: info: CoreCommandRouter::volumioPushState Jul 26 23:10:21 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 26 23:10:21 volumio volumio[998]: info: CoreStateMachine::pushState Jul 26 23:10:21 volumio volumio[998]: info: CorePlayQueue::getTrack 8 Jul 26 23:10:21 volumio volumio[998]: info: CoreCommandRouter::volumioPushState Jul 26 23:10:21 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 26 23:10:21 volumio volumio[998]: info: ------------------------------ 20ms Jul 26 23:11:01 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 26 23:11:01 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 26 23:11:01 volumio volumio[998]: info: Discovery: Getting this device information Jul 26 23:11:01 volumio volumio[998]: info: CoreCommandRouter::volumioGetState Jul 26 23:11:01 volumio volumio[998]: info: CorePlayQueue::getTrack 8 Jul 26 23:11:01 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Jul 26 23:11:01 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getConf Jul 26 23:11:01 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getConf Jul 26 23:11:01 volumio volumio[998]: info: CoreCommandRouter::volumioGetState Jul 26 23:11:01 volumio volumio[998]: info: CorePlayQueue::getTrack 8 Jul 26 23:11:01 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jul 26 23:11:01 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jul 26 23:11:03 volumio sudo[6006]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 26 23:11:03 volumio sudo[6008]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 26 23:11:03 volumio sudo[6008]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 26 23:11:03 volumio sudo[6006]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 26 23:11:03 volumio sudo[6008]: pam_unix(sudo:session): session closed for user root Jul 26 23:11:03 volumio sudo[6006]: pam_unix(sudo:session): session closed for user root Jul 26 23:11:03 volumio volumio[998]: info: CoreCommandRouter::volumioGetState Jul 26 23:11:03 volumio volumio[998]: info: CorePlayQueue::getTrack 8 Jul 26 23:11:03 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 26 23:11:03 volumio volumio[998]: info: Listing playlists Jul 26 23:11:03 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jul 26 23:11:03 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jul 26 23:11:03 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jul 26 23:11:03 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 26 23:11:04 volumio volumio[998]: info: CoreCommandRouter::volumioPause Jul 26 23:11:04 volumio volumio[998]: info: CoreStateMachine::pause Jul 26 23:11:04 volumio volumio[998]: info: CoreStateMachine::stPlaybackTimer Jul 26 23:11:04 volumio volumio[998]: info: CoreStateMachine::servicePause Jul 26 23:11:04 volumio volumio[998]: info: CorePlayQueue::getTrack 8 Jul 26 23:11:04 volumio volumio[998]: info: CoreCommandRouter::servicePause Jul 26 23:11:04 volumio volumio[998]: info: ControllerMpd::pause Jul 26 23:11:04 volumio volumio[998]: verbose: ControllerMpd::sendMpdCommand pause Jul 26 23:11:04 volumio volumio[998]: info: sendMpdCommand pause took 62 milliseconds Jul 26 23:11:04 volumio volumio[998]: info: Jul 26 23:11:04 volumio volumio[998]: ---------------------------- MPD announces state update: player Jul 26 23:11:04 volumio volumio[998]: info: ControllerMpd::getState Jul 26 23:11:04 volumio volumio[998]: verbose: ControllerMpd::sendMpdCommand status Jul 26 23:11:04 volumio volumio[998]: info: sendMpdCommand status took 1 milliseconds Jul 26 23:11:04 volumio volumio[998]: verbose: ControllerMpd::parseState Jul 26 23:11:04 volumio volumio[998]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 23:11:04 volumio volumio[998]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 26 23:11:04 volumio volumio[998]: verbose: ControllerMpd::parseTrackInfo Jul 26 23:11:04 volumio volumio[998]: info: ControllerMpd::pushState Jul 26 23:11:04 volumio volumio[998]: info: CoreCommandRouter::servicePushState Jul 26 23:11:04 volumio volumio[998]: info: CorePlayQueue::getTrack 8 Jul 26 23:11:04 volumio volumio[998]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":42771,"duration":305,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"09 Debussy_ Reverie, L 68.wav","artist":null,"album":null,"uri":"USB/My Passport/Classic/25 Romantic Classics/09 Debussy_ Reverie, L 68.wav","trackType":"wav"} Jul 26 23:11:04 volumio volumio[998]: verbose: CURRENT POSITION 8 Jul 26 23:11:04 volumio volumio[998]: info: CoreStateMachine::syncState stateService pause Jul 26 23:11:04 volumio volumio[998]: info: CoreStateMachine::syncState currentStatus pause Jul 26 23:11:04 volumio volumio[998]: info: CoreStateMachine::pushState Jul 26 23:11:04 volumio volumio[998]: info: CorePlayQueue::getTrack 8 Jul 26 23:11:04 volumio volumio[998]: info: CoreCommandRouter::volumioPushState Jul 26 23:11:04 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 26 23:11:04 volumio volumio[998]: info: CoreStateMachine::stPlaybackTimer Jul 26 23:11:04 volumio volumio[998]: info: ------------------------------ 17ms Jul 26 23:11:04 volumio volumio[998]: info: touch_display: Setting screensaver timeout to 120 seconds. Jul 26 23:11:04 volumio volumio[998]: info: touch_display: Setting screensaver timeout to 120 seconds. Jul 26 23:11:04 volumio volumio[998]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Jul 26 23:11:04 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 26 23:11:05 volumio volumio[998]: info: CoreCommandRouter::volumioGetVisibleSources Jul 26 23:11:05 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 26 23:11:05 volumio volumio[998]: info: CoreCommandRouter::volumioGetQueue Jul 26 23:11:05 volumio volumio[998]: info: CoreStateMachine::getQueue Jul 26 23:11:05 volumio volumio[998]: info: CorePlayQueue::getQueue Jul 26 23:11:06 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 26 23:11:07 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri Jul 26 23:11:07 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri Jul 26 23:11:08 volumio volumio[998]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 26 23:11:08 volumio volumio[998]: info: CoreStateMachine::ClearQueue Jul 26 23:11:08 volumio volumio[998]: info: CoreStateMachine::stop Jul 26 23:11:08 volumio volumio[998]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 26 23:11:08 volumio volumio[998]: verbose: UNSET VOLATILE Jul 26 23:11:08 volumio volumio[998]: info: CoreStateMachine::updateTrackBlock Jul 26 23:11:08 volumio volumio[998]: info: CorePlayQueue::getTrackBlock Jul 26 23:11:08 volumio volumio[998]: info: CoreStateMachine::stPlaybackTimer Jul 26 23:11:08 volumio volumio[998]: info: CoreStateMachine::pushState Jul 26 23:11:08 volumio volumio[998]: info: CorePlayQueue::getTrack 8 Jul 26 23:11:08 volumio volumio[998]: info: CoreCommandRouter::volumioPushState Jul 26 23:11:08 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 26 23:11:08 volumio volumio[998]: info: CoreStateMachine::serviceStop Jul 26 23:11:08 volumio volumio[998]: info: CorePlayQueue::getTrack 8 Jul 26 23:11:08 volumio volumio[998]: info: CoreCommandRouter::serviceStop Jul 26 23:11:08 volumio volumio[998]: info: ControllerMpd::stop Jul 26 23:11:08 volumio volumio[998]: verbose: ControllerMpd::sendMpdCommand stop Jul 26 23:11:08 volumio volumio[998]: info: CorePlayQueue::clearPlayQueue Jul 26 23:11:08 volumio volumio[998]: info: CorePlayQueue::saveQueue Jul 26 23:11:08 volumio volumio[998]: info: CoreCommandRouter::volumioPushState Jul 26 23:11:08 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 26 23:11:08 volumio volumio[998]: info: CoreCommandRouter::volumioPushQueue Jul 26 23:11:08 volumio volumio[998]: info: CoreStateMachine::addQueueItems Jul 26 23:11:08 volumio volumio[998]: info: CorePlayQueue::addQueueItems Jul 26 23:11:08 volumio volumio[998]: info: Adding Item to queue: webkbs/0 Jul 26 23:11:08 volumio volumio[998]: info: Exploding uri webkbs/0 in service personal_radio Jul 26 23:11:08 volumio volumio[998]: info: Jul 26 23:11:08 volumio volumio[998]: ---------------------------- MPD announces state update: player Jul 26 23:11:08 volumio volumio[998]: info: sendMpdCommand stop took 42 milliseconds Jul 26 23:11:08 volumio volumio[998]: info: ControllerMpd::getState Jul 26 23:11:08 volumio volumio[998]: verbose: ControllerMpd::sendMpdCommand status Jul 26 23:11:08 volumio volumio[998]: info: sendMpdCommand status took 1 milliseconds Jul 26 23:11:08 volumio volumio[998]: verbose: ControllerMpd::parseState Jul 26 23:11:08 volumio volumio[998]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 23:11:08 volumio volumio[998]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 26 23:11:08 volumio volumio[998]: verbose: ControllerMpd::parseTrackInfo Jul 26 23:11:08 volumio volumio[998]: info: ControllerMpd::pushState Jul 26 23:11:08 volumio volumio[998]: info: CoreCommandRouter::servicePushState Jul 26 23:11:08 volumio volumio[998]: info: CoreStateMachine::pushState Jul 26 23:11:08 volumio volumio[998]: info: CorePlayQueue::getTrack 8 Jul 26 23:11:08 volumio volumio[998]: info: CoreCommandRouter::volumioPushState Jul 26 23:11:08 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 26 23:11:08 volumio volumio[998]: info: CorePlayQueue::getTrack 8 Jul 26 23:11:08 volumio volumio[998]: 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":"09 Debussy_ Reverie, L 68.wav","artist":null,"album":null,"uri":"USB/My Passport/Classic/25 Romantic Classics/09 Debussy_ Reverie, L 68.wav","trackType":"wav"} Jul 26 23:11:08 volumio volumio[998]: verbose: CURRENT POSITION 8 Jul 26 23:11:08 volumio volumio[998]: info: CoreStateMachine::syncState stateService stop Jul 26 23:11:08 volumio volumio[998]: info: CoreStateMachine::syncState currentStatus stop Jul 26 23:11:08 volumio volumio[998]: info: CoreStateMachine::pushState Jul 26 23:11:08 volumio volumio[998]: info: CorePlayQueue::getTrack 8 Jul 26 23:11:09 volumio volumio[998]: info: CoreCommandRouter::volumioPushState Jul 26 23:11:09 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 26 23:11:09 volumio volumio[998]: info: No code Jul 26 23:11:09 volumio volumio[998]: info: CoreStateMachine::pushState Jul 26 23:11:09 volumio volumio[998]: info: CorePlayQueue::getTrack 8 Jul 26 23:11:09 volumio volumio[998]: info: CoreCommandRouter::volumioPushState Jul 26 23:11:09 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 26 23:11:09 volumio volumio[998]: info: ------------------------------ 44ms Jul 26 23:11:09 volumio volumio[998]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 26 23:11:09 volumio volumio[998]: ReferenceError: self is not defined Jul 26 23:11:09 volumio volumio[998]: at ControllerPersonalRadio.errorToast (/data/plugins/music_service/personal_radio/index.js:575:22) Jul 26 23:11:09 volumio volumio[998]: at /data/plugins/music_service/personal_radio/index.js:487:12 Jul 26 23:11:09 volumio volumio[998]: at Request.handleRequestResponse [as _callback] (/data/plugins/music_service/personal_radio/node_modules/unirest/index.js:463:26) Jul 26 23:11:09 volumio volumio[998]: at Request.self.callback (/data/plugins/music_service/personal_radio/node_modules/request/request.js:187:22) Jul 26 23:11:09 volumio volumio[998]: at emitTwo (events.js:126:13) Jul 26 23:11:09 volumio volumio[998]: at Request.emit (events.js:214:7) Jul 26 23:11:09 volumio volumio[998]: at Request. (/data/plugins/music_service/personal_radio/node_modules/request/request.js:1044:10) Jul 26 23:11:09 volumio volumio[998]: at emitOne (events.js:116:13) Jul 26 23:11:09 volumio volumio[998]: at Request.emit (events.js:211:7) Jul 26 23:11:09 volumio volumio[998]: at IncomingMessage. (/data/plugins/music_service/personal_radio/node_modules/request/request.js:965:12) Jul 26 23:11:09 volumio volumio[998]: at emitNone (events.js:111:20) Jul 26 23:11:09 volumio volumio[998]: at IncomingMessage.emit (events.js:208:7) Jul 26 23:11:09 volumio volumio[998]: at endReadableNT (_stream_readable.js:1064:12) Jul 26 23:11:09 volumio volumio[998]: at _combinedTickCallback (internal/process/next_tick.js:138:11) Jul 26 23:11:09 volumio volumio[998]: at process._tickCallback (internal/process/next_tick.js:180:9) Jul 26 23:11:09 volumio volumio[998]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 26 23:11:09 volumio sudo[6055]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-26 23:10 Jul 26 23:11:09 volumio sudo[6055]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae" VOLUMIO_BE_VERSION="307f91893fca011201acba9973e1c41bd3a0ad5d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Sep 30 22:42:09 CEST 2021" VOLUMIO_VERSION="2.915" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="02ee61bb422c79b6e5c0b6d1847a78d9"