-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Sat 2025-04-26 09:34:15 CEST. -- Apr 26 09:33:18 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 26 09:33:18 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 26 09:33:18 volumio volumio[960]: info: Discovery: Getting this device information Apr 26 09:33:18 volumio volumio[960]: info: CoreCommandRouter::volumioGetState Apr 26 09:33:18 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 26 09:33:19 volumio ntpd[810]: 130.162.220.39 local addr 192.168.188.17 -> Apr 26 09:33:26 volumio volumio[960]: info: CALLMETHOD: system_hardware ir_controller saveGpioOptions [object Object] Apr 26 09:33:26 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: ir_controller , saveGpioOptions Apr 26 09:33:26 volumio sudo[11732]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -r 0 Apr 26 09:33:26 volumio sudo[11732]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 09:33:26 volumio sudo[11732]: pam_unix(sudo:session): session closed for user root Apr 26 09:33:26 volumio volumio[960]: info: ir_controller: Overlay gpio-ir gpio_pin=25 gpio_pull=up removed. Apr 26 09:33:26 volumio sudo[11751]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay gpio-ir gpio_pin=17 gpio_pull=up Apr 26 09:33:26 volumio sudo[11751]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 09:33:26 volumio kernel: Registered IR keymap rc-rc6-mce Apr 26 09:33:26 volumio kernel: rc rc1: gpio_ir_recv as /devices/platform/ir-receiver@11/rc/rc1 Apr 26 09:33:26 volumio kernel: rc rc1: lirc_dev: driver gpio_ir_recv registered at minor = 1, raw IR receiver, no transmitter Apr 26 09:33:26 volumio kernel: input: gpio_ir_recv as /devices/platform/ir-receiver@11/rc/rc1/input4 Apr 26 09:33:26 volumio sudo[11751]: pam_unix(sudo:session): session closed for user root Apr 26 09:33:26 volumio volumio[960]: info: ir_controller: Overlay gpio-ir gpio_pin=17 gpio_pull=up loaded. Apr 26 09:33:26 volumio sudo[11763]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart lircd.service Apr 26 09:33:26 volumio sudo[11763]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 09:33:26 volumio lircd[10788]: lircd-0.10.1[10788]: Notice: caught signal Apr 26 09:33:26 volumio lircd-0.10.1[10788]: Notice: caught signal Apr 26 09:33:26 volumio systemd[1]: Stopping Flexible IR remote input/output application support... Apr 26 09:33:26 volumio systemd[1]: irexec.service: Succeeded. Apr 26 09:33:26 volumio systemd[1]: lircd.service: Main process exited, code=killed, status=15/TERM Apr 26 09:33:26 volumio systemd[1]: lircd.service: Succeeded. Apr 26 09:33:26 volumio systemd[1]: Stopped Flexible IR remote input/output application support. Apr 26 09:33:26 volumio systemd[1]: Starting lircd(8) initialization helper tool... Apr 26 09:33:26 volumio systemd-udevd[11739]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Apr 26 09:33:26 volumio systemd-logind[633]: Watching system buttons on /dev/input/event1 (gpio_ir_recv) Apr 26 09:33:26 volumio lircd-setup[11767]: /usr/sbin/lircd-setup:37: DeprecationWarning: The SafeConfigParser class has been renamed to ConfigParser in Python 3.2. This alias will be removed in future versions. Use ConfigParser directly instead. Apr 26 09:33:26 volumio lircd-setup[11767]: parser = configparser.SafeConfigParser() Apr 26 09:33:26 volumio systemd[1]: lircd-setup.service: Succeeded. Apr 26 09:33:26 volumio systemd[1]: Started lircd(8) initialization helper tool. Apr 26 09:33:26 volumio systemd[1]: Starting Flexible IR remote input/output application support... Apr 26 09:33:26 volumio lircd-0.10.1[11769]: Info: lircd: Opening log, level: Info Apr 26 09:33:26 volumio lircd-0.10.1[11769]: Notice: Version: lircd 0.10.1 Apr 26 09:33:26 volumio lircd-0.10.1[11769]: Notice: System info: Linux volumio 6.6.62-v7+ #1816 SMP Mon Nov 18 15:30:49 GMT 2024 armv7l GNU/Linux Apr 26 09:33:26 volumio lircd-0.10.1[11769]: Info: Initial device: /dev/lirc0 Apr 26 09:33:26 volumio lircd-0.10.1[11769]: Info: [lirc] protocol is enabled Apr 26 09:33:26 volumio lircd-0.10.1[11769]: Info: Initial device: /dev/lirc0 Apr 26 09:33:26 volumio lircd-0.10.1[11769]: Info: [lirc] protocol is enabled Apr 26 09:33:26 volumio lircd-0.10.1[11769]: Notice: Options: driver: default Apr 26 09:33:26 volumio lircd-0.10.1[11769]: Notice: Options: output: /var/run/lirc/lircd Apr 26 09:33:26 volumio lircd[11769]: lircd-0.10.1[11769]: Info: lircd: Opening log, level: Info Apr 26 09:33:26 volumio lircd-0.10.1[11769]: Notice: Options: nodaemon: 1 Apr 26 09:33:26 volumio lircd[11769]: lircd-0.10.1[11769]: Notice: Using systemd fd Apr 26 09:33:26 volumio lircd[11769]: lircd-0.10.1[11769]: Warning: Running as root Apr 26 09:33:26 volumio lircd[11769]: lircd-0.10.1[11769]: Info: Using remote: mceusb. Apr 26 09:33:26 volumio lircd-0.10.1[11769]: Notice: Options: plugindir: /usr/lib/arm-linux-gnueabihf/lirc/plugins Apr 26 09:33:26 volumio lircd-0.10.1[11769]: Notice: Options: logfile: syslog Apr 26 09:33:26 volumio lircd-0.10.1[11769]: Notice: Options: immediate-init: 0 Apr 26 09:33:26 volumio lircd-0.10.1[11769]: Notice: Options: permission: 666 Apr 26 09:33:26 volumio lircd-0.10.1[11769]: Notice: Options: driver-options: Apr 26 09:33:26 volumio systemd[1]: Started Flexible IR remote input/output application support. Apr 26 09:33:26 volumio lircd[11769]: lircd-0.10.1[11769]: Notice: lircd(default) ready, using /var/run/lirc/lircd Apr 26 09:33:26 volumio lircd-0.10.1[11769]: Notice: Options: pidfile: /var/run/lirc/lircd.pid Apr 26 09:33:26 volumio lircd-0.10.1[11769]: Notice: Options: listen: 0 Apr 26 09:33:26 volumio lircd-0.10.1[11769]: Notice: Options: connect: (null) Apr 26 09:33:26 volumio lircd-0.10.1[11769]: Notice: Options: userelease: 0 Apr 26 09:33:26 volumio lircd-0.10.1[11769]: Notice: Options: effective_user: (null) Apr 26 09:33:26 volumio lircd-0.10.1[11769]: Notice: Options: release_suffix: _EVUP Apr 26 09:33:26 volumio lircd-0.10.1[11769]: Notice: Options: allow_simulate: 0 Apr 26 09:33:26 volumio lircd-0.10.1[11769]: Notice: Options: repeat_max: 600 Apr 26 09:33:26 volumio lircd-0.10.1[11769]: Notice: Options: configfile: /etc/lirc/lircd.conf Apr 26 09:33:26 volumio lircd-0.10.1[11769]: Notice: Options: dynamic_codes: (null) Apr 26 09:33:26 volumio lircd-0.10.1[11769]: Notice: Current driver: default Apr 26 09:33:26 volumio lircd-0.10.1[11769]: Notice: Driver API version: 3 Apr 26 09:33:26 volumio lircd-0.10.1[11769]: Notice: Driver version: 0.10.0 Apr 26 09:33:26 volumio lircd-0.10.1[11769]: Notice: Driver info: See file:///usr/share/doc/lirc/plugindocs/default.html Apr 26 09:33:26 volumio lircd-0.10.1[11769]: Info: lircd: Opening log, level: Info Apr 26 09:33:26 volumio lircd-0.10.1[11769]: Notice: Using systemd fd Apr 26 09:33:26 volumio lircd-0.10.1[11769]: Warning: Running as root Apr 26 09:33:26 volumio lircd-0.10.1[11769]: Info: Using remote: mceusb. Apr 26 09:33:26 volumio lircd-0.10.1[11769]: Notice: lircd(default) ready, using /var/run/lirc/lircd Apr 26 09:33:26 volumio sudo[11763]: pam_unix(sudo:session): session closed for user root Apr 26 09:33:26 volumio volumio[960]: info: ir_controller: systemctl restart lircd.service succeeded. Apr 26 09:33:27 volumio sudo[11773]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart irexec.service Apr 26 09:33:27 volumio sudo[11773]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 09:33:27 volumio systemd[1]: Started Handle events from IR remotes decoded by lircd(8). Apr 26 09:33:27 volumio sudo[11773]: pam_unix(sudo:session): session closed for user root Apr 26 09:33:27 volumio volumio[960]: info: ir_controller: systemctl restart irexec.service succeeded. Apr 26 09:33:27 volumio lircd[11769]: lircd-0.10.1[11769]: Notice: accepted new client on /var/run/lirc/lircd Apr 26 09:33:27 volumio lircd-0.10.1[11769]: Notice: accepted new client on /var/run/lirc/lircd Apr 26 09:33:27 volumio lircd-0.10.1[11769]: Info: [lirc] protocol is enabled Apr 26 09:33:27 volumio lircd[11769]: lircd-0.10.1[11769]: Info: [lirc] protocol is enabled Apr 26 09:33:41 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 26 09:33:41 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 26 09:33:48 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 26 09:33:48 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 26 09:33:48 volumio volumio[960]: info: Discovery: Getting this device information Apr 26 09:33:48 volumio volumio[960]: info: CoreCommandRouter::volumioGetState Apr 26 09:33:48 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 26 09:33:50 volumio sudo[11897]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop lircd.service Apr 26 09:33:50 volumio sudo[11897]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 09:33:50 volumio lircd[11769]: lircd-0.10.1[11769]: Notice: caught signal Apr 26 09:33:50 volumio lircd-0.10.1[11769]: Notice: caught signal Apr 26 09:33:50 volumio systemd[1]: Stopping Flexible IR remote input/output application support... Apr 26 09:33:50 volumio systemd[1]: lircd.service: Main process exited, code=killed, status=15/TERM Apr 26 09:33:50 volumio systemd[1]: lircd.service: Succeeded. Apr 26 09:33:50 volumio systemd[1]: Stopped Flexible IR remote input/output application support. Apr 26 09:33:50 volumio systemd[1]: irexec.service: Succeeded. Apr 26 09:33:50 volumio sudo[11897]: pam_unix(sudo:session): session closed for user root Apr 26 09:33:50 volumio volumio[960]: info: ir_controller: systemctl stop lircd.service succeeded. Apr 26 09:33:50 volumio volumio[960]: info: Disabling plugin ir_controller Apr 26 09:33:50 volumio volumio[960]: info: Done. Apr 26 09:33:50 volumio sudo[11902]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -r 0 Apr 26 09:33:50 volumio sudo[11902]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 09:33:50 volumio sudo[11902]: pam_unix(sudo:session): session closed for user root Apr 26 09:33:50 volumio volumio[960]: info: ir_controller: gpio-ir overlay removed. Apr 26 09:33:58 volumio volumio[960]: info: CoreCommandRouter::volumioStop Apr 26 09:33:58 volumio volumio[960]: info: CoreStateMachine::stop Apr 26 09:33:58 volumio volumio[960]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 09:33:58 volumio volumio[960]: info: CoreStateMachine::stPlaybackTimer Apr 26 09:33:58 volumio volumio[960]: info: CoreStateMachine::updateTrackBlock Apr 26 09:33:58 volumio volumio[960]: info: CorePlayQueue::getTrackBlock Apr 26 09:33:58 volumio volumio[960]: info: CoreStateMachine::pushState Apr 26 09:33:58 volumio volumio[960]: info: CorePlayQueue::getTrack 0 Apr 26 09:33:58 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 09:33:58 volumio volumio[960]: info: CoreCommandRouter::volumioPushState Apr 26 09:33:58 volumio volumio[960]: info: CoreStateMachine::serviceStop Apr 26 09:33:58 volumio volumio[960]: info: CorePlayQueue::getTrack 0 Apr 26 09:33:58 volumio volumio[960]: info: CoreCommandRouter::serviceStop Apr 26 09:33:58 volumio volumio[960]: info: [1745652838631] ControllerWebradio::stop Apr 26 09:33:58 volumio volumio[960]: verbose: ControllerMpd::sendMpdCommand stop Apr 26 09:33:58 volumio volumio[960]: info: Apr 26 09:33:58 volumio volumio[960]: ---------------------------- MPD announces state update: player Apr 26 09:33:58 volumio volumio[960]: info: sendMpdCommand stop took 94 milliseconds Apr 26 09:33:58 volumio volumio[960]: info: ControllerMpd::getState Apr 26 09:33:58 volumio volumio[960]: verbose: ControllerMpd::sendMpdCommand status Apr 26 09:33:58 volumio volumio[960]: info: sendMpdCommand status took 6 milliseconds Apr 26 09:33:58 volumio volumio[960]: verbose: ControllerMpd::parseState Apr 26 09:33:58 volumio volumio[960]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 26 09:33:58 volumio volumio[960]: info: touch_display: Setting screensaver timeout to 120 seconds. Apr 26 09:33:58 volumio volumio[960]: info: sendMpdCommand playlistinfo took 10 milliseconds Apr 26 09:33:58 volumio volumio[960]: verbose: ControllerMpd::parseTrackInfo Apr 26 09:33:58 volumio volumio[960]: info: ControllerMpd::pushState Apr 26 09:33:58 volumio volumio[960]: info: CoreCommandRouter::servicePushState Apr 26 09:33:58 volumio volumio[960]: info: CoreStateMachine::pushState Apr 26 09:33:58 volumio volumio[960]: info: CorePlayQueue::getTrack 0 Apr 26 09:33:58 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 09:33:58 volumio volumio[960]: info: CoreCommandRouter::volumioPushState Apr 26 09:33:58 volumio volumio[960]: info: CorePlayQueue::getTrack 0 Apr 26 09:33:58 volumio volumio[960]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Apr 26 09:33:58 volumio volumio[960]: info: ------------------------------ 80ms Apr 26 09:33:59 volumio volumio[960]: info: peppy_screensaver: Start PeppyMeter Apr 26 09:34:03 volumio volumio[960]: info: CoreCommandRouter::volumioPlay Apr 26 09:34:03 volumio volumio[960]: info: CoreStateMachine::play index undefined Apr 26 09:34:03 volumio volumio[960]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 09:34:03 volumio volumio[960]: info: CorePlayQueue::getTrack 0 Apr 26 09:34:03 volumio volumio[960]: info: CoreStateMachine::startPlaybackTimer Apr 26 09:34:03 volumio volumio[960]: info: CorePlayQueue::getTrack 0 Apr 26 09:34:03 volumio volumio[960]: info: [1745652843257] ControllerWebradio::clearAddPlayTrack Apr 26 09:34:03 volumio volumio[960]: verbose: ControllerMpd::sendMpdCommand stop Apr 26 09:34:03 volumio volumio[960]: info: sendMpdCommand stop took 1 milliseconds Apr 26 09:34:03 volumio volumio[960]: verbose: ControllerMpd::sendMpdCommand clear Apr 26 09:34:03 volumio volumio[960]: info: Apr 26 09:34:03 volumio volumio[960]: ---------------------------- MPD announces system playlist update Apr 26 09:34:03 volumio volumio[960]: info: Ignoring MPD Status Update Apr 26 09:34:03 volumio volumio[960]: info: sendMpdCommand clear took 3 milliseconds Apr 26 09:34:03 volumio volumio[960]: verbose: ControllerMpd::sendMpdCommand load "https://streams.radiobob.de/bob-national/mp3-192/tunein/" Apr 26 09:34:03 volumio volumio[960]: error: updateQueue error: null Apr 26 09:34:03 volumio volumio[960]: info: ------------------------------ 6ms Apr 26 09:34:05 volumio volumio[960]: verbose: ControllerMpd::sendMpdCommand add "https://streams.radiobob.de/bob-national/mp3-192/tunein/" Apr 26 09:34:05 volumio volumio[960]: Upnp client error: Error: This socket has been ended by the other party Apr 26 09:34:05 volumio volumio[960]: info: Apr 26 09:34:05 volumio volumio[960]: ---------------------------- MPD announces system playlist update Apr 26 09:34:05 volumio volumio[960]: info: Ignoring MPD Status Update Apr 26 09:34:05 volumio volumio[960]: info: sendMpdCommand add "https://streams.radiobob.de/bob-national/mp3-192/tunein/" took 5 milliseconds Apr 26 09:34:05 volumio volumio[960]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 26 09:34:05 volumio volumio[960]: verbose: ControllerMpd::sendMpdCommand play Apr 26 09:34:05 volumio volumio[960]: info: ------------------------------ 4ms Apr 26 09:34:05 volumio volumio[960]: info: sendMpdCommand play took 3 milliseconds Apr 26 09:34:06 volumio volumio[960]: info: Apr 26 09:34:06 volumio volumio[960]: ---------------------------- MPD announces state update: player Apr 26 09:34:06 volumio volumio[960]: info: ControllerMpd::getState Apr 26 09:34:06 volumio volumio[960]: verbose: ControllerMpd::sendMpdCommand status Apr 26 09:34:06 volumio volumio[960]: info: Apr 26 09:34:06 volumio volumio[960]: ---------------------------- MPD announces state update: player Apr 26 09:34:06 volumio volumio[960]: info: sendMpdCommand status took 24 milliseconds Apr 26 09:34:06 volumio volumio[960]: info: ControllerMpd::getState Apr 26 09:34:06 volumio volumio[960]: verbose: ControllerMpd::sendMpdCommand status Apr 26 09:34:06 volumio volumio[960]: verbose: ControllerMpd::parseState Apr 26 09:34:06 volumio volumio[960]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 26 09:34:06 volumio volumio[960]: info: sendMpdCommand status took 3 milliseconds Apr 26 09:34:06 volumio volumio[960]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 26 09:34:06 volumio volumio[960]: verbose: ControllerMpd::parseState Apr 26 09:34:06 volumio volumio[960]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 26 09:34:06 volumio volumio[960]: verbose: ControllerMpd::parseTrackInfo Apr 26 09:34:06 volumio volumio[960]: info: ControllerMpd::pushState Apr 26 09:34:06 volumio volumio[960]: info: CoreCommandRouter::servicePushState Apr 26 09:34:06 volumio volumio[960]: info: CorePlayQueue::getTrack 0 Apr 26 09:34:06 volumio volumio[960]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":null,"album":null,"uri":"https://streams.radiobob.de/bob-national/mp3-192/tunein/","trackType":""} Apr 26 09:34:06 volumio volumio[960]: verbose: CURRENT POSITION 0 Apr 26 09:34:06 volumio volumio[960]: info: CoreStateMachine::syncState stateService play Apr 26 09:34:06 volumio volumio[960]: info: CoreStateMachine::syncState currentStatus stop Apr 26 09:34:06 volumio volumio[960]: info: ------------------------------ 36ms Apr 26 09:34:06 volumio volumio[960]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 26 09:34:06 volumio volumio[960]: verbose: ControllerMpd::parseTrackInfo Apr 26 09:34:06 volumio volumio[960]: info: ControllerMpd::pushState Apr 26 09:34:06 volumio volumio[960]: info: CoreCommandRouter::servicePushState Apr 26 09:34:06 volumio volumio[960]: info: CorePlayQueue::getTrack 0 Apr 26 09:34:06 volumio volumio[960]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":null,"album":null,"uri":"https://streams.radiobob.de/bob-national/mp3-192/tunein/","trackType":""} Apr 26 09:34:06 volumio volumio[960]: verbose: CURRENT POSITION 0 Apr 26 09:34:06 volumio volumio[960]: info: CoreStateMachine::syncState stateService play Apr 26 09:34:06 volumio volumio[960]: info: CoreStateMachine::syncState currentStatus play Apr 26 09:34:06 volumio volumio[960]: info: Received an update from plugin. extracting info from payload Apr 26 09:34:06 volumio volumio[960]: info: CoreStateMachine::pushState Apr 26 09:34:06 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 09:34:06 volumio volumio[960]: info: CoreCommandRouter::volumioPushState Apr 26 09:34:06 volumio volumio[960]: info: CoreStateMachine::pushState Apr 26 09:34:06 volumio volumio[960]: info: CoreCommandRouter::volumioPushState Apr 26 09:34:06 volumio volumio[960]: info: ------------------------------ 69ms Apr 26 09:34:06 volumio volumio[960]: info: Apr 26 09:34:06 volumio volumio[960]: ---------------------------- MPD announces system playlist update Apr 26 09:34:06 volumio volumio[960]: info: Ignoring MPD Status Update Apr 26 09:34:06 volumio volumio[960]: info: Apr 26 09:34:06 volumio volumio[960]: ---------------------------- MPD announces state update: player Apr 26 09:34:06 volumio volumio[960]: info: ControllerMpd::getState Apr 26 09:34:06 volumio volumio[960]: verbose: ControllerMpd::sendMpdCommand status Apr 26 09:34:06 volumio volumio[960]: info: ------------------------------ 49ms Apr 26 09:34:06 volumio volumio[960]: info: sendMpdCommand status took 48 milliseconds Apr 26 09:34:06 volumio volumio[960]: verbose: ControllerMpd::parseState Apr 26 09:34:06 volumio volumio[960]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 26 09:34:06 volumio volumio[960]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 26 09:34:06 volumio volumio[960]: verbose: ControllerMpd::parseTrackInfo Apr 26 09:34:06 volumio volumio[960]: info: ControllerMpd::pushState Apr 26 09:34:06 volumio volumio[960]: info: CoreCommandRouter::servicePushState Apr 26 09:34:06 volumio volumio[960]: info: CorePlayQueue::getTrack 0 Apr 26 09:34:06 volumio volumio[960]: verbose: STATE SERVICE {"status":"play","position":0,"seek":731,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"RADIO BOB - Livestream National","artist":"RADIO BOB - Livestream National","album":null,"uri":"https://streams.radiobob.de/bob-national/mp3-192/tunein/","trackType":""} Apr 26 09:34:06 volumio volumio[960]: verbose: CURRENT POSITION 0 Apr 26 09:34:06 volumio volumio[960]: info: CoreStateMachine::syncState stateService play Apr 26 09:34:06 volumio volumio[960]: info: CoreStateMachine::syncState currentStatus play Apr 26 09:34:06 volumio volumio[960]: info: Received an update from plugin. extracting info from payload Apr 26 09:34:06 volumio volumio[960]: info: CoreStateMachine::pushState Apr 26 09:34:06 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 09:34:06 volumio volumio[960]: info: CoreCommandRouter::volumioPushState Apr 26 09:34:06 volumio volumio[960]: info: CoreStateMachine::pushState Apr 26 09:34:06 volumio volumio[960]: info: CoreCommandRouter::volumioPushState Apr 26 09:34:06 volumio volumio[960]: info: ------------------------------ 132ms Apr 26 09:34:06 volumio volumio[960]: info: touch_display: Setting screensaver timeout to 0 seconds. Apr 26 09:34:10 volumio volumio[960]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 26 09:34:10 volumio volumio[960]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 26 09:34:10 volumio volumio[960]: info: Retrieving Cloud Streaming UI Apr 26 09:34:10 volumio volumio[960]: info: Getting Tidal Cloud Configuration Apr 26 09:34:10 volumio volumio[960]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 26 09:34:10 volumio volumio[960]: info: Getting Qobuz Cloud Configuration Apr 26 09:34:10 volumio volumio[960]: info: Asking plugin for UI Config Apr 26 09:34:10 volumio volumio[960]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 26 09:34:10 volumio volumio[960]: info: Getting Spotify Cloud Configuration Apr 26 09:34:10 volumio volumio[960]: info: Asking plugin for UI Config Apr 26 09:34:10 volumio volumio[960]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 26 09:34:10 volumio volumio[960]: info: Saving Spotify Acccount Apr 26 09:34:10 volumio volumio[960]: info: Got Tidal Cloud Configuration Apr 26 09:34:10 volumio volumio[960]: info: Got it Apr 26 09:34:10 volumio volumio[960]: info: Got it Apr 26 09:34:10 volumio volumio[960]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Apr 26 09:34:10 volumio volumio[960]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 26 09:34:10 volumio volumio[960]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Apr 26 09:34:10 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 26 09:34:10 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 26 09:34:10 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 26 09:34:10 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 26 09:34:10 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 26 09:34:10 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 26 09:34:10 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 26 09:34:10 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 26 09:34:10 volumio volumio[960]: info: CoreCommandRouter::volumioGetBrowseSources Apr 26 09:34:10 volumio volumio[960]: info: CoreCommandRouter::volumioGetBrowseSources Apr 26 09:34:10 volumio volumio[960]: info: CoreCommandRouter::volumioGetBrowseSources Apr 26 09:34:11 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 26 09:34:11 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Apr 26 09:34:11 volumio volumio[960]: info: Apr 26 09:34:11 volumio volumio[960]: ---------------------------- MPD announces system playlist update Apr 26 09:34:11 volumio volumio[960]: info: Ignoring MPD Status Update Apr 26 09:34:11 volumio volumio[960]: info: Apr 26 09:34:11 volumio volumio[960]: ---------------------------- MPD announces state update: player Apr 26 09:34:11 volumio volumio[960]: info: ControllerMpd::getState Apr 26 09:34:11 volumio volumio[960]: verbose: ControllerMpd::sendMpdCommand status Apr 26 09:34:11 volumio volumio[960]: info: ------------------------------ 4ms Apr 26 09:34:11 volumio volumio[960]: info: sendMpdCommand status took 2 milliseconds Apr 26 09:34:11 volumio volumio[960]: verbose: ControllerMpd::parseState Apr 26 09:34:11 volumio volumio[960]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 26 09:34:11 volumio volumio[960]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 26 09:34:11 volumio volumio[960]: verbose: ControllerMpd::parseTrackInfo Apr 26 09:34:11 volumio volumio[960]: info: ControllerMpd::pushState Apr 26 09:34:11 volumio volumio[960]: info: CoreCommandRouter::servicePushState Apr 26 09:34:11 volumio volumio[960]: info: CorePlayQueue::getTrack 0 Apr 26 09:34:11 volumio volumio[960]: verbose: STATE SERVICE {"status":"play","position":0,"seek":6114,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Iron Maiden - The Number of the Beast","artist":"RADIO BOB - Livestream National","album":null,"uri":"https://streams.radiobob.de/bob-national/mp3-192/tunein/","trackType":""} Apr 26 09:34:11 volumio volumio[960]: verbose: CURRENT POSITION 0 Apr 26 09:34:11 volumio volumio[960]: info: CoreStateMachine::syncState stateService play Apr 26 09:34:11 volumio volumio[960]: info: CoreStateMachine::syncState currentStatus play Apr 26 09:34:11 volumio volumio[960]: info: Received an update from plugin. extracting info from payload Apr 26 09:34:11 volumio volumio[960]: info: CoreStateMachine::pushState Apr 26 09:34:11 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 09:34:11 volumio volumio[960]: info: CoreCommandRouter::volumioPushState Apr 26 09:34:11 volumio volumio[960]: info: CoreStateMachine::pushState Apr 26 09:34:11 volumio volumio[960]: info: CoreCommandRouter::volumioPushState Apr 26 09:34:11 volumio volumio[960]: info: ------------------------------ 50ms Apr 26 09:34:14 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Apr 26 09:34:14 volumio volumio[960]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Apr 26 09:34:14 volumio volumio[960]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 26 09:34:14 volumio volumio[960]: Error: dns service error: unknown Apr 26 09:34:14 volumio volumio[960]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) Apr 26 09:34:14 volumio volumio[960]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Apr 26 09:34:14 volumio volumio[960]: errorCode: -65537 Apr 26 09:34:14 volumio volumio[960]: } Apr 26 09:34:14 volumio volumio[960]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 26 09:34:15 volumio sudo[12032]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-26 09:33 Apr 26 09:34:15 volumio sudo[12032]: 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="e32c2c71ae78852844c70357816bdd871c155ab8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 31 Mar 2025 06:54:47 PM CEST" VOLUMIO_VERSION="3.799" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="436f3f84f6d0b4ffc344f0bc132a32e8"