Sep 05 11:47:00 volumio dbus-daemon[591]: [system] Successfully activated service 'org.freedesktop.timedate1'
Sep 05 11:47:00 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service.
Sep 05 11:47:00 volumio setdatetime-helper.sh[1910]: Time is already synchronized.
Sep 05 11:47:00 volumio systemd[1]: setdatetime-helper.timer.service: Deactivated successfully.
Sep 05 11:47:00 volumio systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service.
Sep 05 11:47:30 volumio systemd[1]: systemd-timedated.service: Deactivated successfully.
Sep 05 11:47:48 volumio volumio[1091]: info: CorePlayQueue::getTrack 21
Sep 05 11:47:48 volumio volumio[1091]: info: CorePlayQueue::getTrack 22
Sep 05 11:47:48 volumio volumio[1091]: info: Prefetching next song
Sep 05 11:47:48 volumio volumio[1091]: error: [ytmusic-play] Prefetch failed: Error: Streaming data not available
Sep 05 11:47:53 volumio volumio[1091]: info:
Sep 05 11:47:53 volumio volumio[1091]: ---------------------------- MPD announces system playlist update
Sep 05 11:47:53 volumio volumio[1091]: info: Ignoring MPD Status Update
Sep 05 11:47:53 volumio volumio[1091]: info:
Sep 05 11:47:53 volumio volumio[1091]: ---------------------------- MPD announces state update: player
Sep 05 11:47:53 volumio volumio[1091]: info: ControllerMpd::getState
Sep 05 11:47:53 volumio volumio[1091]: verbose: ControllerMpd::sendMpdCommand status
Sep 05 11:47:53 volumio volumio[1091]: info:
Sep 05 11:47:53 volumio volumio[1091]: ---------------------------- MPD announces system playlist update
Sep 05 11:47:53 volumio volumio[1091]: info: Ignoring MPD Status Update
Sep 05 11:47:53 volumio volumio[1091]: info:
Sep 05 11:47:53 volumio volumio[1091]: ---------------------------- MPD announces state update: player
Sep 05 11:47:53 volumio volumio[1091]: info: ControllerMpd::getState
Sep 05 11:47:53 volumio volumio[1091]: verbose: ControllerMpd::sendMpdCommand status
Sep 05 11:47:53 volumio volumio[1091]: info:
Sep 05 11:47:53 volumio volumio[1091]: ---------------------------- MPD announces system playlist update
Sep 05 11:47:53 volumio volumio[1091]: info: Ignoring MPD Status Update
Sep 05 11:47:53 volumio volumio[1091]: info:
Sep 05 11:47:53 volumio volumio[1091]: ---------------------------- MPD announces state update: player
Sep 05 11:47:53 volumio volumio[1091]: info: ControllerMpd::getState
Sep 05 11:47:53 volumio volumio[1091]: verbose: ControllerMpd::sendMpdCommand status
Sep 05 11:47:53 volumio volumio[1091]: error: updateQueue error: null
Sep 05 11:47:53 volumio volumio[1091]: error: updateQueue error: null
Sep 05 11:47:53 volumio volumio[1091]: error: updateQueue error: null
Sep 05 11:47:53 volumio volumio[1091]: info: ------------------------------ 9ms
Sep 05 11:47:53 volumio volumio[1091]: info: sendMpdCommand status took 9 milliseconds
Sep 05 11:47:53 volumio volumio[1091]: info: ------------------------------ 8ms
Sep 05 11:47:53 volumio volumio[1091]: info: sendMpdCommand status took 7 milliseconds
Sep 05 11:47:53 volumio volumio[1091]: info: ------------------------------ 7ms
Sep 05 11:47:53 volumio volumio[1091]: info: sendMpdCommand status took 6 milliseconds
Sep 05 11:47:53 volumio volumio[1091]: verbose: ControllerMpd::parseState
Sep 05 11:47:53 volumio volumio[1091]: verbose: ControllerMpd::parseState
Sep 05 11:47:53 volumio volumio[1091]: verbose: ControllerMpd::parseState
Sep 05 11:47:53 volumio volumio[1091]: info: ControllerMpd::pushState
Sep 05 11:47:53 volumio volumio[1091]: info: CoreCommandRouter::servicePushState
Sep 05 11:47:53 volumio volumio[1091]: info: CoreStateMachine::pushState
Sep 05 11:47:53 volumio volumio[1091]: info: CorePlayQueue::getTrack 21
Sep 05 11:47:53 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 05 11:47:53 volumio volumio[1091]: info: CoreCommandRouter::volumioPushState
Sep 05 11:47:53 volumio volumio[1091]: info: CorePlayQueue::getTrack 21
Sep 05 11:47:53 volumio volumio[1091]: 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}
Sep 05 11:47:53 volumio volumio[1091]: verbose: CURRENT POSITION 21
Sep 05 11:47:53 volumio volumio[1091]: info: CoreStateMachine::syncState stateService stop
Sep 05 11:47:53 volumio volumio[1091]: info: CoreStateMachine::syncState currentStatus play
Sep 05 11:47:53 volumio volumio[1091]: info: CoreStateMachine::play index undefined
Sep 05 11:47:53 volumio volumio[1091]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 05 11:47:53 volumio volumio[1091]: info: CoreStateMachine::pushState
Sep 05 11:47:53 volumio volumio[1091]: info: CorePlayQueue::getTrack 22
Sep 05 11:47:53 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 05 11:47:53 volumio volumio[1091]: info: CoreCommandRouter::volumioPushState
Sep 05 11:47:53 volumio volumio[1091]: info: ControllerMpd::pushState
Sep 05 11:47:53 volumio volumio[1091]: info: CoreCommandRouter::servicePushState
Sep 05 11:47:53 volumio volumio[1091]: info: CoreStateMachine::pushState
Sep 05 11:47:53 volumio volumio[1091]: info: CorePlayQueue::getTrack 22
Sep 05 11:47:53 volumio volumio[1091]: info: CoreCommandRouter::volumioPushState
Sep 05 11:47:53 volumio volumio[1091]: info: CorePlayQueue::getTrack 22
Sep 05 11:47:53 volumio volumio[1091]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current ytmusic Received mpd
Sep 05 11:47:53 volumio volumio[1091]: info: ControllerMpd::pushState
Sep 05 11:47:53 volumio volumio[1091]: info: CoreCommandRouter::servicePushState
Sep 05 11:47:53 volumio volumio[1091]: info: CoreStateMachine::pushState
Sep 05 11:47:53 volumio volumio[1091]: info: CorePlayQueue::getTrack 22
Sep 05 11:47:53 volumio volumio[1091]: info: CoreCommandRouter::volumioPushState
Sep 05 11:47:53 volumio volumio[1091]: info: CorePlayQueue::getTrack 22
Sep 05 11:47:53 volumio volumio[1091]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current ytmusic Received mpd
Sep 05 11:47:53 volumio volumio[1091]: info: CorePlayQueue::getTrack 22
Sep 05 11:47:53 volumio volumio[1091]: info: CoreStateMachine::startPlaybackTimer
Sep 05 11:47:53 volumio volumio[1091]: info: CorePlayQueue::getTrack 22
Sep 05 11:47:53 volumio volumio[1091]: info: [ytmusic-play] clearAddPlayTrack: ytmusic/song@explodeTrackData:o=%7B%22type%22%3A%22song%22%2C%22title%22%3A%22Money%20Talks%22%2C%22artist%22%3A%22Kamel%22%2C%22album%22%3A%22Money%20Talks%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2FsKOgiRhtVOZQJtCpSgsMFyA2PffFDkhJB198BGzyGVJb6U7ghfIsQUVj_7X7p9tdk_u8JJr-Oac6wB4jWw%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22MXp3IAA89qU%22%2C%22playlistId%22%3A%22OLAK5uy_kGR0HFZ6x9AuHiV7US0mDM6tzzhIzWzqg%22%2C%22index%22%3A0%2C%22playlistSetVideoId%22%3A%22C715F6D1FB204D0A%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22OLAK5uy_kGR0HFZ6x9AuHiV7US0mDM6tzzhIzWzqg%22%2C%22videoId%22%3A%22MXp3IAA89qU%22%7D%7D%7D%7D
Sep 05 11:47:53 volumio volumio[1091]: info: ------------------------------ 45ms
Sep 05 11:47:53 volumio volumio[1091]: info: ------------------------------ 44ms
Sep 05 11:47:53 volumio volumio[1091]: info: ------------------------------ 43ms
Sep 05 11:47:53 volumio volumio[1091]: info: CoreStateMachine::pushState
Sep 05 11:47:53 volumio volumio[1091]: info: CorePlayQueue::getTrack 22
Sep 05 11:47:53 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 05 11:47:53 volumio volumio[1091]: info: CoreCommandRouter::volumioPushState
Sep 05 11:47:54 volumio volumio[1091]: info: touch_display: Setting screensaver timeout to 0 seconds.
Sep 05 11:48:03 volumio sudo[2126]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Sep 05 11:48:03 volumio sudo[2124]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Sep 05 11:48:03 volumio sudo[2124]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Sep 05 11:48:03 volumio sudo[2126]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Sep 05 11:48:03 volumio sudo[2124]: pam_unix(sudo:session): session closed for user root
Sep 05 11:48:03 volumio sudo[2126]: pam_unix(sudo:session): session closed for user root
Sep 05 11:48:03 volumio volumio[1091]: verbose: New Socket.io Connection to 192.168.0.117 from 192.168.0.239 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 6
Sep 05 11:48:04 volumio sudo[2130]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Sep 05 11:48:04 volumio sudo[2130]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Sep 05 11:48:04 volumio sudo[2130]: pam_unix(sudo:session): session closed for user root
Sep 05 11:48:04 volumio sudo[2132]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Sep 05 11:48:04 volumio sudo[2132]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Sep 05 11:48:04 volumio sudo[2132]: pam_unix(sudo:session): session closed for user root
Sep 05 11:48:04 volumio volumio[1091]: verbose: New Socket.io Connection to 192.168.0.117 from 192.168.0.239 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:142.0) Gecko/20100101 Firefox/142.0 Engine version: 3 Transport: polling Total Clients: 7
Sep 05 11:48:04 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Sep 05 11:48:04 volumio volumio[1091]: info: CoreCommandRouter::volumioGetVisibleSources
Sep 05 11:48:04 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 05 11:48:04 volumio volumio[1091]: info: CoreCommandRouter::volumioGetState
Sep 05 11:48:04 volumio volumio[1091]: info: CorePlayQueue::getTrack 22
Sep 05 11:48:04 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Sep 05 11:48:04 volumio volumio[1091]: info: CoreCommandRouter::volumioGetQueue
Sep 05 11:48:04 volumio volumio[1091]: info: CoreStateMachine::getQueue
Sep 05 11:48:04 volumio volumio[1091]: info: CorePlayQueue::getQueue
Sep 05 11:48:04 volumio volumio[1091]: info: Listing playlists
Sep 05 11:48:04 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Sep 05 11:48:04 volumio volumio[1091]: info: Received Get System Info
Sep 05 11:48:04 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 05 11:48:04 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 05 11:48:04 volumio volumio[1091]: info: Discovery: Getting this device information
Sep 05 11:48:04 volumio volumio[1091]: info: CoreCommandRouter::volumioGetState
Sep 05 11:48:04 volumio volumio[1091]: info: CorePlayQueue::getTrack 22
Sep 05 11:48:04 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 05 11:48:04 volumio volumio[1091]: info: CoreCommandRouter::volumioGetState
Sep 05 11:48:04 volumio volumio[1091]: info: CorePlayQueue::getTrack 22
Sep 05 11:48:04 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Sep 05 11:48:04 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Sep 05 11:48:04 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Sep 05 11:48:05 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Sep 05 11:48:05 volumio volumio[1091]: info: Preload queue cleared
Sep 05 11:48:05 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Sep 05 11:48:06 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Sep 05 11:48:06 volumio volumio[1091]: info: Received Get System Info
Sep 05 11:48:06 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 05 11:48:06 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 05 11:48:06 volumio volumio[1091]: info: Discovery: Getting this device information
Sep 05 11:48:06 volumio volumio[1091]: info: CoreCommandRouter::volumioGetState
Sep 05 11:48:06 volumio volumio[1091]: info: CorePlayQueue::getTrack 22
Sep 05 11:48:06 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 05 11:48:06 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Sep 05 11:48:06 volumio volumio[1091]: info: READ
Sep 05 11:48:07 volumio volumio[1091]: Use XMLElement.setAttribute instead
Sep 05 11:48:07 volumio volumio[1091]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 05 11:48:07 volumio volumio[1091]: TypeError: children[i].attr(...).value is not a function
Sep 05 11:48:07 volumio volumio[1091]: at /volumio/app/plugins/music_service/webradio/index.js:286:47
Sep 05 11:48:07 volumio volumio[1091]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5)
Sep 05 11:48:07 volumio volumio[1091]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 05 11:48:08 volumio sudo[2165]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-09-05 11:47'
Sep 05 11:48:08 volumio sudo[2165]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)"
NAME="Raspbian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
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="1da895bfdbb6eb90d965df32a25a3568df7c84ed"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu May 29 13:12:59 UTC 2025"
VOLUMIO_VERSION="4.004"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="2df63d74196e499fa1e34fb765df1cca"