-- Logs begin at Mon 2025-06-30 03:13:20 UTC, end at Mon 2025-06-30 07:06:23 UTC. -- Jun 30 07:05:09 ifi-phmidsd-lsq-test ethernet-detect[454]: No change in avahi-daemon interfaces. Skipping restart. Jun 30 07:05:18 ifi-phmidsd-lsq-test sshd[13317]: Accepted password for volumio from 192.168.1.174 port 58250 ssh2 Jun 30 07:05:18 ifi-phmidsd-lsq-test sshd[13317]: pam_unix(sshd:session): session opened for user volumio by (uid=0) Jun 30 07:05:18 ifi-phmidsd-lsq-test systemd-logind[468]: New session 65 of user volumio. Jun 30 07:05:18 ifi-phmidsd-lsq-test systemd[1]: Started Session 65 of user volumio. Jun 30 07:05:18 ifi-phmidsd-lsq-test sshd[13374]: Received disconnect from 192.168.1.174 port 58250:11: disconnected by user Jun 30 07:05:18 ifi-phmidsd-lsq-test sshd[13374]: Disconnected from user volumio 192.168.1.174 port 58250 Jun 30 07:05:18 ifi-phmidsd-lsq-test sshd[13317]: pam_unix(sshd:session): session closed for user volumio Jun 30 07:05:18 ifi-phmidsd-lsq-test systemd-logind[468]: Session 65 logged out. Waiting for processes to exit. Jun 30 07:05:18 ifi-phmidsd-lsq-test systemd[1]: session-65.scope: Succeeded. Jun 30 07:05:18 ifi-phmidsd-lsq-test systemd-logind[468]: Removed session 65. Jun 30 07:05:19 ifi-phmidsd-lsq-test ethernet-detect[454]: No change in avahi-daemon interfaces. Skipping restart. Jun 30 07:05:24 ifi-phmidsd-lsq-test volumio[10190]: info: ++++--++++ pause Jun 30 07:05:24 ifi-phmidsd-lsq-test volumio[10190]: info: CoreCommandRouter::volumioPause Jun 30 07:05:24 ifi-phmidsd-lsq-test volumio[10190]: info: CoreStateMachine::pause Jun 30 07:05:24 ifi-phmidsd-lsq-test volumio[10190]: info: CoreStateMachine::stPlaybackTimer Jun 30 07:05:24 ifi-phmidsd-lsq-test volumio[10190]: info: CoreStateMachine::servicePause Jun 30 07:05:24 ifi-phmidsd-lsq-test volumio[10190]: servicePause+++++++++++++++++++++++++++++++111111, this.volatileService: ifi-cdplayer Jun 30 07:05:24 ifi-phmidsd-lsq-test volumio[10190]: info: CoreCommandRouter::servicePause Jun 30 07:05:24 ifi-phmidsd-lsq-test volumio[10190]: info: [1751267124583] CdPlayer::pause Jun 30 07:05:24 ifi-phmidsd-lsq-test volumio[10190]: info: [1751267124584] CdPlayer::pushState Jun 30 07:05:24 ifi-phmidsd-lsq-test volumio[10190]: Pushing state: {"status":"pause","service":"ifi-cdplayer","title":"Track 2","artist":"","album":"","albumart":"/albumart","uri":"","trackType":"CD","seek":0,"duration":0,"samplerate":"","bitdepth":"","channels":2,"disableUiControls":false,"stream":false,"codec":"","repeatMode":"all"}, service: ifi-cdplayer Jun 30 07:05:24 ifi-phmidsd-lsq-test volumio[10190]: info: CoreCommandRouter::servicePushState Jun 30 07:05:24 ifi-phmidsd-lsq-test volumio[10190]: info: CoreStateMachine::pushState Jun 30 07:05:24 ifi-phmidsd-lsq-test volumio[10190]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 07:05:24 ifi-phmidsd-lsq-test volumio[10190]: info: CoreCommandRouter::volumioPushState Jun 30 07:05:24 ifi-phmidsd-lsq-test volumio[10190]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 07:05:25 ifi-phmidsd-lsq-test volumio[10190]: info: CDClient: Get message Jun 30 07:05:25 ifi-phmidsd-lsq-test volumio[10190]: info: disc onGetPlaybackStatus Jun 30 07:05:25 ifi-phmidsd-lsq-test volumio[10190]: info: [1751267125224] CdPlayer::pushState Jun 30 07:05:25 ifi-phmidsd-lsq-test volumio[10190]: Pushing state: {"status":"pause","service":"ifi-cdplayer","title":"Track 2","artist":"","album":"","albumart":"/albumart","uri":"","trackType":"CD","seek":0,"duration":0,"samplerate":"","bitdepth":"","channels":2,"disableUiControls":false,"stream":false,"codec":"","repeatMode":"all"}, service: ifi-cdplayer Jun 30 07:05:25 ifi-phmidsd-lsq-test volumio[10190]: info: CoreCommandRouter::servicePushState Jun 30 07:05:25 ifi-phmidsd-lsq-test volumio[10190]: info: CoreStateMachine::pushState Jun 30 07:05:25 ifi-phmidsd-lsq-test volumio[10190]: info: CoreCommandRouter::volumioPushState Jun 30 07:05:25 ifi-phmidsd-lsq-test volumio[10190]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 07:05:29 ifi-phmidsd-lsq-test ethernet-detect[454]: No change in avahi-daemon interfaces. Skipping restart. Jun 30 07:05:33 ifi-phmidsd-lsq-test sudo[13832]: volumio : TTY=pts/0 ; PWD=/home/volumio ; USER=root ; COMMAND=/bin/systemctl restart volumio Jun 30 07:05:33 ifi-phmidsd-lsq-test sudo[13832]: pam_unix(sudo:session): session opened for user root by volumio(uid=0) Jun 30 07:05:33 ifi-phmidsd-lsq-test systemd[1]: Started dynamicswap service. Jun 30 07:05:33 ifi-phmidsd-lsq-test systemd[1]: Stopping Volumio Backend Module... Jun 30 07:05:33 ifi-phmidsd-lsq-test systemd[1]: volumio.service: Main process exited, code=killed, status=15/TERM Jun 30 07:05:33 ifi-phmidsd-lsq-test node[481]: ConvSwitch: Drop client volumio Jun 30 07:05:33 ifi-phmidsd-lsq-test volumio-remote-updater[469]: [2025-06-30 07:05:33] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jun 30 07:05:33 ifi-phmidsd-lsq-test volumio-remote-updater[469]: [2025-06-30 07:05:33] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jun 30 07:05:33 ifi-phmidsd-lsq-test node[482]: Closing connection with the client volumio Jun 30 07:05:33 ifi-phmidsd-lsq-test systemd[1]: volumio.service: Succeeded. Jun 30 07:05:33 ifi-phmidsd-lsq-test systemd[1]: Stopped Volumio Backend Module. Jun 30 07:05:33 ifi-phmidsd-lsq-test systemd[1]: Started Volumio Backend Module. Jun 30 07:05:33 ifi-phmidsd-lsq-test sudo[13832]: pam_unix(sudo:session): session closed for user root Jun 30 07:05:33 ifi-phmidsd-lsq-test systemd[1]: dynamicswap.service: Succeeded. Jun 30 07:05:36 ifi-phmidsd-lsq-test volumio[13855]: info: ------------------------------------------- Jun 30 07:05:36 ifi-phmidsd-lsq-test volumio[13855]: info: ----- Volumio3 ---- Jun 30 07:05:36 ifi-phmidsd-lsq-test volumio[13855]: info: ------------------------------------------- Jun 30 07:05:36 ifi-phmidsd-lsq-test volumio[13855]: info: ----- System startup ---- Jun 30 07:05:36 ifi-phmidsd-lsq-test volumio[13855]: info: ------------------------------------------- Jun 30 07:05:36 ifi-phmidsd-lsq-test volumio[13855]: info: ConvSwitch: Client Start Jun 30 07:05:36 ifi-phmidsd-lsq-test volumio[13855]: info: MetaClient: Client Start Jun 30 07:05:36 ifi-phmidsd-lsq-test node[482]: A new connection has been established. Jun 30 07:05:37 ifi-phmidsd-lsq-test volumio[13855]: info: Plugin folders cleanup Jun 30 07:05:37 ifi-phmidsd-lsq-test volumio[13855]: info: Scanning into folder /volumio/app/plugins/ Jun 30 07:05:37 ifi-phmidsd-lsq-test volumio[13855]: info: Scanning category audio_interface Jun 30 07:05:37 ifi-phmidsd-lsq-test volumio[13855]: info: Scanning category miscellanea Jun 30 07:05:37 ifi-phmidsd-lsq-test volumio[13855]: info: Scanning category music_service Jun 30 07:05:37 ifi-phmidsd-lsq-test volumio[13855]: info: Scanning category plugins.json Jun 30 07:05:37 ifi-phmidsd-lsq-test volumio[13855]: info: Scanning category system_controller Jun 30 07:05:37 ifi-phmidsd-lsq-test volumio[13855]: info: Scanning category user_interface Jun 30 07:05:37 ifi-phmidsd-lsq-test volumio[13855]: info: Scanning into folder /data/plugins/ Jun 30 07:05:37 ifi-phmidsd-lsq-test volumio[13855]: info: Scanning category .git Jun 30 07:05:37 ifi-phmidsd-lsq-test volumio[13855]: info: Scanning category music_service Jun 30 07:05:37 ifi-phmidsd-lsq-test volumio[13855]: info: Plugin folders cleanup completed Jun 30 07:05:37 ifi-phmidsd-lsq-test volumio[13855]: info: ------------------------------------------- Jun 30 07:05:37 ifi-phmidsd-lsq-test volumio[13855]: info: ----- Core plugins startup ---- Jun 30 07:05:37 ifi-phmidsd-lsq-test volumio[13855]: info: ------------------------------------------- Jun 30 07:05:37 ifi-phmidsd-lsq-test volumio[13855]: info: Loading plugins from folder /volumio/app/plugins/ Jun 30 07:05:37 ifi-phmidsd-lsq-test volumio[13855]: info: Adding plugin networkaudiod to MyMusic Plugins Jun 30 07:05:37 ifi-phmidsd-lsq-test volumio[13855]: info: Adding plugin qobuz_connect to MyMusic Plugins Jun 30 07:05:37 ifi-phmidsd-lsq-test volumio[13855]: info: Adding plugin spotify_connect to MyMusic Plugins Jun 30 07:05:37 ifi-phmidsd-lsq-test volumio[13855]: info: Adding plugin tidal_connect to MyMusic Plugins Jun 30 07:05:37 ifi-phmidsd-lsq-test volumio[13855]: info: Adding plugin upnp to MyMusic Plugins Jun 30 07:05:37 ifi-phmidsd-lsq-test volumio[13855]: info: Adding plugin airplay1_switch to MyMusic Plugins Jun 30 07:05:37 ifi-phmidsd-lsq-test volumio[13855]: info: Adding plugin airplay2_switch to MyMusic Plugins Jun 30 07:05:37 ifi-phmidsd-lsq-test volumio[13855]: info: Adding plugin roon_ready to MyMusic Plugins Jun 30 07:05:37 ifi-phmidsd-lsq-test volumio[13855]: info: Adding plugin upnp_browser to MyMusic Plugins Jun 30 07:05:37 ifi-phmidsd-lsq-test volumio[13855]: info: Loading plugins from folder /data/plugins/ Jun 30 07:05:37 ifi-phmidsd-lsq-test volumio[13855]: info: Loading plugin "system"... Jun 30 07:05:37 ifi-phmidsd-lsq-test volumio[13855]: info: Loading plugin "appearance"... Jun 30 07:05:38 ifi-phmidsd-lsq-test volumio-remote-updater[469]: [2025-06-30 07:05:38] [connect] Successful connection Jun 30 07:05:39 ifi-phmidsd-lsq-test ethernet-detect[454]: No change in avahi-daemon interfaces. Skipping restart. Jun 30 07:05:39 ifi-phmidsd-lsq-test volumio[13855]: info: Loading plugin "network"... Jun 30 07:05:39 ifi-phmidsd-lsq-test volumio[13855]: info: Refreshing Cached IP Addresses Jun 30 07:05:39 ifi-phmidsd-lsq-test sudo[14063]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 30 07:05:39 ifi-phmidsd-lsq-test sudo[14063]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 07:05:39 ifi-phmidsd-lsq-test sudo[14063]: pam_unix(sudo:session): session closed for user root Jun 30 07:05:39 ifi-phmidsd-lsq-test sudo[14065]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 30 07:05:39 ifi-phmidsd-lsq-test sudo[14065]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 07:05:39 ifi-phmidsd-lsq-test sudo[14065]: pam_unix(sudo:session): session closed for user root Jun 30 07:05:39 ifi-phmidsd-lsq-test volumio[13855]: info: Loading plugin "services"... Jun 30 07:05:39 ifi-phmidsd-lsq-test volumio[13855]: info: Loading plugin "alsa_controller"... Jun 30 07:05:39 ifi-phmidsd-lsq-test sudo[14074]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jun 30 07:05:39 ifi-phmidsd-lsq-test sudo[14074]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 07:05:40 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 30 07:05:40 ifi-phmidsd-lsq-test volumio[13855]: info: Loading plugin "wizard"... Jun 30 07:05:40 ifi-phmidsd-lsq-test volumio[13855]: info: Loading plugin "networkfs"... Jun 30 07:05:40 ifi-phmidsd-lsq-test volumio[13855]: info: Cannot mount NAS testmusic at system boot, trial number 1 ,retrying in 5 seconds Jun 30 07:05:40 ifi-phmidsd-lsq-test volumio[13855]: info: Starting Udev Watcher for removable devices Jun 30 07:05:40 ifi-phmidsd-lsq-test volumio[13855]: error: Cannot associate FS Label, not mounting Jun 30 07:05:40 ifi-phmidsd-lsq-test volumio[13855]: error: Cannot associate FS Label, not mounting Jun 30 07:05:40 ifi-phmidsd-lsq-test volumio[13855]: info: Ignoring mount for partition: BOOT Jun 30 07:05:40 ifi-phmidsd-lsq-test sudo[14074]: pam_unix(sudo:session): session closed for user root Jun 30 07:05:40 ifi-phmidsd-lsq-test volumio[13855]: info: Ignoring mount for partition: archivefs Jun 30 07:05:40 ifi-phmidsd-lsq-test volumio[13855]: info: Ignoring mount for partition: rootfs Jun 30 07:05:40 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 30 07:05:40 ifi-phmidsd-lsq-test volumio[13855]: info: Loading plugin "volumio_command_line_client"... Jun 30 07:05:40 ifi-phmidsd-lsq-test volumio[13855]: info: Loading plugin "networkaudiod"... Jun 30 07:05:40 ifi-phmidsd-lsq-test volumio[13855]: info: [1751267140354] Starting NAA Service Jun 30 07:05:40 ifi-phmidsd-lsq-test volumio[13855]: info: Loading plugin "tidal_connect"... Jun 30 07:05:40 ifi-phmidsd-lsq-test volumio[13855]: info: [1751267140382] Starting Tidal Connect Service Jun 30 07:05:40 ifi-phmidsd-lsq-test volumio[13855]: info: Loading plugin "upnp"... Jun 30 07:05:40 ifi-phmidsd-lsq-test volumio[13855]: info: [1751267140395] Starting Upmpd Daemon Jun 30 07:05:40 ifi-phmidsd-lsq-test sudo[14111]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart networkaudiod.service Jun 30 07:05:40 ifi-phmidsd-lsq-test volumio[13855]: info: Starting Upmpd Daemon Jun 30 07:05:40 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 30 07:05:40 ifi-phmidsd-lsq-test sudo[14111]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 07:05:40 ifi-phmidsd-lsq-test volumio[13855]: error: ATTENTION!!!: Plugin upnp does not return adequate promise from onVolumioStart: please update! Jun 30 07:05:40 ifi-phmidsd-lsq-test volumio[13855]: info: Loading plugin "my_music"... Jun 30 07:05:40 ifi-phmidsd-lsq-test volumio[13855]: info: Loading plugin "mpd"... Jun 30 07:05:40 ifi-phmidsd-lsq-test systemd[1]: Stopping Network Audio Adapter daemon... Jun 30 07:05:40 ifi-phmidsd-lsq-test systemd[1]: networkaudiod.service: Succeeded. Jun 30 07:05:40 ifi-phmidsd-lsq-test systemd[1]: Stopped Network Audio Adapter daemon. Jun 30 07:05:40 ifi-phmidsd-lsq-test sudo[14111]: pam_unix(sudo:session): session closed for user root Jun 30 07:05:40 ifi-phmidsd-lsq-test systemd[1]: Started Network Audio Adapter daemon. Jun 30 07:05:40 ifi-phmidsd-lsq-test networkaudiod[14113]: [/usr/sbin/networkaudiod] (14113): networkaudiod Copyright (C) 2011-2020 Jussi Laako / Signalyst. All rights reserved. Jun 30 07:05:40 ifi-phmidsd-lsq-test networkaudiod[14113]: [/usr/sbin/networkaudiod] (14113): create alsa engine Jun 30 07:05:40 ifi-phmidsd-lsq-test networkaudiod[14113]: [/usr/sbin/networkaudiod] (14113): listen discovery on :: Jun 30 07:05:40 ifi-phmidsd-lsq-test networkaudiod[14113]: [/usr/sbin/networkaudiod] (14113): clSocket::SetOption(): setsockopt(..., 41,20, ...): No such device Jun 30 07:05:40 ifi-phmidsd-lsq-test networkaudiod[14113]: [/usr/sbin/networkaudiod] (14113): Socket failure, falling back to IPv4-only! Jun 30 07:05:41 ifi-phmidsd-lsq-test volumio[13855]: info: Loading plugin "upnp_browser"... Jun 30 07:05:41 ifi-phmidsd-lsq-test networkaudiod[14113]: [/usr/sbin/networkaudiod] (14113): listen discovery on 0.0.0.0 Jun 30 07:05:41 ifi-phmidsd-lsq-test volumio[13855]: info: Loading plugin "qobuz_connect"... Jun 30 07:05:41 ifi-phmidsd-lsq-test volumio[13855]: info: [1751267141628] Starting Qobuz Connect Service Jun 30 07:05:41 ifi-phmidsd-lsq-test volumio[13855]: info: Loading plugin "alarm-clock"... Jun 30 07:05:41 ifi-phmidsd-lsq-test volumio[13855]: info: Loading plugin "last_100"... Jun 30 07:05:41 ifi-phmidsd-lsq-test volumio[13855]: info: Loading plugin "roon_ready"... Jun 30 07:05:41 ifi-phmidsd-lsq-test volumio[13855]: info: Starting RoonReady Sync Jun 30 07:05:41 ifi-phmidsd-lsq-test volumio[13855]: info: Loading plugin "webradio"... Jun 30 07:05:42 ifi-phmidsd-lsq-test volumio[13855]: info: Loading plugin "i2s_dacs"... Jun 30 07:05:42 ifi-phmidsd-lsq-test volumio[13855]: info: I2S DAC not set, start Auto-detection Jun 30 07:05:42 ifi-phmidsd-lsq-test volumio[13855]: info: Loading plugin "volumiodiscovery"... Jun 30 07:05:42 ifi-phmidsd-lsq-test volumio[13855]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 30 07:05:42 ifi-phmidsd-lsq-test volumio[13855]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 07:05:42 ifi-phmidsd-lsq-test volumio[13855]: *** WARNING *** For more information see Jun 30 07:05:42 ifi-phmidsd-lsq-test volumio[13855]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 30 07:05:42 ifi-phmidsd-lsq-test node[13855]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 30 07:05:42 ifi-phmidsd-lsq-test volumio[13855]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 07:05:42 ifi-phmidsd-lsq-test volumio[13855]: *** WARNING *** For more information see Jun 30 07:05:42 ifi-phmidsd-lsq-test node[13855]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 07:05:42 ifi-phmidsd-lsq-test node[13855]: *** WARNING *** For more information see Jun 30 07:05:42 ifi-phmidsd-lsq-test node[13855]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 30 07:05:42 ifi-phmidsd-lsq-test node[13855]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 07:05:42 ifi-phmidsd-lsq-test node[13855]: *** WARNING *** For more information see Jun 30 07:05:42 ifi-phmidsd-lsq-test volumio[13855]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 30 07:05:42 ifi-phmidsd-lsq-test volumio[13855]: info: Discovery: Started advertising with name: "ifi-phmidsd-lsq-test [32:EF:95:FD:98:7F]" Jun 30 07:05:42 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 30 07:05:42 ifi-phmidsd-lsq-test volumio[13855]: info: Loading plugin "spotify_connect"... Jun 30 07:05:42 ifi-phmidsd-lsq-test volumio[13855]: info: [1751267142295] Starting Spotify Connect Service Jun 30 07:05:42 ifi-phmidsd-lsq-test volumio[13855]: info: Plugin airplay1_switch is not enabled Jun 30 07:05:42 ifi-phmidsd-lsq-test volumio[13855]: info: Loading plugin "airplay2_switch"... Jun 30 07:05:42 ifi-phmidsd-lsq-test volumio[13855]: info: Loading plugin "airplay_emulation"... Jun 30 07:05:42 ifi-phmidsd-lsq-test volumio[13855]: info: Starting Shairport Sync Jun 30 07:05:42 ifi-phmidsd-lsq-test volumio[13855]: info: Loading plugin "outputs"... Jun 30 07:05:42 ifi-phmidsd-lsq-test volumio[13855]: info: Loading plugin "albumart"... Jun 30 07:05:42 ifi-phmidsd-lsq-test volumio[13855]: info: Plugin example_plugin is not enabled Jun 30 07:05:42 ifi-phmidsd-lsq-test volumio[13855]: info: Loading plugin "inputs"... Jun 30 07:05:42 ifi-phmidsd-lsq-test volumio[13855]: info: Loading plugin "updater_comm"... Jun 30 07:05:42 ifi-phmidsd-lsq-test volumio[13855]: info: Plugin mpdemulation is not enabled Jun 30 07:05:42 ifi-phmidsd-lsq-test volumio[13855]: info: Loading plugin "rest_api"... Jun 30 07:05:42 ifi-phmidsd-lsq-test volumio[13855]: info: Loading plugin "websocket"... Jun 30 07:05:42 ifi-phmidsd-lsq-test volumio[13855]: info: Starting Socket.io Server version 2.3.0 Jun 30 07:05:42 ifi-phmidsd-lsq-test volumio[13855]: info: Plugin cdplayer is not enabled Jun 30 07:05:42 ifi-phmidsd-lsq-test volumio[13855]: info: Loading plugin "ifi-cdplayer"... Jun 30 07:05:43 ifi-phmidsd-lsq-test volumio[13855]: Forking 3 albumart workers Jun 30 07:05:43 ifi-phmidsd-lsq-test volumio[13855]: info: Applying required configuration parameters for plugin ifi-cdplayer Jun 30 07:05:43 ifi-phmidsd-lsq-test volumio[13855]: info: Loading i18n strings for locale en Jun 30 07:05:43 ifi-phmidsd-lsq-test volumio[13855]: Updating browse sources language Jun 30 07:05:43 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 07:05:44 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 30 07:05:44 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::initPlayerControls Jun 30 07:05:44 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 07:05:44 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Jun 30 07:05:44 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 07:05:44 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 07:05:44 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 07:05:44 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 07:05:44 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 07:05:44 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 30 07:05:44 ifi-phmidsd-lsq-test volumio[13855]: Removing existing socket file at /tmp/meta.sock Jun 30 07:05:44 ifi-phmidsd-lsq-test volumio[13855]: Express server listening on port 3000 Jun 30 07:05:44 ifi-phmidsd-lsq-test volumio[13855]: [Metrics] WebUI: 9s 49.60ms Jun 30 07:05:44 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::resetVolumioState Jun 30 07:05:44 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::getcurrentVolume Jun 30 07:05:44 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioRetrievevolume Jun 30 07:05:44 ifi-phmidsd-lsq-test volumio[13855]: Meta server listening Jun 30 07:05:44 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveCurrentVolume Jun 30 07:05:44 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::pushState Jun 30 07:05:44 ifi-phmidsd-lsq-test volumio[13855]: info: CorePlayQueue::getTrack 0 Jun 30 07:05:44 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 07:05:44 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioPushState Jun 30 07:05:44 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 07:05:44 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 07:05:44 ifi-phmidsd-lsq-test volumio[13855]: info: Server listening on port 6599 Jun 30 07:05:44 ifi-phmidsd-lsq-test sudo[14250]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-tidal-connect.service Jun 30 07:05:44 ifi-phmidsd-lsq-test sudo[14250]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 07:05:44 ifi-phmidsd-lsq-test volumio[13855]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jun 30 07:05:44 ifi-phmidsd-lsq-test sudo[14256]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start ifi-streamer-qobuz-connect.service Jun 30 07:05:44 ifi-phmidsd-lsq-test volumio[13855]: info: Completed loading Core Plugins Jun 30 07:05:44 ifi-phmidsd-lsq-test volumio[13855]: info: Preparing to generate the ALSA configuration file Jun 30 07:05:44 ifi-phmidsd-lsq-test sudo[14256]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 07:05:44 ifi-phmidsd-lsq-test node[482]: Closing connection with the client tidal-connect Jun 30 07:05:44 ifi-phmidsd-lsq-test systemd[1]: Stopping iFi Streamer Tidal Metadata Service... Jun 30 07:05:44 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-tidal-metadata.service: Main process exited, code=killed, status=15/TERM Jun 30 07:05:44 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-tidal-metadata.service: Succeeded. Jun 30 07:05:44 ifi-phmidsd-lsq-test systemd[1]: Stopped iFi Streamer Tidal Metadata Service. Jun 30 07:05:44 ifi-phmidsd-lsq-test sudo[14256]: pam_unix(sudo:session): session closed for user root Jun 30 07:05:44 ifi-phmidsd-lsq-test systemd[1]: Stopping iFi Streamer Tidal Connect Service... Jun 30 07:05:44 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-tidal-connect.service: Main process exited, code=killed, status=15/TERM Jun 30 07:05:44 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-tidal-connect.service: Succeeded. Jun 30 07:05:44 ifi-phmidsd-lsq-test systemd[1]: Stopped iFi Streamer Tidal Connect Service. Jun 30 07:05:44 ifi-phmidsd-lsq-test systemd[1]: Started iFi Streamer Tidal Connect Service. Jun 30 07:05:44 ifi-phmidsd-lsq-test sudo[14250]: pam_unix(sudo:session): session closed for user root Jun 30 07:05:44 ifi-phmidsd-lsq-test volumio[13855]: info: ConvSwitch: Connected to server Jun 30 07:05:44 ifi-phmidsd-lsq-test node[481]: ConvSwitch: Add client volumio Jun 30 07:05:45 ifi-phmidsd-lsq-test volumio[13855]: info: MetaClient: Connected to server Jun 30 07:05:45 ifi-phmidsd-lsq-test systemd[1]: Started iFi Streamer Tidal Metadata Service. Jun 30 07:05:45 ifi-phmidsd-lsq-test node[482]: A new connection has been established. Jun 30 07:05:45 ifi-phmidsd-lsq-test volumio[13855]: info: Volumio Network Manager: Network status updated: 3 Jun 30 07:05:45 ifi-phmidsd-lsq-test volumio[13855]: Starting albumart workers Jun 30 07:05:45 ifi-phmidsd-lsq-test volumio[13855]: info: NAA Service Started Jun 30 07:05:45 ifi-phmidsd-lsq-test volumio[13855]: Starting albumart workers Jun 30 07:05:45 ifi-phmidsd-lsq-test volumio[13855]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Jun 30 07:05:45 ifi-phmidsd-lsq-test volumio[13855]: info: Cannot mount NAS testmusic at system boot, trial number 2 ,retrying in 5 seconds Jun 30 07:05:45 ifi-phmidsd-lsq-test volumio[13855]: Starting albumart workers Jun 30 07:05:45 ifi-phmidsd-lsq-test volumio[13855]: info: ConvSwitch: Get message: success Jun 30 07:05:45 ifi-phmidsd-lsq-test volumio[13855]: info: MetaClient: Get message: success Jun 30 07:05:45 ifi-phmidsd-lsq-test volumio[13855]: verbose: New Socket.io Connection to 192.168.1.127 from 192.168.1.189 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Jun 30 07:05:45 ifi-phmidsd-lsq-test volumio[13855]: verbose: New Socket.io Connection to 192.168.1.171 from 192.168.1.189 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Jun 30 07:05:45 ifi-phmidsd-lsq-test volumio[13855]: verbose: New Socket.io Connection to 192.168.1.127 from 192.168.1.189 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Jun 30 07:05:45 ifi-phmidsd-lsq-test volumio[13855]: verbose: New Socket.io Connection to 192.168.1.127 from 192.168.1.189 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Jun 30 07:05:45 ifi-phmidsd-lsq-test volumio[13855]: verbose: New Socket.io Connection to 192.168.1.171 from 192.168.1.189 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Jun 30 07:05:45 ifi-phmidsd-lsq-test volumio[13855]: verbose: New Socket.io Connection to 192.168.1.171 from 192.168.1.189 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Jun 30 07:05:45 ifi-phmidsd-lsq-test volumio[13855]: verbose: New Socket.io Connection to 192.168.1.127 from 192.168.1.189 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Jun 30 07:05:45 ifi-phmidsd-lsq-test volumio[13855]: verbose: New Socket.io Connection to 192.168.1.171 from 192.168.1.189 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Jun 30 07:05:45 ifi-phmidsd-lsq-test volumio[13855]: verbose: New Socket.io Connection to 192.168.1.127 from 192.168.1.189 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Jun 30 07:05:45 ifi-phmidsd-lsq-test volumio[13855]: verbose: New Socket.io Connection to 192.168.1.171 from 192.168.1.189 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Jun 30 07:05:45 ifi-phmidsd-lsq-test volumio[13855]: verbose: New Socket.io Connection to 192.168.1.127 from 192.168.1.189 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Jun 30 07:05:45 ifi-phmidsd-lsq-test volumio[13855]: verbose: New Socket.io Connection to 192.168.1.171 from 192.168.1.189 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 Jun 30 07:05:45 ifi-phmidsd-lsq-test volumio[13855]: info: Tidal Connect Service Started Jun 30 07:05:45 ifi-phmidsd-lsq-test volumio[13855]: info: Qobuz Connect Service Started Jun 30 07:05:45 ifi-phmidsd-lsq-test volumio[13855]: verbose: New Socket.io Connection to 192.168.1.127 from 192.168.1.189 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 13 Jun 30 07:05:45 ifi-phmidsd-lsq-test sudo[14301]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-spotify-connect.service Jun 30 07:05:45 ifi-phmidsd-lsq-test sudo[14301]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 07:05:45 ifi-phmidsd-lsq-test volumio[13855]: verbose: New Socket.io Connection to 192.168.1.171 from 192.168.1.189 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 14 Jun 30 07:05:45 ifi-phmidsd-lsq-test volumio[13855]: verbose: New Socket.io Connection to 192.168.1.127 from 192.168.1.189 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 15 Jun 30 07:05:45 ifi-phmidsd-lsq-test play[11026]: 2025-06-30 07:05:45.888 E esdk select error: 4 -> Interrupted system call Jun 30 07:05:45 ifi-phmidsd-lsq-test play[11026]: 2025-06-30 07:05:45.889 I app Exiting with error = 0 Jun 30 07:05:45 ifi-phmidsd-lsq-test play[11026]: 2025-06-30 07:05:45.890 I api SpFree() Jun 30 07:05:45 ifi-phmidsd-lsq-test play[11026]: 2025-06-30 07:05:45.896 I api SpFree [returned value: 0] Jun 30 07:05:45 ifi-phmidsd-lsq-test play[11026]: [Info] ConvSwitch: ConvSwitch SDK -- v1.03 Jun 30 07:05:45 ifi-phmidsd-lsq-test play[11026]: [Info] ConvSwitch: ConvSwitchInit Jun 30 07:05:45 ifi-phmidsd-lsq-test play[11026]: [Info] MetaClient: MetaClient SDK -- v1.02 Jun 30 07:05:45 ifi-phmidsd-lsq-test play[11026]: [Info] MetaClient: MetaClientInit Jun 30 07:05:45 ifi-phmidsd-lsq-test play[11026]: [Info] ConvSwitch: ConvSwitchExit Jun 30 07:05:45 ifi-phmidsd-lsq-test play[11026]: [Info] MetaClient: MetaClientExit Jun 30 07:05:45 ifi-phmidsd-lsq-test node[482]: Closing connection with the client spotify Jun 30 07:05:45 ifi-phmidsd-lsq-test node[481]: ConvSwitch: Drop client spotify Jun 30 07:05:45 ifi-phmidsd-lsq-test volumio[13855]: verbose: New Socket.io Connection to 192.168.1.127 from 192.168.1.189 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 16 Jun 30 07:05:45 ifi-phmidsd-lsq-test volumio[13855]: verbose: New Socket.io Connection to 192.168.1.171 from 192.168.1.189 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 17 Jun 30 07:05:45 ifi-phmidsd-lsq-test systemd[1]: Stopping iFi Streamer Spotify Connect Service... Jun 30 07:05:45 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-spotify-connect.service: Main process exited, code=killed, status=15/TERM Jun 30 07:05:45 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-spotify-connect.service: Succeeded. Jun 30 07:05:45 ifi-phmidsd-lsq-test systemd[1]: Stopped iFi Streamer Spotify Connect Service. Jun 30 07:05:45 ifi-phmidsd-lsq-test volumio[13855]: verbose: New Socket.io Connection to 192.168.1.171 from 192.168.1.189 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 18 Jun 30 07:05:45 ifi-phmidsd-lsq-test systemd[1]: Started iFi Streamer Spotify Connect Service. Jun 30 07:05:45 ifi-phmidsd-lsq-test sudo[14301]: pam_unix(sudo:session): session closed for user root Jun 30 07:05:45 ifi-phmidsd-lsq-test volumio[13855]: verbose: New Socket.io Connection to 192.168.1.127 from 192.168.1.189 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 19 Jun 30 07:05:45 ifi-phmidsd-lsq-test volumio[13855]: verbose: New Socket.io Connection to 192.168.1.171 from 192.168.1.189 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 20 Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: verbose: New Socket.io Connection to 192.168.1.127 from 192.168.1.189 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 21 Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: verbose: New Socket.io Connection to 192.168.1.171 from 192.168.1.189 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 22 Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: verbose: New Socket.io Connection to 192.168.1.127 from 192.168.1.189 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 23 Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: verbose: New Socket.io Connection to 192.168.1.171 from 192.168.1.189 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 24 Jun 30 07:05:46 ifi-phmidsd-lsq-test play[14304]: output: volumio mixer: hw:0 Jun 30 07:05:46 ifi-phmidsd-lsq-test node[481]: ConvSwitch: Add client spotify Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: Reloading queue from file Jun 30 07:05:46 ifi-phmidsd-lsq-test node[482]: A new connection has been established. Jun 30 07:05:46 ifi-phmidsd-lsq-test play[14304]: 2025-06-30 07:05:46.329 I api SpRegisterDebugCallbacks [returned value: 0] Jun 30 07:05:46 ifi-phmidsd-lsq-test play[14304]: 2025-06-30 07:05:46.330 I api SpInit(0xff808ff0, API v66) Jun 30 07:05:46 ifi-phmidsd-lsq-test play[14304]: 2025-06-30 07:05:46.330 I esdk eSDK version: HEAD-v3.166.69-g24821f73 Jun 30 07:05:46 ifi-phmidsd-lsq-test play[14304]: 2025-06-30 07:05:46.331 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 Jun 30 07:05:46 ifi-phmidsd-lsq-test play[14304]: 2025-06-30 07:05:46.331 I esdk Successfully registered dns callback: dns_lookup_callback Jun 30 07:05:46 ifi-phmidsd-lsq-test play[14304]: 2025-06-30 07:05:46.331 I download Using 128 kB for cache buffer Jun 30 07:05:46 ifi-phmidsd-lsq-test play[14304]: 2025-06-30 07:05:46.331 I download Using 621 kB for compressed audio buffer Jun 30 07:05:46 ifi-phmidsd-lsq-test play[14304]: 2025-06-30 07:05:46.331 I esdk Successfully registered error callback Jun 30 07:05:46 ifi-phmidsd-lsq-test play[14304]: 2025-06-30 07:05:46.351 I esdk Creating IPv4 socket (domain 2) Jun 30 07:05:46 ifi-phmidsd-lsq-test play[14304]: 2025-06-30 07:05:46.360 I zc webserver: service port 5566 (5566-5576) buffer size 4444 Jun 30 07:05:46 ifi-phmidsd-lsq-test play[14304]: 2025-06-30 07:05:46.361 I zc Started ZeroConf service on port 5566 path /zc alias count 0 Jun 30 07:05:46 ifi-phmidsd-lsq-test play[14304]: 2025-06-30 07:05:46.372 I esdk Creating IPv4 socket (domain 2) Jun 30 07:05:46 ifi-phmidsd-lsq-test play[14304]: 2025-06-30 07:05:46.374 I api SpInit [returned value: 0] Jun 30 07:05:46 ifi-phmidsd-lsq-test play[14304]: 2025-06-30 07:05:46.375 I api SpRegisterConnectionCallbacks(0xff808fd8, (nil)) Jun 30 07:05:46 ifi-phmidsd-lsq-test play[14304]: 2025-06-30 07:05:46.377 I esdk Successfully registered connection callbacks: on_notify, on_message, on_new_credentials Jun 30 07:05:46 ifi-phmidsd-lsq-test play[14304]: 2025-06-30 07:05:46.378 I api SpRegisterConnectionCallbacks [returned value: 0] Jun 30 07:05:46 ifi-phmidsd-lsq-test play[14304]: 2025-06-30 07:05:46.379 I api SpRegisterPlaybackCallbacks(0xff808fc0, (nil)) Jun 30 07:05:46 ifi-phmidsd-lsq-test play[14304]: 2025-06-30 07:05:46.380 I esdk Successfully registered playback callbacks: on_notify, on_audio_data, on_seek, on_apply_volume, - Jun 30 07:05:46 ifi-phmidsd-lsq-test play[14304]: 2025-06-30 07:05:46.381 I api SpRegisterPlaybackCallbacks [returned value: 0] Jun 30 07:05:46 ifi-phmidsd-lsq-test play[14304]: 2025-06-30 07:05:46.389 I app Initialized! Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: ++++--++++ getState Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioGetState Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: CorePlayQueue::getTrack 0 Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: Spotify Connect Service Started Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::setRepeat false single undefined Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::pushState Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: CorePlayQueue::getTrack 0 Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioPushState Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::setRandom undefined Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::pushState Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: CorePlayQueue::getTrack 0 Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioPushState Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: ++++--++++ getMultiRoomDevices: null Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: ++++--++++ getMultiroom: null Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: error: Could not retrieve plugin audio_interface multiroom Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: ++++--++++ getBrowseSources: null Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioGetVisibleSources Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: ++++--++++ getMenuItems Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: ++++--++++ listPlaylist: null Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: Listing playlists Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: ++++--++++ getQueue Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioGetQueue Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::getQueue Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: CorePlayQueue::getQueue Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: Asound.conf file unchanged, so no further update is needed Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: Tidal connect: Output device has changed Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: Output device has changed, restarting MPD Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: Qobuz connect: Output device has changed Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: Roon Ready: Output device has changed Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: Spotify: Output device has changed Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: ___________ START PLUGINS ___________ Jun 30 07:05:46 ifi-phmidsd-lsq-test sudo[14360]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: ControllerMpd::onStart: Initializing MPD Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: Creating MPD Configuration file Jun 30 07:05:46 ifi-phmidsd-lsq-test sudo[14360]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 07:05:46 ifi-phmidsd-lsq-test sudo[14360]: pam_unix(sudo:session): session closed for user root Jun 30 07:05:46 ifi-phmidsd-lsq-test sudo[14370]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 30 07:05:46 ifi-phmidsd-lsq-test sudo[14370]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: [1751267146740] CoreMusicLibrary::Adding element Media Servers Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 07:05:46 ifi-phmidsd-lsq-test sudo[14370]: pam_unix(sudo:session): session closed for user root Jun 30 07:05:46 ifi-phmidsd-lsq-test sudo[14372]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop mpd.socket mpd.service Jun 30 07:05:46 ifi-phmidsd-lsq-test sudo[14372]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 07:05:46 ifi-phmidsd-lsq-test systemd[1]: mpd.socket: Succeeded. Jun 30 07:05:46 ifi-phmidsd-lsq-test systemd[1]: Closed mpd.socket. Jun 30 07:05:46 ifi-phmidsd-lsq-test systemd[1]: Stopping Music Player Daemon... Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: [1751267146810] CoreMusicLibrary::Adding element Last_100 Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: Starting RoonReady Sync Jun 30 07:05:46 ifi-phmidsd-lsq-test systemd[1]: mpd.service: Succeeded. Jun 30 07:05:46 ifi-phmidsd-lsq-test systemd[1]: Stopped Music Player Daemon. Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: [1751267146846] CoreMusicLibrary::Adding element Webradio Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: Initializing BBC Radios Jun 30 07:05:46 ifi-phmidsd-lsq-test sudo[14376]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-roon-ready.service Jun 30 07:05:46 ifi-phmidsd-lsq-test sudo[14376]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 07:05:46 ifi-phmidsd-lsq-test sudo[14372]: pam_unix(sudo:session): session closed for user root Jun 30 07:05:46 ifi-phmidsd-lsq-test systemd[1]: Stopping iFi Streamer Roon Ready Service... Jun 30 07:05:46 ifi-phmidsd-lsq-test node[482]: Closing connection with the client roon-ready Jun 30 07:05:46 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=killed, status=15/TERM Jun 30 07:05:46 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-roon-ready.service: Succeeded. Jun 30 07:05:46 ifi-phmidsd-lsq-test systemd[1]: Stopped iFi Streamer Roon Ready Service. Jun 30 07:05:46 ifi-phmidsd-lsq-test systemd[1]: Started iFi Streamer Roon Ready Service. Jun 30 07:05:46 ifi-phmidsd-lsq-test sudo[14376]: pam_unix(sudo:session): session closed for user root Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 30 07:05:46 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 07:05:47 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 07:05:47 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 07:05:47 ifi-phmidsd-lsq-test sudo[14390]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -snf /usr/local/bin/airplay2 /usr/local/bin/shairport-sync Jun 30 07:05:47 ifi-phmidsd-lsq-test sudo[14390]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 07:05:47 ifi-phmidsd-lsq-test sudo[14390]: pam_unix(sudo:session): session closed for user root Jun 30 07:05:47 ifi-phmidsd-lsq-test volumio[13855]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 07:05:47 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 07:05:47 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 07:05:47 ifi-phmidsd-lsq-test volumio[13855]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 07:05:47 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 30 07:05:47 ifi-phmidsd-lsq-test volumio[13855]: info: [1751267147111] CoreMusicLibrary::Adding element Audio CD/DVD Jun 30 07:05:47 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 07:05:47 ifi-phmidsd-lsq-test volumio[13855]: Cannot find translation for source Audio CD/DVD Jun 30 07:05:47 ifi-phmidsd-lsq-test play[14381]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input Jun 30 07:05:47 ifi-phmidsd-lsq-test volumio[13855]: info: CDClient: Client Start Jun 30 07:05:47 ifi-phmidsd-lsq-test volumio[13855]: info: Volumio Calling Home Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jun 30 07:05:47 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.004E/input/input77 Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: hid-generic 0003:20B1:3008.004E: input,hidraw0: USB HID v1.11 Device [iFi (by AMR) iDSD PHANTOM] on usb-xhci-hcd.0.auto-1.2/input4 Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test demo[26398]: MPD error: Connection refused Jun 30 07:05:47 ifi-phmidsd-lsq-test demo[26398]: MPD error: Connection refused Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test systemd-udevd[14415]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test demo[26398]: MPD error: Connection refused Jun 30 07:05:47 ifi-phmidsd-lsq-test demo[26398]: MPD error: Connection refused Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test volumio[13855]: info: Discovery: adding 0a764952-50a3-46c5-aace-8fe6aecec920 Jun 30 07:05:47 ifi-phmidsd-lsq-test volumio[13855]: info: Discovery: Found device iFi-neo-eriri Jun 30 07:05:47 ifi-phmidsd-lsq-test volumio[13855]: info: Discovery: Connecting to remote: 192.168.1.169 Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jun 30 07:05:47 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jun 30 07:05:47 ifi-phmidsd-lsq-test volumio[13855]: info: Starting RoonReady Sync Jun 30 07:05:47 ifi-phmidsd-lsq-test sudo[14496]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop ifi-streamer-qobuz-connect.service Jun 30 07:05:47 ifi-phmidsd-lsq-test sudo[14496]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 07:05:47 ifi-phmidsd-lsq-test volumio[13855]: info: Discovery: adding 26417df3-38a8-4f75-ba8a-55b45544821c Jun 30 07:05:47 ifi-phmidsd-lsq-test volumio[13855]: info: Discovery: Found device iFi-2 Jun 30 07:05:47 ifi-phmidsd-lsq-test sudo[14498]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-roon-ready.service Jun 30 07:05:47 ifi-phmidsd-lsq-test sudo[14498]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 07:05:47 ifi-phmidsd-lsq-test volumio[13855]: info: Discovery: Connecting to remote: 192.168.1.218 Jun 30 07:05:47 ifi-phmidsd-lsq-test node[482]: Closing connection with the client qobuz-connect Jun 30 07:05:47 ifi-phmidsd-lsq-test systemd[1]: Stopping iFi Streamer Qobuz Connect Service... Jun 30 07:05:47 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-qobuz-connect.service: Main process exited, code=killed, status=15/TERM Jun 30 07:05:47 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-qobuz-connect.service: Succeeded. Jun 30 07:05:47 ifi-phmidsd-lsq-test systemd[1]: Stopped iFi Streamer Qobuz Connect Service. Jun 30 07:05:47 ifi-phmidsd-lsq-test volumio[13855]: info: ConvSwitch: Get message: request:pause Jun 30 07:05:47 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioStop Jun 30 07:05:47 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::stop Jun 30 07:05:47 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 30 07:05:47 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioStop Jun 30 07:05:47 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::stop Jun 30 07:05:47 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 30 07:05:47 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 30 07:05:47 ifi-phmidsd-lsq-test sudo[14496]: pam_unix(sudo:session): session closed for user root Jun 30 07:05:47 ifi-phmidsd-lsq-test volumio[13855]: info: CDClient: Connected to server Jun 30 07:05:47 ifi-phmidsd-lsq-test systemd[1]: Stopping iFi Streamer Roon Ready Service... Jun 30 07:05:47 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=killed, status=15/TERM Jun 30 07:05:47 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-roon-ready.service: Succeeded. Jun 30 07:05:47 ifi-phmidsd-lsq-test volumio[13855]: info: Airplay2 Started Jun 30 07:05:47 ifi-phmidsd-lsq-test systemd[1]: Stopped iFi Streamer Roon Ready Service. Jun 30 07:05:47 ifi-phmidsd-lsq-test volumio[13855]: error: Could not retrieve plugin music_service airplay1_switch Jun 30 07:05:47 ifi-phmidsd-lsq-test systemd[1]: Started iFi Streamer Roon Ready Service. Jun 30 07:05:47 ifi-phmidsd-lsq-test sudo[14498]: pam_unix(sudo:session): session closed for user root Jun 30 07:05:47 ifi-phmidsd-lsq-test volumio[13855]: info: Disabling plugin airplay1_switch Jun 30 07:05:47 ifi-phmidsd-lsq-test volumio[13855]: info: Done. Jun 30 07:05:47 ifi-phmidsd-lsq-test volumio[13855]: info: RoonReady Started Jun 30 07:05:48 ifi-phmidsd-lsq-test sudo[14504]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop shairport-sync Jun 30 07:05:48 ifi-phmidsd-lsq-test sudo[14504]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: info: MPD Permissions set Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: info: MPD Permissions set Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: info: CDClient: Get message Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: Disc loaded: /dev/sr0 Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: info: disc onGetDisc Jun 30 07:05:48 ifi-phmidsd-lsq-test systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 30 07:05:48 ifi-phmidsd-lsq-test systemd[1]: shairport-sync.service: Succeeded. Jun 30 07:05:48 ifi-phmidsd-lsq-test systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 30 07:05:48 ifi-phmidsd-lsq-test sudo[14507]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.socket mpd.service Jun 30 07:05:48 ifi-phmidsd-lsq-test sudo[14504]: pam_unix(sudo:session): session closed for user root Jun 30 07:05:48 ifi-phmidsd-lsq-test sudo[14507]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 07:05:48 ifi-phmidsd-lsq-test systemd[1]: Listening on mpd.socket. Jun 30 07:05:48 ifi-phmidsd-lsq-test ifi_metadata[14262]: [Info] MetaClient: MetaClient SDK -- v1.02 Jun 30 07:05:48 ifi-phmidsd-lsq-test ifi_metadata[14262]: [Info] MetaClient: MetaClientInit Jun 30 07:05:48 ifi-phmidsd-lsq-test ifi_metadata[14262]: Could not connect: Reason::CONNECTION_ERROR Jun 30 07:05:48 ifi-phmidsd-lsq-test systemd[1]: Starting Music Player Daemon... Jun 30 07:05:48 ifi-phmidsd-lsq-test tidal_connect_application[14494]: *** WARNING *** The program 'tidal_connect_application' uses the Apple Bonjour compatibility layer of Avahi. Jun 30 07:05:48 ifi-phmidsd-lsq-test tidal_connect_application[14494]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 07:05:48 ifi-phmidsd-lsq-test tidal_connect_application[14494]: *** WARNING *** For more information see Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: info: RoonReady Started Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: info: Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: ---------------------------- Client requests Start RoonReady PlaybackRoutine Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: roon_ready , startRoonReadyPlayback Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: info: Roon Ready playback start Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioStop Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::stop Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: info: Starting Roon Ready metadata receiver Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: Error adding Membership: Error: addMembership EINVAL Jun 30 07:05:48 ifi-phmidsd-lsq-test sudo[14510]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 30 07:05:48 ifi-phmidsd-lsq-test sudo[14510]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 07:05:48 ifi-phmidsd-lsq-test sudo[14510]: pam_unix(sudo:session): session closed for user root Jun 30 07:05:48 ifi-phmidsd-lsq-test ifi_metadata[14262]: Connected Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 25 Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: info: Volumio called home Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: info: Shairport-Sync Stopped Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 07:05:48 ifi-phmidsd-lsq-test play[14502]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: error: Could not retrieve plugin audio_interface multiroom Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: info: Discovery: Connected to remote: 192.168.1.169 Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: error: Could not retrieve plugin audio_interface multiroom Jun 30 07:05:48 ifi-phmidsd-lsq-test sudo[14592]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-tidal-connect.service Jun 30 07:05:48 ifi-phmidsd-lsq-test sudo[14592]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: info: Discovery: adding 7a2a87ae-9864-4896-b72d-e2751dd260de Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: info: Discovery: Found device lsq-test Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioGetState Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: info: CorePlayQueue::getTrack 0 Jun 30 07:05:48 ifi-phmidsd-lsq-test volumio[13855]: error: Could not retrieve plugin audio_interface multiroom Jun 30 07:05:49 ifi-phmidsd-lsq-test sudo[14594]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop mpd.socket mpd.service Jun 30 07:05:49 ifi-phmidsd-lsq-test sudo[14594]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 07:05:49 ifi-phmidsd-lsq-test node[482]: Closing connection with the client tidal-connect Jun 30 07:05:49 ifi-phmidsd-lsq-test systemd[1]: Stopping iFi Streamer Tidal Metadata Service... Jun 30 07:05:49 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-tidal-metadata.service: Main process exited, code=killed, status=15/TERM Jun 30 07:05:49 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-tidal-metadata.service: Succeeded. Jun 30 07:05:49 ifi-phmidsd-lsq-test systemd[1]: Stopped iFi Streamer Tidal Metadata Service. Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: error: Could not retrieve plugin audio_interface multiroom Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: info: Discovery: Connected to remote: 192.168.1.218 Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: error: Could not retrieve plugin audio_interface multiroom Jun 30 07:05:49 ifi-phmidsd-lsq-test systemd[1]: mpd.socket: Succeeded. Jun 30 07:05:49 ifi-phmidsd-lsq-test systemd[1]: Closed mpd.socket. Jun 30 07:05:49 ifi-phmidsd-lsq-test systemd[1]: Stopping iFi Streamer Tidal Connect Service... Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: info: ConvSwitch: Get message: request:pause Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioStop Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::stop Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioStop Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::stop Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 30 07:05:49 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-tidal-connect.service: Main process exited, code=killed, status=15/TERM Jun 30 07:05:49 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-tidal-connect.service: Succeeded. Jun 30 07:05:49 ifi-phmidsd-lsq-test systemd[1]: Stopped iFi Streamer Tidal Connect Service. Jun 30 07:05:49 ifi-phmidsd-lsq-test systemd[1]: Started iFi Streamer Tidal Connect Service. Jun 30 07:05:49 ifi-phmidsd-lsq-test sudo[14592]: pam_unix(sudo:session): session closed for user root Jun 30 07:05:49 ifi-phmidsd-lsq-test systemd[1]: Started iFi Streamer Tidal Metadata Service. Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: info: Starting Shairport Sync Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: info: Starting Shairport Sync Jun 30 07:05:49 ifi-phmidsd-lsq-test node[482]: A new connection has been established. Jun 30 07:05:49 ifi-phmidsd-lsq-test sudo[14507]: pam_unix(sudo:session): session closed for user root Jun 30 07:05:49 ifi-phmidsd-lsq-test demo[26398]: MPD error: Connection reset by peer Jun 30 07:05:49 ifi-phmidsd-lsq-test systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jun 30 07:05:49 ifi-phmidsd-lsq-test systemd[1]: mpd.service: Succeeded. Jun 30 07:05:49 ifi-phmidsd-lsq-test systemd[1]: Stopped Music Player Daemon. Jun 30 07:05:49 ifi-phmidsd-lsq-test sudo[14604]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 30 07:05:49 ifi-phmidsd-lsq-test sudo[14604]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 07:05:49 ifi-phmidsd-lsq-test demo[26398]: MPD error: Connection refused Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: info: Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: ---------------------------- Client requests Start RoonReady PlaybackRoutine Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: roon_ready , startRoonReadyPlayback Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: info: Roon Ready playback start Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioStop Jun 30 07:05:49 ifi-phmidsd-lsq-test sudo[14614]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 30 07:05:49 ifi-phmidsd-lsq-test sudo[14614]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::stop Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 30 07:05:49 ifi-phmidsd-lsq-test demo[26398]: MPD error: Connection refused Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: info: Roon Ready metadata receiver is on Jun 30 07:05:49 ifi-phmidsd-lsq-test sudo[14594]: pam_unix(sudo:session): session closed for user root Jun 30 07:05:49 ifi-phmidsd-lsq-test demo[26398]: MPD error: Connection refused Jun 30 07:05:49 ifi-phmidsd-lsq-test systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 30 07:05:49 ifi-phmidsd-lsq-test demo[26398]: MPD error: Connection refused Jun 30 07:05:49 ifi-phmidsd-lsq-test sudo[14604]: pam_unix(sudo:session): session closed for user root Jun 30 07:05:49 ifi-phmidsd-lsq-test sudo[14614]: pam_unix(sudo:session): session closed for user root Jun 30 07:05:49 ifi-phmidsd-lsq-test demo[26398]: MPD error: Connection refused Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: info: ++++--++++ getState Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioGetState Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: info: CorePlayQueue::getTrack 0 Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: info: Tidal Connect Service Started Jun 30 07:05:49 ifi-phmidsd-lsq-test sudo[14638]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start ifi-streamer-qobuz-connect.service Jun 30 07:05:49 ifi-phmidsd-lsq-test sudo[14638]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: info: Shairport-Sync Started Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: Error adding Membership: Error: addMembership EINVAL Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: info: Shairport-Sync Started Jun 30 07:05:49 ifi-phmidsd-lsq-test systemd[1]: Started iFi Streamer Qobuz Connect Service. Jun 30 07:05:49 ifi-phmidsd-lsq-test sudo[14638]: pam_unix(sudo:session): session closed for user root Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: error: Cannot start MPD on system Start: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.socket mpd.service Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: Job for mpd.service canceled. Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: info: Completed starting Core Plugins Jun 30 07:05:49 ifi-phmidsd-lsq-test sudo[14645]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.socket mpd.service Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: [Metrics] CommandRouter: 13s 445.27ms Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::Close All Modals sent Jun 30 07:05:49 ifi-phmidsd-lsq-test sudo[14645]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumiosetStartupVolume Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: info: VolumeController::SetAlsaVolume68 Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 07:05:49 ifi-phmidsd-lsq-test systemd[1]: Listening on mpd.socket. Jun 30 07:05:49 ifi-phmidsd-lsq-test systemd[1]: Starting Music Player Daemon... Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveCurrentVolume Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::pushState Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioPushState Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: error: connect ECONNREFUSED /run/mpd/socket {"errno":-111,"code":"ECONNREFUSED","syscall":"connect","address":"/run/mpd/socket"} Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: error: Could not retrieve plugin audio_interface multiroom Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: error: Could not retrieve plugin audio_interface multiroom Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: aplay: main:828: audio open error: Device or resource busy Jun 30 07:05:49 ifi-phmidsd-lsq-test volumio[13855]: info: Qobuz Connect Service Started Jun 30 07:05:50 ifi-phmidsd-lsq-test sudo[14660]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 30 07:05:50 ifi-phmidsd-lsq-test sudo[14660]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 07:05:50 ifi-phmidsd-lsq-test ethernet-detect[454]: No change in avahi-daemon interfaces. Skipping restart. Jun 30 07:05:50 ifi-phmidsd-lsq-test sudo[14660]: pam_unix(sudo:session): session closed for user root Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:50.042 [14702.14702] DEBUG SampleApp: Starting sample application Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:50.045 [14702.14702] DEBUG SampleApp: Device Name: lsq-test Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:50.046 [14702.14702] DEBUG SampleApp: Manufacturer: Sample manufacturer Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:50.046 [14702.14702] DEBUG SampleApp: Model: iFi Streamer Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:50.046 [14702.14702] DEBUG SampleApp: Serial Number: ifi:32:ef:95:fd:98:7f Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:50.046 [14702.14702] DEBUG SampleApp: Application ID: 679318972 Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:50.046 [14702.14702] DEBUG SampleApp: Application Secret: a32fe515ff9d11ffafcb2b2a1426c244 Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:50.046 [14702.14702] DEBUG SampleApp: Audio output device: volumio Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:50.046 [14702.14702] DEBUG SampleApp: Volume control device: default Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:50.046 [14702.14702] DEBUG SampleApp: Volume control element: Master Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:50.046 [14702.14702] DEBUG SampleApp: Local config server port: 8000 Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:50.053 [14702.14702] ERROR SampleApp: Unable to find ALSA mixer element 'Master' on index 0 Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:50.055 [14702.14702] DEBUG SampleApp: Maximum supported audio quality: HIRES_L3 Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: [Info] MetaClient: MetaClient SDK -- v1.02 Jun 30 07:05:50 ifi-phmidsd-lsq-test node[482]: A new connection has been established. Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: [Info] MetaClient: MetaClientInit Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: [Info] ConvSwitch: ConvSwitch SDK -- v1.03 Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: [Info] ConvSwitch: ConvSwitchInit Jun 30 07:05:50 ifi-phmidsd-lsq-test volumio[13855]: info: Cannot mount NAS testmusic at system boot, trial number 3 ,retrying in 5 seconds Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:50.187 [14702.14702] DEBUG ActiveStateManager: [0xab267da0]: Creating new Active State Manager Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:50.187 [14702.14702] DEBUG NetworkActivityTracker: [0xab267e10]: Creating new Network Activity Tracker Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:50.191 [14702.14702] DEBUG EndpointManager: [0xab268d88]: Creating Endpoint Manager Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:50.191 [14702.14702] DEBUG PlaybackSessionManager: [0xab269178]: Creating Playback Session Manager Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:50.191 [14702.14702] DEBUG BackoffTimer: [0xab2692f0]: Creating Backoff Timer Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:50.191 [14702.14702] DEBUG MediaEngine: [0xab269410]: Creating new Media Engine Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:50.191 [14702.14702] DEBUG AudioRenderer: [0xab269630]: Creating Audio Renderer Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:50.191 [14702.14702] TRACE MediaEngineCommandSequencer: [0xab269788]: Creating Media Engine Command Sequencer Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:50.191 [14702.14702] DEBUG PlaybackControlsManager: [0xab2697e8]: Creating new Playback Controls Manager Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:50.191 [14702.14702] DEBUG VolumeManager: [0xab269878]: Creating new Volume Manager Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:50.191 [14702.14702] DEBUG ProtocolHandler: [0xab269b50]: Creating Protocol Handler Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:50.191 [14702.14702] DEBUG MessageReceiver: [0xab269bf0]: Creating Message Receiver Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:50.191 [14702.14702] DEBUG RendererActivationController: [0xab269d68]: Creating new Renderer Activation Controller Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:50.191 [14702.14702] TRACE RendererActivationCommandSequencer: [0xab269e10]: Creating Renderer Activation Command Sequencer Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:50.191 [14702.14702] DEBUG ReportingManager: [0xab269f20]: Creating new Reporting Manager Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:50.191 [14702.14702] DEBUG StreamingEventReporter: [0xab269f68]: Creating Streaming Event Reporter Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:50.191 [14702.14702] DEBUG BackoffTimer: [0xab26a048]: Creating Backoff Timer Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:50.192 [14702.14702] DEBUG TokenExpiryController: [0xab26a158]: Creating Token Expiry Controller Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:50.192 [14702.14702] DEBUG UserInactivityManager: [0xab26a1a8]: Creating new User Inactivity Manager Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:50.192 [14702.14702] INFO VolumeManager: [0xab269878]: Setting new playback volume: 100 Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:50.192 [14702.14702] INFO VolumeManager: [0xab269878]: Setting new mute state: 1 Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:50.192 [14702.14702] DEBUG SampleApp: Qobuz Connect has been initialized Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:50.192 [14702.14702] TRACE SampleApp: Running event loop Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:50.192 [14702.14702] INFO QobuzConnect: [0xab26a248]: Client initialized! Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:50.192 [14702.14702] INFO SampleApp: Starting Avahi advertising, name: lsq-test, service name: _qobuz-connect._tcp Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:50.211 [14702.14702] DEBUG SampleApp: Avahi client state changed: RUNNING Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:50.216 [14702.14702] DEBUG SampleApp: Avahi entry group state changed: UNCOMMITED Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:50.222 [14702.14702] INFO LocalConfigManager: [0xab269158]: Starting Local Configuration server Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:50.222 [14702.14702] INFO SampleApp: Starting Local configuration server Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:50.224 [14702.14702] INFO SampleApp: Playback mute state changed: 1 Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:50.224 [14702.14702] ERROR SampleApp: Unable to set mute state, no ALSA volume element Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:50.224 [14702.14702] DEBUG SampleApp: Avahi entry group state changed: REGISTERING Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:50.224 [14702.14702] INFO SampleApp: Playback volume changed: 100 Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:50.224 [14702.14702] ERROR SampleApp: Unable to set volume, no ALSA volume element Jun 30 07:05:50 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=exited, status=1/FAILURE Jun 30 07:05:50 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-roon-ready.service: Failed with result 'exit-code'. Jun 30 07:05:50 ifi-phmidsd-lsq-test sudo[14732]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 30 07:05:50 ifi-phmidsd-lsq-test sudo[14732]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 07:05:50 ifi-phmidsd-lsq-test sudo[14732]: pam_unix(sudo:session): session closed for user root Jun 30 07:05:50 ifi-phmidsd-lsq-test sudo[14735]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 30 07:05:50 ifi-phmidsd-lsq-test sudo[14735]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 07:05:50 ifi-phmidsd-lsq-test sudo[14735]: pam_unix(sudo:session): session closed for user root Jun 30 07:05:50 ifi-phmidsd-lsq-test sudo[14737]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart upmpdcli.service Jun 30 07:05:50 ifi-phmidsd-lsq-test sudo[14737]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 07:05:50 ifi-phmidsd-lsq-test systemd[1]: Stopping UPnP Renderer front-end to MPD... Jun 30 07:05:50 ifi-phmidsd-lsq-test systemd[1]: upmpdcli.service: Succeeded. Jun 30 07:05:50 ifi-phmidsd-lsq-test systemd[1]: Stopped UPnP Renderer front-end to MPD. Jun 30 07:05:50 ifi-phmidsd-lsq-test systemd[1]: Started UPnP Renderer front-end to MPD. Jun 30 07:05:50 ifi-phmidsd-lsq-test sudo[14737]: pam_unix(sudo:session): session closed for user root Jun 30 07:05:50 ifi-phmidsd-lsq-test volumio[13855]: info: Upmpdcli Daemon Started Jun 30 07:05:50 ifi-phmidsd-lsq-test volumio[13855]: New connection from ::ffff:127.0.0.1:37636 Jun 30 07:05:50 ifi-phmidsd-lsq-test volumio[13855]: Connected to MPD server Jun 30 07:05:50 ifi-phmidsd-lsq-test volumio-remote-updater[469]: [2025-06-30 07:05:50] [connect] Successful connection Jun 30 07:05:50 ifi-phmidsd-lsq-test volumio-remote-updater[469]: [2025-06-30 07:05:50] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1751267150 101 Jun 30 07:05:50 ifi-phmidsd-lsq-test volumio[13855]: 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: 26 Jun 30 07:05:50 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jun 30 07:05:50 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 30 07:05:50 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jun 30 07:05:50 ifi-phmidsd-lsq-test sudo[14750]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-spotify-connect.service Jun 30 07:05:50 ifi-phmidsd-lsq-test sudo[14750]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14304]: 2025-06-30 07:05:50.944 E esdk select error: 4 -> Interrupted system call Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14304]: 2025-06-30 07:05:50.945 I app Exiting with error = 0 Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14304]: 2025-06-30 07:05:50.945 I api SpFree() Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14304]: 2025-06-30 07:05:50.946 I api SpFree [returned value: 0] Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14304]: [Info] ConvSwitch: ConvSwitch SDK -- v1.03 Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14304]: [Info] ConvSwitch: ConvSwitchInit Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14304]: [Info] MetaClient: MetaClient SDK -- v1.02 Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14304]: [Info] MetaClient: MetaClientInit Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14304]: [Info] ConvSwitch: ConvSwitchExit Jun 30 07:05:50 ifi-phmidsd-lsq-test play[14304]: [Info] MetaClient: MetaClientExit Jun 30 07:05:50 ifi-phmidsd-lsq-test node[482]: Closing connection with the client spotify Jun 30 07:05:50 ifi-phmidsd-lsq-test node[481]: ConvSwitch: Drop client spotify Jun 30 07:05:50 ifi-phmidsd-lsq-test systemd[1]: Stopping iFi Streamer Spotify Connect Service... Jun 30 07:05:50 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-spotify-connect.service: Main process exited, code=killed, status=15/TERM Jun 30 07:05:50 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-spotify-connect.service: Succeeded. Jun 30 07:05:50 ifi-phmidsd-lsq-test systemd[1]: Stopped iFi Streamer Spotify Connect Service. Jun 30 07:05:50 ifi-phmidsd-lsq-test systemd[1]: Started iFi Streamer Spotify Connect Service. Jun 30 07:05:50 ifi-phmidsd-lsq-test sudo[14750]: pam_unix(sudo:session): session closed for user root Jun 30 07:05:51 ifi-phmidsd-lsq-test volumio[13855]: info: Spotify Connect Service Started Jun 30 07:05:51 ifi-phmidsd-lsq-test play[14752]: output: volumio mixer: hw:0 Jun 30 07:05:51 ifi-phmidsd-lsq-test node[481]: ConvSwitch: Add client spotify Jun 30 07:05:51 ifi-phmidsd-lsq-test node[482]: A new connection has been established. Jun 30 07:05:51 ifi-phmidsd-lsq-test play[14643]: 20250630 07:05:51.213 [14702.14702] DEBUG SampleApp: Avahi entry group state changed: ESTABLISHED Jun 30 07:05:51 ifi-phmidsd-lsq-test play[14752]: 2025-06-30 07:05:51.226 I api SpRegisterDebugCallbacks [returned value: 0] Jun 30 07:05:51 ifi-phmidsd-lsq-test play[14752]: 2025-06-30 07:05:51.227 I api SpInit(0xfff8d6c0, API v66) Jun 30 07:05:51 ifi-phmidsd-lsq-test play[14752]: 2025-06-30 07:05:51.228 I esdk eSDK version: HEAD-v3.166.69-g24821f73 Jun 30 07:05:51 ifi-phmidsd-lsq-test play[14752]: 2025-06-30 07:05:51.230 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 Jun 30 07:05:51 ifi-phmidsd-lsq-test play[14752]: 2025-06-30 07:05:51.231 I esdk Successfully registered dns callback: dns_lookup_callback Jun 30 07:05:51 ifi-phmidsd-lsq-test play[14752]: 2025-06-30 07:05:51.232 I download Using 128 kB for cache buffer Jun 30 07:05:51 ifi-phmidsd-lsq-test play[14752]: 2025-06-30 07:05:51.232 I download Using 621 kB for compressed audio buffer Jun 30 07:05:51 ifi-phmidsd-lsq-test play[14752]: 2025-06-30 07:05:51.232 I esdk Successfully registered error callback Jun 30 07:05:51 ifi-phmidsd-lsq-test play[14752]: 2025-06-30 07:05:51.247 I esdk Creating IPv4 socket (domain 2) Jun 30 07:05:51 ifi-phmidsd-lsq-test play[14752]: 2025-06-30 07:05:51.248 I zc webserver: service port 5566 (5566-5576) buffer size 4444 Jun 30 07:05:51 ifi-phmidsd-lsq-test play[14752]: 2025-06-30 07:05:51.249 I zc Started ZeroConf service on port 5566 path /zc alias count 0 Jun 30 07:05:51 ifi-phmidsd-lsq-test play[14752]: 2025-06-30 07:05:51.250 I esdk Creating IPv4 socket (domain 2) Jun 30 07:05:51 ifi-phmidsd-lsq-test play[14752]: 2025-06-30 07:05:51.251 I api SpInit [returned value: 0] Jun 30 07:05:51 ifi-phmidsd-lsq-test play[14752]: 2025-06-30 07:05:51.252 I api SpRegisterConnectionCallbacks(0xfff8d6a8, (nil)) Jun 30 07:05:51 ifi-phmidsd-lsq-test play[14752]: 2025-06-30 07:05:51.253 I esdk Successfully registered connection callbacks: on_notify, on_message, on_new_credentials Jun 30 07:05:51 ifi-phmidsd-lsq-test play[14752]: 2025-06-30 07:05:51.255 I api SpRegisterConnectionCallbacks [returned value: 0] Jun 30 07:05:51 ifi-phmidsd-lsq-test play[14752]: 2025-06-30 07:05:51.256 I api SpRegisterPlaybackCallbacks(0xfff8d690, (nil)) Jun 30 07:05:51 ifi-phmidsd-lsq-test play[14752]: 2025-06-30 07:05:51.258 I esdk Successfully registered playback callbacks: on_notify, on_audio_data, on_seek, on_apply_volume, - Jun 30 07:05:51 ifi-phmidsd-lsq-test play[14752]: 2025-06-30 07:05:51.259 I api SpRegisterPlaybackCallbacks [returned value: 0] Jun 30 07:05:51 ifi-phmidsd-lsq-test play[14752]: 2025-06-30 07:05:51.267 I app Initialized! Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jun 30 07:05:51 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.004F/input/input78 Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: hid-generic 0003:20B1:3008.004F: input,hidraw0: USB HID v1.11 Device [iFi (by AMR) iDSD PHANTOM] on usb-xhci-hcd.0.auto-1.2/input4 Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-roon-ready.service: Service RestartSec=1s expired, scheduling restart. Jun 30 07:05:51 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-roon-ready.service: Scheduled restart job, restart counter is at 1. Jun 30 07:05:51 ifi-phmidsd-lsq-test systemd[1]: Stopped iFi Streamer Roon Ready Service. Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test systemd[1]: Started iFi Streamer Roon Ready Service. Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test systemd-udevd[14781]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Jun 30 07:05:51 ifi-phmidsd-lsq-test kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jun 30 07:05:52 ifi-phmidsd-lsq-test play[14786]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input Jun 30 07:05:52 ifi-phmidsd-lsq-test tidal_connect_application[14809]: *** WARNING *** The program 'tidal_connect_application' uses the Apple Bonjour compatibility layer of Avahi. Jun 30 07:05:52 ifi-phmidsd-lsq-test tidal_connect_application[14809]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 07:05:52 ifi-phmidsd-lsq-test tidal_connect_application[14809]: *** WARNING *** For more information see Jun 30 07:05:52 ifi-phmidsd-lsq-test ifi_metadata[14598]: [Info] MetaClient: MetaClient SDK -- v1.02 Jun 30 07:05:52 ifi-phmidsd-lsq-test ifi_metadata[14598]: [Info] MetaClient: MetaClientInit Jun 30 07:05:52 ifi-phmidsd-lsq-test ifi_metadata[14598]: Could not connect: Reason::CONNECTION_ERROR Jun 30 07:05:52 ifi-phmidsd-lsq-test volumio[13855]: info: ConvSwitch: Get message: request:pause Jun 30 07:05:52 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioStop Jun 30 07:05:52 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::stop Jun 30 07:05:52 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::serviceStop Jun 30 07:05:52 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::serviceStop Jun 30 07:05:52 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioStop Jun 30 07:05:52 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::stop Jun 30 07:05:52 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 30 07:05:52 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 30 07:05:52 ifi-phmidsd-lsq-test volumio[13855]: info: Roon Ready Stop Jun 30 07:05:52 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioStop Jun 30 07:05:52 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::stop Jun 30 07:05:52 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 30 07:05:52 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 30 07:05:52 ifi-phmidsd-lsq-test volumio[13855]: info: Jun 30 07:05:52 ifi-phmidsd-lsq-test volumio[13855]: ---------------------------- Client requests Start RoonReady PlaybackRoutine Jun 30 07:05:52 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: roon_ready , startRoonReadyPlayback Jun 30 07:05:52 ifi-phmidsd-lsq-test volumio[13855]: info: Roon Ready playback start Jun 30 07:05:52 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioStop Jun 30 07:05:52 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::stop Jun 30 07:05:52 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 30 07:05:52 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 30 07:05:52 ifi-phmidsd-lsq-test volumio[13855]: info: Roon Ready metadata receiver is on Jun 30 07:05:52 ifi-phmidsd-lsq-test ifi_metadata[14598]: Connected Jun 30 07:05:52 ifi-phmidsd-lsq-test volumio[13855]: Connection closed by client Jun 30 07:05:53 ifi-phmidsd-lsq-test mpd[14711]: Jun 30 07:05 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 30 07:05:53 ifi-phmidsd-lsq-test systemd[1]: Started Music Player Daemon. Jun 30 07:05:53 ifi-phmidsd-lsq-test volumio[13855]: error: Socket error: Error: This socket has been ended by the other party Jun 30 07:05:53 ifi-phmidsd-lsq-test sudo[14645]: pam_unix(sudo:session): session closed for user root Jun 30 07:05:53 ifi-phmidsd-lsq-test volumio[13855]: MPD server connection closed Jun 30 07:05:53 ifi-phmidsd-lsq-test volumio[13855]: info: Restarted MPD. Jun 30 07:05:53 ifi-phmidsd-lsq-test volumio[13855]: error: updateQueue error: null Jun 30 07:05:53 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=exited, status=1/FAILURE Jun 30 07:05:53 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-roon-ready.service: Failed with result 'exit-code'. Jun 30 07:05:54 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioStop Jun 30 07:05:54 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::stop Jun 30 07:05:54 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::serviceStop Jun 30 07:05:54 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::serviceStop Jun 30 07:05:54 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioStop Jun 30 07:05:54 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::stop Jun 30 07:05:54 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 30 07:05:54 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 30 07:05:54 ifi-phmidsd-lsq-test volumio[13855]: info: Roon Ready Stop Jun 30 07:05:54 ifi-phmidsd-lsq-test volumio[13855]: New connection from ::ffff:127.0.0.1:37644 Jun 30 07:05:54 ifi-phmidsd-lsq-test volumio[13855]: Connected to MPD server Jun 30 07:05:54 ifi-phmidsd-lsq-test volumio[13855]: New connection from ::ffff:127.0.0.1:37648 Jun 30 07:05:54 ifi-phmidsd-lsq-test volumio[13855]: Connected to MPD server Jun 30 07:05:54 ifi-phmidsd-lsq-test volumio[14740]: writing RSA key Jun 30 07:05:54 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-roon-ready.service: Service RestartSec=1s expired, scheduling restart. Jun 30 07:05:54 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-roon-ready.service: Scheduled restart job, restart counter is at 2. Jun 30 07:05:54 ifi-phmidsd-lsq-test systemd[1]: Stopped iFi Streamer Roon Ready Service. Jun 30 07:05:54 ifi-phmidsd-lsq-test systemd[1]: Started iFi Streamer Roon Ready Service. Jun 30 07:05:55 ifi-phmidsd-lsq-test volumio[13855]: info: Cannot mount NAS testmusic at system boot, trial number 4 ,retrying in 5 seconds Jun 30 07:05:55 ifi-phmidsd-lsq-test play[14956]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input Jun 30 07:05:55 ifi-phmidsd-lsq-test volumio[13855]: info: ConvSwitch: Get message: request:pause Jun 30 07:05:55 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioStop Jun 30 07:05:55 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::stop Jun 30 07:05:55 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 30 07:05:55 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioStop Jun 30 07:05:55 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::stop Jun 30 07:05:55 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 30 07:05:55 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 30 07:05:55 ifi-phmidsd-lsq-test volumio[13855]: info: Jun 30 07:05:55 ifi-phmidsd-lsq-test volumio[13855]: ---------------------------- Client requests Start RoonReady PlaybackRoutine Jun 30 07:05:55 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: roon_ready , startRoonReadyPlayback Jun 30 07:05:55 ifi-phmidsd-lsq-test volumio[13855]: info: Roon Ready playback start Jun 30 07:05:55 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioStop Jun 30 07:05:55 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::stop Jun 30 07:05:55 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 30 07:05:55 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 30 07:05:55 ifi-phmidsd-lsq-test volumio[13855]: info: Roon Ready metadata receiver is on Jun 30 07:05:56 ifi-phmidsd-lsq-test volumio[13855]: info: ++++--++++ browseLibrary: {"uri":"cdrom"} Jun 30 07:05:56 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: ifi-cdplayer , handleBrowseUri Jun 30 07:05:56 ifi-phmidsd-lsq-test volumio[13855]: info: cdrom Jun 30 07:05:56 ifi-phmidsd-lsq-test sudo[15028]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 664 /dev/sr0 Jun 30 07:05:56 ifi-phmidsd-lsq-test sudo[15028]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 07:05:56 ifi-phmidsd-lsq-test sudo[15028]: pam_unix(sudo:session): session closed for user root Jun 30 07:05:56 ifi-phmidsd-lsq-test volumio[13855]: info: Preload queue cleared Jun 30 07:05:56 ifi-phmidsd-lsq-test volumio[13855]: info: BOOT COMPLETED Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: ++++--++++ browseLibrary: {"uri":"cdrom/tracks/dev/sr0","prevUri":"cdrom"} Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: ifi-cdplayer , handleBrowseUri Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: cdrom/tracks/dev/sr0 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: +++++++++++++++++++uri: cdrom/tracks/dev/sr0 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: [ Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: "dev", Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: "sr0" Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: ] Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: request tracks for /dev/sr0 Jun 30 07:05:57 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=exited, status=1/FAILURE Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: ++++++++++++cdDrives: {"loaded":true,"disc":{"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}]}} Jun 30 07:05:57 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-roon-ready.service: Failed with result 'exit-code'. Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: Received drive state: { Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: loaded: true, Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: disc: { Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: dev: '/dev/sr0', Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: mode: 6, Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: total_tracks: 10, Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: audio_length: 0, Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: tracks: [ Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: [Object], [Object], Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: [Object], [Object] Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: ] Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: } Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: } Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: ++++++++++++++++song: {"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"} Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: ++++++++++++++++song: {"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"} Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: ++++++++++++++++song: {"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"} Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: ++++++++++++++++song: {"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"} Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: ++++++++++++++++song: {"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"} Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: ++++++++++++++++song: {"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"} Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: ++++++++++++++++song: {"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"} Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: ++++++++++++++++song: {"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"} Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: ++++++++++++++++song: {"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"} Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: ++++++++++++++++song: {"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"} Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: Preload queue cleared Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: Preloading song: cdrom/tracks/dev/sr0/0 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: Preloading song: cdrom/tracks/dev/sr0/1 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: Preloading song: cdrom/tracks/dev/sr0/2 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: Preloading song: cdrom/tracks/dev/sr0/3 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: Preloading song: cdrom/tracks/dev/sr0/4 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: Preloading song: cdrom/tracks/dev/sr0/5 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: Preloading song: cdrom/tracks/dev/sr0/6 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: Preloading song: cdrom/tracks/dev/sr0/7 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: Preloading song: cdrom/tracks/dev/sr0/8 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: Preloading song: cdrom/tracks/dev/sr0/9 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: Exploding uri cdrom/tracks/dev/sr0/0 in service ifi-cdplayer Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: explode: cdrom/tracks/dev/sr0/0 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: +++++++++++++++++++uri: cdrom/tracks/dev/sr0/0 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: [ Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: "dev", Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: "sr0", Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: "0" Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: ] Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: aaaaaaaaaaaaa parts: {"drive":"/dev/sr0","track":"0","uri":"/dev/sr0/0"} Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: ++++++++++++cdDrives: {"loaded":true,"disc":{"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}]}} Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: -------------- drive: {"loaded":true,"disc":{"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}]}}, parts.track: 0 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: hhhhhhhhhhhhhhhhhhhhhhhh, uri: /dev/sr0/0, name: Track 1, time: 328 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: Exploding uri cdrom/tracks/dev/sr0/1 in service ifi-cdplayer Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: explode: cdrom/tracks/dev/sr0/1 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: +++++++++++++++++++uri: cdrom/tracks/dev/sr0/1 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: [ Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: "dev", Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: "sr0", Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: "1" Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: ] Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: aaaaaaaaaaaaa parts: {"drive":"/dev/sr0","track":"1","uri":"/dev/sr0/1"} Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: ++++++++++++cdDrives: {"loaded":true,"disc":{"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}]}} Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: -------------- drive: {"loaded":true,"disc":{"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}]}}, parts.track: 1 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: hhhhhhhhhhhhhhhhhhhhhhhh, uri: /dev/sr0/1, name: Track 2, time: 290 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: Exploding uri cdrom/tracks/dev/sr0/2 in service ifi-cdplayer Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: explode: cdrom/tracks/dev/sr0/2 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: +++++++++++++++++++uri: cdrom/tracks/dev/sr0/2 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: [ Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: "dev", Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: "sr0", Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: "2" Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: ] Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: aaaaaaaaaaaaa parts: {"drive":"/dev/sr0","track":"2","uri":"/dev/sr0/2"} Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: ++++++++++++cdDrives: {"loaded":true,"disc":{"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}]}} Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: -------------- drive: {"loaded":true,"disc":{"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}]}}, parts.track: 2 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: hhhhhhhhhhhhhhhhhhhhhhhh, uri: /dev/sr0/2, name: Track 3, time: 312 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: Exploding uri cdrom/tracks/dev/sr0/3 in service ifi-cdplayer Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: explode: cdrom/tracks/dev/sr0/3 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: +++++++++++++++++++uri: cdrom/tracks/dev/sr0/3 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: [ Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: "dev", Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: "sr0", Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: "3" Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: ] Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: aaaaaaaaaaaaa parts: {"drive":"/dev/sr0","track":"3","uri":"/dev/sr0/3"} Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: ++++++++++++cdDrives: {"loaded":true,"disc":{"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}]}} Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: -------------- drive: {"loaded":true,"disc":{"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}]}}, parts.track: 3 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: hhhhhhhhhhhhhhhhhhhhhhhh, uri: /dev/sr0/3, name: Track 4, time: 304 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: Exploding uri cdrom/tracks/dev/sr0/4 in service ifi-cdplayer Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: explode: cdrom/tracks/dev/sr0/4 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: +++++++++++++++++++uri: cdrom/tracks/dev/sr0/4 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: [ Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: "dev", Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: "sr0", Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: "4" Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: ] Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: aaaaaaaaaaaaa parts: {"drive":"/dev/sr0","track":"4","uri":"/dev/sr0/4"} Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: ++++++++++++cdDrives: {"loaded":true,"disc":{"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}]}} Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: -------------- drive: {"loaded":true,"disc":{"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}]}}, parts.track: 4 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: hhhhhhhhhhhhhhhhhhhhhhhh, uri: /dev/sr0/4, name: Track 5, time: 363 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: Exploding uri cdrom/tracks/dev/sr0/5 in service ifi-cdplayer Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: explode: cdrom/tracks/dev/sr0/5 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: +++++++++++++++++++uri: cdrom/tracks/dev/sr0/5 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: [ Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: "dev", Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: "sr0", Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: "5" Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: ] Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: aaaaaaaaaaaaa parts: {"drive":"/dev/sr0","track":"5","uri":"/dev/sr0/5"} Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: ++++++++++++cdDrives: {"loaded":true,"disc":{"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}]}} Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: -------------- drive: {"loaded":true,"disc":{"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}]}}, parts.track: 5 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: hhhhhhhhhhhhhhhhhhhhhhhh, uri: /dev/sr0/5, name: Track 6, time: 251 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: Exploding uri cdrom/tracks/dev/sr0/6 in service ifi-cdplayer Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: explode: cdrom/tracks/dev/sr0/6 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: +++++++++++++++++++uri: cdrom/tracks/dev/sr0/6 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: [ Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: "dev", Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: "sr0", Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: "6" Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: ] Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: aaaaaaaaaaaaa parts: {"drive":"/dev/sr0","track":"6","uri":"/dev/sr0/6"} Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: ++++++++++++cdDrives: {"loaded":true,"disc":{"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}]}} Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: -------------- drive: {"loaded":true,"disc":{"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}]}}, parts.track: 6 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: hhhhhhhhhhhhhhhhhhhhhhhh, uri: /dev/sr0/6, name: Track 7, time: 321 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: Exploding uri cdrom/tracks/dev/sr0/7 in service ifi-cdplayer Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: explode: cdrom/tracks/dev/sr0/7 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: +++++++++++++++++++uri: cdrom/tracks/dev/sr0/7 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: [ Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: "dev", Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: "sr0", Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: "7" Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: ] Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: aaaaaaaaaaaaa parts: {"drive":"/dev/sr0","track":"7","uri":"/dev/sr0/7"} Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: ++++++++++++cdDrives: {"loaded":true,"disc":{"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}]}} Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: -------------- drive: {"loaded":true,"disc":{"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}]}}, parts.track: 7 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: hhhhhhhhhhhhhhhhhhhhhhhh, uri: /dev/sr0/7, name: Track 8, time: 266 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: Exploding uri cdrom/tracks/dev/sr0/8 in service ifi-cdplayer Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: explode: cdrom/tracks/dev/sr0/8 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: +++++++++++++++++++uri: cdrom/tracks/dev/sr0/8 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: [ Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: "dev", Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: "sr0", Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: "8" Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: ] Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: aaaaaaaaaaaaa parts: {"drive":"/dev/sr0","track":"8","uri":"/dev/sr0/8"} Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: ++++++++++++cdDrives: {"loaded":true,"disc":{"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}]}} Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: -------------- drive: {"loaded":true,"disc":{"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}]}}, parts.track: 8 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: hhhhhhhhhhhhhhhhhhhhhhhh, uri: /dev/sr0/8, name: Track 9, time: 272 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: Exploding uri cdrom/tracks/dev/sr0/9 in service ifi-cdplayer Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: explode: cdrom/tracks/dev/sr0/9 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: +++++++++++++++++++uri: cdrom/tracks/dev/sr0/9 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: [ Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: "dev", Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: "sr0", Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: "9" Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: ] Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: aaaaaaaaaaaaa parts: {"drive":"/dev/sr0","track":"9","uri":"/dev/sr0/9"} Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: ++++++++++++cdDrives: {"loaded":true,"disc":{"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}]}} Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: -------------- drive: {"loaded":true,"disc":{"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}]}}, parts.track: 9 Jun 30 07:05:57 ifi-phmidsd-lsq-test volumio[13855]: info: hhhhhhhhhhhhhhhhhhhhhhhh, uri: /dev/sr0/9, name: Track 10, time: 289 Jun 30 07:05:58 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-roon-ready.service: Service RestartSec=1s expired, scheduling restart. Jun 30 07:05:58 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-roon-ready.service: Scheduled restart job, restart counter is at 3. Jun 30 07:05:58 ifi-phmidsd-lsq-test systemd[1]: Stopped iFi Streamer Roon Ready Service. Jun 30 07:05:58 ifi-phmidsd-lsq-test systemd[1]: Started iFi Streamer Roon Ready Service. Jun 30 07:05:58 ifi-phmidsd-lsq-test volumio[13855]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Jun 30 07:05:58 ifi-phmidsd-lsq-test play[15077]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: info: ConvSwitch: Get message: request:pause Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioStop Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::stop Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::serviceStop Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::serviceStop Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioStop Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::stop Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: info: Roon Ready Stop Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioStop Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::stop Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: info: Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: ---------------------------- Client requests Start RoonReady PlaybackRoutine Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: roon_ready , startRoonReadyPlayback Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: info: Roon Ready playback start Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioStop Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::stop Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: info: Roon Ready metadata receiver is on Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: 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} Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: info: Preload queue cleared Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::ClearQueue Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::stop Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: info: CorePlayQueue::clearPlayQueue Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: info: CorePlayQueue::saveQueue Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioPushQueue Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::addQueueItems Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: info: CorePlayQueue::addQueueItems Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: info: Preload queue cleared Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: info: Adding Item to queue: cdrom/tracks/dev/sr0/0 Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: info: Exploding uri cdrom/tracks/dev/sr0/0 in service ifi-cdplayer Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: info: explode: cdrom/tracks/dev/sr0/0 Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: +++++++++++++++++++uri: cdrom/tracks/dev/sr0/0 Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: info: [ Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: "dev", Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: "sr0", Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: "0" Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: ] Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: aaaaaaaaaaaaa parts: {"drive":"/dev/sr0","track":"0","uri":"/dev/sr0/0"} Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: ++++++++++++cdDrives: {"loaded":true,"disc":{"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}]}} Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: -------------- drive: {"loaded":true,"disc":{"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}]}}, parts.track: 0 Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: info: hhhhhhhhhhhhhhhhhhhhhhhh, uri: /dev/sr0/0, name: Track 1, time: 328 Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: info: Adding Item to queue: cdrom/tracks/dev/sr0/1 Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: info: Exploding uri cdrom/tracks/dev/sr0/1 in service ifi-cdplayer Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: info: explode: cdrom/tracks/dev/sr0/1 Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: +++++++++++++++++++uri: cdrom/tracks/dev/sr0/1 Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: info: [ Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: "dev", Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: "sr0", Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: "1" Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: ] Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: aaaaaaaaaaaaa parts: {"drive":"/dev/sr0","track":"1","uri":"/dev/sr0/1"} Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: ++++++++++++cdDrives: {"loaded":true,"disc":{"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}]}} Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: -------------- drive: {"loaded":true,"disc":{"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}]}}, parts.track: 1 Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: info: hhhhhhhhhhhhhhhhhhhhhhhh, uri: /dev/sr0/1, name: Track 2, time: 290 Jun 30 07:05:59 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioPushQueue Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: CorePlayQueue::saveQueue Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::updateTrackBlock Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: CorePlayQueue::getTrackBlock Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: ConvSwitch: Sent Play Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioPlay Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::play index 1 Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::addQueueItems Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: CorePlayQueue::addQueueItems Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: Preload queue cleared Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: Adding Item to queue: cdrom/tracks/dev/sr0/2 Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: Exploding uri cdrom/tracks/dev/sr0/2 in service ifi-cdplayer Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: explode: cdrom/tracks/dev/sr0/2 Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: +++++++++++++++++++uri: cdrom/tracks/dev/sr0/2 Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: [ Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: "dev", Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: "sr0", Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: "2" Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: ] Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: aaaaaaaaaaaaa parts: {"drive":"/dev/sr0","track":"2","uri":"/dev/sr0/2"} Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: ++++++++++++cdDrives: {"loaded":true,"disc":{"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}]}} Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: -------------- drive: {"loaded":true,"disc":{"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}]}}, parts.track: 2 Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: hhhhhhhhhhhhhhhhhhhhhhhh, uri: /dev/sr0/2, name: Track 3, time: 312 Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: Adding Item to queue: cdrom/tracks/dev/sr0/3 Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: Exploding uri cdrom/tracks/dev/sr0/3 in service ifi-cdplayer Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: explode: cdrom/tracks/dev/sr0/3 Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: +++++++++++++++++++uri: cdrom/tracks/dev/sr0/3 Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: [ Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: "dev", Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: "sr0", Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: "3" Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: ] Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: aaaaaaaaaaaaa parts: {"drive":"/dev/sr0","track":"3","uri":"/dev/sr0/3"} Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: ++++++++++++cdDrives: {"loaded":true,"disc":{"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}]}} Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: -------------- drive: {"loaded":true,"disc":{"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}]}}, parts.track: 3 Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: hhhhhhhhhhhhhhhhhhhhhhhh, uri: /dev/sr0/3, name: Track 4, time: 304 Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: Adding Item to queue: cdrom/tracks/dev/sr0/4 Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: Exploding uri cdrom/tracks/dev/sr0/4 in service ifi-cdplayer Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: explode: cdrom/tracks/dev/sr0/4 Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: +++++++++++++++++++uri: cdrom/tracks/dev/sr0/4 Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: [ Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: "dev", Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: "sr0", Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: "4" Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: ] Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: aaaaaaaaaaaaa parts: {"drive":"/dev/sr0","track":"4","uri":"/dev/sr0/4"} Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: ++++++++++++cdDrives: {"loaded":true,"disc":{"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}]}} Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: -------------- drive: {"loaded":true,"disc":{"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}]}}, parts.track: 4 Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: hhhhhhhhhhhhhhhhhhhhhhhh, uri: /dev/sr0/4, name: Track 5, time: 363 Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: Adding Item to queue: cdrom/tracks/dev/sr0/5 Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: Exploding uri cdrom/tracks/dev/sr0/5 in service ifi-cdplayer Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: explode: cdrom/tracks/dev/sr0/5 Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: +++++++++++++++++++uri: cdrom/tracks/dev/sr0/5 Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: [ Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: "dev", Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: "sr0", Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: "5" Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: ] Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: aaaaaaaaaaaaa parts: {"drive":"/dev/sr0","track":"5","uri":"/dev/sr0/5"} Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: ++++++++++++cdDrives: {"loaded":true,"disc":{"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}]}} Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: -------------- drive: {"loaded":true,"disc":{"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}]}}, parts.track: 5 Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: hhhhhhhhhhhhhhhhhhhhhhhh, uri: /dev/sr0/5, name: Track 6, time: 251 Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: Adding Item to queue: cdrom/tracks/dev/sr0/6 Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: Exploding uri cdrom/tracks/dev/sr0/6 in service ifi-cdplayer Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: explode: cdrom/tracks/dev/sr0/6 Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: +++++++++++++++++++uri: cdrom/tracks/dev/sr0/6 Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: [ Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: "dev", Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: "sr0", Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: "6" Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: ] Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: aaaaaaaaaaaaa parts: {"drive":"/dev/sr0","track":"6","uri":"/dev/sr0/6"} Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: ++++++++++++cdDrives: {"loaded":true,"disc":{"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}]}} Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: -------------- drive: {"loaded":true,"disc":{"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}]}}, parts.track: 6 Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: hhhhhhhhhhhhhhhhhhhhhhhh, uri: /dev/sr0/6, name: Track 7, time: 321 Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: Adding Item to queue: cdrom/tracks/dev/sr0/7 Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: Exploding uri cdrom/tracks/dev/sr0/7 in service ifi-cdplayer Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: explode: cdrom/tracks/dev/sr0/7 Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: +++++++++++++++++++uri: cdrom/tracks/dev/sr0/7 Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: [ Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: "dev", Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: "sr0", Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: "7" Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: ] Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: aaaaaaaaaaaaa parts: {"drive":"/dev/sr0","track":"7","uri":"/dev/sr0/7"} Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: ++++++++++++cdDrives: {"loaded":true,"disc":{"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}]}} Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: -------------- drive: {"loaded":true,"disc":{"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}]}}, parts.track: 7 Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: hhhhhhhhhhhhhhhhhhhhhhhh, uri: /dev/sr0/7, name: Track 8, time: 266 Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: Adding Item to queue: cdrom/tracks/dev/sr0/8 Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: Exploding uri cdrom/tracks/dev/sr0/8 in service ifi-cdplayer Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: explode: cdrom/tracks/dev/sr0/8 Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: +++++++++++++++++++uri: cdrom/tracks/dev/sr0/8 Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: [ Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: "dev", Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: "sr0", Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: "8" Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: ] Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: aaaaaaaaaaaaa parts: {"drive":"/dev/sr0","track":"8","uri":"/dev/sr0/8"} Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: ++++++++++++cdDrives: {"loaded":true,"disc":{"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}]}} Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: -------------- drive: {"loaded":true,"disc":{"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}]}}, parts.track: 8 Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: hhhhhhhhhhhhhhhhhhhhhhhh, uri: /dev/sr0/8, name: Track 9, time: 272 Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: Adding Item to queue: cdrom/tracks/dev/sr0/9 Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: Exploding uri cdrom/tracks/dev/sr0/9 in service ifi-cdplayer Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: explode: cdrom/tracks/dev/sr0/9 Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: +++++++++++++++++++uri: cdrom/tracks/dev/sr0/9 Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: [ Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: "dev", Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: "sr0", Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: "9" Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: ] Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: aaaaaaaaaaaaa parts: {"drive":"/dev/sr0","track":"9","uri":"/dev/sr0/9"} Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: ++++++++++++cdDrives: {"loaded":true,"disc":{"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}]}} Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: -------------- drive: {"loaded":true,"disc":{"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}]}}, parts.track: 9 Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: hhhhhhhhhhhhhhhhhhhhhhhh, uri: /dev/sr0/9, name: Track 10, time: 289 Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::stop Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::play index undefined Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: CorePlayQueue::getTrack 1 Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::startPlaybackTimer Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: CorePlayQueue::getTrack 1 Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: error: Could not retrieve plugin miscellanea metavolumio Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: aaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaa, track: {"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} Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: [1751267160107] CdPlayer::clearAddPlayTrack Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: 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} Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: [1751267160110] CdPlayer::pushState Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: Pushing state: {"status":"stop","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 Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::servicePushState Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::pushState Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioPushState Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: CorePlayQueue::getTrack 1 Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: verbose: STATE SERVICE {"status":"stop","service":"ifi-cdplayer","title":"Track 2","artist":"","album":"","albumart":"/albumart","uri":"","trackType":"CD","seek":0,"duration":290,"samplerate":"","bitdepth":"","channels":2,"disableUiControls":false} Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: verbose: CURRENT POSITION 1 Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::syncState stateService stop Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::syncState currentStatus stop Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::pushState Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioPushState Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: No code Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::pushState Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioPushState Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioPushQueue Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: CorePlayQueue::saveQueue Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::updateTrackBlock Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: CorePlayQueue::getTrackBlock Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Jun 30 07:06:00 ifi-phmidsd-lsq-test ethernet-detect[454]: No change in avahi-daemon interfaces. Skipping restart. Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: ConvSwitch: Get message: success Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: CDClient: Get message Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: disc onGetPlaybackStatus Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: [1751267160392] CdPlayer::pushState Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: 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 Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::servicePushState Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::pushState Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioPushState Jun 30 07:06:00 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 07:06:00 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=exited, status=1/FAILURE Jun 30 07:06:00 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-roon-ready.service: Failed with result 'exit-code'. Jun 30 07:06:01 ifi-phmidsd-lsq-test volumio[13855]: info: MetaClient: Sent Meta Jun 30 07:06:01 ifi-phmidsd-lsq-test volumio[13855]: info: MetaClient: Get message: success Jun 30 07:06:01 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-roon-ready.service: Service RestartSec=1s expired, scheduling restart. Jun 30 07:06:01 ifi-phmidsd-lsq-test systemd[1]: ifi-streamer-roon-ready.service: Scheduled restart job, restart counter is at 4. Jun 30 07:06:01 ifi-phmidsd-lsq-test systemd[1]: Stopped iFi Streamer Roon Ready Service. Jun 30 07:06:01 ifi-phmidsd-lsq-test systemd[1]: Started iFi Streamer Roon Ready Service. Jun 30 07:06:02 ifi-phmidsd-lsq-test play[15249]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: info: ConvSwitch: Get message: request:pause Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioStop Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::stop Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::serviceStop Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::serviceStop Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: info: [1751267162631] CdPlayer::stop Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: info: [1751267162632] CdPlayer::pushState Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: Pushing state: {"status":"stop","service":"ifi-cdplayer","title":"Track 2","artist":"","album":"","albumart":"/albumart","uri":"","trackType":"CD","seek":0,"duration":290,"samplerate":"","bitdepth":"","channels":2,"disableUiControls":false,"stream":false,"codec":"","repeatMode":"all"}, service: ifi-cdplayer Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::servicePushState Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::pushState Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioPushState Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: info: CorePlayQueue::getTrack 1 Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: verbose: STATE SERVICE {"status":"stop","service":"ifi-cdplayer","title":"Track 2","artist":"","album":"","albumart":"/albumart","uri":"","trackType":"CD","seek":0,"duration":290,"samplerate":"","bitdepth":"","channels":2,"disableUiControls":false,"stream":false,"codec":"","repeatMode":"all"} Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: verbose: CURRENT POSITION 1 Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::syncState stateService stop Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::syncState currentStatus play Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::play index undefined Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::pushState Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioPushState Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: info: CorePlayQueue::getTrack 2 Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::startPlaybackTimer Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: info: CorePlayQueue::getTrack 2 Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: aaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaaa, track: {"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} Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: info: [1751267162718] CdPlayer::clearAddPlayTrack Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: 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} Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: info: [1751267162720] CdPlayer::pushState Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: Pushing state: {"status":"stop","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 Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::servicePushState Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::pushState Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioPushState Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: info: CorePlayQueue::getTrack 2 Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: verbose: STATE SERVICE {"status":"stop","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"} Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: verbose: CURRENT POSITION 2 Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::syncState stateService stop Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::syncState currentStatus stop Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::pushState Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioPushState Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: info: No code Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::pushState Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioPushState Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::pushState Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioPushState Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: info: Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: ---------------------------- Client requests Start RoonReady PlaybackRoutine Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: roon_ready , startRoonReadyPlayback Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: info: Roon Ready playback start Jun 30 07:06:02 ifi-phmidsd-lsq-test volumio[13855]: info: Roon Ready metadata receiver is on Jun 30 07:06:04 ifi-phmidsd-lsq-test node[482]: A new connection has been established. Jun 30 07:06:04 ifi-phmidsd-lsq-test volumio[13855]: info: CDClient: Get message Jun 30 07:06:04 ifi-phmidsd-lsq-test volumio[13855]: info: disc onGetPlaybackStatus Jun 30 07:06:04 ifi-phmidsd-lsq-test volumio[13855]: info: [1751267164678] CdPlayer::pushState Jun 30 07:06:04 ifi-phmidsd-lsq-test volumio[13855]: Pushing state: {"status":"play","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 Jun 30 07:06:04 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::servicePushState Jun 30 07:06:04 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::pushState Jun 30 07:06:04 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 07:06:04 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioPushState Jun 30 07:06:04 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 07:06:05 ifi-phmidsd-lsq-test volumio[13855]: info: MetaClient: Sent Meta Jun 30 07:06:05 ifi-phmidsd-lsq-test node[482]: metadata.title changed Jun 30 07:06:05 ifi-phmidsd-lsq-test volumio[13855]: info: MetaClient: Get message: success Jun 30 07:06:05 ifi-phmidsd-lsq-test node[482]: metadata.album: /albumart Jun 30 07:06:10 ifi-phmidsd-lsq-test ethernet-detect[454]: No change in avahi-daemon interfaces. Skipping restart. Jun 30 07:06:17 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 30 07:06:17 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 07:06:17 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 30 07:06:17 ifi-phmidsd-lsq-test volumio[13855]: error: Could not retrieve plugin system_controller my_volumio Jun 30 07:06:20 ifi-phmidsd-lsq-test ethernet-detect[454]: No change in avahi-daemon interfaces. Skipping restart. Jun 30 07:06:23 ifi-phmidsd-lsq-test volumio[13855]: info: ++++--++++ seek: 199 Jun 30 07:06:23 ifi-phmidsd-lsq-test volumio[13855]: info: CoreCommandRouter::volumioSeek Jun 30 07:06:23 ifi-phmidsd-lsq-test volumio[13855]: info: CoreStateMachine::seek Jun 30 07:06:23 ifi-phmidsd-lsq-test volumio[13855]: info: [1751267183087] CdPlayer::seek to 199000 Jun 30 07:06:23 ifi-phmidsd-lsq-test volumio[13855]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 30 07:06:23 ifi-phmidsd-lsq-test volumio[13855]: TypeError: this.sendSpopCommand is not a function Jun 30 07:06:23 ifi-phmidsd-lsq-test volumio[13855]: at CdPlayer.seek (/data/plugins/music_service/ifi-cdplayer/index.js:398:17) Jun 30 07:06:23 ifi-phmidsd-lsq-test volumio[13855]: at CoreStateMachine.seek (/volumio/app/statemachine.js:1097:20) Jun 30 07:06:23 ifi-phmidsd-lsq-test volumio[13855]: at CoreCommandRouter.volumioSeek (/volumio/app/index.js:1553:28) Jun 30 07:06:23 ifi-phmidsd-lsq-test volumio[13855]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:194:33) Jun 30 07:06:23 ifi-phmidsd-lsq-test volumio[13855]: at Socket.emit (events.js:400:28) Jun 30 07:06:23 ifi-phmidsd-lsq-test volumio[13855]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Jun 30 07:06:23 ifi-phmidsd-lsq-test volumio[13855]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Jun 30 07:06:23 ifi-phmidsd-lsq-test volumio[13855]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 30 07:06:23 ifi-phmidsd-lsq-test sudo[15889]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-30 07:05 Jun 30 07:06:23 ifi-phmidsd-lsq-test sudo[15889]: 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"