-- Logs begin at Sun 2024-08-25 10:15:25 UTC, end at Sat 2024-09-07 08:09:48 UTC. -- Sep 07 08:09:24 swm-store-audio sudo[26112]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 07 08:09:24 swm-store-audio sudo[26112]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 07 08:09:24 swm-store-audio sudo[26112]: pam_unix(sudo:session): session closed for user root Sep 07 08:09:24 swm-store-audio sudo[26115]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 07 08:09:24 swm-store-audio sudo[26115]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 07 08:09:24 swm-store-audio sudo[26115]: pam_unix(sudo:session): session closed for user root Sep 07 08:09:24 swm-store-audio volumio[973]: info: CoreCommandRouter::volumioGetState Sep 07 08:09:24 swm-store-audio volumio[973]: info: CorePlayQueue::getTrack 0 Sep 07 08:09:24 swm-store-audio volumio[973]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 07 08:09:24 swm-store-audio volumio[973]: info: Listing playlists Sep 07 08:09:24 swm-store-audio volumio[973]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Sep 07 08:09:24 swm-store-audio volumio[973]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Sep 07 08:09:24 swm-store-audio volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Sep 07 08:09:24 swm-store-audio volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 07 08:09:26 swm-store-audio volumio[973]: info: CoreCommandRouter::volumioGetQueue Sep 07 08:09:26 swm-store-audio volumio[973]: info: CoreStateMachine::getQueue Sep 07 08:09:26 swm-store-audio volumio[973]: info: CorePlayQueue::getQueue Sep 07 08:09:26 swm-store-audio volumio[973]: info: CoreCommandRouter::volumioGetVisibleSources Sep 07 08:09:26 swm-store-audio volumio[973]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 07 08:09:30 swm-store-audio volumio[973]: info: CoreCommandRouter::executeOnPlugin: volusonic , handleBrowseUri Sep 07 08:09:38 swm-store-audio volumio[973]: info: CoreCommandRouter::executeOnPlugin: volusonic , handleBrowseUri Sep 07 08:09:41 swm-store-audio volumio[973]: info: CoreCommandRouter::executeOnPlugin: volusonic , handleBrowseUri Sep 07 08:09:44 swm-store-audio volumio[973]: info: CoreCommandRouter::volumioReplaceandPlayItems Sep 07 08:09:44 swm-store-audio volumio[973]: info: CoreStateMachine::ClearQueue Sep 07 08:09:44 swm-store-audio volumio[973]: info: CoreStateMachine::stop Sep 07 08:09:44 swm-store-audio volumio[973]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 07 08:09:44 swm-store-audio volumio[973]: UNSET VOLATILE Sep 07 08:09:44 swm-store-audio volumio[973]: info: CorePlayQueue::clearPlayQueue Sep 07 08:09:44 swm-store-audio volumio[973]: info: CorePlayQueue::saveQueue Sep 07 08:09:44 swm-store-audio volumio[973]: info: CoreCommandRouter::volumioPushState Sep 07 08:09:44 swm-store-audio volumio[973]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 07 08:09:44 swm-store-audio volumio[973]: info: CoreCommandRouter::volumioPushQueue Sep 07 08:09:44 swm-store-audio volumio[973]: info: CoreStateMachine::addQueueItems Sep 07 08:09:44 swm-store-audio volumio[973]: info: CorePlayQueue::addQueueItems Sep 07 08:09:44 swm-store-audio volumio[973]: info: Adding Item to queue: volusonic/playlists/30 Sep 07 08:09:44 swm-store-audio volumio[973]: info: Exploding uri volusonic/playlists/30 in service volusonic Sep 07 08:09:44 swm-store-audio volumio[973]: info: CorePlayQueue::saveQueue Sep 07 08:09:44 swm-store-audio volumio[973]: info: CoreCommandRouter::volumioPushQueue Sep 07 08:09:44 swm-store-audio volumio[973]: info: CoreStateMachine::updateTrackBlock Sep 07 08:09:44 swm-store-audio volumio[973]: info: CorePlayQueue::getTrackBlock Sep 07 08:09:44 swm-store-audio volumio[973]: info: CoreCommandRouter::volumioPlay Sep 07 08:09:44 swm-store-audio volumio[973]: UNSET VOLATILE Sep 07 08:09:44 swm-store-audio volumio[973]: info: CoreStateMachine::play index 0 Sep 07 08:09:44 swm-store-audio volumio[973]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 07 08:09:44 swm-store-audio volumio[973]: info: CoreStateMachine::stop Sep 07 08:09:44 swm-store-audio volumio[973]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 07 08:09:44 swm-store-audio volumio[973]: UNSET VOLATILE Sep 07 08:09:44 swm-store-audio volumio[973]: info: CoreStateMachine::play index undefined Sep 07 08:09:44 swm-store-audio volumio[973]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 07 08:09:44 swm-store-audio volumio[973]: info: CorePlayQueue::getTrack 0 Sep 07 08:09:44 swm-store-audio volumio[973]: info: CoreStateMachine::startPlaybackTimer Sep 07 08:09:44 swm-store-audio volumio[973]: info: CorePlayQueue::getTrack 0 Sep 07 08:09:44 swm-store-audio volumio[973]: info: [1725696584053] ControllerVolusonic::clearAddPlayTrack Sep 07 08:09:44 swm-store-audio volumio[973]: verbose: ControllerMpd::sendMpdCommand stop Sep 07 08:09:44 swm-store-audio volumio[973]: info: sendMpdCommand stop took 6 milliseconds Sep 07 08:09:44 swm-store-audio volumio[973]: verbose: ControllerMpd::sendMpdCommand clear Sep 07 08:09:44 swm-store-audio volumio[973]: info: Sep 07 08:09:44 swm-store-audio volumio[973]: ---------------------------- MPD announces system playlist update Sep 07 08:09:44 swm-store-audio volumio[973]: info: Ignoring MPD Status Update Sep 07 08:09:44 swm-store-audio volumio[973]: info: sendMpdCommand clear took 3 milliseconds Sep 07 08:09:44 swm-store-audio volumio[973]: verbose: ControllerMpd::sendMpdCommand load "http://media.schattorie.nl/rest/stream?id=31511&format=raw&u=SWMStoreMusic&t=78849ed2f03df5360c86b4098b4d0dcb&s=fvpHn&v=1.13.0&f=json&c=volusonic" Sep 07 08:09:44 swm-store-audio volumio[973]: error: updateQueue error: null Sep 07 08:09:44 swm-store-audio volumio[973]: info: ------------------------------ 2ms Sep 07 08:09:44 swm-store-audio volumio[973]: verbose: ControllerMpd::sendMpdCommand add "http://media.schattorie.nl/rest/stream?id=31511&format=raw&u=SWMStoreMusic&t=78849ed2f03df5360c86b4098b4d0dcb&s=fvpHn&v=1.13.0&f=json&c=volusonic" Sep 07 08:09:44 swm-store-audio volumio[973]: info: Sep 07 08:09:44 swm-store-audio volumio[973]: ---------------------------- MPD announces system playlist update Sep 07 08:09:44 swm-store-audio volumio[973]: info: Ignoring MPD Status Update Sep 07 08:09:44 swm-store-audio volumio[973]: info: sendMpdCommand add "http://media.schattorie.nl/rest/stream?id=31511&format=raw&u=SWMStoreMusic&t=78849ed2f03df5360c86b4098b4d0dcb&s=fvpHn&v=1.13.0&f=json&c=volusonic" took 1 milliseconds Sep 07 08:09:44 swm-store-audio volumio[973]: verbose: ControllerMpd::sendMpdCommand play Sep 07 08:09:44 swm-store-audio volumio[973]: info: ------------------------------ 2ms Sep 07 08:09:44 swm-store-audio volumio[973]: info: sendMpdCommand play took 2 milliseconds Sep 07 08:09:44 swm-store-audio volumio[973]: info: ControllerMpd::getState Sep 07 08:09:44 swm-store-audio volumio[973]: verbose: ControllerMpd::sendMpdCommand status Sep 07 08:09:44 swm-store-audio volumio[973]: info: sendMpdCommand status took 1 milliseconds Sep 07 08:09:44 swm-store-audio volumio[973]: verbose: ControllerMpd::parseState Sep 07 08:09:44 swm-store-audio volumio[973]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 07 08:09:44 swm-store-audio volumio[973]: info: sendMpdCommand playlistinfo took 7 milliseconds Sep 07 08:09:44 swm-store-audio volumio[973]: verbose: ControllerMpd::parseTrackInfo Sep 07 08:09:44 swm-store-audio volumio[973]: info: [1725696584213] ControllerVolusonic::pushState Sep 07 08:09:44 swm-store-audio volumio[973]: info: CoreCommandRouter::servicePushState Sep 07 08:09:44 swm-store-audio volumio[973]: info: CorePlayQueue::getTrack 0 Sep 07 08:09:44 swm-store-audio volumio[973]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream?id=31511&format=raw&u=SWMStoreMusic&t=78849ed2f03df5360c86b4098b4d0dcb&s=fvpHn&v=1.13.0&f=json&c=volusonic","artist":null,"album":null,"uri":"http://media.schattorie.nl/rest/stream?id=31511&format=raw&u=SWMStoreMusic&t=78849ed2f03df5360c86b4098b4d0dcb&s=fvpHn&v=1.13.0&f=json&c=volusonic","trackType":""} Sep 07 08:09:44 swm-store-audio volumio[973]: verbose: CURRENT POSITION 0 Sep 07 08:09:44 swm-store-audio volumio[973]: info: CoreStateMachine::syncState stateService play Sep 07 08:09:44 swm-store-audio volumio[973]: info: CoreStateMachine::syncState currentStatus stop Sep 07 08:09:44 swm-store-audio volumio[973]: info: CoreStateMachine::pushState Sep 07 08:09:44 swm-store-audio volumio[973]: info: CorePlayQueue::getTrack 0 Sep 07 08:09:44 swm-store-audio volumio[973]: info: CoreCommandRouter::volumioPushState Sep 07 08:09:44 swm-store-audio volumio[973]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 07 08:09:44 swm-store-audio volumio[973]: info: [1725696584274] ControllerVolusonic: MPD player state update Sep 07 08:09:44 swm-store-audio volumio[973]: info: ControllerMpd::getState Sep 07 08:09:44 swm-store-audio volumio[973]: verbose: ControllerMpd::sendMpdCommand status Sep 07 08:09:44 swm-store-audio volumio[973]: info: Sep 07 08:09:44 swm-store-audio volumio[973]: ---------------------------- MPD announces state update: player Sep 07 08:09:44 swm-store-audio volumio[973]: info: ControllerMpd::getState Sep 07 08:09:44 swm-store-audio volumio[973]: verbose: ControllerMpd::sendMpdCommand status Sep 07 08:09:44 swm-store-audio volumio[973]: info: Sep 07 08:09:44 swm-store-audio volumio[973]: ---------------------------- MPD announces state update: player Sep 07 08:09:44 swm-store-audio volumio[973]: info: sendMpdCommand status took 16 milliseconds Sep 07 08:09:44 swm-store-audio volumio[973]: info: ControllerMpd::getState Sep 07 08:09:44 swm-store-audio volumio[973]: verbose: ControllerMpd::sendMpdCommand status Sep 07 08:09:44 swm-store-audio volumio[973]: verbose: ControllerMpd::parseState Sep 07 08:09:44 swm-store-audio volumio[973]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 07 08:09:44 swm-store-audio volumio[973]: info: Sep 07 08:09:44 swm-store-audio volumio[973]: ---------------------------- MPD announces system playlist update Sep 07 08:09:44 swm-store-audio volumio[973]: info: Ignoring MPD Status Update Sep 07 08:09:44 swm-store-audio volumio[973]: info: sendMpdCommand status took 18 milliseconds Sep 07 08:09:44 swm-store-audio volumio[973]: info: sendMpdCommand status took 2 milliseconds Sep 07 08:09:44 swm-store-audio volumio[973]: info: sendMpdCommand playlistinfo took 3 milliseconds Sep 07 08:09:44 swm-store-audio volumio[973]: verbose: ControllerMpd::parseState Sep 07 08:09:44 swm-store-audio volumio[973]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 07 08:09:44 swm-store-audio volumio[973]: verbose: ControllerMpd::parseState Sep 07 08:09:44 swm-store-audio volumio[973]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 07 08:09:44 swm-store-audio volumio[973]: verbose: ControllerMpd::parseTrackInfo Sep 07 08:09:44 swm-store-audio volumio[973]: info: CorePlayQueue::getTrack 0 Sep 07 08:09:44 swm-store-audio volumio[973]: info: [1725696584296] ControllerVolusonic::pushState Sep 07 08:09:44 swm-store-audio volumio[973]: info: CoreCommandRouter::servicePushState Sep 07 08:09:44 swm-store-audio volumio[973]: info: CorePlayQueue::getTrack 0 Sep 07 08:09:44 swm-store-audio volumio[973]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":208,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"BIG GIRLS DON'T CRY (bachata mix)","artist":"Victoria Justice","album":null,"uri":"http://media.schattorie.nl/rest/stream?id=31511&format=raw&u=SWMStoreMusic&t=78849ed2f03df5360c86b4098b4d0dcb&s=fvpHn&v=1.13.0&f=json&c=volusonic","trackType":""} Sep 07 08:09:44 swm-store-audio volumio[973]: verbose: CURRENT POSITION 0 Sep 07 08:09:44 swm-store-audio volumio[973]: info: CoreStateMachine::syncState stateService play Sep 07 08:09:44 swm-store-audio volumio[973]: info: CoreStateMachine::syncState currentStatus play Sep 07 08:09:44 swm-store-audio volumio[973]: info: Received an update from plugin. extracting info from payload Sep 07 08:09:44 swm-store-audio volumio[973]: info: CoreStateMachine::pushState Sep 07 08:09:44 swm-store-audio volumio[973]: info: CorePlayQueue::getTrack 0 Sep 07 08:09:44 swm-store-audio volumio[973]: info: CoreCommandRouter::volumioPushState Sep 07 08:09:44 swm-store-audio volumio[973]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 07 08:09:44 swm-store-audio volumio[973]: info: CoreStateMachine::pushState Sep 07 08:09:44 swm-store-audio volumio[973]: info: CorePlayQueue::getTrack 0 Sep 07 08:09:44 swm-store-audio volumio[973]: info: CoreCommandRouter::volumioPushState Sep 07 08:09:44 swm-store-audio volumio[973]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 07 08:09:44 swm-store-audio volumio[973]: info: ------------------------------ 17ms Sep 07 08:09:44 swm-store-audio volumio[973]: info: sendMpdCommand playlistinfo took 16 milliseconds Sep 07 08:09:44 swm-store-audio volumio[973]: info: sendMpdCommand playlistinfo took 15 milliseconds Sep 07 08:09:44 swm-store-audio volumio[973]: verbose: ControllerMpd::parseTrackInfo Sep 07 08:09:44 swm-store-audio volumio[973]: verbose: ControllerMpd::parseTrackInfo Sep 07 08:09:44 swm-store-audio volumio[973]: info: ControllerMpd::pushState Sep 07 08:09:44 swm-store-audio volumio[973]: info: CoreCommandRouter::servicePushState Sep 07 08:09:44 swm-store-audio volumio[973]: info: CorePlayQueue::getTrack 0 Sep 07 08:09:44 swm-store-audio volumio[973]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current volusonic Received mpd Sep 07 08:09:44 swm-store-audio volumio[973]: info: ControllerMpd::pushState Sep 07 08:09:44 swm-store-audio volumio[973]: info: CoreCommandRouter::servicePushState Sep 07 08:09:44 swm-store-audio volumio[973]: info: CorePlayQueue::getTrack 0 Sep 07 08:09:44 swm-store-audio volumio[973]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current volusonic Received mpd Sep 07 08:09:44 swm-store-audio volumio[973]: info: ------------------------------ 38ms Sep 07 08:09:44 swm-store-audio volumio[973]: info: ------------------------------ 23ms Sep 07 08:09:47 swm-store-audio volumio[973]: info: Adding http://media.schattorie.nl/rest/stream?id=31511&format=raw&u=SWMStoreMusic&t=78849ed2f03df5360c86b4098b4d0dcb&s=fvpHn&v=1.13.0&f=json&c=volusonic to favourites with specific volusonic method Sep 07 08:09:47 swm-store-audio volumio[973]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 07 08:09:47 swm-store-audio volumio[973]: TypeError: Cannot read property 'then' of undefined Sep 07 08:09:47 swm-store-audio volumio[973]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:579:20) Sep 07 08:09:47 swm-store-audio volumio[973]: at emitTwo (events.js:126:13) Sep 07 08:09:47 swm-store-audio volumio[973]: at Socket.emit (events.js:214:7) Sep 07 08:09:47 swm-store-audio volumio[973]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Sep 07 08:09:47 swm-store-audio volumio[973]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Sep 07 08:09:47 swm-store-audio volumio[973]: at process._tickCallback (internal/process/next_tick.js:180:9) Sep 07 08:09:47 swm-store-audio volumio[973]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 07 08:09:48 swm-store-audio sudo[26191]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-07 08:08 Sep 07 08:09:48 swm-store-audio sudo[26191]: 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="74f64fbba9dc8053dc27ed7125863d6ad6533965" VOLUMIO_BE_VERSION="0a6008ded215bf284d5d4cd9c4df3333cb320899" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat Apr 24 17:39:58 CEST 2021" VOLUMIO_VERSION="2.882" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="1a98a01eef5aa5927a5874c2d3c1b0dc"