-- Logs begin at Sat 2024-04-06 16:17:57 UTC, end at Sat 2024-04-06 16:20:40 UTC. --
Apr 06 16:19:00 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Apr 06 16:19:01 volumio volumio[985]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 06 16:19:01 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 06 16:19:01 volumio volumio[985]: info: CoreCommandRouter::volumioGetQueue
Apr 06 16:19:01 volumio volumio[985]: info: CoreStateMachine::getQueue
Apr 06 16:19:01 volumio volumio[985]: info: CorePlayQueue::getQueue
Apr 06 16:19:01 volumio volumio[985]: info: Listing playlists
Apr 06 16:19:02 volumio volumio[985]: info: CoreCommandRouter::volumioPlay
Apr 06 16:19:02 volumio volumio[985]: verbose: UNSET VOLATILE
Apr 06 16:19:02 volumio volumio[985]: info: CoreStateMachine::play index undefined
Apr 06 16:19:02 volumio volumio[985]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 06 16:19:02 volumio volumio[985]: info: CorePlayQueue::getTrack 0
Apr 06 16:19:02 volumio volumio[985]: info: CoreStateMachine::startPlaybackTimer
Apr 06 16:19:02 volumio volumio[985]: info: CorePlayQueue::getTrack 0
Apr 06 16:19:02 volumio volumio[985]: info: [1712420342172] ControllerUPNPBrowser::clearAddPlayTrack
Apr 06 16:19:02 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand stop
Apr 06 16:19:02 volumio volumio-streaming-daemon[1230]: Environment: production
Apr 06 16:19:02 volumio volumio[985]: info: Fetching Streaming Services browse cache
Apr 06 16:19:03 volumio volumio[985]: info: CoreCommandRouter::volumioPlay
Apr 06 16:19:03 volumio volumio[985]: verbose: UNSET VOLATILE
Apr 06 16:19:03 volumio volumio[985]: info: CoreStateMachine::play index undefined
Apr 06 16:19:03 volumio volumio[985]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 06 16:19:03 volumio volumio[985]: info: CorePlayQueue::getTrack 0
Apr 06 16:19:03 volumio volumio[985]: info: CoreStateMachine::startPlaybackTimer
Apr 06 16:19:03 volumio volumio[985]: info: CorePlayQueue::getTrack 0
Apr 06 16:19:03 volumio volumio[985]: info: [1712420343508] ControllerUPNPBrowser::clearAddPlayTrack
Apr 06 16:19:03 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand stop
Apr 06 16:19:04 volumio volumio-remote-updater[654]: [2024-04-06 16:19:04] [connect] Successful connection
Apr 06 16:19:04 volumio volumio-remote-updater[654]: [2024-04-06 16:19:04] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1712420344 101
Apr 06 16:19:05 volumio volumio[985]: info: CoreCommandRouter::volumioPlay
Apr 06 16:19:05 volumio volumio[985]: verbose: UNSET VOLATILE
Apr 06 16:19:05 volumio volumio[985]: info: CoreStateMachine::play index undefined
Apr 06 16:19:05 volumio volumio[985]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 06 16:19:05 volumio volumio[985]: info: CorePlayQueue::getTrack 0
Apr 06 16:19:05 volumio volumio[985]: info: CoreStateMachine::startPlaybackTimer
Apr 06 16:19:05 volumio volumio[985]: info: CorePlayQueue::getTrack 0
Apr 06 16:19:05 volumio volumio[985]: info: [1712420345050] ControllerUPNPBrowser::clearAddPlayTrack
Apr 06 16:19:05 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand stop
Apr 06 16:19:05 volumio volumio[985]: info: CoreCommandRouter::volumioPlay
Apr 06 16:19:05 volumio volumio[985]: verbose: UNSET VOLATILE
Apr 06 16:19:05 volumio volumio[985]: info: CoreStateMachine::play index undefined
Apr 06 16:19:05 volumio volumio[985]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 06 16:19:05 volumio volumio[985]: info: CorePlayQueue::getTrack 0
Apr 06 16:19:05 volumio volumio[985]: info: CoreStateMachine::startPlaybackTimer
Apr 06 16:19:05 volumio volumio[985]: info: CorePlayQueue::getTrack 0
Apr 06 16:19:05 volumio volumio[985]: info: [1712420345569] ControllerUPNPBrowser::clearAddPlayTrack
Apr 06 16:19:05 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand stop
Apr 06 16:19:05 volumio volumio[985]: info: CoreCommandRouter::volumioPlay
Apr 06 16:19:05 volumio volumio[985]: verbose: UNSET VOLATILE
Apr 06 16:19:05 volumio volumio[985]: info: CoreStateMachine::play index undefined
Apr 06 16:19:05 volumio volumio[985]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 06 16:19:05 volumio volumio[985]: info: CorePlayQueue::getTrack 0
Apr 06 16:19:05 volumio volumio[985]: info: CoreStateMachine::startPlaybackTimer
Apr 06 16:19:05 volumio volumio[985]: info: CorePlayQueue::getTrack 0
Apr 06 16:19:05 volumio volumio[985]: info: [1712420345863] ControllerUPNPBrowser::clearAddPlayTrack
Apr 06 16:19:05 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand stop
Apr 06 16:19:07 volumio volumio[985]: info: CoreCommandRouter::volumioPlay
Apr 06 16:19:07 volumio volumio[985]: verbose: UNSET VOLATILE
Apr 06 16:19:07 volumio volumio[985]: info: CoreStateMachine::play index undefined
Apr 06 16:19:07 volumio volumio[985]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 06 16:19:07 volumio volumio[985]: info: CorePlayQueue::getTrack 0
Apr 06 16:19:07 volumio volumio[985]: info: CoreStateMachine::startPlaybackTimer
Apr 06 16:19:07 volumio volumio[985]: info: CorePlayQueue::getTrack 0
Apr 06 16:19:07 volumio volumio[985]: info: [1712420347793] ControllerUPNPBrowser::clearAddPlayTrack
Apr 06 16:19:07 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand stop
Apr 06 16:19:08 volumio volumio[985]: info: CoreCommandRouter::volumioSeek
Apr 06 16:19:08 volumio volumio[985]: info: CoreStateMachine::seek
Apr 06 16:19:08 volumio volumio[985]: info: CorePlayQueue::getTrack 0
Apr 06 16:19:08 volumio volumio[985]: info: TRACKBLOCK {"service":"upnp_browser","uri":"http://192.168.1.68:8200/MediaItems/680.mp3","realUri":"upnp/folder/http://192.168.1.68:8200/ctl/ContentDir@1$6$28$1","type":"song","albumart":"/albumart?cacheid=665&web=Ito%20Yuna/miss%20you/extralarge&path=&metadata=false","artist":"Ito Yuna","album":"miss you","name":"miss you","title":"miss you","duration":303}
Apr 06 16:19:08 volumio volumio[985]: info: CoreStateMachine::startPlaybackTimer
Apr 06 16:19:08 volumio volumio[985]: info: CorePlayQueue::getTrack 0
Apr 06 16:19:08 volumio volumio[985]: info: [1712420348654] ControllerUPNPBrowser::seek
Apr 06 16:19:08 volumio volumio[985]: info: ControllerMpd::seek
Apr 06 16:19:08 volumio volumio[985]: error: Could not seek because there is no mpd connection
Apr 06 16:19:08 volumio volumio[985]: info: CoreStateMachine::pushState
Apr 06 16:19:08 volumio volumio[985]: info: CorePlayQueue::getTrack 0
Apr 06 16:19:08 volumio volumio[985]: info: CoreCommandRouter::volumioPushState
Apr 06 16:19:08 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 06 16:19:09 volumio volumio[985]: info: CoreCommandRouter::volumioPlay
Apr 06 16:19:09 volumio volumio[985]: verbose: UNSET VOLATILE
Apr 06 16:19:09 volumio volumio[985]: info: CoreStateMachine::play index undefined
Apr 06 16:19:09 volumio volumio[985]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 06 16:19:09 volumio volumio[985]: info: CorePlayQueue::getTrack 0
Apr 06 16:19:09 volumio volumio[985]: info: CoreStateMachine::startPlaybackTimer
Apr 06 16:19:09 volumio volumio[985]: info: CorePlayQueue::getTrack 0
Apr 06 16:19:09 volumio volumio[985]: info: [1712420349621] ControllerUPNPBrowser::clearAddPlayTrack
Apr 06 16:19:09 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand stop
Apr 06 16:19:11 volumio sudo[1244]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 06 16:19:11 volumio sudo[1244]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 06 16:19:11 volumio sudo[1246]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 06 16:19:11 volumio sudo[1244]: pam_unix(sudo:session): session closed for user root
Apr 06 16:19:11 volumio sudo[1246]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 06 16:19:11 volumio sudo[1246]: pam_unix(sudo:session): session closed for user root
Apr 06 16:19:11 volumio volumio[985]: info: CoreCommandRouter::volumioGetState
Apr 06 16:19:11 volumio volumio[985]: info: CorePlayQueue::getTrack 0
Apr 06 16:19:11 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Apr 06 16:19:11 volumio volumio[985]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 06 16:19:11 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 06 16:19:11 volumio volumio[985]: info: CoreCommandRouter::volumioGetQueue
Apr 06 16:19:11 volumio volumio[985]: info: CoreStateMachine::getQueue
Apr 06 16:19:11 volumio volumio[985]: info: CorePlayQueue::getQueue
Apr 06 16:19:11 volumio volumio[985]: info: Listing playlists
Apr 06 16:19:14 volumio sudo[1262]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 06 16:19:14 volumio sudo[1262]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 06 16:19:14 volumio sudo[1264]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 06 16:19:14 volumio sudo[1262]: pam_unix(sudo:session): session closed for user root
Apr 06 16:19:14 volumio sudo[1264]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 06 16:19:14 volumio sudo[1264]: pam_unix(sudo:session): session closed for user root
Apr 06 16:19:14 volumio volumio[985]: info: CoreCommandRouter::volumioGetState
Apr 06 16:19:14 volumio volumio[985]: info: CorePlayQueue::getTrack 0
Apr 06 16:19:14 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Apr 06 16:19:14 volumio volumio[985]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 06 16:19:14 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 06 16:19:14 volumio volumio[985]: info: CoreCommandRouter::volumioGetQueue
Apr 06 16:19:14 volumio volumio[985]: info: CoreStateMachine::getQueue
Apr 06 16:19:14 volumio volumio[985]: info: CorePlayQueue::getQueue
Apr 06 16:19:14 volumio volumio[985]: info: Listing playlists
Apr 06 16:19:16 volumio volumio[985]: info: CoreCommandRouter::volumioPlay
Apr 06 16:19:16 volumio volumio[985]: verbose: UNSET VOLATILE
Apr 06 16:19:16 volumio volumio[985]: info: CoreStateMachine::play index undefined
Apr 06 16:19:16 volumio volumio[985]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 06 16:19:16 volumio volumio[985]: info: CorePlayQueue::getTrack 0
Apr 06 16:19:16 volumio volumio[985]: info: CoreStateMachine::startPlaybackTimer
Apr 06 16:19:16 volumio volumio[985]: info: CorePlayQueue::getTrack 0
Apr 06 16:19:16 volumio volumio[985]: info: [1712420356259] ControllerUPNPBrowser::clearAddPlayTrack
Apr 06 16:19:16 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand stop
Apr 06 16:19:16 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Apr 06 16:19:16 volumio volumio[985]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Apr 06 16:19:16 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Apr 06 16:19:16 volumio volumio[985]: info: Error : CoreCommandRouter::executeOnPlugin: No method [retreiveBackendEventStates] in plugin my_volumio
Apr 06 16:19:16 volumio volumio[985]: info: Received Get System Version
Apr 06 16:19:16 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 06 16:19:20 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 06 16:19:20 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 06 16:19:21 volumio volumio[985]: info: CoreCommandRouter::volumioPlay
Apr 06 16:19:21 volumio volumio[985]: verbose: UNSET VOLATILE
Apr 06 16:19:21 volumio volumio[985]: info: CoreStateMachine::play index undefined
Apr 06 16:19:21 volumio volumio[985]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 06 16:19:21 volumio volumio[985]: info: CorePlayQueue::getTrack 0
Apr 06 16:19:21 volumio volumio[985]: info: CoreStateMachine::startPlaybackTimer
Apr 06 16:19:21 volumio volumio[985]: info: CorePlayQueue::getTrack 0
Apr 06 16:19:21 volumio volumio[985]: info: [1712420361744] ControllerUPNPBrowser::clearAddPlayTrack
Apr 06 16:19:21 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand stop
Apr 06 16:19:28 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 06 16:19:28 volumio volumio[985]: info: CURURI: music-library
Apr 06 16:19:28 volumio volumio[985]: error: Failed to execute browseSource: TypeError: Cannot read property 'then' of undefined
Apr 06 16:19:30 volumio volumio[985]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600
Apr 06 16:19:36 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 06 16:19:36 volumio volumio[985]: info: CURURI: music-library
Apr 06 16:19:36 volumio volumio[985]: error: Failed to execute browseSource: TypeError: Cannot read property 'then' of undefined
Apr 06 16:20:02 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 06 16:20:02 volumio volumio[985]: info: CURURI: music-library
Apr 06 16:20:02 volumio volumio[985]: error: Failed to execute browseSource: TypeError: Cannot read property 'then' of undefined
Apr 06 16:20:04 volumio volumio[985]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600
Apr 06 16:20:08 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 06 16:20:08 volumio volumio[985]: info: CURURI: music-library
Apr 06 16:20:08 volumio volumio[985]: error: Failed to execute browseSource: TypeError: Cannot read property 'then' of undefined
Apr 06 16:20:37 volumio volumio[985]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 06 16:20:37 volumio volumio[985]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 06 16:20:37 volumio volumio[985]: info: Retrieving Cloud Streaming UI
Apr 06 16:20:37 volumio volumio[985]: info: Getting Tidal Cloud Configuration
Apr 06 16:20:37 volumio volumio[985]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 06 16:20:37 volumio volumio[985]: info: Getting Qobuz Cloud Configuration
Apr 06 16:20:37 volumio volumio[985]: info: Asking plugin for UI Config
Apr 06 16:20:37 volumio volumio[985]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 06 16:20:37 volumio volumio[985]: info: Getting Spotify Cloud Configuration
Apr 06 16:20:37 volumio volumio[985]: info: Asking plugin for UI Config
Apr 06 16:20:37 volumio volumio[985]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 06 16:20:37 volumio volumio[985]: info: Saving Spotify Acccount
Apr 06 16:20:37 volumio volumio[985]: info: Got Tidal Cloud Configuration
Apr 06 16:20:37 volumio volumio[985]: info: Got it
Apr 06 16:20:37 volumio volumio[985]: info: Got it
Apr 06 16:20:37 volumio volumio[985]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Apr 06 16:20:37 volumio volumio[985]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 06 16:20:37 volumio volumio[985]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
Apr 06 16:20:37 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Apr 06 16:20:37 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Apr 06 16:20:37 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Apr 06 16:20:37 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Apr 06 16:20:37 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 06 16:20:37 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 06 16:20:37 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 06 16:20:37 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 06 16:20:37 volumio volumio[985]: info: CoreCommandRouter::volumioGetBrowseSources
Apr 06 16:20:37 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 06 16:20:37 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Apr 06 16:20:39 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb
Apr 06 16:20:39 volumio volumio[985]: verbose: ControllerMpd::sendMpdCommand rescan
Apr 06 16:20:39 volumio volumio[985]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 06 16:20:39 volumio volumio[985]: TypeError: Cannot read property 'then' of undefined
Apr 06 16:20:39 volumio volumio[985]: at ControllerMpd.sendMpdCommand (/volumio/app/plugins/music_service/mpd/index.js:330:6)
Apr 06 16:20:39 volumio volumio[985]: at ControllerMpd.rescanDb (/volumio/app/plugins/music_service/mpd/index.js:1825:15)
Apr 06 16:20:39 volumio volumio[985]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1052:32)
Apr 06 16:20:39 volumio volumio[985]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:907:26)
Apr 06 16:20:39 volumio volumio[985]: at emitTwo (events.js:126:13)
Apr 06 16:20:39 volumio volumio[985]: at Socket.emit (events.js:214:7)
Apr 06 16:20:39 volumio volumio[985]: at /volumio/node_modules/socket.io/lib/socket.js:503:12
Apr 06 16:20:39 volumio volumio[985]: at _combinedTickCallback (internal/process/next_tick.js:131:7)
Apr 06 16:20:39 volumio volumio[985]: at process._tickCallback (internal/process/next_tick.js:180:9)
Apr 06 16:20:39 volumio volumio[985]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 06 16:20:40 volumio sudo[1328]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-06 16:19
Apr 06 16:20:40 volumio sudo[1328]: 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="fd3e37ffec12db034ec93f94dbc26e5495d5b91a"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed Oct 6 12:34:49 CEST 2021"
VOLUMIO_VERSION="2.917"
VOLUMIO_HARDWARE="pi"
VOLUMIO_HASH="98c8f08c531a6f0456f17ab17795e35f"