-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Sun 2025-05-18 09:39:52 CEST. -- May 18 09:38:08 volumio volumio[998]: info: CoreCommandRouter::volumioGetQueue May 18 09:38:08 volumio volumio[998]: info: CoreStateMachine::getQueue May 18 09:38:08 volumio volumio[998]: info: CorePlayQueue::getQueue May 18 09:38:22 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri May 18 09:38:22 volumio volumio[998]: info: Preload queue cleared May 18 09:38:24 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri May 18 09:38:24 volumio volumio[998]: info: TuneIn handleBrowseUri: tunein/location May 18 09:38:24 volumio volumio[998]: info: Preload queue cleared May 18 09:38:28 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri May 18 09:38:28 volumio volumio[998]: info: TuneIn handleBrowseUri: tunein/browse/?id=r101320 May 18 09:38:28 volumio volumio[998]: info: [TuneIn] Fetching (browse) results For tunein/browse/?id=r101320 May 18 09:38:28 volumio volumio[998]: info: Preload queue cleared May 18 09:38:43 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri May 18 09:38:43 volumio volumio[998]: info: TuneIn handleBrowseUri: tunein/browse/?id=r101219 May 18 09:38:43 volumio volumio[998]: info: [TuneIn] Fetching (browse) results For tunein/browse/?id=r101219 May 18 09:38:44 volumio volumio[998]: info: Preload queue cleared May 18 09:39:02 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri May 18 09:39:02 volumio volumio[998]: info: TuneIn handleBrowseUri: tunein/browse/?id=r101320 May 18 09:39:02 volumio volumio[998]: info: [TuneIn] Fetching (browse) results For tunein/browse/?id=r101320 May 18 09:39:02 volumio volumio[998]: info: Preload queue cleared May 18 09:39:07 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri May 18 09:39:07 volumio volumio[998]: info: TuneIn handleBrowseUri: tunein/browse/?id=r101230 May 18 09:39:07 volumio volumio[998]: info: [TuneIn] Fetching (browse) results For tunein/browse/?id=r101230 May 18 09:39:07 volumio volumio[998]: info: Selecting previously unselected package chromium-browser-l10n. May 18 09:39:07 volumio volumio[998]: info: Preparing to unpack .../05-chromium-browser-l10n_92.0.4515.98~buster-rpt2_all.deb ... May 18 09:39:07 volumio volumio[998]: info: Unpacking chromium-browser-l10n (92.0.4515.98~buster-rpt2) ... May 18 09:39:07 volumio volumio[998]: info: Preload queue cleared May 18 09:39:07 volumio volumio[998]: info: Preload queue cleared May 18 09:39:11 volumio volumio[998]: info: Preload queue cleared May 18 09:39:11 volumio volumio[998]: info: CoreCommandRouter::volumioReplaceandPlayItems May 18 09:39:11 volumio volumio[998]: info: CoreStateMachine::ClearQueue May 18 09:39:11 volumio volumio[998]: info: CoreStateMachine::stop May 18 09:39:11 volumio volumio[998]: info: CoreStateMachine::setConsumeUpdateService undefined May 18 09:39:11 volumio volumio[998]: info: CorePlayQueue::clearPlayQueue May 18 09:39:11 volumio volumio[998]: info: CorePlayQueue::saveQueue May 18 09:39:11 volumio volumio[998]: info: CoreCommandRouter::volumioPushQueue May 18 09:39:11 volumio volumio[998]: info: CoreStateMachine::addQueueItems May 18 09:39:11 volumio volumio[998]: info: CorePlayQueue::addQueueItems May 18 09:39:11 volumio volumio[998]: info: Preload queue cleared May 18 09:39:11 volumio volumio[998]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s161703 May 18 09:39:11 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri May 18 09:39:12 volumio volumio[998]: info: CoreCommandRouter::volumioPushQueue May 18 09:39:12 volumio volumio[998]: info: CorePlayQueue::saveQueue May 18 09:39:12 volumio volumio[998]: info: CoreStateMachine::updateTrackBlock May 18 09:39:12 volumio volumio[998]: info: CorePlayQueue::getTrackBlock May 18 09:39:12 volumio volumio[998]: info: CoreCommandRouter::volumioPlay May 18 09:39:12 volumio volumio[998]: info: CoreStateMachine::play index 0 May 18 09:39:12 volumio volumio[998]: info: CoreStateMachine::setConsumeUpdateService undefined May 18 09:39:12 volumio volumio[998]: info: CoreStateMachine::stop May 18 09:39:12 volumio volumio[998]: info: CoreStateMachine::setConsumeUpdateService undefined May 18 09:39:12 volumio volumio[998]: info: CoreStateMachine::play index undefined May 18 09:39:12 volumio volumio[998]: info: CoreStateMachine::setConsumeUpdateService undefined May 18 09:39:12 volumio volumio[998]: info: CorePlayQueue::getTrack 0 May 18 09:39:12 volumio volumio[998]: info: CoreStateMachine::startPlaybackTimer May 18 09:39:12 volumio volumio[998]: info: CorePlayQueue::getTrack 0 May 18 09:39:12 volumio volumio[998]: info: [1747553952207] ControllerWebradio::clearAddPlayTrack May 18 09:39:12 volumio volumio[998]: verbose: ControllerMpd::sendMpdCommand stop May 18 09:39:16 volumio volumio[998]: info: sendMpdCommand stop took 4332 milliseconds May 18 09:39:16 volumio volumio[998]: verbose: ControllerMpd::sendMpdCommand clear May 18 09:39:17 volumio volumio[998]: info: CoreCommandRouter::volumioGetState May 18 09:39:17 volumio volumio[998]: info: CorePlayQueue::getTrack 0 May 18 09:39:18 volumio volumio[998]: info: sendMpdCommand clear took 1933 milliseconds May 18 09:39:18 volumio volumio[998]: verbose: ControllerMpd::sendMpdCommand load "http://stream.puravidafm.cr:9986/stream" May 18 09:39:18 volumio volumio[998]: info: May 18 09:39:18 volumio volumio[998]: ---------------------------- MPD announces system playlist update May 18 09:39:18 volumio volumio[998]: info: Ignoring MPD Status Update May 18 09:39:24 volumio volumio[998]: error: Upnp client error: Error: This socket has been ended by the other party May 18 09:39:24 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 18 09:39:24 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 18 09:39:25 volumio volumio[998]: info: Selecting previously unselected package libipc-system-simple-perl. May 18 09:39:25 volumio volumio[998]: info: Preparing to unpack .../06-libipc-system-simple-perl_1.25-4_all.deb ... May 18 09:39:25 volumio volumio[998]: info: Unpacking libipc-system-simple-perl (1.25-4) ... May 18 09:39:31 volumio volumio[998]: info: Enabling plugin touch_display May 18 09:39:31 volumio volumio[998]: info: Loading plugin "touch_display"... May 18 09:39:35 volumio volumio[998]: info: PLUGIN START: touch_display May 18 09:39:35 volumio volumio[998]: info: Loading i18n strings for locale pl May 18 09:39:35 volumio volumio[998]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. May 18 09:39:35 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 18 09:39:35 volumio volumio[998]: info: touch_display: Backlight interface detected. May 18 09:39:35 volumio volumio[998]: error: updateQueue error: null May 18 09:39:35 volumio volumio[998]: verbose: ControllerMpd::sendMpdCommand add "http://stream.puravidafm.cr:9986/stream" May 18 09:39:35 volumio volumio[998]: info: ------------------------------ 17161ms May 18 09:39:35 volumio volumio[998]: Upnp client error: Error: This socket has been ended by the other party May 18 09:39:35 volumio volumio[998]: info: May 18 09:39:35 volumio volumio[998]: ---------------------------- MPD announces system playlist update May 18 09:39:35 volumio volumio[998]: info: Ignoring MPD Status Update May 18 09:39:35 volumio volumio[998]: info: sendMpdCommand add "http://stream.puravidafm.cr:9986/stream" took 69 milliseconds May 18 09:39:35 volumio volumio[998]: info: CoreStateMachine::setConsumeUpdateService mpd May 18 09:39:35 volumio volumio[998]: verbose: ControllerMpd::sendMpdCommand play May 18 09:39:35 volumio volumio[998]: info: Selecting previously unselected package libfile-basedir-perl. May 18 09:39:35 volumio volumio[998]: info: Preparing to unpack .../07-libfile-basedir-perl_0.08-1_all.deb ... May 18 09:39:35 volumio volumio[998]: info: Unpacking libfile-basedir-perl (0.08-1) ... May 18 09:39:35 volumio volumio[998]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 May 18 09:39:35 volumio volumio[998]: info: ------------------------------ 45ms May 18 09:39:35 volumio volumio[998]: info: sendMpdCommand play took 43 milliseconds May 18 09:39:35 volumio volumio[998]: info: touch_display: No Raspberry Pi Foundation touch screen detected. May 18 09:39:36 volumio sudo[6722]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service May 18 09:39:36 volumio sudo[6735]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+w /sys/class/backlight/10-0045/brightness May 18 09:39:36 volumio sudo[6724]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service May 18 09:39:36 volumio sudo[6733]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf May 18 09:39:36 volumio sudo[6722]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 09:39:36 volumio sudo[6726]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload May 18 09:39:36 volumio sudo[6724]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 09:39:36 volumio sudo[6726]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 09:39:36 volumio sudo[6735]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 09:39:36 volumio sudo[6733]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 09:39:36 volumio sudo[6735]: pam_unix(sudo:session): session closed for user root May 18 09:39:36 volumio volumio[998]: info: touch_display: File permissions for backlight brightness control set. May 18 09:39:36 volumio sudo[6733]: pam_unix(sudo:session): session closed for user root May 18 09:39:36 volumio volumio[998]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. May 18 09:39:36 volumio volumio[998]: info: Selecting previously unselected package libfile-desktopentry-perl. May 18 09:39:36 volumio systemd[1]: Starting Cleanup of Temporary Directories... May 18 09:39:36 volumio volumio[998]: info: Preparing to unpack .../08-libfile-desktopentry-perl_0.22-1_all.deb ... May 18 09:39:36 volumio systemd[1]: Reloading. May 18 09:39:36 volumio volumio[998]: info: Unpacking libfile-desktopentry-perl (0.22-1) ... May 18 09:39:36 volumio systemd-udevd[398]: Network interface NamePolicy= disabled on kernel command line, ignoring. May 18 09:39:36 volumio volumio[998]: info: Selecting previously unselected package libfile-mimeinfo-perl. May 18 09:39:36 volumio volumio[998]: info: Preparing to unpack .../09-libfile-mimeinfo-perl_0.29-1_all.deb ... May 18 09:39:36 volumio volumio[998]: info: Unpacking libfile-mimeinfo-perl (0.29-1) ... May 18 09:39:36 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. May 18 09:39:36 volumio volumio[998]: info: Selecting previously unselected package libio-stringy-perl. May 18 09:39:36 volumio volumio[998]: info: Preparing to unpack .../10-libio-stringy-perl_2.111-3_all.deb ... May 18 09:39:37 volumio volumio[998]: info: Unpacking libio-stringy-perl (2.111-3) ... May 18 09:39:37 volumio sudo[6726]: pam_unix(sudo:session): session closed for user root May 18 09:39:37 volumio volumio[998]: info: touch_display: systemctl daemon-reload succeeded. May 18 09:39:37 volumio volumio[998]: info: CoreCommandRouter::getUIConfigOnPlugin May 18 09:39:37 volumio sudo[6793]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service May 18 09:39:37 volumio sudo[6793]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 09:39:37 volumio systemd[1]: Stopping Getty on tty1... May 18 09:39:37 volumio systemd[1]: getty@tty1.service: Main process exited, code=killed, status=15/TERM May 18 09:39:37 volumio systemd[1]: getty@tty1.service: Succeeded. May 18 09:39:37 volumio systemd[1]: Stopped Getty on tty1. May 18 09:39:37 volumio systemd[1]: Reloading. May 18 09:39:37 volumio volumio[998]: info: Selecting previously unselected package libxml-parser-perl. May 18 09:39:37 volumio volumio[998]: info: Preparing to unpack .../11-libxml-parser-perl_2.44-4_armhf.deb ... May 18 09:39:37 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. May 18 09:39:37 volumio volumio[998]: info: Unpacking libxml-parser-perl (2.44-4) ... May 18 09:39:37 volumio systemd[1]: systemd-tmpfiles-clean.service: Succeeded. May 18 09:39:37 volumio systemd[1]: Started Cleanup of Temporary Directories. May 18 09:39:37 volumio sudo[6724]: pam_unix(sudo:session): session closed for user root May 18 09:39:37 volumio volumio[998]: info: touch_display: systemctl disable getty@tty1.service succeeded. May 18 09:39:37 volumio sudo[6722]: pam_unix(sudo:session): session closed for user root May 18 09:39:37 volumio sudo[6793]: pam_unix(sudo:session): session closed for user root May 18 09:39:37 volumio volumio[998]: info: touch_display: systemctl stop getty@tty1.service succeeded. May 18 09:39:37 volumio volumio[998]: error: touch_display: Failed to start volumio-kiosk.service: Error: Command failed: /usr/bin/sudo /bin/systemctl start volumio-kiosk.service May 18 09:39:37 volumio volumio[998]: Failed to start volumio-kiosk.service: Unit volumio-kiosk.service not found. May 18 09:39:37 volumio volumio[998]: info: Error: Error May 18 09:39:38 volumio volumio[998]: info: Selecting previously unselected package libxml-twig-perl. May 18 09:39:38 volumio volumio[998]: info: Preparing to unpack .../12-libxml-twig-perl_1%3a3.50-1.1_all.deb ... May 18 09:39:38 volumio volumio[998]: info: Unpacking libxml-twig-perl (1:3.50-1.1) ... May 18 09:39:38 volumio volumio[998]: info: Selecting previously unselected package libnet-dbus-perl. May 18 09:39:38 volumio volumio[998]: info: Preparing to unpack .../13-libnet-dbus-perl_1.1.0-5+b1_armhf.deb ... May 18 09:39:38 volumio volumio[998]: info: Unpacking libnet-dbus-perl (1.1.0-5+b1) ... May 18 09:39:46 volumio volumio[998]: info: May 18 09:39:46 volumio volumio[998]: ---------------------------- MPD announces state update: player May 18 09:39:46 volumio volumio[998]: info: ControllerMpd::getState May 18 09:39:46 volumio volumio[998]: verbose: ControllerMpd::sendMpdCommand status May 18 09:39:46 volumio volumio[998]: verbose: ControllerMpd::sendMpdCommand clearerror May 18 09:39:46 volumio volumio[998]: info: sendMpdCommand status took 5 milliseconds May 18 09:39:46 volumio volumio[998]: verbose: ControllerMpd::parseState May 18 09:39:46 volumio volumio[998]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 18 09:39:46 volumio volumio[998]: info: sendMpdCommand clearerror took 2 milliseconds May 18 09:39:46 volumio volumio[998]: info: sendMpdCommand playlistinfo took 1 milliseconds May 18 09:39:46 volumio volumio[998]: verbose: ControllerMpd::parseTrackInfo May 18 09:39:46 volumio volumio[998]: info: ControllerMpd::pushState May 18 09:39:46 volumio volumio[998]: info: CoreCommandRouter::servicePushState May 18 09:39:46 volumio volumio[998]: info: CoreStateMachine::pushState May 18 09:39:46 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 18 09:39:46 volumio volumio[998]: info: CoreCommandRouter::volumioPushState May 18 09:39:46 volumio volumio[998]: info: CorePlayQueue::getTrack 0 May 18 09:39:46 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":"stream","artist":null,"album":null,"uri":"http://stream.puravidafm.cr:9986/stream","trackType":""} May 18 09:39:46 volumio volumio[998]: verbose: CURRENT POSITION 0 May 18 09:39:46 volumio volumio[998]: info: CoreStateMachine::syncState stateService stop May 18 09:39:46 volumio volumio[998]: info: CoreStateMachine::syncState currentStatus stop May 18 09:39:46 volumio volumio[998]: info: CoreStateMachine::pushState May 18 09:39:46 volumio volumio[998]: info: CoreCommandRouter::volumioPushState May 18 09:39:46 volumio volumio[998]: info: No code May 18 09:39:46 volumio volumio[998]: info: CoreStateMachine::pushState May 18 09:39:46 volumio volumio[998]: info: CoreCommandRouter::volumioPushState May 18 09:39:46 volumio volumio[998]: info: ------------------------------ 30ms May 18 09:39:47 volumio volumio[998]: info: CALLMETHOD: user_interface touch_display saveOrientationConf [object Object] May 18 09:39:47 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: touch_display , saveOrientationConf May 18 09:39:47 volumio sudo[6875]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf May 18 09:39:47 volumio sudo[6875]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 09:39:47 volumio sudo[6875]: pam_unix(sudo:session): session closed for user root May 18 09:39:47 volumio volumio[998]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set. May 18 09:39:47 volumio volumio[998]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 18 09:39:47 volumio volumio[998]: TypeError: Cannot read property 'split' of undefined May 18 09:39:47 volumio volumio[998]: at /data/plugins/user_interface/touch_display/index.js:1258:37 May 18 09:39:47 volumio volumio[998]: at ChildProcess.exithandler (child_process.js:299:7) May 18 09:39:47 volumio volumio[998]: at ChildProcess.emit (events.js:315:20) May 18 09:39:47 volumio volumio[998]: at maybeClose (internal/child_process.js:1048:16) May 18 09:39:47 volumio volumio[998]: at Process.ChildProcess._handle.onexit (internal/child_process.js:288:5) May 18 09:39:47 volumio volumio[998]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 18 09:39:52 volumio sudo[6903]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-18 09:38 May 18 09:39:52 volumio sudo[6903]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:16:30 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3934ee440d5d3f0186049a23752ad680"