Dec 13 10:28:14 volumio-pi-3 volumio[1023]: Upnp client error: Error: This socket has been ended by the other party
Dec 13 10:28:14 volumio-pi-3 volumio[1023]: info: CoreCommandRouter::volumioGetState
Dec 13 10:28:14 volumio-pi-3 volumio[1023]: info: Listing playlists
Dec 13 10:28:14 volumio-pi-3 volumio[1023]: info: Listing playlists
Dec 13 10:28:14 volumio-pi-3 go-librespot[1411]: time="2025-12-13T10:28:14+07:00" level=trace msg="received accesspoint ping"
Dec 13 10:28:14 volumio-pi-3 go-librespot[1411]: time="2025-12-13T10:28:14+07:00" level=trace msg="received accesspoint pong ack"
Dec 13 10:28:15 volumio-pi-3 go-librespot[1411]: time="2025-12-13T10:28:15+07:00" level=trace msg="sent dealer ping"
Dec 13 10:28:15 volumio-pi-3 go-librespot[1411]: time="2025-12-13T10:28:15+07:00" level=trace msg="received dealer pong"
Dec 13 10:28:16 volumio-pi-3 volumio[1023]: info: [yt-cast-receiver] Player.play(): h3CxbcR0SV0 @ 0s
Dec 13 10:28:16 volumio-pi-3 volumio[1023]: info: CoreCommandRouter::volumioGetState
Dec 13 10:28:16 volumio-pi-3 volumio[1023]: info: CoreCommandRouter::volumioGetState
Dec 13 10:28:16 volumio-pi-3 volumio[1023]: info: CoreCommandRouter::volumioStop
Dec 13 10:28:16 volumio-pi-3 volumio[1023]: info: CoreStateMachine::stop
Dec 13 10:28:16 volumio-pi-3 volumio[1023]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 13 10:28:16 volumio-pi-3 volumio[1023]: info: CoreStateMachine::stPlaybackTimer
Dec 13 10:28:16 volumio-pi-3 volumio[1023]: info: CoreStateMachine::updateTrackBlock
Dec 13 10:28:16 volumio-pi-3 volumio[1023]: info: CorePlayQueue::getTrackBlock
Dec 13 10:28:16 volumio-pi-3 volumio[1023]: info: CoreStateMachine::pushState
Dec 13 10:28:16 volumio-pi-3 volumio[1023]: info: CorePlayQueue::getTrack 1
Dec 13 10:28:16 volumio-pi-3 volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 13 10:28:16 volumio-pi-3 volumio[1023]: info: CoreCommandRouter::volumioPushState
Dec 13 10:28:16 volumio-pi-3 volumio[1023]: info: CoreStateMachine::serviceStop
Dec 13 10:28:16 volumio-pi-3 volumio[1023]: info: CorePlayQueue::getTrack 1
Dec 13 10:28:16 volumio-pi-3 volumio[1023]: info: CoreCommandRouter::serviceStop
Dec 13 10:28:16 volumio-pi-3 volumio[1023]: info: [youtube2] (AutoplayManager) Removed mpdStateListener
Dec 13 10:28:16 volumio-pi-3 volumio[1023]: info: [youtube2] (AutoplayManager) Removed volumioStateListener
Dec 13 10:28:16 volumio-pi-3 volumio[1023]: info: [youtube2] (AutoplayManager) Disabled
Dec 13 10:28:16 volumio-pi-3 volumio[1023]: info: CoreStateMachine::setConsumeUpdateService mpd
Dec 13 10:28:16 volumio-pi-3 volumio[1023]: info: ControllerMpd::stop
Dec 13 10:28:16 volumio-pi-3 volumio[1023]: verbose: ControllerMpd::sendMpdCommand stop
Dec 13 10:28:22 volumio-pi-3 volumio[1023]: info: [ytcr] Innertube support service: Deno not installed or otherwise failed to start: Command failed: npx --no-install --yes deno --version
Dec 13 10:28:22 volumio-pi-3 volumio[1023]: info: [ytcr] Innertube support service: Start service with Node
Dec 13 10:28:22 volumio-pi-3 volumio[1023]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86
Dec 13 10:28:22 volumio-pi-3 mpd[1290]: player: played "https://rr8---sn-42u-i5ol6.googlevideo.com/videoplayback?expire=1765618049&ei=Id08aYmiJOmZ1d8PloK68Q4&ip=1.55.193.204&id=o-AGlssWWrHu9rnUBb4wD3nVE1ZHT26jvMcZ00hBZk1XVq&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&cps=104&met=1765596449%2C&mh=yU&mm=31%2C26&mn=sn-42u-i5ol6%2Csn-oguesndl&ms=au%2Conr&mv=m&mvi=8&pl=23&rms=au%2Cau&initcwndbps=2672500&bui=AYUSA3Dn04wgX3E-MS6ofj2oh1uuL0XBQ1h8Fj8d8MKMJtMkdxG8tT5UAzFmDV3pes-vNN48HWIN4c1r&spc=wH4QqzKCTVPCMknKLFh9XLe6TCcBivEIwJjvv8McBhKsg660kbhyHg&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=f7ZxJx4HjmbEEg3KLYyXux4R&rqh=1&gir=yes&clen=105658242&dur=5303.061&lmt=1639468080827104&mt=1765595813&fvip=1&keepalive=yes&fexp=51552689%2C51565115%2C51565682%2C51580968&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=4532434&n=WuoNyfCNCQ6S-w&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=cps%2Cmet%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRQIhALgfln6El4tKSyr0ZoqGrYdnoMD0GB4KLNckeQMv4KjfAiAGopmCBKMAHC9GSuHQrGn9W7x26J6uTFQhdQZl3yrRuQ%3D%3D&sig=AJfQdSswRQIhAKz1_5hwq0MU6UfRoo-44RXtXDWCBApJHQBIrN7G4H_tAiB6th86AKQy6KlO_hqgilZYY2ASl_t368cDpEXStF2HzQ%3D%3D&pot=MlXHNMOnd4XpHMcKbZkiTSCIac6hokgeaj27dwoBeJ_RCZMcMp2nP0hXyU9JENPz5iCUu9qWlAXyRnG6zGlNeRnTlJv7eQr8HOkkDArsrhNpkNpl1UB5&cver=1.20250219.01.00&t.YouTube"
Dec 13 10:28:22 volumio-pi-3 volumio[1023]: info:
Dec 13 10:28:22 volumio-pi-3 volumio[1023]: ---------------------------- MPD announces state update: player
Dec 13 10:28:22 volumio-pi-3 volumio[1023]: info: sendMpdCommand stop took 6483 milliseconds
Dec 13 10:28:22 volumio-pi-3 volumio[1023]: info: ControllerMpd::getState
Dec 13 10:28:22 volumio-pi-3 volumio[1023]: verbose: ControllerMpd::sendMpdCommand status
Dec 13 10:28:22 volumio-pi-3 volumio[1023]: info: CoreCommandRouter::volumioGetState
Dec 13 10:28:22 volumio-pi-3 volumio[1023]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 13 10:28:22 volumio-pi-3 volumio[1023]: info: CoreCommandRouter::servicePushState
Dec 13 10:28:22 volumio-pi-3 volumio[1023]: info: CoreStateMachine::pushState
Dec 13 10:28:22 volumio-pi-3 volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 13 10:28:22 volumio-pi-3 volumio[1023]: info: CoreCommandRouter::volumioPushState
Dec 13 10:28:22 volumio-pi-3 volumio[1023]: info: CoreCommandRouter::servicePushState
Dec 13 10:28:22 volumio-pi-3 volumio[1023]: info: CoreStateMachine::pushState
Dec 13 10:28:22 volumio-pi-3 volumio[1023]: info: CoreCommandRouter::volumioPushState
Dec 13 10:28:22 volumio-pi-3 volumio[1023]: info: CoreCommandRouter::volumioGetState
Dec 13 10:28:22 volumio-pi-3 volumio[1023]: error: touch_display: Error setting screensaver timeout: Error: ENOENT: no such file or directory, stat '/tmp/.X11-unix/X'
Dec 13 10:28:22 volumio-pi-3 volumio[1023]: info: Ignoring MPD Status Update
Dec 13 10:28:22 volumio-pi-3 volumio[1023]: info: Ignoring MPD Status Update
Dec 13 10:28:22 volumio-pi-3 volumio[1023]: Upnp client error: Error: This socket has been ended by the other party
Dec 13 10:28:22 volumio-pi-3 volumio[1023]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86
Dec 13 10:28:22 volumio-pi-3 volumio[1023]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86
Dec 13 10:28:22 volumio-pi-3 volumio[1023]: info: sendMpdCommand status took 85 milliseconds
Dec 13 10:28:22 volumio-pi-3 volumio[1023]: verbose: ControllerMpd::parseState
Dec 13 10:28:22 volumio-pi-3 volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 13 10:28:22 volumio-pi-3 volumio[1023]: info: sendMpdCommand playlistinfo took 5 milliseconds
Dec 13 10:28:22 volumio-pi-3 volumio[1023]: verbose: ControllerMpd::parseTrackInfo
Dec 13 10:28:22 volumio-pi-3 volumio[1023]: info: ControllerMpd::pushState
Dec 13 10:28:22 volumio-pi-3 volumio[1023]: info: CoreCommandRouter::servicePushState
Dec 13 10:28:22 volumio-pi-3 volumio[1023]: info: CoreStateMachine::pushState
Dec 13 10:28:22 volumio-pi-3 volumio[1023]: info: CoreCommandRouter::volumioPushState
Dec 13 10:28:22 volumio-pi-3 volumio[1023]: info: CorePlayQueue::getTrack 1
Dec 13 10:28:22 volumio-pi-3 volumio[1023]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received mpd
Dec 13 10:28:22 volumio-pi-3 volumio[1023]: info: ------------------------------ 112ms
Dec 13 10:28:22 volumio-pi-3 volumio[1023]: info: CoreCommandRouter::volumioGetState
Dec 13 10:28:22 volumio-pi-3 volumio[1023]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86
Dec 13 10:28:27 volumio-pi-3 volumio[1023]: info: [ytcr] Innertube support service: result: {"status":"started","server":{"address":"127.0.0.1","port":34535}}
Dec 13 10:28:27 volumio-pi-3 volumio[1023]: info: [ytcr] Innertube support service running at http://127.0.0.1:34535
Dec 13 10:28:33 volumio-pi-3 nmbd[953]: [2025/12/13 10:28:33.364966, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Dec 13 10:28:33 volumio-pi-3 nmbd[953]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.109 for name WORKGROUP<1d>.
Dec 13 10:28:33 volumio-pi-3 nmbd[953]: This response was from IP 192.168.1.191, reporting an IP address of 192.168.1.191.
Dec 13 10:28:35 volumio-pi-3 volumio[1023]: info: CoreCommandRouter::volumioGetState
Dec 13 10:28:35 volumio-pi-3 volumio[1023]: info: Listing playlists
Dec 13 10:28:35 volumio-pi-3 volumio[1023]: info: Listing playlists
Dec 13 10:28:38 volumio-pi-3 volumio[1023]: info: [ytcr] Obtained session PO token using visitorData (expires in 43199 seconds)
Dec 13 10:28:44 volumio-pi-3 volumio[1023]: info: [ytcr] Going to refresh session PO token in 43099 seconds
Dec 13 10:28:44 volumio-pi-3 volumio[1023]: info: CoreCommandRouter::volumioGetState
Dec 13 10:28:44 volumio-pi-3 volumio[1023]: error: [yt-cast-receiver] Caught error handling incoming message:
Dec 13 10:28:44 volumio-pi-3 volumio[1023]: (TypeError) fetch failed
Dec 13 10:28:44 volumio-pi-3 volumio[1023]: TypeError: fetch failed
Dec 13 10:28:44 volumio-pi-3 volumio[1023]: at Object.fetch (node:internal/deps/undici/undici:11576:11)
Dec 13 10:28:44 volumio-pi-3 volumio[1023]: at async InnertubeWrapper.generatePoToken (/data/plugins/music_service/ytcr/node_modules/volumio-yt-support/dist/lib/innertube/Wrapper.js:100:17)
Dec 13 10:28:44 volumio-pi-3 volumio[1023]: at async InnertubeLoader.generatePoToken (/data/plugins/music_service/ytcr/dist/lib/InnertubeLoader.js:42:16)
Dec 13 10:28:44 volumio-pi-3 volumio[1023]: at async VideoLoader.getInfo (/data/plugins/music_service/ytcr/dist/lib/VideoLoader.js:94:33)
Dec 13 10:28:44 volumio-pi-3 volumio[1023]: at async MPDPlayer.doPlay (/data/plugins/music_service/ytcr/dist/lib/MPDPlayer.js:71:25)
Dec 13 10:28:44 volumio-pi-3 volumio[1023]: at async MPDPlayer.play (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/Player.js:62:24)
Dec 13 10:28:44 volumio-pi-3 volumio[1023]: at async YouTubeApp._YouTubeApp_handleIncomingMessage (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/app/YouTubeApp.js:416:21)
Dec 13 10:28:44 volumio-pi-3 volumio[1023]: at async YouTubeApp._YouTubeApp_handleIncomingMessage (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/lib/app/YouTubeApp.js:302:13)
Dec 13 10:28:44 volumio-pi-3 volumio[1023]: info: CoreCommandRouter::volumioGetState
Dec 13 10:28:45 volumio-pi-3 go-librespot[1411]: time="2025-12-13T10:28:45+07:00" level=trace msg="sent dealer ping"
Dec 13 10:28:45 volumio-pi-3 go-librespot[1411]: time="2025-12-13T10:28:45+07:00" level=trace msg="received dealer pong"
Dec 13 10:28:49 volumio-pi-3 volumio[1023]: info: CoreCommandRouter::volumioGetState
Dec 13 10:28:52 volumio-pi-3 volumio[1023]: info: CoreCommandRouter::volumioGetState
Dec 13 10:28:52 volumio-pi-3 volumio[1023]: info: Listing playlists
Dec 13 10:28:52 volumio-pi-3 volumio[1023]: info: Listing playlists
Dec 13 10:28:52 volumio-pi-3 volumio[1023]: info: CoreCommandRouter::volumioGetState
Dec 13 10:28:58 volumio-pi-3 ntpd[848]: CLOCK: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Dec 13 10:28:58 volumio-pi-3 volumio[1023]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Dec 13 10:28:58 volumio-pi-3 volumio[1023]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Dec 13 10:29:02 volumio-pi-3 volumio[1023]: info: CoreCommandRouter::volumioGetState
Dec 13 10:29:03 volumio-pi-3 volumio[1023]: info: Starting Uninstall of plugin user_interface - touch_display
Dec 13 10:29:03 volumio-pi-3 volumio[1023]: info: Uninstalling plugin touch_display
Dec 13 10:29:03 volumio-pi-3 volumio[1023]: info: touch_display: Un-/commenting gpu_mem settings in /boot/config.txt.
Dec 13 10:29:03 volumio-pi-3 volumio[1023]: info: touch_display: Using /boot/config.txt instead of /boot/userconfig.txt.
Dec 13 10:29:03 volumio-pi-3 sudo[2485]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl enable getty@tty1.service
Dec 13 10:29:03 volumio-pi-3 sudo[2483]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start getty@tty1.service
Dec 13 10:29:03 volumio-pi-3 sudo[2487]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumio-kiosk.service
Dec 13 10:29:03 volumio-pi-3 sudo[2487]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 13 10:29:03 volumio-pi-3 sudo[2483]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 13 10:29:03 volumio-pi-3 sudo[2485]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 13 10:29:03 volumio-pi-3 sudo[2481]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf
Dec 13 10:29:03 volumio-pi-3 sudo[2481]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 13 10:29:04 volumio-pi-3 sudo[2481]: pam_unix(sudo:session): session closed for user root
Dec 13 10:29:04 volumio-pi-3 volumio[1023]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set.
Dec 13 10:29:04 volumio-pi-3 volumio[1023]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 13 10:29:04 volumio-pi-3 volumio[1023]: TypeError: Cannot read properties of undefined (reading 'split')
Dec 13 10:29:04 volumio-pi-3 volumio[1023]: at /data/plugins/user_interface/touch_display/index.js:1298:37
Dec 13 10:29:04 volumio-pi-3 volumio[1023]: at ChildProcess.exithandler (node:child_process:413:7)
Dec 13 10:29:04 volumio-pi-3 volumio[1023]: at ChildProcess.emit (node:events:514:28)
Dec 13 10:29:04 volumio-pi-3 volumio[1023]: at maybeClose (node:internal/child_process:1105:16)
Dec 13 10:29:04 volumio-pi-3 volumio[1023]: at ChildProcess._handle.onexit (node:internal/child_process:305:5)
Dec 13 10:29:04 volumio-pi-3 volumio[1023]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 13 10:29:04 volumio-pi-3 systemd[1]: Reloading.
Dec 13 10:29:05 volumio-pi-3 sudo[2526]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-13 10:28'
Dec 13 10:29:05 volumio-pi-3 sudo[2526]: 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="cfdc872d40b979cca36352a7333c940c38dc64b5"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025"
VOLUMIO_VERSION="4.073"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"