-- Logs begin at Wed 2025-07-02 06:17:01 UTC, end at Wed 2025-07-02 09:17:38 UTC. -- Jul 02 09:16:08 ifi-phmidsd-lsq-test ethernet-detect[469]: No change in avahi-daemon interfaces. Skipping restart. Jul 02 09:16:18 ifi-phmidsd-lsq-test ethernet-detect[469]: No change in avahi-daemon interfaces. Skipping restart. Jul 02 09:16:28 ifi-phmidsd-lsq-test sshd[8999]: Accepted password for volumio from 192.168.1.174 port 57210 ssh2 Jul 02 09:16:28 ifi-phmidsd-lsq-test sshd[8999]: pam_unix(sshd:session): session opened for user volumio by (uid=0) Jul 02 09:16:28 ifi-phmidsd-lsq-test systemd-logind[476]: New session 16 of user volumio. Jul 02 09:16:28 ifi-phmidsd-lsq-test systemd[1]: Started Session 16 of user volumio. Jul 02 09:16:28 ifi-phmidsd-lsq-test sshd[9039]: Received disconnect from 192.168.1.174 port 57210:11: disconnected by user Jul 02 09:16:28 ifi-phmidsd-lsq-test sshd[9039]: Disconnected from user volumio 192.168.1.174 port 57210 Jul 02 09:16:28 ifi-phmidsd-lsq-test sshd[8999]: pam_unix(sshd:session): session closed for user volumio Jul 02 09:16:28 ifi-phmidsd-lsq-test systemd[1]: session-16.scope: Succeeded. Jul 02 09:16:28 ifi-phmidsd-lsq-test systemd-logind[476]: Session 16 logged out. Waiting for processes to exit. Jul 02 09:16:28 ifi-phmidsd-lsq-test systemd-logind[476]: Removed session 16. Jul 02 09:16:28 ifi-phmidsd-lsq-test ethernet-detect[469]: No change in avahi-daemon interfaces. Skipping restart. Jul 02 09:16:33 ifi-phmidsd-lsq-test sudo[9141]: volumio : TTY=pts/0 ; PWD=/home/volumio ; USER=root ; COMMAND=/bin/systemctl restart volumio Jul 02 09:16:33 ifi-phmidsd-lsq-test sudo[9141]: pam_unix(sudo:session): session opened for user root by volumio(uid=0) Jul 02 09:16:33 ifi-phmidsd-lsq-test systemd[1]: Started dynamicswap service. Jul 02 09:16:33 ifi-phmidsd-lsq-test systemd[1]: Stopping Volumio Backend Module... Jul 02 09:16:33 ifi-phmidsd-lsq-test volumio-remote-updater[467]: [2025-07-02 09:16:33] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jul 02 09:16:33 ifi-phmidsd-lsq-test volumio-remote-updater[467]: [2025-07-02 09:16:33] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jul 02 09:16:33 ifi-phmidsd-lsq-test node[448]: ConvSwitch: Drop client volumio Jul 02 09:16:33 ifi-phmidsd-lsq-test node[449]: Closing connection with the client volumio Jul 02 09:16:33 ifi-phmidsd-lsq-test systemd[1]: volumio.service: Main process exited, code=killed, status=15/TERM Jul 02 09:16:33 ifi-phmidsd-lsq-test systemd[1]: volumio.service: Succeeded. Jul 02 09:16:33 ifi-phmidsd-lsq-test systemd[1]: Stopped Volumio Backend Module. Jul 02 09:16:33 ifi-phmidsd-lsq-test systemd[1]: Started Volumio Backend Module. Jul 02 09:16:33 ifi-phmidsd-lsq-test sudo[9141]: pam_unix(sudo:session): session closed for user root Jul 02 09:16:33 ifi-phmidsd-lsq-test systemd[1]: dynamicswap.service: Succeeded. Jul 02 09:16:36 ifi-phmidsd-lsq-test volumio[9149]: info: ------------------------------------------- Jul 02 09:16:36 ifi-phmidsd-lsq-test volumio[9149]: info: ----- Volumio3 ---- Jul 02 09:16:36 ifi-phmidsd-lsq-test volumio[9149]: info: ------------------------------------------- Jul 02 09:16:36 ifi-phmidsd-lsq-test volumio[9149]: info: ----- System startup ---- Jul 02 09:16:36 ifi-phmidsd-lsq-test volumio[9149]: info: ------------------------------------------- Jul 02 09:16:36 ifi-phmidsd-lsq-test volumio[9149]: info: ConvSwitch: Client Start Jul 02 09:16:36 ifi-phmidsd-lsq-test volumio[9149]: info: MetaClient: Client Start Jul 02 09:16:36 ifi-phmidsd-lsq-test node[449]: A new connection has been established. Jul 02 09:16:37 ifi-phmidsd-lsq-test volumio[9149]: info: Plugin folders cleanup Jul 02 09:16:37 ifi-phmidsd-lsq-test volumio[9149]: info: Scanning into folder /volumio/app/plugins/ Jul 02 09:16:37 ifi-phmidsd-lsq-test volumio[9149]: info: Scanning category audio_interface Jul 02 09:16:37 ifi-phmidsd-lsq-test volumio[9149]: info: Scanning category miscellanea Jul 02 09:16:37 ifi-phmidsd-lsq-test volumio[9149]: info: Scanning category music_service Jul 02 09:16:37 ifi-phmidsd-lsq-test volumio[9149]: info: Scanning category plugins.json Jul 02 09:16:37 ifi-phmidsd-lsq-test volumio[9149]: info: Scanning category system_controller Jul 02 09:16:37 ifi-phmidsd-lsq-test volumio[9149]: info: Scanning category user_interface Jul 02 09:16:37 ifi-phmidsd-lsq-test volumio[9149]: info: Scanning into folder /data/plugins/ Jul 02 09:16:37 ifi-phmidsd-lsq-test volumio[9149]: info: Scanning category .git Jul 02 09:16:37 ifi-phmidsd-lsq-test volumio[9149]: info: Scanning category music_service Jul 02 09:16:37 ifi-phmidsd-lsq-test volumio[9149]: info: Plugin folders cleanup completed Jul 02 09:16:37 ifi-phmidsd-lsq-test volumio[9149]: info: ------------------------------------------- Jul 02 09:16:37 ifi-phmidsd-lsq-test volumio[9149]: info: ----- Core plugins startup ---- Jul 02 09:16:37 ifi-phmidsd-lsq-test volumio[9149]: info: ------------------------------------------- Jul 02 09:16:37 ifi-phmidsd-lsq-test volumio[9149]: info: Loading plugins from folder /volumio/app/plugins/ Jul 02 09:16:37 ifi-phmidsd-lsq-test volumio[9149]: info: Adding plugin networkaudiod to MyMusic Plugins Jul 02 09:16:37 ifi-phmidsd-lsq-test volumio[9149]: info: Adding plugin qobuz_connect to MyMusic Plugins Jul 02 09:16:37 ifi-phmidsd-lsq-test volumio[9149]: info: Adding plugin spotify_connect to MyMusic Plugins Jul 02 09:16:37 ifi-phmidsd-lsq-test volumio[9149]: info: Adding plugin tidal_connect to MyMusic Plugins Jul 02 09:16:37 ifi-phmidsd-lsq-test volumio[9149]: info: Adding plugin upnp to MyMusic Plugins Jul 02 09:16:37 ifi-phmidsd-lsq-test volumio[9149]: info: Adding plugin airplay1_switch to MyMusic Plugins Jul 02 09:16:37 ifi-phmidsd-lsq-test volumio[9149]: info: Adding plugin airplay2_switch to MyMusic Plugins Jul 02 09:16:37 ifi-phmidsd-lsq-test volumio[9149]: info: Adding plugin roon_ready to MyMusic Plugins Jul 02 09:16:37 ifi-phmidsd-lsq-test volumio[9149]: info: Adding plugin upnp_browser to MyMusic Plugins Jul 02 09:16:37 ifi-phmidsd-lsq-test volumio[9149]: info: Loading plugins from folder /data/plugins/ Jul 02 09:16:37 ifi-phmidsd-lsq-test volumio[9149]: info: Loading plugin "system"... Jul 02 09:16:37 ifi-phmidsd-lsq-test volumio[9149]: info: Loading plugin "appearance"... Jul 02 09:16:38 ifi-phmidsd-lsq-test ethernet-detect[469]: No change in avahi-daemon interfaces. Skipping restart. Jul 02 09:16:38 ifi-phmidsd-lsq-test volumio-remote-updater[467]: [2025-07-02 09:16:38] [connect] Successful connection Jul 02 09:16:39 ifi-phmidsd-lsq-test volumio[9149]: info: Loading plugin "network"... Jul 02 09:16:39 ifi-phmidsd-lsq-test volumio[9149]: info: Refreshing Cached IP Addresses Jul 02 09:16:39 ifi-phmidsd-lsq-test sudo[9254]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 02 09:16:39 ifi-phmidsd-lsq-test sudo[9254]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 02 09:16:39 ifi-phmidsd-lsq-test sudo[9254]: pam_unix(sudo:session): session closed for user root Jul 02 09:16:39 ifi-phmidsd-lsq-test sudo[9256]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 02 09:16:39 ifi-phmidsd-lsq-test sudo[9256]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 02 09:16:39 ifi-phmidsd-lsq-test sudo[9256]: pam_unix(sudo:session): session closed for user root Jul 02 09:16:39 ifi-phmidsd-lsq-test volumio[9149]: info: Loading plugin "services"... Jul 02 09:16:39 ifi-phmidsd-lsq-test volumio[9149]: info: Loading plugin "alsa_controller"... Jul 02 09:16:39 ifi-phmidsd-lsq-test sudo[9265]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jul 02 09:16:39 ifi-phmidsd-lsq-test sudo[9265]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 02 09:16:39 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 02 09:16:39 ifi-phmidsd-lsq-test volumio[9149]: info: Loading plugin "wizard"... Jul 02 09:16:39 ifi-phmidsd-lsq-test volumio[9149]: info: Loading plugin "networkfs"... Jul 02 09:16:39 ifi-phmidsd-lsq-test volumio[9149]: info: Cannot mount NAS testmusic at system boot, trial number 1 ,retrying in 5 seconds Jul 02 09:16:39 ifi-phmidsd-lsq-test volumio[9149]: info: Starting Udev Watcher for removable devices Jul 02 09:16:39 ifi-phmidsd-lsq-test volumio[9149]: error: Cannot associate FS Label, not mounting Jul 02 09:16:39 ifi-phmidsd-lsq-test volumio[9149]: error: Cannot associate FS Label, not mounting Jul 02 09:16:39 ifi-phmidsd-lsq-test volumio[9149]: info: Ignoring mount for partition: BOOT Jul 02 09:16:39 ifi-phmidsd-lsq-test volumio[9149]: info: Ignoring mount for partition: archivefs Jul 02 09:16:39 ifi-phmidsd-lsq-test sudo[9265]: pam_unix(sudo:session): session closed for user root Jul 02 09:16:39 ifi-phmidsd-lsq-test volumio[9149]: info: Ignoring mount for partition: rootfs Jul 02 09:16:39 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 02 09:16:39 ifi-phmidsd-lsq-test volumio[9149]: info: Loading plugin "volumio_command_line_client"... Jul 02 09:16:39 ifi-phmidsd-lsq-test volumio[9149]: info: Loading plugin "networkaudiod"... Jul 02 09:16:39 ifi-phmidsd-lsq-test volumio[9149]: info: [1751447799718] Starting NAA Service Jul 02 09:16:39 ifi-phmidsd-lsq-test volumio[9149]: info: Loading plugin "tidal_connect"... Jul 02 09:16:39 ifi-phmidsd-lsq-test volumio[9149]: info: [1751447799744] Starting Tidal Connect Service Jul 02 09:16:39 ifi-phmidsd-lsq-test volumio[9149]: info: Loading plugin "upnp"... Jul 02 09:16:39 ifi-phmidsd-lsq-test sudo[9295]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart networkaudiod.service Jul 02 09:16:39 ifi-phmidsd-lsq-test volumio[9149]: info: [1751447799756] Starting Upmpd Daemon Jul 02 09:16:39 ifi-phmidsd-lsq-test volumio[9149]: info: Starting Upmpd Daemon Jul 02 09:16:39 ifi-phmidsd-lsq-test sudo[9295]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 02 09:16:39 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 02 09:16:39 ifi-phmidsd-lsq-test volumio[9149]: error: ATTENTION!!!: Plugin upnp does not return adequate promise from onVolumioStart: please update! Jul 02 09:16:39 ifi-phmidsd-lsq-test volumio[9149]: info: Loading plugin "my_music"... Jul 02 09:16:39 ifi-phmidsd-lsq-test volumio[9149]: info: Loading plugin "mpd"... Jul 02 09:16:39 ifi-phmidsd-lsq-test systemd[1]: Stopping Network Audio Adapter daemon... Jul 02 09:16:39 ifi-phmidsd-lsq-test systemd[1]: networkaudiod.service: Succeeded. Jul 02 09:16:39 ifi-phmidsd-lsq-test systemd[1]: Stopped Network Audio Adapter daemon. Jul 02 09:16:39 ifi-phmidsd-lsq-test systemd[1]: Started Network Audio Adapter daemon. Jul 02 09:16:39 ifi-phmidsd-lsq-test sudo[9295]: pam_unix(sudo:session): session closed for user root Jul 02 09:16:39 ifi-phmidsd-lsq-test networkaudiod[9297]: [/usr/sbin/networkaudiod] (9297): networkaudiod Copyright (C) 2011-2020 Jussi Laako / Signalyst. All rights reserved. Jul 02 09:16:39 ifi-phmidsd-lsq-test networkaudiod[9297]: [/usr/sbin/networkaudiod] (9297): create alsa engine Jul 02 09:16:39 ifi-phmidsd-lsq-test networkaudiod[9297]: [/usr/sbin/networkaudiod] (9297): listen discovery on :: Jul 02 09:16:39 ifi-phmidsd-lsq-test networkaudiod[9297]: [/usr/sbin/networkaudiod] (9297): clSocket::SetOption(): setsockopt(..., 41,20, ...): No such device Jul 02 09:16:39 ifi-phmidsd-lsq-test networkaudiod[9297]: [/usr/sbin/networkaudiod] (9297): Socket failure, falling back to IPv4-only! Jul 02 09:16:40 ifi-phmidsd-lsq-test volumio[9149]: info: Loading plugin "upnp_browser"... Jul 02 09:16:40 ifi-phmidsd-lsq-test volumio[9149]: info: Loading plugin "qobuz_connect"... Jul 02 09:16:40 ifi-phmidsd-lsq-test volumio[9149]: info: [1751447800781] Starting Qobuz Connect Service Jul 02 09:16:40 ifi-phmidsd-lsq-test volumio[9149]: info: Loading plugin "alarm-clock"... Jul 02 09:16:40 ifi-phmidsd-lsq-test networkaudiod[9297]: [/usr/sbin/networkaudiod] (9297): listen discovery on 0.0.0.0 Jul 02 09:16:41 ifi-phmidsd-lsq-test volumio[9149]: info: Loading plugin "last_100"... Jul 02 09:16:41 ifi-phmidsd-lsq-test volumio[9149]: info: Loading plugin "roon_ready"... Jul 02 09:16:41 ifi-phmidsd-lsq-test volumio[9149]: info: Starting RoonReady Sync Jul 02 09:16:41 ifi-phmidsd-lsq-test volumio[9149]: info: Loading plugin "webradio"... Jul 02 09:16:41 ifi-phmidsd-lsq-test volumio[9149]: info: Loading plugin "i2s_dacs"... Jul 02 09:16:41 ifi-phmidsd-lsq-test volumio[9149]: info: I2S DAC not set, start Auto-detection Jul 02 09:16:41 ifi-phmidsd-lsq-test volumio[9149]: info: Loading plugin "volumiodiscovery"... Jul 02 09:16:41 ifi-phmidsd-lsq-test volumio[9149]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 02 09:16:41 ifi-phmidsd-lsq-test volumio[9149]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 02 09:16:41 ifi-phmidsd-lsq-test volumio[9149]: *** WARNING *** For more information see Jul 02 09:16:41 ifi-phmidsd-lsq-test volumio[9149]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 02 09:16:41 ifi-phmidsd-lsq-test node[9149]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 02 09:16:41 ifi-phmidsd-lsq-test volumio[9149]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 02 09:16:41 ifi-phmidsd-lsq-test volumio[9149]: *** WARNING *** For more information see Jul 02 09:16:41 ifi-phmidsd-lsq-test node[9149]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 02 09:16:41 ifi-phmidsd-lsq-test node[9149]: *** WARNING *** For more information see Jul 02 09:16:41 ifi-phmidsd-lsq-test node[9149]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 02 09:16:41 ifi-phmidsd-lsq-test node[9149]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 02 09:16:41 ifi-phmidsd-lsq-test node[9149]: *** WARNING *** For more information see Jul 02 09:16:41 ifi-phmidsd-lsq-test volumio[9149]: info: Applying required configuration parameters for plugin volumiodiscovery Jul 02 09:16:41 ifi-phmidsd-lsq-test volumio[9149]: info: Discovery: Started advertising with name: "ifi-phmidsd-lsq-test [32:EF:95:FD:98:7F]" Jul 02 09:16:41 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 02 09:16:41 ifi-phmidsd-lsq-test volumio[9149]: info: Loading plugin "spotify_connect"... Jul 02 09:16:41 ifi-phmidsd-lsq-test volumio[9149]: info: [1751447801371] Starting Spotify Connect Service Jul 02 09:16:41 ifi-phmidsd-lsq-test volumio[9149]: info: Plugin airplay1_switch is not enabled Jul 02 09:16:41 ifi-phmidsd-lsq-test volumio[9149]: info: Loading plugin "airplay2_switch"... Jul 02 09:16:41 ifi-phmidsd-lsq-test volumio[9149]: info: Loading plugin "airplay_emulation"... Jul 02 09:16:41 ifi-phmidsd-lsq-test volumio[9149]: info: Starting Shairport Sync Jul 02 09:16:41 ifi-phmidsd-lsq-test volumio[9149]: info: Loading plugin "outputs"... Jul 02 09:16:41 ifi-phmidsd-lsq-test volumio[9149]: info: Loading plugin "albumart"... Jul 02 09:16:41 ifi-phmidsd-lsq-test volumio[9149]: info: Plugin example_plugin is not enabled Jul 02 09:16:41 ifi-phmidsd-lsq-test volumio[9149]: info: Loading plugin "inputs"... Jul 02 09:16:41 ifi-phmidsd-lsq-test volumio[9149]: info: Loading plugin "updater_comm"... Jul 02 09:16:41 ifi-phmidsd-lsq-test volumio[9149]: info: Plugin mpdemulation is not enabled Jul 02 09:16:41 ifi-phmidsd-lsq-test volumio[9149]: info: Loading plugin "rest_api"... Jul 02 09:16:41 ifi-phmidsd-lsq-test volumio[9149]: info: Loading plugin "websocket"... Jul 02 09:16:41 ifi-phmidsd-lsq-test volumio[9149]: info: Starting Socket.io Server version 2.3.0 Jul 02 09:16:41 ifi-phmidsd-lsq-test volumio[9149]: info: Plugin cdplayer is not enabled Jul 02 09:16:41 ifi-phmidsd-lsq-test volumio[9149]: info: Plugin ifi-cdplayer is not enabled Jul 02 09:16:41 ifi-phmidsd-lsq-test volumio[9149]: info: Loading i18n strings for locale en Jul 02 09:16:41 ifi-phmidsd-lsq-test volumio[9149]: Updating browse sources language Jul 02 09:16:41 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 02 09:16:42 ifi-phmidsd-lsq-test volumio[9149]: Forking 3 albumart workers Jul 02 09:16:42 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 02 09:16:42 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::initPlayerControls Jul 02 09:16:42 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 02 09:16:42 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Jul 02 09:16:42 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 02 09:16:42 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 02 09:16:42 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 02 09:16:42 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 02 09:16:42 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 02 09:16:42 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 02 09:16:42 ifi-phmidsd-lsq-test volumio[9149]: Removing existing socket file at /tmp/meta.sock Jul 02 09:16:42 ifi-phmidsd-lsq-test volumio[9149]: Express server listening on port 3000 Jul 02 09:16:42 ifi-phmidsd-lsq-test volumio[9149]: [Metrics] WebUI: 6s 855.86ms Jul 02 09:16:42 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::resetVolumioState Jul 02 09:16:42 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::getcurrentVolume Jul 02 09:16:42 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::volumioRetrievevolume Jul 02 09:16:42 ifi-phmidsd-lsq-test volumio[9149]: Meta server listening Jul 02 09:16:42 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveCurrentVolume Jul 02 09:16:42 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::pushState Jul 02 09:16:42 ifi-phmidsd-lsq-test volumio[9149]: info: CorePlayQueue::getTrack 0 Jul 02 09:16:42 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 02 09:16:42 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::volumioPushState Jul 02 09:16:42 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 02 09:16:42 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 02 09:16:42 ifi-phmidsd-lsq-test volumio[9149]: info: Server listening on port 6599 Jul 02 09:16:42 ifi-phmidsd-lsq-test sudo[9365]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-tidal-connect.service Jul 02 09:16:42 ifi-phmidsd-lsq-test sudo[9365]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 02 09:16:42 ifi-phmidsd-lsq-test volumio[9149]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jul 02 09:16:42 ifi-phmidsd-lsq-test volumio[9149]: info: Completed loading Core Plugins Jul 02 09:16:42 ifi-phmidsd-lsq-test volumio[9149]: info: Preparing to generate the ALSA configuration file Jul 02 09:16:42 ifi-phmidsd-lsq-test sudo[9367]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start ifi-streamer-qobuz-connect.service Jul 02 09:16:42 ifi-phmidsd-lsq-test sudo[9367]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 02 09:16:42 ifi-phmidsd-lsq-test node[449]: Closing connection with the client tidal-connect Jul 02 09:16:42 ifi-phmidsd-lsq-test systemd[1]: Stopping iFi Streamer Tidal Metadata Service... Jul 02 09:16:42 ifi-phmidsd-lsq-test sudo[9367]: pam_unix(sudo:session): session closed for user root Jul 02 09:16:42 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-tidal-metadata.service: Main process exited, code=killed, status=15/TERM Jul 02 09:16:42 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-tidal-metadata.service: Succeeded. Jul 02 09:16:42 ifi-phmidsd-lsq-test systemd[1]: Stopped iFi Streamer Tidal Metadata Service. Jul 02 09:16:42 ifi-phmidsd-lsq-test node[448]: ConvSwitch: Drop client tidal Jul 02 09:16:42 ifi-phmidsd-lsq-test systemd[1]: Stopping iFi Streamer Tidal Connect Service... Jul 02 09:16:42 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-tidal-connect.service: Main process exited, code=killed, status=15/TERM Jul 02 09:16:42 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-tidal-connect.service: Succeeded. Jul 02 09:16:42 ifi-phmidsd-lsq-test systemd[1]: Stopped iFi Streamer Tidal Connect Service. Jul 02 09:16:42 ifi-phmidsd-lsq-test systemd[1]: Started iFi Streamer Tidal Connect Service. Jul 02 09:16:42 ifi-phmidsd-lsq-test sudo[9365]: pam_unix(sudo:session): session closed for user root Jul 02 09:16:43 ifi-phmidsd-lsq-test systemd[1]: Started iFi Streamer Tidal Metadata Service. Jul 02 09:16:43 ifi-phmidsd-lsq-test volumio[9149]: info: ConvSwitch: Connected to server Jul 02 09:16:43 ifi-phmidsd-lsq-test node[448]: ConvSwitch: Add client volumio Jul 02 09:16:43 ifi-phmidsd-lsq-test volumio[9149]: info: MetaClient: Connected to server Jul 02 09:16:43 ifi-phmidsd-lsq-test node[449]: A new connection has been established. Jul 02 09:16:43 ifi-phmidsd-lsq-test volumio[9149]: info: Volumio Network Manager: Network status updated: 3 Jul 02 09:16:43 ifi-phmidsd-lsq-test volumio[9149]: info: NAA Service Started Jul 02 09:16:43 ifi-phmidsd-lsq-test volumio[9149]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Jul 02 09:16:43 ifi-phmidsd-lsq-test volumio[9149]: info: ConvSwitch: Get message: success Jul 02 09:16:43 ifi-phmidsd-lsq-test volumio[9149]: info: MetaClient: Get message: success Jul 02 09:16:43 ifi-phmidsd-lsq-test volumio[9149]: verbose: New Socket.io Connection to 192.168.1.129 from 192.168.1.189 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Jul 02 09:16:43 ifi-phmidsd-lsq-test volumio[9149]: verbose: New Socket.io Connection to 192.168.1.191 from 192.168.1.189 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Jul 02 09:16:43 ifi-phmidsd-lsq-test volumio[9149]: verbose: New Socket.io Connection to 192.168.1.129 from 192.168.1.189 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Jul 02 09:16:43 ifi-phmidsd-lsq-test volumio[9149]: verbose: New Socket.io Connection to 192.168.1.129 from 192.168.1.189 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Jul 02 09:16:43 ifi-phmidsd-lsq-test volumio[9149]: verbose: New Socket.io Connection to 192.168.1.191 from 192.168.1.189 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Jul 02 09:16:43 ifi-phmidsd-lsq-test volumio[9149]: verbose: New Socket.io Connection to 192.168.1.191 from 192.168.1.189 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Jul 02 09:16:43 ifi-phmidsd-lsq-test volumio[9149]: verbose: New Socket.io Connection to 192.168.1.129 from 192.168.1.189 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Jul 02 09:16:43 ifi-phmidsd-lsq-test volumio[9149]: verbose: New Socket.io Connection to 192.168.1.191 from 192.168.1.189 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Jul 02 09:16:43 ifi-phmidsd-lsq-test volumio-remote-updater[467]: [2025-07-02 09:16:43] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1751447798 101 Jul 02 09:16:43 ifi-phmidsd-lsq-test volumio[9149]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 9 Jul 02 09:16:43 ifi-phmidsd-lsq-test volumio[9149]: verbose: New Socket.io Connection to 192.168.1.129 from 192.168.1.189 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Jul 02 09:16:43 ifi-phmidsd-lsq-test volumio[9149]: verbose: New Socket.io Connection to 192.168.1.191 from 192.168.1.189 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Jul 02 09:16:43 ifi-phmidsd-lsq-test volumio[9149]: verbose: New Socket.io Connection to 192.168.1.129 from 192.168.1.189 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 Jul 02 09:16:43 ifi-phmidsd-lsq-test volumio[9149]: verbose: New Socket.io Connection to 192.168.1.191 from 192.168.1.189 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 13 Jul 02 09:16:43 ifi-phmidsd-lsq-test volumio[9149]: info: Tidal Connect Service Started Jul 02 09:16:43 ifi-phmidsd-lsq-test volumio[9149]: info: Qobuz Connect Service Started Jul 02 09:16:43 ifi-phmidsd-lsq-test volumio[9149]: verbose: New Socket.io Connection to 192.168.1.129 from 192.168.1.189 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 14 Jul 02 09:16:43 ifi-phmidsd-lsq-test volumio[9149]: verbose: New Socket.io Connection to 192.168.1.191 from 192.168.1.189 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 15 Jul 02 09:16:43 ifi-phmidsd-lsq-test volumio[9149]: verbose: New Socket.io Connection to 192.168.1.129 from 192.168.1.189 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 16 Jul 02 09:16:43 ifi-phmidsd-lsq-test volumio[9149]: verbose: New Socket.io Connection to 192.168.1.129 from 192.168.1.189 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 17 Jul 02 09:16:43 ifi-phmidsd-lsq-test volumio[9149]: verbose: New Socket.io Connection to 192.168.1.191 from 192.168.1.189 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 18 Jul 02 09:16:43 ifi-phmidsd-lsq-test volumio[9149]: verbose: New Socket.io Connection to 192.168.1.191 from 192.168.1.189 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 19 Jul 02 09:16:43 ifi-phmidsd-lsq-test volumio[9149]: info: Reloading queue from file Jul 02 09:16:43 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::setRepeat undefined single undefined Jul 02 09:16:43 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::pushState Jul 02 09:16:43 ifi-phmidsd-lsq-test volumio[9149]: info: CorePlayQueue::getTrack 0 Jul 02 09:16:43 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 02 09:16:43 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::volumioPushState Jul 02 09:16:43 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 02 09:16:43 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::setRandom false Jul 02 09:16:43 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::pushState Jul 02 09:16:43 ifi-phmidsd-lsq-test volumio[9149]: info: CorePlayQueue::getTrack 0 Jul 02 09:16:43 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 02 09:16:43 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::volumioPushState Jul 02 09:16:43 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 02 09:16:44 ifi-phmidsd-lsq-test volumio[9149]: Starting albumart workers Jul 02 09:16:44 ifi-phmidsd-lsq-test volumio[9149]: Starting albumart workers Jul 02 09:16:44 ifi-phmidsd-lsq-test volumio[9149]: info: Asound.conf file unchanged, so no further update is needed Jul 02 09:16:44 ifi-phmidsd-lsq-test volumio[9149]: info: Tidal connect: Output device has changed Jul 02 09:16:44 ifi-phmidsd-lsq-test volumio[9149]: info: Output device has changed, restarting MPD Jul 02 09:16:44 ifi-phmidsd-lsq-test volumio[9149]: info: Qobuz connect: Output device has changed Jul 02 09:16:44 ifi-phmidsd-lsq-test volumio[9149]: info: Roon Ready: Output device has changed Jul 02 09:16:44 ifi-phmidsd-lsq-test volumio[9149]: info: Spotify: Output device has changed Jul 02 09:16:44 ifi-phmidsd-lsq-test volumio[9149]: info: ___________ START PLUGINS ___________ Jul 02 09:16:44 ifi-phmidsd-lsq-test sudo[9400]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 02 09:16:44 ifi-phmidsd-lsq-test sudo[9400]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 02 09:16:44 ifi-phmidsd-lsq-test volumio[9149]: info: ControllerMpd::onStart: Initializing MPD Jul 02 09:16:44 ifi-phmidsd-lsq-test volumio[9149]: info: Creating MPD Configuration file Jul 02 09:16:44 ifi-phmidsd-lsq-test sudo[9400]: pam_unix(sudo:session): session closed for user root Jul 02 09:16:44 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 02 09:16:44 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 02 09:16:44 ifi-phmidsd-lsq-test volumio[9149]: info: [1751447804261] CoreMusicLibrary::Adding element Media Servers Jul 02 09:16:44 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 02 09:16:44 ifi-phmidsd-lsq-test volumio[9149]: Starting albumart workers Jul 02 09:16:44 ifi-phmidsd-lsq-test sudo[9404]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 02 09:16:44 ifi-phmidsd-lsq-test sudo[9404]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 02 09:16:44 ifi-phmidsd-lsq-test sudo[9404]: pam_unix(sudo:session): session closed for user root Jul 02 09:16:44 ifi-phmidsd-lsq-test sudo[9406]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop mpd.socket mpd.service Jul 02 09:16:44 ifi-phmidsd-lsq-test sudo[9406]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 02 09:16:44 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 02 09:16:44 ifi-phmidsd-lsq-test volumio[9149]: info: [1751447804377] CoreMusicLibrary::Adding element Last_100 Jul 02 09:16:44 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 02 09:16:44 ifi-phmidsd-lsq-test volumio[9149]: info: Starting RoonReady Sync Jul 02 09:16:44 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 02 09:16:44 ifi-phmidsd-lsq-test volumio[9149]: info: [1751447804420] CoreMusicLibrary::Adding element Webradio Jul 02 09:16:44 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 02 09:16:44 ifi-phmidsd-lsq-test systemd[1]: mpd.socket: Succeeded. Jul 02 09:16:44 ifi-phmidsd-lsq-test systemd[1]: Closed mpd.socket. Jul 02 09:16:44 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 02 09:16:44 ifi-phmidsd-lsq-test volumio[9149]: info: Initializing BBC Radios Jul 02 09:16:44 ifi-phmidsd-lsq-test systemd[1]: Stopping Music Player Daemon... Jul 02 09:16:44 ifi-phmidsd-lsq-test sudo[9410]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-roon-ready.service Jul 02 09:16:44 ifi-phmidsd-lsq-test sudo[9410]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 02 09:16:44 ifi-phmidsd-lsq-test systemd[1]: mpd.service: Succeeded. Jul 02 09:16:44 ifi-phmidsd-lsq-test systemd[1]: Stopped Music Player Daemon. Jul 02 09:16:44 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 02 09:16:44 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 02 09:16:44 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 02 09:16:44 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 02 09:16:44 ifi-phmidsd-lsq-test sudo[9406]: pam_unix(sudo:session): session closed for user root Jul 02 09:16:44 ifi-phmidsd-lsq-test sudo[9429]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -snf /usr/local/bin/airplay2 /usr/local/bin/shairport-sync Jul 02 09:16:44 ifi-phmidsd-lsq-test sudo[9429]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 02 09:16:44 ifi-phmidsd-lsq-test node[449]: Closing connection with the client roon-ready Jul 02 09:16:44 ifi-phmidsd-lsq-test node[448]: ConvSwitch: Drop client roon-ready Jul 02 09:16:44 ifi-phmidsd-lsq-test systemd[1]: Stopping iFi Streamer Roon Ready Service... Jul 02 09:16:44 ifi-phmidsd-lsq-test sudo[9429]: pam_unix(sudo:session): session closed for user root Jul 02 09:16:44 ifi-phmidsd-lsq-test volumio[9149]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 02 09:16:44 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 02 09:16:44 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 02 09:16:44 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=killed, status=15/TERM Jul 02 09:16:44 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-roon-ready.service: Succeeded. Jul 02 09:16:44 ifi-phmidsd-lsq-test systemd[1]: Stopped iFi Streamer Roon Ready Service. Jul 02 09:16:44 ifi-phmidsd-lsq-test systemd[1]: Started iFi Streamer Roon Ready Service. Jul 02 09:16:44 ifi-phmidsd-lsq-test sudo[9410]: pam_unix(sudo:session): session closed for user root Jul 02 09:16:44 ifi-phmidsd-lsq-test volumio[9149]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 02 09:16:44 ifi-phmidsd-lsq-test volumio[9149]: info: Volumio Calling Home Jul 02 09:16:45 ifi-phmidsd-lsq-test play[9435]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: input: iFi (by AMR) iDSD PHANTOM as /devices/platform/usb@ff600000/ff600000.dwc3/xhci-hcd.0.auto/usb4/4-1/4-1.2/4-1.2:1.4/0003:20B1:3008.0010/input/input15 Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: hid-generic 0003:20B1:3008.0010: input,hidraw0: USB HID v1.11 Device [iFi (by AMR) iDSD PHANTOM] on usb-xhci-hcd.0.auto-1.2/input4 Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jul 02 09:16:45 ifi-phmidsd-lsq-test systemd-udevd[9473]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jul 02 09:16:45 ifi-phmidsd-lsq-test volumio[9149]: info: Discovery: adding 26417df3-38a8-4f75-ba8a-55b45544821c Jul 02 09:16:45 ifi-phmidsd-lsq-test volumio[9149]: info: Discovery: Found device iFi-2 Jul 02 09:16:45 ifi-phmidsd-lsq-test volumio[9149]: info: Discovery: Connecting to remote: 192.168.1.218 Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jul 02 09:16:45 ifi-phmidsd-lsq-test volumio[9149]: info: ++++--++++ getBrowseSources: null Jul 02 09:16:45 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 02 09:16:45 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::volumioGetVisibleSources Jul 02 09:16:45 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 02 09:16:45 ifi-phmidsd-lsq-test volumio[9149]: info: ++++--++++ getState Jul 02 09:16:45 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::volumioGetState Jul 02 09:16:45 ifi-phmidsd-lsq-test volumio[9149]: info: CorePlayQueue::getTrack 0 Jul 02 09:16:45 ifi-phmidsd-lsq-test volumio[9149]: info: ++++--++++ getQueue Jul 02 09:16:45 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::volumioGetQueue Jul 02 09:16:45 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::getQueue Jul 02 09:16:45 ifi-phmidsd-lsq-test volumio[9149]: info: CorePlayQueue::getQueue Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jul 02 09:16:45 ifi-phmidsd-lsq-test volumio[9149]: info: ++++--++++ listPlaylist: null Jul 02 09:16:45 ifi-phmidsd-lsq-test volumio[9149]: info: Listing playlists Jul 02 09:16:45 ifi-phmidsd-lsq-test volumio[9149]: info: ++++--++++ getMultiRoomDevices: null Jul 02 09:16:45 ifi-phmidsd-lsq-test volumio[9149]: info: ++++--++++ getMultiroom: null Jul 02 09:16:45 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 02 09:16:45 ifi-phmidsd-lsq-test volumio[9149]: error: Could not retrieve plugin audio_interface multiroom Jul 02 09:16:45 ifi-phmidsd-lsq-test volumio[9149]: info: ++++--++++ getMenuItems Jul 02 09:16:45 ifi-phmidsd-lsq-test volumio[9149]: info: ++++--++++ getMenuItems Jul 02 09:16:45 ifi-phmidsd-lsq-test node[448]: ConvSwitch: Add client roon-ready Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:45 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jul 02 09:16:46 ifi-phmidsd-lsq-test volumio[9149]: info: Cannot mount NAS testmusic at system boot, trial number 2 ,retrying in 5 seconds Jul 02 09:16:46 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jul 02 09:16:46 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jul 02 09:16:46 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:46 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jul 02 09:16:46 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jul 02 09:16:46 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:46 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jul 02 09:16:46 ifi-phmidsd-lsq-test sudo[9538]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-spotify-connect.service Jul 02 09:16:46 ifi-phmidsd-lsq-test volumio[9149]: info: Starting RoonReady Sync Jul 02 09:16:46 ifi-phmidsd-lsq-test sudo[9538]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 02 09:16:46 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jul 02 09:16:46 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jul 02 09:16:46 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:46 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jul 02 09:16:46 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jul 02 09:16:46 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:46 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jul 02 09:16:46 ifi-phmidsd-lsq-test sudo[9545]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop ifi-streamer-qobuz-connect.service Jul 02 09:16:46 ifi-phmidsd-lsq-test systemd[1]: Stopping iFi Streamer Spotify Connect Service... Jul 02 09:16:46 ifi-phmidsd-lsq-test play[6521]: 2025-07-02 09:16:46.090 E esdk select error: 4 -> Interrupted system call Jul 02 09:16:46 ifi-phmidsd-lsq-test play[6521]: 2025-07-02 09:16:46.091 I app Exiting with error = 0 Jul 02 09:16:46 ifi-phmidsd-lsq-test play[6521]: 2025-07-02 09:16:46.091 I api SpFree() Jul 02 09:16:46 ifi-phmidsd-lsq-test play[6521]: 2025-07-02 09:16:46.093 I api SpFree [returned value: 0] Jul 02 09:16:46 ifi-phmidsd-lsq-test play[6521]: [Info] ConvSwitch: ConvSwitch SDK -- v1.03 Jul 02 09:16:46 ifi-phmidsd-lsq-test play[6521]: [Info] ConvSwitch: ConvSwitchInit Jul 02 09:16:46 ifi-phmidsd-lsq-test play[6521]: [Info] MetaClient: MetaClient SDK -- v1.02 Jul 02 09:16:46 ifi-phmidsd-lsq-test play[6521]: [Info] MetaClient: MetaClientInit Jul 02 09:16:46 ifi-phmidsd-lsq-test play[6521]: [Info] ConvSwitch: ConvSwitchExit Jul 02 09:16:46 ifi-phmidsd-lsq-test play[6521]: [Info] MetaClient: MetaClientExit Jul 02 09:16:46 ifi-phmidsd-lsq-test node[448]: ConvSwitch: Drop client spotify Jul 02 09:16:46 ifi-phmidsd-lsq-test node[449]: Closing connection with the client spotify Jul 02 09:16:46 ifi-phmidsd-lsq-test sudo[9545]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 02 09:16:46 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-spotify-connect.service: Main process exited, code=killed, status=15/TERM Jul 02 09:16:46 ifi-phmidsd-lsq-test volumio[9149]: info: Discovery: adding 0a764952-50a3-46c5-aace-8fe6aecec920 Jul 02 09:16:46 ifi-phmidsd-lsq-test volumio[9149]: info: Discovery: Found device iFi-neo-eriri Jul 02 09:16:46 ifi-phmidsd-lsq-test sudo[9538]: pam_unix(sudo:session): session closed for user root Jul 02 09:16:46 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-spotify-connect.service: Succeeded. Jul 02 09:16:46 ifi-phmidsd-lsq-test systemd[1]: Stopped iFi Streamer Spotify Connect Service. Jul 02 09:16:46 ifi-phmidsd-lsq-test systemd[1]: Started iFi Streamer Spotify Connect Service. Jul 02 09:16:46 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jul 02 09:16:46 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jul 02 09:16:46 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:46 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jul 02 09:16:46 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jul 02 09:16:46 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:46 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jul 02 09:16:46 ifi-phmidsd-lsq-test volumio[9149]: info: Discovery: Connecting to remote: 192.168.1.169 Jul 02 09:16:46 ifi-phmidsd-lsq-test sudo[9550]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-roon-ready.service Jul 02 09:16:46 ifi-phmidsd-lsq-test sudo[9550]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 02 09:16:46 ifi-phmidsd-lsq-test ifi_metadata[9372]: [Info] MetaClient: MetaClient SDK -- v1.02 Jul 02 09:16:46 ifi-phmidsd-lsq-test ifi_metadata[9372]: [Info] MetaClient: MetaClientInit Jul 02 09:16:46 ifi-phmidsd-lsq-test ifi_metadata[9372]: Could not connect: Reason::CONNECTION_ERROR Jul 02 09:16:46 ifi-phmidsd-lsq-test systemd[1]: Stopping iFi Streamer Qobuz Connect Service... Jul 02 09:16:46 ifi-phmidsd-lsq-test node[448]: ConvSwitch: Drop client qobuz-connect Jul 02 09:16:46 ifi-phmidsd-lsq-test node[449]: Closing connection with the client qobuz-connect Jul 02 09:16:46 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-qobuz-connect.service: Main process exited, code=killed, status=15/TERM Jul 02 09:16:46 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-qobuz-connect.service: Succeeded. Jul 02 09:16:46 ifi-phmidsd-lsq-test systemd[1]: Stopped iFi Streamer Qobuz Connect Service. Jul 02 09:16:46 ifi-phmidsd-lsq-test volumio[9149]: info: ConvSwitch: Get message: request:pause Jul 02 09:16:46 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::volumioStop Jul 02 09:16:46 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::stop Jul 02 09:16:46 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 02 09:16:46 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::volumioStop Jul 02 09:16:46 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::stop Jul 02 09:16:46 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 02 09:16:46 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 02 09:16:46 ifi-phmidsd-lsq-test sudo[9545]: pam_unix(sudo:session): session closed for user root Jul 02 09:16:46 ifi-phmidsd-lsq-test node[448]: ConvSwitch: Drop client roon-ready Jul 02 09:16:46 ifi-phmidsd-lsq-test systemd[1]: Stopping iFi Streamer Roon Ready Service... Jul 02 09:16:46 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=killed, status=15/TERM Jul 02 09:16:46 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-roon-ready.service: Succeeded. Jul 02 09:16:46 ifi-phmidsd-lsq-test systemd[1]: Stopped iFi Streamer Roon Ready Service. Jul 02 09:16:46 ifi-phmidsd-lsq-test systemd[1]: Started iFi Streamer Roon Ready Service. Jul 02 09:16:46 ifi-phmidsd-lsq-test sudo[9550]: pam_unix(sudo:session): session closed for user root Jul 02 09:16:46 ifi-phmidsd-lsq-test volumio[9149]: info: Airplay2 Started Jul 02 09:16:46 ifi-phmidsd-lsq-test volumio[9149]: error: Could not retrieve plugin music_service airplay1_switch Jul 02 09:16:46 ifi-phmidsd-lsq-test play[9551]: output: volumio mixer: hw:0 Jul 02 09:16:46 ifi-phmidsd-lsq-test volumio[9149]: info: Disabling plugin airplay1_switch Jul 02 09:16:46 ifi-phmidsd-lsq-test volumio[9149]: info: Done. Jul 02 09:16:46 ifi-phmidsd-lsq-test node[448]: ConvSwitch: Add client spotify Jul 02 09:16:46 ifi-phmidsd-lsq-test volumio[9149]: info: RoonReady Started Jul 02 09:16:46 ifi-phmidsd-lsq-test volumio[9149]: info: MPD Permissions set Jul 02 09:16:46 ifi-phmidsd-lsq-test sudo[9572]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop shairport-sync Jul 02 09:16:46 ifi-phmidsd-lsq-test volumio[9149]: info: MPD Permissions set Jul 02 09:16:46 ifi-phmidsd-lsq-test sudo[9572]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 02 09:16:46 ifi-phmidsd-lsq-test node[449]: A new connection has been established. Jul 02 09:16:46 ifi-phmidsd-lsq-test sudo[9574]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.socket mpd.service Jul 02 09:16:46 ifi-phmidsd-lsq-test sudo[9574]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 02 09:16:46 ifi-phmidsd-lsq-test play[9551]: 2025-07-02 09:16:46.504 I api SpRegisterDebugCallbacks [returned value: 0] Jul 02 09:16:46 ifi-phmidsd-lsq-test play[9551]: 2025-07-02 09:16:46.504 I api SpInit(0xffc60110, API v66) Jul 02 09:16:46 ifi-phmidsd-lsq-test play[9551]: 2025-07-02 09:16:46.505 I esdk eSDK version: HEAD-v3.166.69-g24821f73 Jul 02 09:16:46 ifi-phmidsd-lsq-test play[9551]: 2025-07-02 09:16:46.505 I esdk Successfully registered socket callbacks: cre, set_opt, cl, bind, list, con, acc, rd, wr, rd_from, wr_to, err, readable, writable, local_addresses, address, pump Jul 02 09:16:46 ifi-phmidsd-lsq-test play[9551]: 2025-07-02 09:16:46.505 I esdk Successfully registered dns callback: dns_lookup_callback Jul 02 09:16:46 ifi-phmidsd-lsq-test play[9551]: 2025-07-02 09:16:46.505 I download Using 128 kB for cache buffer Jul 02 09:16:46 ifi-phmidsd-lsq-test play[9551]: 2025-07-02 09:16:46.505 I download Using 621 kB for compressed audio buffer Jul 02 09:16:46 ifi-phmidsd-lsq-test play[9551]: 2025-07-02 09:16:46.505 I esdk Successfully registered error callback Jul 02 09:16:46 ifi-phmidsd-lsq-test play[9551]: 2025-07-02 09:16:46.524 I esdk Creating IPv4 socket (domain 2) Jul 02 09:16:46 ifi-phmidsd-lsq-test play[9551]: 2025-07-02 09:16:46.525 I zc webserver: service port 5566 (5566-5576) buffer size 4444 Jul 02 09:16:46 ifi-phmidsd-lsq-test play[9551]: 2025-07-02 09:16:46.526 I zc Started ZeroConf service on port 5566 path /zc alias count 0 Jul 02 09:16:46 ifi-phmidsd-lsq-test play[9551]: 2025-07-02 09:16:46.527 I esdk Creating IPv4 socket (domain 2) Jul 02 09:16:46 ifi-phmidsd-lsq-test play[9551]: 2025-07-02 09:16:46.528 I api SpInit [returned value: 0] Jul 02 09:16:46 ifi-phmidsd-lsq-test play[9551]: 2025-07-02 09:16:46.529 I api SpRegisterConnectionCallbacks(0xffc600f8, (nil)) Jul 02 09:16:46 ifi-phmidsd-lsq-test play[9551]: 2025-07-02 09:16:46.530 I esdk Successfully registered connection callbacks: on_notify, on_message, on_new_credentials Jul 02 09:16:46 ifi-phmidsd-lsq-test play[9551]: 2025-07-02 09:16:46.531 I api SpRegisterConnectionCallbacks [returned value: 0] Jul 02 09:16:46 ifi-phmidsd-lsq-test play[9551]: 2025-07-02 09:16:46.532 I api SpRegisterPlaybackCallbacks(0xffc600e0, (nil)) Jul 02 09:16:46 ifi-phmidsd-lsq-test play[9551]: 2025-07-02 09:16:46.533 I esdk Successfully registered playback callbacks: on_notify, on_audio_data, on_seek, on_apply_volume, - Jul 02 09:16:46 ifi-phmidsd-lsq-test play[9551]: 2025-07-02 09:16:46.534 I api SpRegisterPlaybackCallbacks [returned value: 0] Jul 02 09:16:46 ifi-phmidsd-lsq-test play[9551]: 2025-07-02 09:16:46.552 W app Couldn't find mixer for volume controls. (tried , SoftMaster) Jul 02 09:16:46 ifi-phmidsd-lsq-test play[9551]: 2025-07-02 09:16:46.567 I app Initialized! Jul 02 09:16:46 ifi-phmidsd-lsq-test sudo[9579]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop mpd.socket mpd.service Jul 02 09:16:46 ifi-phmidsd-lsq-test sudo[9579]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 02 09:16:46 ifi-phmidsd-lsq-test systemd[1]: Listening on mpd.socket. Jul 02 09:16:46 ifi-phmidsd-lsq-test systemd[1]: Starting Music Player Daemon... Jul 02 09:16:46 ifi-phmidsd-lsq-test systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 02 09:16:46 ifi-phmidsd-lsq-test systemd[1]: shairport-sync.service: Succeeded. Jul 02 09:16:46 ifi-phmidsd-lsq-test systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 02 09:16:46 ifi-phmidsd-lsq-test node[448]: ConvSwitch: Add client tidal Jul 02 09:16:46 ifi-phmidsd-lsq-test sudo[9572]: pam_unix(sudo:session): session closed for user root Jul 02 09:16:46 ifi-phmidsd-lsq-test tidal_connect_application[9553]: *** WARNING *** The program 'tidal_connect_application' uses the Apple Bonjour compatibility layer of Avahi. Jul 02 09:16:46 ifi-phmidsd-lsq-test tidal_connect_application[9553]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 02 09:16:46 ifi-phmidsd-lsq-test tidal_connect_application[9553]: *** WARNING *** For more information see Jul 02 09:16:46 ifi-phmidsd-lsq-test sudo[9574]: pam_unix(sudo:session): session closed for user root Jul 02 09:16:46 ifi-phmidsd-lsq-test systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jul 02 09:16:46 ifi-phmidsd-lsq-test systemd[1]: mpd.service: Succeeded. Jul 02 09:16:46 ifi-phmidsd-lsq-test systemd[1]: Stopped Music Player Daemon. Jul 02 09:16:46 ifi-phmidsd-lsq-test systemd[1]: mpd.socket: Succeeded. Jul 02 09:16:46 ifi-phmidsd-lsq-test ifi_metadata[9372]: Connected Jul 02 09:16:46 ifi-phmidsd-lsq-test systemd[1]: Closed mpd.socket. Jul 02 09:16:46 ifi-phmidsd-lsq-test volumio[9149]: info: RoonReady Started Jul 02 09:16:46 ifi-phmidsd-lsq-test volumio[9149]: info: Spotify Connect Service Started Jul 02 09:16:46 ifi-phmidsd-lsq-test sudo[9579]: pam_unix(sudo:session): session closed for user root Jul 02 09:16:46 ifi-phmidsd-lsq-test volumio[9149]: info: Jul 02 09:16:46 ifi-phmidsd-lsq-test volumio[9149]: ---------------------------- Client requests Start RoonReady PlaybackRoutine Jul 02 09:16:46 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: roon_ready , startRoonReadyPlayback Jul 02 09:16:46 ifi-phmidsd-lsq-test volumio[9149]: info: Roon Ready playback start Jul 02 09:16:46 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::volumioStop Jul 02 09:16:46 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::stop Jul 02 09:16:46 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 02 09:16:46 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 02 09:16:46 ifi-phmidsd-lsq-test volumio[9149]: info: Starting Roon Ready metadata receiver Jul 02 09:16:46 ifi-phmidsd-lsq-test volumio[9149]: Error adding Membership: Error: addMembership EINVAL Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 20 Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: error: Cannot start MPD on system Start: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.socket mpd.service Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: Job for mpd.service canceled. Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: info: Completed starting Core Plugins Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: [Metrics] CommandRouter: 10s 829.87ms Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::Close All Modals sent Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::volumiosetStartupVolume Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: info: VolumeController::SetAlsaVolume70 Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveCurrentVolume Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::pushState Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: info: CorePlayQueue::getTrack 0 Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::volumioPushState Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: info: Shairport-Sync Stopped Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: error: connect ECONNREFUSED /run/mpd/socket {"errno":-111,"code":"ECONNREFUSED","syscall":"connect","address":"/run/mpd/socket"} Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 02 09:16:47 ifi-phmidsd-lsq-test sudo[9605]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-tidal-connect.service Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 02 09:16:47 ifi-phmidsd-lsq-test sudo[9605]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 02 09:16:47 ifi-phmidsd-lsq-test demo[7098]: MPD error: Connection refused Jul 02 09:16:47 ifi-phmidsd-lsq-test demo[7098]: MPD error: Connection refused Jul 02 09:16:47 ifi-phmidsd-lsq-test node[449]: Closing connection with the client tidal-connect Jul 02 09:16:47 ifi-phmidsd-lsq-test systemd[1]: Stopping iFi Streamer Tidal Metadata Service... Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 02 09:16:47 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-tidal-metadata.service: Main process exited, code=killed, status=15/TERM Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 02 09:16:47 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-tidal-metadata.service: Succeeded. Jul 02 09:16:47 ifi-phmidsd-lsq-test systemd[1]: Stopped iFi Streamer Tidal Metadata Service. Jul 02 09:16:47 ifi-phmidsd-lsq-test systemd[1]: Stopping iFi Streamer Tidal Connect Service... Jul 02 09:16:47 ifi-phmidsd-lsq-test node[448]: ConvSwitch: Drop client tidal Jul 02 09:16:47 ifi-phmidsd-lsq-test play[9563]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input Jul 02 09:16:47 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-tidal-connect.service: Main process exited, code=killed, status=15/TERM Jul 02 09:16:47 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-tidal-connect.service: Succeeded. Jul 02 09:16:47 ifi-phmidsd-lsq-test systemd[1]: Stopped iFi Streamer Tidal Connect Service. Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 02 09:16:47 ifi-phmidsd-lsq-test systemd[1]: Started iFi Streamer Tidal Connect Service. Jul 02 09:16:47 ifi-phmidsd-lsq-test sudo[9605]: pam_unix(sudo:session): session closed for user root Jul 02 09:16:47 ifi-phmidsd-lsq-test systemd[1]: Started iFi Streamer Tidal Metadata Service. Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 02 09:16:47 ifi-phmidsd-lsq-test node[449]: A new connection has been established. Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: error: Could not retrieve plugin audio_interface multiroom Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: info: Discovery: Connected to remote: 192.168.1.218 Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: error: Could not retrieve plugin audio_interface multiroom Jul 02 09:16:47 ifi-phmidsd-lsq-test node[448]: ConvSwitch: Add client roon-ready Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: info: Volumio called home Jul 02 09:16:47 ifi-phmidsd-lsq-test sudo[9687]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.socket mpd.service Jul 02 09:16:47 ifi-phmidsd-lsq-test sudo[9687]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: info: Discovery: adding 7a2a87ae-9864-4896-b72d-e2751dd260de Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: info: Discovery: Found device lsq-test Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::volumioGetState Jul 02 09:16:47 ifi-phmidsd-lsq-test sudo[9691]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start ifi-streamer-qobuz-connect.service Jul 02 09:16:47 ifi-phmidsd-lsq-test sudo[9691]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 02 09:16:47 ifi-phmidsd-lsq-test volumio[9149]: error: Could not retrieve plugin audio_interface multiroom Jul 02 09:16:47 ifi-phmidsd-lsq-test systemd[1]: Listening on mpd.socket. Jul 02 09:16:48 ifi-phmidsd-lsq-test systemd[1]: Starting Music Player Daemon... Jul 02 09:16:48 ifi-phmidsd-lsq-test systemd[1]: Started iFi Streamer Qobuz Connect Service. Jul 02 09:16:48 ifi-phmidsd-lsq-test sudo[9691]: pam_unix(sudo:session): session closed for user root Jul 02 09:16:48 ifi-phmidsd-lsq-test volumio[9149]: error: Could not retrieve plugin audio_interface multiroom Jul 02 09:16:48 ifi-phmidsd-lsq-test volumio[9149]: info: Discovery: Connected to remote: 192.168.1.169 Jul 02 09:16:48 ifi-phmidsd-lsq-test volumio[9149]: error: Could not retrieve plugin audio_interface multiroom Jul 02 09:16:48 ifi-phmidsd-lsq-test sudo[9693]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 02 09:16:48 ifi-phmidsd-lsq-test sudo[9693]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 02 09:16:48 ifi-phmidsd-lsq-test volumio[9149]: info: ConvSwitch: Get message: request:pause Jul 02 09:16:48 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::volumioStop Jul 02 09:16:48 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::stop Jul 02 09:16:48 ifi-phmidsd-lsq-test sudo[9693]: pam_unix(sudo:session): session closed for user root Jul 02 09:16:48 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::serviceStop Jul 02 09:16:48 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::serviceStop Jul 02 09:16:48 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::volumioStop Jul 02 09:16:48 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::stop Jul 02 09:16:48 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 02 09:16:48 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 02 09:16:48 ifi-phmidsd-lsq-test volumio[9149]: info: Roon Ready Stop Jul 02 09:16:48 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::volumioStop Jul 02 09:16:48 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::stop Jul 02 09:16:48 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 02 09:16:48 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:48.253 [9714.9714] DEBUG SampleApp: Starting sample application Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:48.254 [9714.9714] DEBUG SampleApp: Device Name: lsq-test Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:48.254 [9714.9714] DEBUG SampleApp: Manufacturer: Sample manufacturer Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:48.254 [9714.9714] DEBUG SampleApp: Model: iFi Streamer Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:48.254 [9714.9714] DEBUG SampleApp: Serial Number: ifi:32:ef:95:fd:98:7f Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:48.254 [9714.9714] DEBUG SampleApp: Application ID: 679318972 Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:48.254 [9714.9714] DEBUG SampleApp: Application Secret: a32fe515ff9d11ffafcb2b2a1426c244 Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:48.254 [9714.9714] DEBUG SampleApp: Audio output device: volumio Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:48.254 [9714.9714] DEBUG SampleApp: Volume control device: default Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:48.254 [9714.9714] DEBUG SampleApp: Volume control element: Master Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:48.254 [9714.9714] DEBUG SampleApp: Local config server port: 8000 Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:48.260 [9714.9714] ERROR SampleApp: Unable to find ALSA mixer element 'Master' on index 0 Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:48.261 [9714.9714] DEBUG SampleApp: Maximum supported audio quality: HIRES_L3 Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: [Info] MetaClient: MetaClient SDK -- v1.02 Jul 02 09:16:48 ifi-phmidsd-lsq-test node[449]: A new connection has been established. Jul 02 09:16:48 ifi-phmidsd-lsq-test volumio[9149]: info: Tidal Connect Service Started Jul 02 09:16:48 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jul 02 09:16:48 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: [Info] MetaClient: MetaClientInit Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: [Info] ConvSwitch: ConvSwitch SDK -- v1.03 Jul 02 09:16:48 ifi-phmidsd-lsq-test node[448]: ConvSwitch: Add client qobuz-connect Jul 02 09:16:48 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: [Info] ConvSwitch: ConvSwitchInit Jul 02 09:16:48 ifi-phmidsd-lsq-test volumio[9149]: info: Qobuz Connect Service Started Jul 02 09:16:48 ifi-phmidsd-lsq-test volumio[9149]: info: Starting Shairport Sync Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:48.368 [9714.9714] DEBUG ActiveStateManager: [0xab1c4970]: Creating new Active State Manager Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:48.369 [9714.9714] DEBUG NetworkActivityTracker: [0xab1c49e0]: Creating new Network Activity Tracker Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:48.370 [9714.9714] DEBUG EndpointManager: [0xab1c5958]: Creating Endpoint Manager Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:48.370 [9714.9714] DEBUG PlaybackSessionManager: [0xab1c5d48]: Creating Playback Session Manager Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:48.370 [9714.9714] DEBUG BackoffTimer: [0xab1c5ec0]: Creating Backoff Timer Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:48.371 [9714.9714] DEBUG MediaEngine: [0xab1c5fe0]: Creating new Media Engine Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:48.371 [9714.9714] DEBUG AudioRenderer: [0xab1c6200]: Creating Audio Renderer Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:48.371 [9714.9714] TRACE MediaEngineCommandSequencer: [0xab1c6358]: Creating Media Engine Command Sequencer Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:48.371 [9714.9714] DEBUG PlaybackControlsManager: [0xab1c63b8]: Creating new Playback Controls Manager Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:48.371 [9714.9714] DEBUG VolumeManager: [0xab1c6448]: Creating new Volume Manager Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:48.371 [9714.9714] DEBUG ProtocolHandler: [0xab1c6720]: Creating Protocol Handler Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:48.371 [9714.9714] DEBUG MessageReceiver: [0xab1c67c0]: Creating Message Receiver Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:48.371 [9714.9714] DEBUG RendererActivationController: [0xab1c6938]: Creating new Renderer Activation Controller Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:48.371 [9714.9714] TRACE RendererActivationCommandSequencer: [0xab1c69e0]: Creating Renderer Activation Command Sequencer Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:48.371 [9714.9714] DEBUG ReportingManager: [0xab1c6af0]: Creating new Reporting Manager Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:48.371 [9714.9714] DEBUG StreamingEventReporter: [0xab1c6b38]: Creating Streaming Event Reporter Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:48.371 [9714.9714] DEBUG BackoffTimer: [0xab1c6c18]: Creating Backoff Timer Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:48.371 [9714.9714] DEBUG TokenExpiryController: [0xab1c6d28]: Creating Token Expiry Controller Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:48.371 [9714.9714] DEBUG UserInactivityManager: [0xab1c6d78]: Creating new User Inactivity Manager Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:48.371 [9714.9714] INFO VolumeManager: [0xab1c6448]: Setting new playback volume: 100 Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:48.371 [9714.9714] INFO VolumeManager: [0xab1c6448]: Setting new mute state: 1 Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:48.371 [9714.9714] DEBUG SampleApp: Qobuz Connect has been initialized Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:48.371 [9714.9714] TRACE SampleApp: Running event loop Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:48.371 [9714.9714] INFO QobuzConnect: [0xab1c6e18]: Client initialized! Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:48.371 [9714.9714] INFO SampleApp: Starting Avahi advertising, name: lsq-test, service name: _qobuz-connect._tcp Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:48.387 [9714.9714] DEBUG SampleApp: Avahi client state changed: RUNNING Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:48.392 [9714.9714] DEBUG SampleApp: Avahi entry group state changed: UNCOMMITED Jul 02 09:16:48 ifi-phmidsd-lsq-test volumio[9149]: info: Starting Shairport Sync Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:48.405 [9714.9714] INFO LocalConfigManager: [0xab1c5d28]: Starting Local Configuration server Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:48.406 [9714.9714] INFO SampleApp: Starting Local configuration server Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:48.408 [9714.9714] INFO SampleApp: Playback mute state changed: 1 Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:48.409 [9714.9714] ERROR SampleApp: Unable to set mute state, no ALSA volume element Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:48.411 [9714.9714] DEBUG SampleApp: Avahi entry group state changed: REGISTERING Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:48.412 [9714.9714] INFO SampleApp: Playback volume changed: 100 Jul 02 09:16:48 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:48.412 [9714.9714] ERROR SampleApp: Unable to set volume, no ALSA volume element Jul 02 09:16:48 ifi-phmidsd-lsq-test volumio[9149]: info: Jul 02 09:16:48 ifi-phmidsd-lsq-test volumio[9149]: ---------------------------- Client requests Start RoonReady PlaybackRoutine Jul 02 09:16:48 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: roon_ready , startRoonReadyPlayback Jul 02 09:16:48 ifi-phmidsd-lsq-test volumio[9149]: info: Roon Ready playback start Jul 02 09:16:48 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::volumioStop Jul 02 09:16:48 ifi-phmidsd-lsq-test sudo[9721]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 02 09:16:48 ifi-phmidsd-lsq-test sudo[9721]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 02 09:16:48 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::stop Jul 02 09:16:48 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 02 09:16:48 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 02 09:16:48 ifi-phmidsd-lsq-test volumio[9149]: info: Roon Ready metadata receiver is on Jul 02 09:16:48 ifi-phmidsd-lsq-test sudo[9730]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 02 09:16:48 ifi-phmidsd-lsq-test sudo[9730]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 02 09:16:48 ifi-phmidsd-lsq-test systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 02 09:16:48 ifi-phmidsd-lsq-test sudo[9721]: pam_unix(sudo:session): session closed for user root Jul 02 09:16:48 ifi-phmidsd-lsq-test volumio[9149]: info: ++++--++++ getState Jul 02 09:16:48 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::volumioGetState Jul 02 09:16:48 ifi-phmidsd-lsq-test volumio[9149]: info: CorePlayQueue::getTrack 0 Jul 02 09:16:48 ifi-phmidsd-lsq-test systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 02 09:16:48 ifi-phmidsd-lsq-test systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Jul 02 09:16:48 ifi-phmidsd-lsq-test systemd[1]: shairport-sync.service: Succeeded. Jul 02 09:16:48 ifi-phmidsd-lsq-test systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 02 09:16:48 ifi-phmidsd-lsq-test systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 02 09:16:48 ifi-phmidsd-lsq-test sudo[9730]: pam_unix(sudo:session): session closed for user root Jul 02 09:16:48 ifi-phmidsd-lsq-test volumio[9149]: info: Shairport-Sync Started Jul 02 09:16:48 ifi-phmidsd-lsq-test volumio[9149]: Error adding Membership: Error: addMembership EINVAL Jul 02 09:16:48 ifi-phmidsd-lsq-test volumio[9149]: error: Could not retrieve plugin audio_interface multiroom Jul 02 09:16:48 ifi-phmidsd-lsq-test volumio[9149]: info: Shairport-Sync Started Jul 02 09:16:48 ifi-phmidsd-lsq-test volumio[9149]: error: Could not retrieve plugin audio_interface multiroom Jul 02 09:16:48 ifi-phmidsd-lsq-test ethernet-detect[469]: No change in avahi-daemon interfaces. Skipping restart. Jul 02 09:16:49 ifi-phmidsd-lsq-test sudo[9780]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-spotify-connect.service Jul 02 09:16:49 ifi-phmidsd-lsq-test sudo[9780]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 02 09:16:49 ifi-phmidsd-lsq-test play[9551]: 2025-07-02 09:16:49.186 E esdk select error: 4 -> Interrupted system call Jul 02 09:16:49 ifi-phmidsd-lsq-test play[9551]: 2025-07-02 09:16:49.188 I app Exiting with error = 0 Jul 02 09:16:49 ifi-phmidsd-lsq-test play[9551]: 2025-07-02 09:16:49.188 I api SpFree() Jul 02 09:16:49 ifi-phmidsd-lsq-test play[9551]: 2025-07-02 09:16:49.189 I api SpFree [returned value: 0] Jul 02 09:16:49 ifi-phmidsd-lsq-test play[9551]: [Info] ConvSwitch: ConvSwitch SDK -- v1.03 Jul 02 09:16:49 ifi-phmidsd-lsq-test play[9551]: [Info] ConvSwitch: ConvSwitchInit Jul 02 09:16:49 ifi-phmidsd-lsq-test play[9551]: [Info] MetaClient: MetaClient SDK -- v1.02 Jul 02 09:16:49 ifi-phmidsd-lsq-test play[9551]: [Info] MetaClient: MetaClientInit Jul 02 09:16:49 ifi-phmidsd-lsq-test play[9551]: [Info] ConvSwitch: ConvSwitchExit Jul 02 09:16:49 ifi-phmidsd-lsq-test play[9551]: [Info] MetaClient: MetaClientExit Jul 02 09:16:49 ifi-phmidsd-lsq-test node[449]: Closing connection with the client spotify Jul 02 09:16:49 ifi-phmidsd-lsq-test node[448]: ConvSwitch: Drop client spotify Jul 02 09:16:49 ifi-phmidsd-lsq-test systemd[1]: Stopping iFi Streamer Spotify Connect Service... Jul 02 09:16:49 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-spotify-connect.service: Main process exited, code=killed, status=15/TERM Jul 02 09:16:49 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-spotify-connect.service: Succeeded. Jul 02 09:16:49 ifi-phmidsd-lsq-test systemd[1]: Stopped iFi Streamer Spotify Connect Service. Jul 02 09:16:49 ifi-phmidsd-lsq-test systemd[1]: Started iFi Streamer Spotify Connect Service. Jul 02 09:16:49 ifi-phmidsd-lsq-test sudo[9780]: pam_unix(sudo:session): session closed for user root Jul 02 09:16:49 ifi-phmidsd-lsq-test volumio[9149]: info: Spotify Connect Service Started Jul 02 09:16:49 ifi-phmidsd-lsq-test play[9694]: 20250702 09:16:49.274 [9714.9714] DEBUG SampleApp: Avahi entry group state changed: ESTABLISHED Jul 02 09:16:49 ifi-phmidsd-lsq-test play[9782]: output: volumio mixer: hw:0 Jul 02 09:16:49 ifi-phmidsd-lsq-test node[448]: ConvSwitch: Add client spotify Jul 02 09:16:49 ifi-phmidsd-lsq-test node[449]: A new connection has been established. Jul 02 09:16:49 ifi-phmidsd-lsq-test node[448]: ConvSwitch: Drop client roon-ready Jul 02 09:16:49 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=exited, status=1/FAILURE Jul 02 09:16:49 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-roon-ready.service: Failed with result 'exit-code'. Jul 02 09:16:49 ifi-phmidsd-lsq-test play[9782]: 2025-07-02 09:16:49.463 I api SpRegisterDebugCallbacks [returned value: 0] Jul 02 09:16:49 ifi-phmidsd-lsq-test play[9782]: 2025-07-02 09:16:49.464 I api SpInit(0xff870590, API v66) Jul 02 09:16:49 ifi-phmidsd-lsq-test play[9782]: 2025-07-02 09:16:49.464 I esdk eSDK version: HEAD-v3.166.69-g24821f73 Jul 02 09:16:49 ifi-phmidsd-lsq-test play[9782]: 2025-07-02 09:16:49.464 I esdk Successfully registered socket callbacks: cre, set_opt, cl, bind, list, con, acc, rd, wr, rd_from, wr_to, err, readable, writable, local_addresses, address, pump Jul 02 09:16:49 ifi-phmidsd-lsq-test play[9782]: 2025-07-02 09:16:49.465 I esdk Successfully registered dns callback: dns_lookup_callback Jul 02 09:16:49 ifi-phmidsd-lsq-test play[9782]: 2025-07-02 09:16:49.465 I download Using 128 kB for cache buffer Jul 02 09:16:49 ifi-phmidsd-lsq-test play[9782]: 2025-07-02 09:16:49.465 I download Using 621 kB for compressed audio buffer Jul 02 09:16:49 ifi-phmidsd-lsq-test play[9782]: 2025-07-02 09:16:49.465 I esdk Successfully registered error callback Jul 02 09:16:49 ifi-phmidsd-lsq-test play[9782]: 2025-07-02 09:16:49.485 I esdk Creating IPv4 socket (domain 2) Jul 02 09:16:49 ifi-phmidsd-lsq-test play[9782]: 2025-07-02 09:16:49.495 I zc webserver: service port 5566 (5566-5576) buffer size 4444 Jul 02 09:16:49 ifi-phmidsd-lsq-test play[9782]: 2025-07-02 09:16:49.500 I zc Started ZeroConf service on port 5566 path /zc alias count 0 Jul 02 09:16:49 ifi-phmidsd-lsq-test play[9782]: 2025-07-02 09:16:49.501 I esdk Creating IPv4 socket (domain 2) Jul 02 09:16:49 ifi-phmidsd-lsq-test play[9782]: 2025-07-02 09:16:49.502 I api SpInit [returned value: 0] Jul 02 09:16:49 ifi-phmidsd-lsq-test play[9782]: 2025-07-02 09:16:49.505 I api SpRegisterConnectionCallbacks(0xff870578, (nil)) Jul 02 09:16:49 ifi-phmidsd-lsq-test play[9782]: 2025-07-02 09:16:49.506 I esdk Successfully registered connection callbacks: on_notify, on_message, on_new_credentials Jul 02 09:16:49 ifi-phmidsd-lsq-test play[9782]: 2025-07-02 09:16:49.507 I api SpRegisterConnectionCallbacks [returned value: 0] Jul 02 09:16:49 ifi-phmidsd-lsq-test play[9782]: 2025-07-02 09:16:49.510 I api SpRegisterPlaybackCallbacks(0xff870560, (nil)) Jul 02 09:16:49 ifi-phmidsd-lsq-test play[9782]: 2025-07-02 09:16:49.511 I esdk Successfully registered playback callbacks: on_notify, on_audio_data, on_seek, on_apply_volume, - Jul 02 09:16:49 ifi-phmidsd-lsq-test play[9782]: 2025-07-02 09:16:49.512 I api SpRegisterPlaybackCallbacks [returned value: 0] Jul 02 09:16:49 ifi-phmidsd-lsq-test play[9782]: 2025-07-02 09:16:49.522 W app Couldn't find mixer for volume controls. (tried , SoftMaster) Jul 02 09:16:49 ifi-phmidsd-lsq-test play[9782]: 2025-07-02 09:16:49.523 I app Initialized! Jul 02 09:16:49 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jul 02 09:16:49 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jul 02 09:16:49 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:49 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jul 02 09:16:49 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jul 02 09:16:49 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:49 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jul 02 09:16:49 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jul 02 09:16:49 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jul 02 09:16:49 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:49 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jul 02 09:16:49 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jul 02 09:16:49 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:49 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jul 02 09:16:49 ifi-phmidsd-lsq-test kernel: input: iFi (by AMR) iDSD PHANTOM as /devices/platform/usb@ff600000/ff600000.dwc3/xhci-hcd.0.auto/usb4/4-1/4-1.2/4-1.2:1.4/0003:20B1:3008.0011/input/input16 Jul 02 09:16:49 ifi-phmidsd-lsq-test kernel: hid-generic 0003:20B1:3008.0011: input,hidraw0: USB HID v1.11 Device [iFi (by AMR) iDSD PHANTOM] on usb-xhci-hcd.0.auto-1.2/input4 Jul 02 09:16:49 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jul 02 09:16:49 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jul 02 09:16:49 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:49 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jul 02 09:16:49 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jul 02 09:16:49 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:49 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jul 02 09:16:49 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jul 02 09:16:49 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jul 02 09:16:49 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:49 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jul 02 09:16:49 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jul 02 09:16:49 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:49 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jul 02 09:16:49 ifi-phmidsd-lsq-test sudo[9826]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 02 09:16:49 ifi-phmidsd-lsq-test sudo[9826]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 02 09:16:49 ifi-phmidsd-lsq-test sudo[9826]: pam_unix(sudo:session): session closed for user root Jul 02 09:16:49 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jul 02 09:16:49 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jul 02 09:16:49 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:49 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jul 02 09:16:49 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jul 02 09:16:49 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:49 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jul 02 09:16:49 ifi-phmidsd-lsq-test sudo[9832]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 02 09:16:49 ifi-phmidsd-lsq-test sudo[9832]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 02 09:16:49 ifi-phmidsd-lsq-test sudo[9834]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart upmpdcli.service Jul 02 09:16:49 ifi-phmidsd-lsq-test sudo[9832]: pam_unix(sudo:session): session closed for user root Jul 02 09:16:49 ifi-phmidsd-lsq-test sudo[9834]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 02 09:16:50 ifi-phmidsd-lsq-test systemd-udevd[9823]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jul 02 09:16:50 ifi-phmidsd-lsq-test systemd[1]: Stopping UPnP Renderer front-end to MPD... Jul 02 09:16:50 ifi-phmidsd-lsq-test systemd[1]: upmpdcli.service: Succeeded. Jul 02 09:16:50 ifi-phmidsd-lsq-test systemd[1]: Stopped UPnP Renderer front-end to MPD. Jul 02 09:16:50 ifi-phmidsd-lsq-test systemd[1]: Started UPnP Renderer front-end to MPD. Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jul 02 09:16:50 ifi-phmidsd-lsq-test sudo[9834]: pam_unix(sudo:session): session closed for user root Jul 02 09:16:50 ifi-phmidsd-lsq-test volumio[9149]: info: Upmpdcli Daemon Started Jul 02 09:16:50 ifi-phmidsd-lsq-test volumio[9149]: info: ++++--++++ pluginManager: {"name":"ifi-cdplayer","category":"music_service","action":"enable"} Jul 02 09:16:50 ifi-phmidsd-lsq-test volumio[9149]: info: Enabling plugin ifi-cdplayer Jul 02 09:16:50 ifi-phmidsd-lsq-test volumio[9149]: info: Loading plugin "ifi-cdplayer"... Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:50 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jul 02 09:16:50 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-roon-ready.service: Service RestartSec=1s expired, scheduling restart. Jul 02 09:16:50 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-roon-ready.service: Scheduled restart job, restart counter is at 1. Jul 02 09:16:50 ifi-phmidsd-lsq-test systemd[1]: Stopped iFi Streamer Roon Ready Service. Jul 02 09:16:50 ifi-phmidsd-lsq-test systemd[1]: Started iFi Streamer Roon Ready Service. Jul 02 09:16:50 ifi-phmidsd-lsq-test ifi_metadata[9637]: [Info] MetaClient: MetaClient SDK -- v1.02 Jul 02 09:16:50 ifi-phmidsd-lsq-test ifi_metadata[9637]: [Info] MetaClient: MetaClientInit Jul 02 09:16:50 ifi-phmidsd-lsq-test ifi_metadata[9637]: Could not connect: Reason::CONNECTION_ERROR Jul 02 09:16:50 ifi-phmidsd-lsq-test volumio[9149]: info: Applying required configuration parameters for plugin ifi-cdplayer Jul 02 09:16:50 ifi-phmidsd-lsq-test volumio[9149]: info: PLUGIN START: ifi-cdplayer Jul 02 09:16:50 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 02 09:16:50 ifi-phmidsd-lsq-test volumio[9149]: info: [1751447810861] CoreMusicLibrary::Adding element Audio CD/DVD Jul 02 09:16:50 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 02 09:16:50 ifi-phmidsd-lsq-test volumio[9149]: Cannot find translation for source Audio CD/DVD Jul 02 09:16:50 ifi-phmidsd-lsq-test sudo[9866]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-cdplayer.service Jul 02 09:16:50 ifi-phmidsd-lsq-test sudo[9866]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 02 09:16:50 ifi-phmidsd-lsq-test node[448]: ConvSwitch: Add client tidal Jul 02 09:16:51 ifi-phmidsd-lsq-test tidal_connect_application[9860]: *** WARNING *** The program 'tidal_connect_application' uses the Apple Bonjour compatibility layer of Avahi. Jul 02 09:16:51 ifi-phmidsd-lsq-test tidal_connect_application[9860]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 02 09:16:51 ifi-phmidsd-lsq-test tidal_connect_application[9860]: *** WARNING *** For more information see Jul 02 09:16:51 ifi-phmidsd-lsq-test systemd[1]: Started iFi Streamer ifi cdplayer server daemon. Jul 02 09:16:51 ifi-phmidsd-lsq-test sudo[9866]: pam_unix(sudo:session): session closed for user root Jul 02 09:16:51 ifi-phmidsd-lsq-test ifi_metadata[9637]: Connected Jul 02 09:16:51 ifi-phmidsd-lsq-test play[9627]: /usr/ifi/ifi-tidal-release/play: line 70: 9860 Segmentation fault ${SAME_DIR}bin/tidal_connect_application --netif-for-deviceid eth0 -f "${BROADCAST_NAME}" --codec-mpegh true --codec-mqa true --model-name "iFi Streamer" --disable-app-security false --disable-web-security false --enable-mqa-passthrough "${PASSTHROUGH_MQA}" --playback-device "${OUTPUT}" --log-level ${LOG_LEVEL} >> /var/log/tidal.log 2>&1 Jul 02 09:16:51 ifi-phmidsd-lsq-test node[448]: ConvSwitch: Drop client tidal Jul 02 09:16:51 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-tidal-connect.service: Main process exited, code=exited, status=139/n/a Jul 02 09:16:51 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-tidal-connect.service: Failed with result 'exit-code'. Jul 02 09:16:51 ifi-phmidsd-lsq-test volumio[9149]: info: CDClient: Client Start Jul 02 09:16:51 ifi-phmidsd-lsq-test volumio[9149]: info: Done. Jul 02 09:16:51 ifi-phmidsd-lsq-test volumio[9149]: info: Cannot mount NAS testmusic at system boot, trial number 3 ,retrying in 5 seconds Jul 02 09:16:51 ifi-phmidsd-lsq-test volumio[9149]: error: CDClient: Socket error: Error: connect ECONNREFUSED /tmp/cdplayer.sock Jul 02 09:16:51 ifi-phmidsd-lsq-test volumio[9149]: New connection from ::ffff:127.0.0.1:53200 Jul 02 09:16:51 ifi-phmidsd-lsq-test volumio[9149]: info: cdplayer Service Started Jul 02 09:16:51 ifi-phmidsd-lsq-test ifi_metadata[9637]: Disconnected: Reason::DISCONNECTED Jul 02 09:16:51 ifi-phmidsd-lsq-test volumio[9149]: warn: CDClient: Closed from server Jul 02 09:16:51 ifi-phmidsd-lsq-test volumio[9149]: Connected to MPD server Jul 02 09:16:51 ifi-phmidsd-lsq-test play[9861]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input Jul 02 09:16:51 ifi-phmidsd-lsq-test node[448]: ConvSwitch: Add client roon-ready Jul 02 09:16:51 ifi-phmidsd-lsq-test volumio[9149]: info: ConvSwitch: Get message: request:pause Jul 02 09:16:51 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::volumioStop Jul 02 09:16:51 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::stop Jul 02 09:16:51 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::serviceStop Jul 02 09:16:51 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::serviceStop Jul 02 09:16:51 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::volumioStop Jul 02 09:16:51 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::stop Jul 02 09:16:51 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 02 09:16:51 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 02 09:16:51 ifi-phmidsd-lsq-test volumio[9149]: info: Roon Ready Stop Jul 02 09:16:51 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::volumioStop Jul 02 09:16:51 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::stop Jul 02 09:16:51 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 02 09:16:51 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 02 09:16:51 ifi-phmidsd-lsq-test volumio[9149]: info: Jul 02 09:16:51 ifi-phmidsd-lsq-test volumio[9149]: ---------------------------- Client requests Start RoonReady PlaybackRoutine Jul 02 09:16:51 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: roon_ready , startRoonReadyPlayback Jul 02 09:16:51 ifi-phmidsd-lsq-test volumio[9149]: info: Roon Ready playback start Jul 02 09:16:51 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::volumioStop Jul 02 09:16:51 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::stop Jul 02 09:16:51 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 02 09:16:51 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 02 09:16:51 ifi-phmidsd-lsq-test volumio[9149]: info: Roon Ready metadata receiver is on Jul 02 09:16:51 ifi-phmidsd-lsq-test ifi_cdplayer_run[9874]: [INFO] Listening on /tmp/cdplayer.sock Jul 02 09:16:51 ifi-phmidsd-lsq-test ifi_cdplayer_run[9874]: [DEBUG] [print_handler] Hello from main to worker2 Jul 02 09:16:51 ifi-phmidsd-lsq-test ifi_cdplayer_run[9874]: [DEBUG] [print_handler] Hello from main to worker1 Jul 02 09:16:51 ifi-phmidsd-lsq-test ifi_cdplayer_run[9874]: [DEBUG] DVD detected. Jul 02 09:16:52 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-tidal-connect.service: Service RestartSec=1s expired, scheduling restart. Jul 02 09:16:52 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-tidal-connect.service: Scheduled restart job, restart counter is at 1. Jul 02 09:16:52 ifi-phmidsd-lsq-test systemd[1]: Stopping iFi Streamer Tidal Metadata Service... Jul 02 09:16:52 ifi-phmidsd-lsq-test node[449]: Closing connection with the client tidal-connect Jul 02 09:16:52 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-tidal-metadata.service: Main process exited, code=killed, status=15/TERM Jul 02 09:16:52 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-tidal-metadata.service: Succeeded. Jul 02 09:16:52 ifi-phmidsd-lsq-test systemd[1]: Stopped iFi Streamer Tidal Metadata Service. Jul 02 09:16:52 ifi-phmidsd-lsq-test systemd[1]: Stopped iFi Streamer Tidal Connect Service. Jul 02 09:16:52 ifi-phmidsd-lsq-test systemd[1]: Started iFi Streamer Tidal Connect Service. Jul 02 09:16:52 ifi-phmidsd-lsq-test volumio[9149]: info: CDClient: Reconnecting to server ... Jul 02 09:16:52 ifi-phmidsd-lsq-test volumio[9149]: info: CDClient: Connected to server Jul 02 09:16:52 ifi-phmidsd-lsq-test ifi_cdplayer_run[9874]: [INFO] Accepted new connection Jul 02 09:16:52 ifi-phmidsd-lsq-test ifi_cdplayer_run[9874]: [DEBUG] Received: {"cmd":"info","device":"/dev/sr0"} Jul 02 09:16:52 ifi-phmidsd-lsq-test ifi_cdplayer_run[9874]: [DEBUG] disc_info_load_msg_create: {"cmd":"disc_load","dev":"/dev/sr0","mode":6,"total_tracks":0,"audio_length":0,"tracks":[]} Jul 02 09:16:52 ifi-phmidsd-lsq-test systemd[1]: Started iFi Streamer Tidal Metadata Service. Jul 02 09:16:52 ifi-phmidsd-lsq-test volumio[9149]: info: CDClient: Get message Jul 02 09:16:52 ifi-phmidsd-lsq-test volumio[9149]: Connection closed by client Jul 02 09:16:52 ifi-phmidsd-lsq-test node[449]: A new connection has been established. Jul 02 09:16:52 ifi-phmidsd-lsq-test mpd[9707]: Jul 02 09:16 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 02 09:16:52 ifi-phmidsd-lsq-test systemd[1]: Started Music Player Daemon. Jul 02 09:16:52 ifi-phmidsd-lsq-test volumio[9149]: error: Socket error: Error: This socket has been ended by the other party Jul 02 09:16:52 ifi-phmidsd-lsq-test sudo[9687]: pam_unix(sudo:session): session closed for user root Jul 02 09:16:52 ifi-phmidsd-lsq-test volumio[9149]: MPD server connection closed Jul 02 09:16:52 ifi-phmidsd-lsq-test volumio[9149]: info: Restarted MPD. Jul 02 09:16:52 ifi-phmidsd-lsq-test volumio[9149]: error: updateQueue error: null Jul 02 09:16:53 ifi-phmidsd-lsq-test node[449]: A new connection has been established. Jul 02 09:16:53 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::volumioStop Jul 02 09:16:53 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::stop Jul 02 09:16:53 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::serviceStop Jul 02 09:16:53 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::serviceStop Jul 02 09:16:53 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::volumioStop Jul 02 09:16:53 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::stop Jul 02 09:16:53 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 02 09:16:53 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 02 09:16:53 ifi-phmidsd-lsq-test volumio[9149]: info: Roon Ready Stop Jul 02 09:16:54 ifi-phmidsd-lsq-test volumio[9149]: New connection from ::ffff:127.0.0.1:53206 Jul 02 09:16:54 ifi-phmidsd-lsq-test volumio[9149]: Connected to MPD server Jul 02 09:16:54 ifi-phmidsd-lsq-test volumio[9149]: New connection from ::ffff:127.0.0.1:53210 Jul 02 09:16:54 ifi-phmidsd-lsq-test volumio[9149]: Connected to MPD server Jul 02 09:16:54 ifi-phmidsd-lsq-test volumio[9149]: info: BOOT COMPLETED Jul 02 09:16:54 ifi-phmidsd-lsq-test volumio[9848]: writing RSA key Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: input: iFi (by AMR) iDSD PHANTOM as /devices/platform/usb@ff600000/ff600000.dwc3/xhci-hcd.0.auto/usb4/4-1/4-1.2/4-1.2:1.4/0003:20B1:3008.0012/input/input17 Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: hid-generic 0003:20B1:3008.0012: input,hidraw0: USB HID v1.11 Device [iFi (by AMR) iDSD PHANTOM] on usb-xhci-hcd.0.auto-1.2/input4 Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test systemd-udevd[10030]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jul 02 09:16:54 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jul 02 09:16:54 ifi-phmidsd-lsq-test ifi_cdplayer_run[9874]: [DEBUG] disc_info_load_msg_create: {"cmd":"disc_load","dev":"/dev/sr0","mode":6,"total_tracks":10,"audio_length":0,"tracks":[{"track_num":2,"start_lsn":0,"end_lsn":0,"is_audio":true,"copyp":false,"preemp":false,"channels":0,"name":"Track 1","duration":328},{"track_num":3,"start_lsn":0,"end_lsn":0,"is_audio":true,"copyp":false,"preemp":false,"channels":0,"name":"Track 2","duration":290},{"track_num":4,"start_lsn":0,"end_lsn":0,"is_audio":true,"copyp":false,"preemp":false,"channels":0,"name":"Track 3","duration":312},{"track_num":5,"start_lsn":0,"end_lsn":0,"is_audio":true,"copyp":false,"preemp":false,"channels":0,"name":"Track 4","duration":304},{"track_num":6,"start_lsn":0,"end_lsn":0,"is_audio":true,"copyp":false,"preemp":false,"channels":0,"name":"Track 5","duration":363},{"track_num":7,"start_lsn":0,"end_lsn":0,"is_audio":true,"copyp":false,"preemp":false,"channels":0,"name":"Track 6","duration":251},{"track_num":8,"start_lsn":0,"end_lsn":0,"is_audio":true,"copyp":false,"preemp":false,"channels":0,"name":"Track 7","duration":321},{"track_num":9,"start_lsn":0,"end_lsn":0,"is_audio":true,"copyp":false,"preemp":false,"channels":0,"name":"Track 8","duration":266},{"track_num":10,"start_lsn":0,"end_lsn":0,"is_audio":true,"copyp":false,"preemp":false,"channels":0,"name":"Track 9","duration":272},{"track_num":11,"start_lsn":0,"end_lsn":0,"is_audio":true,"copyp":false,"preemp":false,"channels":0,"name":"Track 10","duration":289}]} Jul 02 09:16:54 ifi-phmidsd-lsq-test volumio[9149]: info: CDClient: Get message Jul 02 09:16:54 ifi-phmidsd-lsq-test volumio[9149]: info: disc onGetDisc Jul 02 09:16:55 ifi-phmidsd-lsq-test node[448]: ConvSwitch: Add client tidal Jul 02 09:16:55 ifi-phmidsd-lsq-test tidal_connect_application[10059]: *** WARNING *** The program 'tidal_connect_application' uses the Apple Bonjour compatibility layer of Avahi. Jul 02 09:16:55 ifi-phmidsd-lsq-test tidal_connect_application[10059]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 02 09:16:55 ifi-phmidsd-lsq-test tidal_connect_application[10059]: *** WARNING *** For more information see Jul 02 09:16:55 ifi-phmidsd-lsq-test ifi_metadata[9946]: [Info] MetaClient: MetaClient SDK -- v1.02 Jul 02 09:16:55 ifi-phmidsd-lsq-test ifi_metadata[9946]: [Info] MetaClient: MetaClientInit Jul 02 09:16:55 ifi-phmidsd-lsq-test ifi_metadata[9946]: Connected Jul 02 09:16:56 ifi-phmidsd-lsq-test volumio[9149]: info: Cannot mount NAS testmusic at system boot, trial number 4 ,retrying in 5 seconds Jul 02 09:16:57 ifi-phmidsd-lsq-test volumio[9149]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Jul 02 09:16:59 ifi-phmidsd-lsq-test ethernet-detect[469]: No change in avahi-daemon interfaces. Skipping restart. Jul 02 09:17:01 ifi-phmidsd-lsq-test CRON[10247]: pam_unix(cron:session): session opened for user root by (uid=0) Jul 02 09:17:01 ifi-phmidsd-lsq-test CRON[10248]: (root) CMD ( cd / && run-parts --report /etc/cron.hourly) Jul 02 09:17:01 ifi-phmidsd-lsq-test CRON[10247]: pam_unix(cron:session): session closed for user root Jul 02 09:17:01 ifi-phmidsd-lsq-test volumio[9149]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Jul 02 09:17:06 ifi-phmidsd-lsq-test sudo[10311]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 02 09:17:06 ifi-phmidsd-lsq-test sudo[10311]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 02 09:17:06 ifi-phmidsd-lsq-test sudo[10312]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 02 09:17:06 ifi-phmidsd-lsq-test sudo[10311]: pam_unix(sudo:session): session closed for user root Jul 02 09:17:06 ifi-phmidsd-lsq-test sudo[10312]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 02 09:17:06 ifi-phmidsd-lsq-test sudo[10312]: pam_unix(sudo:session): session closed for user root Jul 02 09:17:07 ifi-phmidsd-lsq-test volumio[9149]: verbose: New Socket.io Connection to 192.168.1.129 from 192.168.1.189 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 20 Jul 02 09:17:07 ifi-phmidsd-lsq-test volumio[9149]: info: ++++--++++ getInstalledPlugins: null Jul 02 09:17:07 ifi-phmidsd-lsq-test volumio[9149]: info: ++++--++++ getAvailablePlugins: null Jul 02 09:17:07 ifi-phmidsd-lsq-test volumio[9149]: info: ++++--++++ getMultiRoomDevices: null Jul 02 09:17:07 ifi-phmidsd-lsq-test volumio[9149]: info: ++++--++++ getMultiroom: null Jul 02 09:17:07 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 02 09:17:07 ifi-phmidsd-lsq-test volumio[9149]: error: Could not retrieve plugin audio_interface multiroom Jul 02 09:17:07 ifi-phmidsd-lsq-test volumio[9149]: info: ++++--++++ getAudioOutputs: null Jul 02 09:17:07 ifi-phmidsd-lsq-test volumio[9149]: info: ++++--++++ getState Jul 02 09:17:07 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::volumioGetState Jul 02 09:17:07 ifi-phmidsd-lsq-test volumio[9149]: info: CorePlayQueue::getTrack 0 Jul 02 09:17:07 ifi-phmidsd-lsq-test volumio[9149]: info: ++++--++++ getBrowseSources: null Jul 02 09:17:07 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 02 09:17:07 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::volumioGetVisibleSources Jul 02 09:17:07 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 02 09:17:07 ifi-phmidsd-lsq-test volumio[9149]: info: ++++--++++ getMenuItems Jul 02 09:17:07 ifi-phmidsd-lsq-test volumio[9149]: info: ++++--++++ getUiSettings Jul 02 09:17:07 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jul 02 09:17:07 ifi-phmidsd-lsq-test volumio[9149]: info: ++++--++++ getWizard Jul 02 09:17:07 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jul 02 09:17:07 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jul 02 09:17:07 ifi-phmidsd-lsq-test volumio[9149]: info: ++++--++++ getPrivacySettings Jul 02 09:17:07 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 02 09:17:09 ifi-phmidsd-lsq-test ethernet-detect[469]: No change in avahi-daemon interfaces. Skipping restart. Jul 02 09:17:10 ifi-phmidsd-lsq-test volumio[9149]: info: ++++--++++ browseLibrary: {"uri":"cdrom"} Jul 02 09:17:10 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: ifi-cdplayer , handleBrowseUri Jul 02 09:17:10 ifi-phmidsd-lsq-test volumio[9149]: info: cdrom Jul 02 09:17:10 ifi-phmidsd-lsq-test sudo[10402]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 664 /dev/sr0 Jul 02 09:17:10 ifi-phmidsd-lsq-test sudo[10402]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 02 09:17:10 ifi-phmidsd-lsq-test sudo[10402]: pam_unix(sudo:session): session closed for user root Jul 02 09:17:10 ifi-phmidsd-lsq-test volumio[9149]: info: ++++--++++ getQueue Jul 02 09:17:10 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::volumioGetQueue Jul 02 09:17:10 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::getQueue Jul 02 09:17:10 ifi-phmidsd-lsq-test volumio[9149]: info: CorePlayQueue::getQueue Jul 02 09:17:10 ifi-phmidsd-lsq-test volumio[9149]: info: ++++--++++ listPlaylist: null Jul 02 09:17:10 ifi-phmidsd-lsq-test volumio[9149]: info: Listing playlists Jul 02 09:17:10 ifi-phmidsd-lsq-test volumio[9149]: info: Preload queue cleared Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: info: ++++--++++ browseLibrary: {"uri":"cdrom/tracks/dev/sr0","prevUri":"cdrom"} Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: ifi-cdplayer , handleBrowseUri Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: info: cdrom/tracks/dev/sr0 Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: info: [ Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: "dev", Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: "sr0" Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: ] Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: info: Preload queue cleared Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: info: Preloading song: cdrom/tracks/dev/sr0/0 Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: info: Preloading song: cdrom/tracks/dev/sr0/1 Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: info: Preloading song: cdrom/tracks/dev/sr0/2 Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: info: Preloading song: cdrom/tracks/dev/sr0/3 Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: info: Preloading song: cdrom/tracks/dev/sr0/4 Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: info: Preloading song: cdrom/tracks/dev/sr0/5 Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: info: Preloading song: cdrom/tracks/dev/sr0/6 Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: info: Preloading song: cdrom/tracks/dev/sr0/7 Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: info: Preloading song: cdrom/tracks/dev/sr0/8 Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: info: Preloading song: cdrom/tracks/dev/sr0/9 Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: info: Exploding uri cdrom/tracks/dev/sr0/0 in service ifi-cdplayer Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: info: explode: cdrom/tracks/dev/sr0/0 Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: info: [ Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: "dev", Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: "sr0", Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: "0" Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: ] Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: info: Exploding uri cdrom/tracks/dev/sr0/1 in service ifi-cdplayer Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: info: explode: cdrom/tracks/dev/sr0/1 Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: info: [ Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: "dev", Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: "sr0", Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: "1" Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: ] Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: info: Exploding uri cdrom/tracks/dev/sr0/2 in service ifi-cdplayer Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: info: explode: cdrom/tracks/dev/sr0/2 Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: info: [ Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: "dev", Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: "sr0", Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: "2" Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: ] Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: info: Exploding uri cdrom/tracks/dev/sr0/3 in service ifi-cdplayer Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: info: explode: cdrom/tracks/dev/sr0/3 Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: info: [ Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: "dev", Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: "sr0", Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: "3" Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: ] Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: info: Exploding uri cdrom/tracks/dev/sr0/4 in service ifi-cdplayer Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: info: explode: cdrom/tracks/dev/sr0/4 Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: info: [ Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: "dev", Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: "sr0", Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: "4" Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: ] Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: info: Exploding uri cdrom/tracks/dev/sr0/5 in service ifi-cdplayer Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: info: explode: cdrom/tracks/dev/sr0/5 Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: info: [ Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: "dev", Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: "sr0", Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: "5" Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: ] Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: info: Exploding uri cdrom/tracks/dev/sr0/6 in service ifi-cdplayer Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: info: explode: cdrom/tracks/dev/sr0/6 Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: info: [ Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: "dev", Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: "sr0", Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: "6" Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: ] Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: info: Exploding uri cdrom/tracks/dev/sr0/7 in service ifi-cdplayer Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: info: explode: cdrom/tracks/dev/sr0/7 Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: info: [ Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: "dev", Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: "sr0", Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: "7" Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: ] Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: info: Exploding uri cdrom/tracks/dev/sr0/8 in service ifi-cdplayer Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: info: explode: cdrom/tracks/dev/sr0/8 Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: info: [ Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: "dev", Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: "sr0", Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: "8" Jul 02 09:17:11 ifi-phmidsd-lsq-test volumio[9149]: ] Jul 02 09:17:12 ifi-phmidsd-lsq-test volumio[9149]: info: Exploding uri cdrom/tracks/dev/sr0/9 in service ifi-cdplayer Jul 02 09:17:12 ifi-phmidsd-lsq-test volumio[9149]: info: explode: cdrom/tracks/dev/sr0/9 Jul 02 09:17:12 ifi-phmidsd-lsq-test volumio[9149]: info: [ Jul 02 09:17:12 ifi-phmidsd-lsq-test volumio[9149]: "dev", Jul 02 09:17:12 ifi-phmidsd-lsq-test volumio[9149]: "sr0", Jul 02 09:17:12 ifi-phmidsd-lsq-test volumio[9149]: "9" Jul 02 09:17:12 ifi-phmidsd-lsq-test volumio[9149]: ] Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: ++++--++++ playItemsList: {"item":{"service":"ifi-cdplayer","type":"song","trackType":"CD","artist":"","album":"","albumart":"","title":"Track 2","duration":290,"uri":"cdrom/tracks/dev/sr0/1","icon":"fa fa-music"},"list":[{"service":"ifi-cdplayer","type":"song","trackType":"CD","artist":"","album":"","albumart":"","title":"Track 1","duration":328,"uri":"cdrom/tracks/dev/sr0/0","icon":"fa fa-music"},{"service":"ifi-cdplayer","type":"song","trackType":"CD","artist":"","album":"","albumart":"","title":"Track 2","duration":290,"uri":"cdrom/tracks/dev/sr0/1","icon":"fa fa-music"},{"service":"ifi-cdplayer","type":"song","trackType":"CD","artist":"","album":"","albumart":"","title":"Track 3","duration":312,"uri":"cdrom/tracks/dev/sr0/2","icon":"fa fa-music"},{"service":"ifi-cdplayer","type":"song","trackType":"CD","artist":"","album":"","albumart":"","title":"Track 4","duration":304,"uri":"cdrom/tracks/dev/sr0/3","icon":"fa fa-music"},{"service":"ifi-cdplayer","type":"song","trackType":"CD","artist":"","album":"","albumart":"","title":"Track 5","duration":363,"uri":"cdrom/tracks/dev/sr0/4","icon":"fa fa-music"},{"service":"ifi-cdplayer","type":"song","trackType":"CD","artist":"","album":"","albumart":"","title":"Track 6","duration":251,"uri":"cdrom/tracks/dev/sr0/5","icon":"fa fa-music"},{"service":"ifi-cdplayer","type":"song","trackType":"CD","artist":"","album":"","albumart":"","title":"Track 7","duration":321,"uri":"cdrom/tracks/dev/sr0/6","icon":"fa fa-music"},{"service":"ifi-cdplayer","type":"song","trackType":"CD","artist":"","album":"","albumart":"","title":"Track 8","duration":266,"uri":"cdrom/tracks/dev/sr0/7","icon":"fa fa-music"},{"service":"ifi-cdplayer","type":"song","trackType":"CD","artist":"","album":"","albumart":"","title":"Track 9","duration":272,"uri":"cdrom/tracks/dev/sr0/8","icon":"fa fa-music"},{"service":"ifi-cdplayer","type":"song","trackType":"CD","artist":"","album":"","albumart":"","title":"Track 10","duration":289,"uri":"cdrom/tracks/dev/sr0/9","icon":"fa fa-music"}],"index":1} Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: Preload queue cleared Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::ClearQueue Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::stop Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: CorePlayQueue::clearPlayQueue Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: CorePlayQueue::saveQueue Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::volumioPushQueue Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::addQueueItems Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: CorePlayQueue::addQueueItems Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: Preload queue cleared Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: Adding Item to queue: cdrom/tracks/dev/sr0/0 Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: Exploding uri cdrom/tracks/dev/sr0/0 in service ifi-cdplayer Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: explode: cdrom/tracks/dev/sr0/0 Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: [ Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: "dev", Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: "sr0", Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: "0" Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: ] Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: Adding Item to queue: cdrom/tracks/dev/sr0/1 Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: Exploding uri cdrom/tracks/dev/sr0/1 in service ifi-cdplayer Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: explode: cdrom/tracks/dev/sr0/1 Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: [ Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: "dev", Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: "sr0", Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: "1" Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: ] Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::volumioPushQueue Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: CorePlayQueue::saveQueue Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::updateTrackBlock Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: CorePlayQueue::getTrackBlock Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: ConvSwitch: Sent Play Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::volumioPlay Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::play index 1 Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::addQueueItems Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: CorePlayQueue::addQueueItems Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: Preload queue cleared Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: Adding Item to queue: cdrom/tracks/dev/sr0/2 Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: Exploding uri cdrom/tracks/dev/sr0/2 in service ifi-cdplayer Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: explode: cdrom/tracks/dev/sr0/2 Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: [ Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: "dev", Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: "sr0", Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: "2" Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: ] Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: Adding Item to queue: cdrom/tracks/dev/sr0/3 Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: Exploding uri cdrom/tracks/dev/sr0/3 in service ifi-cdplayer Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: explode: cdrom/tracks/dev/sr0/3 Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: [ Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: "dev", Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: "sr0", Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: "3" Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: ] Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: Adding Item to queue: cdrom/tracks/dev/sr0/4 Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: Exploding uri cdrom/tracks/dev/sr0/4 in service ifi-cdplayer Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: explode: cdrom/tracks/dev/sr0/4 Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: [ Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: "dev", Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: "sr0", Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: "4" Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: ] Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: Adding Item to queue: cdrom/tracks/dev/sr0/5 Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: Exploding uri cdrom/tracks/dev/sr0/5 in service ifi-cdplayer Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: explode: cdrom/tracks/dev/sr0/5 Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: [ Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: "dev", Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: "sr0", Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: "5" Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: ] Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: Adding Item to queue: cdrom/tracks/dev/sr0/6 Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: Exploding uri cdrom/tracks/dev/sr0/6 in service ifi-cdplayer Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: explode: cdrom/tracks/dev/sr0/6 Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: [ Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: "dev", Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: "sr0", Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: "6" Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: ] Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: Adding Item to queue: cdrom/tracks/dev/sr0/7 Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: Exploding uri cdrom/tracks/dev/sr0/7 in service ifi-cdplayer Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: explode: cdrom/tracks/dev/sr0/7 Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: [ Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: "dev", Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: "sr0", Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: "7" Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: ] Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: Adding Item to queue: cdrom/tracks/dev/sr0/8 Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: Exploding uri cdrom/tracks/dev/sr0/8 in service ifi-cdplayer Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: explode: cdrom/tracks/dev/sr0/8 Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: [ Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: "dev", Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: "sr0", Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: "8" Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: ] Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: Adding Item to queue: cdrom/tracks/dev/sr0/9 Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: Exploding uri cdrom/tracks/dev/sr0/9 in service ifi-cdplayer Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: explode: cdrom/tracks/dev/sr0/9 Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: [ Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: "dev", Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: "sr0", Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: "9" Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: ] Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: 00000000000000000000000000000, index: 1 Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: 111111111111111111111111111, index: 1 Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::stop Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: sssssssssssssssssssssseeeeeeeeeeeeeeeeettttttttttttt index: 1 Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::play index undefined Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: 00000000000000000000000000000, index: undefined Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: 111111111111111111111111111, index: undefined Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: +++++++++++++++++++++++++++++++++++++++++++++ self.currentPosition: 1 Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: CorePlayQueue::getTrack 1 Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: ====================================== trackBlock.service: ifi-cdplayer Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::startPlaybackTimer Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: CorePlayQueue::getTrack 1 Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: error: Could not retrieve plugin miscellanea metavolumio Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: [1751447834816] CdPlayer::clearAddPlayTrack Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: {"uri":"/dev/sr0/1","service":"ifi-cdplayer","name":"Track 2","title":"Track 2","type":"song","artist":"","albumart":"/albumart","album":"","duration":290,"trackType":"CD","samplerate":"","bitdepth":0,"channels":0} Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: [1751447834818] CdPlayer::pushState Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: Pushing state: {"status":"wait","service":"ifi-cdplayer","title":"Track 2","artist":"","album":"","albumart":"/albumart","uri":"","trackType":"CD","seek":0,"duration":290,"samplerate":"","bitdepth":"","channels":2,"disableUiControls":false}, service: ifi-cdplayer Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::servicePushState Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: CorePlayQueue::getTrack 1 Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: verbose: STATE SERVICE {"status":"wait","service":"ifi-cdplayer","title":"Track 2","artist":"","album":"","albumart":"/albumart","uri":"","trackType":"CD","seek":0,"duration":290,"samplerate":"","bitdepth":"","channels":2,"disableUiControls":false} Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: verbose: CURRENT POSITION 1 Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::syncState stateService wait Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::syncState currentStatus stop Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::pushState Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::volumioPushState Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::volumioPushQueue Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: CorePlayQueue::saveQueue Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::updateTrackBlock Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: CorePlayQueue::getTrackBlock Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: ConvSwitch: Get message: success Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 02 09:17:14 ifi-phmidsd-lsq-test volumio[9149]: error: Could not retrieve plugin system_controller my_volumio Jul 02 09:17:15 ifi-phmidsd-lsq-test ifi_cdplayer_run[9874]: [DEBUG] Received: {"cmd":"play","device":"/dev/sr0","track":"1"} Jul 02 09:17:15 ifi-phmidsd-lsq-test ifi_cdplayer_run[9874]: [DEBUG] track: 3 Jul 02 09:17:15 ifi-phmidsd-lsq-test ifi_cdplayer_run[9874]: [DEBUG] DVD detected. Jul 02 09:17:15 ifi-phmidsd-lsq-test ifi_cdplayer_run[9874]: [DEBUG] +++++++++++ mode: 6 Jul 02 09:17:15 ifi-phmidsd-lsq-test ifi_cdplayer_run[9874]: [INFO] Playing title 3: sector [86340 - 165082] Jul 02 09:17:15 ifi-phmidsd-lsq-test ifi_cdplayer_run[9874]: libdvdread: Attempting to retrieve all CSS keys Jul 02 09:17:15 ifi-phmidsd-lsq-test ifi_cdplayer_run[9874]: libdvdread: This can take a _long_ time, please be patient Jul 02 09:17:15 ifi-phmidsd-lsq-test ifi_cdplayer_run[9874]: libdvdread: Get key for /VIDEO_TS/VIDEO_TS.VOB at 0x00000127 Jul 02 09:17:15 ifi-phmidsd-lsq-test ifi_cdplayer_run[9874]: libdvdread: Elapsed time 0 Jul 02 09:17:15 ifi-phmidsd-lsq-test ifi_cdplayer_run[9874]: libdvdread: Get key for /VIDEO_TS/VTS_01_0.VOB at 0x0000015a Jul 02 09:17:15 ifi-phmidsd-lsq-test ifi_cdplayer_run[9874]: libdvdread: Elapsed time 0 Jul 02 09:17:15 ifi-phmidsd-lsq-test ifi_cdplayer_run[9874]: libdvdread: Get key for /VIDEO_TS/VTS_01_1.VOB at 0x000001c1 Jul 02 09:17:15 ifi-phmidsd-lsq-test ifi_cdplayer_run[9874]: libdvdread: Elapsed time 0 Jul 02 09:17:15 ifi-phmidsd-lsq-test ifi_cdplayer_run[9874]: libdvdread: Found 1 VTS's Jul 02 09:17:15 ifi-phmidsd-lsq-test ifi_cdplayer_run[9874]: libdvdread: Elapsed time 0 Jul 02 09:17:18 ifi-phmidsd-lsq-test ifi_cdplayer_run[9874]: [INFO] DVD audio decoding started[DEBUG] 96000, 2, 10, 334 Jul 02 09:17:18 ifi-phmidsd-lsq-test ifi_cdplayer_run[9874]: [DEBUG] broadcast_play_status_msg_create: {"cmd":"status","status":"play"} Jul 02 09:17:18 ifi-phmidsd-lsq-test volumio[9149]: info: CDClient: Get message Jul 02 09:17:18 ifi-phmidsd-lsq-test volumio[9149]: info: disc onGetPlaybackStatus Jul 02 09:17:18 ifi-phmidsd-lsq-test volumio[9149]: info: [1751447838373] CdPlayer::pushState Jul 02 09:17:18 ifi-phmidsd-lsq-test volumio[9149]: Pushing state: {"status":"play","service":"ifi-cdplayer","title":"Track 2","artist":"","album":"","albumart":"/albumart","uri":"","trackType":"CD","seek":0,"duration":290,"samplerate":"","bitdepth":"","channels":2,"disableUiControls":false}, service: ifi-cdplayer Jul 02 09:17:18 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::servicePushState Jul 02 09:17:18 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::pushState Jul 02 09:17:18 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 02 09:17:18 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::volumioPushState Jul 02 09:17:18 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 02 09:17:19 ifi-phmidsd-lsq-test volumio[9149]: info: MetaClient: Sent Meta Jul 02 09:17:19 ifi-phmidsd-lsq-test volumio[9149]: info: MetaClient: Get message: success Jul 02 09:17:19 ifi-phmidsd-lsq-test ethernet-detect[469]: No change in avahi-daemon interfaces. Skipping restart. Jul 02 09:17:25 ifi-phmidsd-lsq-test volumio[9149]: info: ++++--++++ getPrivacySettings Jul 02 09:17:25 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 02 09:17:25 ifi-phmidsd-lsq-test volumio[9149]: info: ++++--++++ callMethod: {"type":"plugin","endpoint":"system_controller/my_volumio","method":"retreiveBackendEventStates"} Jul 02 09:17:25 ifi-phmidsd-lsq-test volumio[9149]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jul 02 09:17:25 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jul 02 09:17:25 ifi-phmidsd-lsq-test volumio[9149]: error: Could not retrieve plugin system_controller my_volumio Jul 02 09:17:25 ifi-phmidsd-lsq-test volumio[9149]: info: ++++--++++ getSystemVersion Jul 02 09:17:25 ifi-phmidsd-lsq-test volumio[9149]: info: Received Get System Version Jul 02 09:17:25 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 02 09:17:25 ifi-phmidsd-lsq-test volumio[9149]: info: ++++--++++ getSystemInfo Jul 02 09:17:25 ifi-phmidsd-lsq-test volumio[9149]: info: Received Get System Info Jul 02 09:17:25 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 02 09:17:25 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 02 09:17:25 ifi-phmidsd-lsq-test volumio[9149]: info: Discovery: Getting this device information Jul 02 09:17:25 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::volumioGetState Jul 02 09:17:25 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 02 09:17:29 ifi-phmidsd-lsq-test ethernet-detect[469]: No change in avahi-daemon interfaces. Skipping restart. Jul 02 09:17:33 ifi-phmidsd-lsq-test volumio[9149]: info: ++++--++++ getInstalledPlugins: null Jul 02 09:17:33 ifi-phmidsd-lsq-test volumio[9149]: info: ++++--++++ getAvailablePlugins: null Jul 02 09:17:36 ifi-phmidsd-lsq-test volumio[9149]: info: ++++--++++ pluginManager: {"name":"ifi-cdplayer","category":"music_service","action":"disable"} Jul 02 09:17:36 ifi-phmidsd-lsq-test volumio[9149]: info: [1751447856887] CdPlayer::pushState Jul 02 09:17:36 ifi-phmidsd-lsq-test volumio[9149]: Pushing state: {"status":"stop","service":"ifi-cdplayer","title":"Track 2","artist":"","album":"","albumart":"/albumart","uri":"","trackType":"CD","seek":18000,"duration":290,"samplerate":"","bitdepth":"","channels":2,"disableUiControls":false,"stream":false,"codec":"","repeatMode":"all"}, service: ifi-cdplayer Jul 02 09:17:36 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::servicePushState Jul 02 09:17:36 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::pushState Jul 02 09:17:36 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 02 09:17:36 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::volumioPushState Jul 02 09:17:36 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 02 09:17:36 ifi-phmidsd-lsq-test volumio[9149]: info: CorePlayQueue::getTrack 1 Jul 02 09:17:36 ifi-phmidsd-lsq-test volumio[9149]: verbose: STATE SERVICE {"status":"stop","service":"ifi-cdplayer","title":"Track 2","artist":"","album":"","albumart":"/albumart","uri":"","trackType":"CD","seek":18000,"duration":290,"samplerate":"","bitdepth":"","channels":2,"disableUiControls":false,"stream":false,"codec":"","repeatMode":"all"} Jul 02 09:17:36 ifi-phmidsd-lsq-test volumio[9149]: verbose: CURRENT POSITION 1 Jul 02 09:17:36 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::syncState stateService stop Jul 02 09:17:36 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::syncState currentStatus play Jul 02 09:17:36 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::play index undefined Jul 02 09:17:36 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 02 09:17:36 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::pushState Jul 02 09:17:36 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::volumioPushState Jul 02 09:17:36 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 02 09:17:36 ifi-phmidsd-lsq-test ifi_cdplayer_run[9874]: [INFO] Client disconnected Jul 02 09:17:36 ifi-phmidsd-lsq-test volumio[9149]: info: CDClient closed. Jul 02 09:17:36 ifi-phmidsd-lsq-test volumio[9149]: error: Plugin ifi-cdplayer does not return adequate promise from onStop: please update! Jul 02 09:17:37 ifi-phmidsd-lsq-test volumio[9149]: 00000000000000000000000000000, index: undefined Jul 02 09:17:37 ifi-phmidsd-lsq-test volumio[9149]: 111111111111111111111111111, index: undefined Jul 02 09:17:37 ifi-phmidsd-lsq-test volumio[9149]: +++++++++++++++++++++++++++++++++++++++++++++ self.currentPosition: 2 Jul 02 09:17:37 ifi-phmidsd-lsq-test volumio[9149]: info: CorePlayQueue::getTrack 2 Jul 02 09:17:37 ifi-phmidsd-lsq-test sudo[10882]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop ifi-cdplayer.service Jul 02 09:17:37 ifi-phmidsd-lsq-test sudo[10882]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 02 09:17:37 ifi-phmidsd-lsq-test volumio[9149]: ====================================== trackBlock.service: ifi-cdplayer Jul 02 09:17:37 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::startPlaybackTimer Jul 02 09:17:37 ifi-phmidsd-lsq-test volumio[9149]: info: CorePlayQueue::getTrack 2 Jul 02 09:17:37 ifi-phmidsd-lsq-test volumio[9149]: info: [1751447857011] CdPlayer::clearAddPlayTrack Jul 02 09:17:37 ifi-phmidsd-lsq-test volumio[9149]: info: {"uri":"/dev/sr0/2","service":"ifi-cdplayer","name":"Track 3","title":"Track 3","type":"song","artist":"","albumart":"/albumart","album":"","duration":312,"trackType":"CD","samplerate":"","bitdepth":0,"channels":0} Jul 02 09:17:37 ifi-phmidsd-lsq-test volumio[9149]: info: [1751447857014] CdPlayer::pushState Jul 02 09:17:37 ifi-phmidsd-lsq-test volumio[9149]: Pushing state: {"status":"wait","service":"ifi-cdplayer","title":"Track 3","artist":"","album":"","albumart":"/albumart","uri":"","trackType":"CD","seek":0,"duration":312,"samplerate":"","bitdepth":"","channels":2,"disableUiControls":false,"stream":false,"codec":"","repeatMode":"all"}, service: ifi-cdplayer Jul 02 09:17:37 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::servicePushState Jul 02 09:17:37 ifi-phmidsd-lsq-test volumio[9149]: info: CorePlayQueue::getTrack 2 Jul 02 09:17:37 ifi-phmidsd-lsq-test volumio[9149]: verbose: STATE SERVICE {"status":"wait","service":"ifi-cdplayer","title":"Track 3","artist":"","album":"","albumart":"/albumart","uri":"","trackType":"CD","seek":0,"duration":312,"samplerate":"","bitdepth":"","channels":2,"disableUiControls":false,"stream":false,"codec":"","repeatMode":"all"} Jul 02 09:17:37 ifi-phmidsd-lsq-test volumio[9149]: verbose: CURRENT POSITION 2 Jul 02 09:17:37 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::syncState stateService wait Jul 02 09:17:37 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::syncState currentStatus stop Jul 02 09:17:37 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::pushState Jul 02 09:17:37 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 02 09:17:37 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::volumioPushState Jul 02 09:17:37 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 02 09:17:37 ifi-phmidsd-lsq-test volumio[9149]: info: Disabling plugin ifi-cdplayer Jul 02 09:17:37 ifi-phmidsd-lsq-test systemd[1]: Stopping iFi Streamer ifi cdplayer server daemon... Jul 02 09:17:37 ifi-phmidsd-lsq-test volumio[9149]: info: CoreStateMachine::pushState Jul 02 09:17:37 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::volumioPushState Jul 02 09:17:37 ifi-phmidsd-lsq-test volumio[9149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 02 09:17:37 ifi-phmidsd-lsq-test volumio[9149]: info: Done. Jul 02 09:17:37 ifi-phmidsd-lsq-test systemd[1]: ifi-cdplayer.service: Main process exited, code=killed, status=15/TERM Jul 02 09:17:37 ifi-phmidsd-lsq-test systemd[1]: ifi-cdplayer.service: Succeeded. Jul 02 09:17:37 ifi-phmidsd-lsq-test systemd[1]: Stopped iFi Streamer ifi cdplayer server daemon. Jul 02 09:17:37 ifi-phmidsd-lsq-test sudo[10882]: pam_unix(sudo:session): session closed for user root Jul 02 09:17:37 ifi-phmidsd-lsq-test volumio[9149]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 02 09:17:37 ifi-phmidsd-lsq-test volumio[9149]: TypeError: Cannot read property 'sendCommand' of null Jul 02 09:17:37 ifi-phmidsd-lsq-test volumio[9149]: at Timeout._onTimeout (/data/plugins/music_service/ifi-cdplayer/index.js:411:23) Jul 02 09:17:37 ifi-phmidsd-lsq-test volumio[9149]: at listOnTimeout (internal/timers.js:557:17) Jul 02 09:17:37 ifi-phmidsd-lsq-test volumio[9149]: at processTimers (internal/timers.js:500:7) Jul 02 09:17:37 ifi-phmidsd-lsq-test volumio[9149]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 02 09:17:38 ifi-phmidsd-lsq-test sudo[10921]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-02 09:16 Jul 02 09:17:38 ifi-phmidsd-lsq-test sudo[10921]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="8a0defaac7e920a11527bed08dfa1cf7bce6cbbc" VOLUMIO_FE_VERSION="0548e367fe44b194ccf1306c8af35deb040eccd2" VOLUMIO_FE3_VERSION="c63cc070c36379a8d79dc0d7d4a24908bebc2472" VOLUMIO_BE_VERSION="679648e2cde0726b3cc817882082a0e2ad4c7511" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="ifi" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="2025年 04月 28日 星期一 18:15:48 CST" VOLUMIO_VERSION="2.01.0" VOLUMIO_HARDWARE="idsd-phantom" VOLUMIO_DEVICENAME="iDSD PHANTOM" VOLUMIO_HASH="eca77ea0917a55a7681cda1e64cb9701"