-- Logs begin at Sat 2024-04-27 13:21:36 EDT, end at Sat 2024-04-27 13:29:31 EDT. --
Apr 27 13:28:00 volumac lircd[2410]: lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:00 volumac lircd[2410]: lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:00 volumac lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:00 volumac lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:01 volumac lircd[2410]: lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:01 volumac lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:01 volumac lircd[2410]: lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:01 volumac lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:02 volumac lircd[2410]: lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:02 volumac lircd[2410]: lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:02 volumac lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:02 volumac lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:03 volumac lircd[2410]: lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:03 volumac lircd[2410]: lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:03 volumac lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:03 volumac lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:04 volumac lircd[2410]: lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:04 volumac lircd[2410]: lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:04 volumac lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:04 volumac lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:05 volumac lircd[2410]: lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:05 volumac lircd[2410]: lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:05 volumac lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:05 volumac lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:06 volumac lircd[2410]: lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:06 volumac lircd[2410]: lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:06 volumac lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:06 volumac lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:07 volumac lircd[2410]: lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:07 volumac lircd[2410]: lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:07 volumac lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:07 volumac lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:08 volumac lircd[2410]: lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:08 volumac lircd[2410]: lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:08 volumac lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:08 volumac lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:09 volumac lircd[2410]: lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:09 volumac lircd[2410]: lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:09 volumac lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:09 volumac lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:10 volumac lircd[2410]: lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:10 volumac lircd[2410]: lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:10 volumac lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:10 volumac lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:11 volumac lircd[2410]: lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:11 volumac lircd[2410]: lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:11 volumac lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:11 volumac lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:12 volumac lircd[2410]: lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:12 volumac lircd[2410]: lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:12 volumac lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:12 volumac lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:13 volumac lircd[2410]: lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:13 volumac lircd[2410]: lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:13 volumac lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:13 volumac lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:14 volumac lircd[2410]: lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:14 volumac lircd[2410]: lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:14 volumac lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:14 volumac lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:15 volumac lircd[2410]: lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:15 volumac lircd[2410]: lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:15 volumac lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:15 volumac lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:16 volumac lircd[2410]: lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:16 volumac lircd[2410]: lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:16 volumac lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:16 volumac lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:17 volumac lircd[2410]: lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:17 volumac lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:17 volumac lircd[2410]: lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:17 volumac lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:18 volumac lircd[2410]: lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:18 volumac lircd[2410]: lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:18 volumac lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:18 volumac lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:19 volumac lircd[2410]: lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:19 volumac lircd[2410]: lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:19 volumac lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:19 volumac lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:20 volumac lircd[2410]: lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:20 volumac lircd[2410]: lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:20 volumac lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:20 volumac lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:21 volumac lircd[2410]: lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:21 volumac lircd[2410]: lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:21 volumac lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:21 volumac lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:22 volumac lircd[2410]: lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:22 volumac lircd[2410]: lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:22 volumac lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:22 volumac lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:23 volumac lircd[2410]: lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:23 volumac lircd[2410]: lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:23 volumac lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:23 volumac lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:23 volumac volumio-remote-updater[486]: [2024-04-27 13:28:23] [info] asio async_read_at_least error: system:104 (Connection reset by peer)
Apr 27 13:28:23 volumac volumio-remote-updater[486]: [2024-04-27 13:28:23] [error] handle_read_frame error: websocketpp.transport:2 (Underlying Transport Error)
Apr 27 13:28:23 volumac volumio-remote-updater[486]: [2024-04-27 13:28:23] [disconnect] Disconnect close local:[1006,Underlying Transport Error] remote:[1006]
Apr 27 13:28:23 volumac systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Apr 27 13:28:23 volumac systemd[1]: volumio.service: Failed with result 'exit-code'.
Apr 27 13:28:23 volumac systemd[1]: Started dynamicswap service.
Apr 27 13:28:23 volumac systemd[1]: dynamicswap.service: Succeeded.
Apr 27 13:28:23 volumac systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
Apr 27 13:28:23 volumac systemd[1]: volumio.service: Scheduled restart job, restart counter is at 2.
Apr 27 13:28:23 volumac systemd[1]: Started dynamicswap service.
Apr 27 13:28:23 volumac systemd[1]: Stopped Volumio Backend Module.
Apr 27 13:28:23 volumac systemd[1]: Started Volumio Backend Module.
Apr 27 13:28:23 volumac systemd[1]: dynamicswap.service: Succeeded.
Apr 27 13:28:23 volumac volumio[2607]: info: -------------------------------------------
Apr 27 13:28:23 volumac volumio[2607]: info: ----- Volumio3 ----
Apr 27 13:28:23 volumac volumio[2607]: info: -------------------------------------------
Apr 27 13:28:23 volumac volumio[2607]: info: ----- System startup ----
Apr 27 13:28:23 volumac volumio[2607]: info: -------------------------------------------
Apr 27 13:28:24 volumac lircd[2410]: lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:24 volumac lircd[2410]: lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:24 volumac lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:24 volumac lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:24 volumac volumio[2607]: info: MYVOLUMIO Environment detected
Apr 27 13:28:24 volumac volumio[2607]: info: Plugin folders cleanup
Apr 27 13:28:24 volumac volumio[2607]: info: Scanning into folder /volumio/app/plugins/
Apr 27 13:28:24 volumac volumio[2607]: info: Scanning category audio_interface
Apr 27 13:28:24 volumac volumio[2607]: info: Scanning category miscellanea
Apr 27 13:28:24 volumac volumio[2607]: info: Scanning category music_service
Apr 27 13:28:24 volumac volumio[2607]: info: Scanning category plugins.json
Apr 27 13:28:24 volumac volumio[2607]: info: Scanning category system_controller
Apr 27 13:28:24 volumac volumio[2607]: info: Scanning category user_interface
Apr 27 13:28:24 volumac volumio[2607]: info: Scanning into folder /data/plugins/
Apr 27 13:28:24 volumac volumio[2607]: info: Scanning category audio_interface
Apr 27 13:28:24 volumac volumio[2607]: info: Scanning category miscellanea
Apr 27 13:28:24 volumac volumio[2607]: info: Scanning category music_service
Apr 27 13:28:24 volumac volumio[2607]: info: Scanning category system_controller
Apr 27 13:28:24 volumac volumio[2607]: info: Scanning category system_hardware
Apr 27 13:28:24 volumac volumio[2607]: info: Scanning category user_interface
Apr 27 13:28:24 volumac volumio[2607]: info: Plugin folders cleanup completed
Apr 27 13:28:24 volumac volumio[2607]: info: -------------------------------------------
Apr 27 13:28:24 volumac volumio[2607]: info: ----- Core plugins startup ----
Apr 27 13:28:24 volumac volumio[2607]: info: -------------------------------------------
Apr 27 13:28:24 volumac volumio[2607]: info: Loading plugins from folder /volumio/app/plugins/
Apr 27 13:28:24 volumac volumio[2607]: info: Adding plugin upnp to MyMusic Plugins
Apr 27 13:28:24 volumac volumio[2607]: info: Adding plugin airplay_emulation to MyMusic Plugins
Apr 27 13:28:24 volumac volumio[2607]: info: Adding plugin upnp_browser to MyMusic Plugins
Apr 27 13:28:24 volumac volumio[2607]: info: Loading plugins from folder /data/plugins/
Apr 27 13:28:24 volumac volumio[2607]: info: Loading plugin "system"...
Apr 27 13:28:24 volumac volumio[2607]: info: Loading plugin "appearance"...
Apr 27 13:28:24 volumac go-librespot[2593]: time="2024-04-27T13:28:24-04:00" level=fatal msg="failed running with username and spotify token" error="failed obtaining client token: failed requesting clienttoken: Post \"https://clienttoken.spotify.com/v1/clienttoken\": dial tcp: lookup clienttoken.spotify.com: i/o timeout"
Apr 27 13:28:24 volumac systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Apr 27 13:28:24 volumac systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Apr 27 13:28:24 volumac volumio[2607]: info: Loading plugin "network"...
Apr 27 13:28:24 volumac volumio[2607]: info: Refreshing Cached IP Addresses
Apr 27 13:28:24 volumac sudo[2634]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 27 13:28:24 volumac sudo[2634]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 27 13:28:24 volumac sudo[2634]: pam_unix(sudo:session): session closed for user root
Apr 27 13:28:24 volumac sudo[2636]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 27 13:28:24 volumac volumio[2607]: info: Loading plugin "services"...
Apr 27 13:28:24 volumac volumio[2607]: info: Loading plugin "alsa_controller"...
Apr 27 13:28:24 volumac sudo[2636]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 27 13:28:24 volumac sudo[2636]: pam_unix(sudo:session): session closed for user root
Apr 27 13:28:24 volumac sudo[2639]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Apr 27 13:28:24 volumac sudo[2639]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 27 13:28:24 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 27 13:28:24 volumac volumio[2607]: info: Loading plugin "wizard"...
Apr 27 13:28:24 volumac volumio[2607]: info: Loading plugin "networkfs"...
Apr 27 13:28:24 volumac volumio[2607]: info: Cannot mount NAS Music at system boot, trial number 1 ,retrying in 5 seconds
Apr 27 13:28:24 volumac volumio[2607]: info: Starting Udev Watcher for removable devices
Apr 27 13:28:24 volumac volumio[2607]: info: Ignoring mount for partition: boot
Apr 27 13:28:24 volumac volumio[2607]: info: Ignoring mount for partition: volumio
Apr 27 13:28:24 volumac volumio[2607]: info: Ignoring mount for partition: volumio_data
Apr 27 13:28:24 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 27 13:28:24 volumac volumio[2607]: info: Loading plugin "volumio_command_line_client"...
Apr 27 13:28:24 volumac volumio[2607]: info: Loading plugin "upnp"...
Apr 27 13:28:24 volumac volumio[2607]: info: [1714238904949] Starting Upmpd Daemon
Apr 27 13:28:24 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 27 13:28:24 volumac volumio[2607]: info: Loading plugin "my_music"...
Apr 27 13:28:24 volumac volumio[2607]: info: Loading plugin "mpd"...
Apr 27 13:28:25 volumac volumio[2607]: info: Loading plugin "upnp_browser"...
Apr 27 13:28:25 volumac lircd[2410]: lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:25 volumac lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:25 volumac lircd[2410]: lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:25 volumac lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:25 volumac volumio[2607]: info: Loading plugin "alarm-clock"...
Apr 27 13:28:25 volumac volumio[2607]: info: Loading plugin "airplay_emulation"...
Apr 27 13:28:25 volumac volumio[2607]: info: Starting Shairport Sync
Apr 27 13:28:25 volumac volumio[2607]: info: Loading plugin "last_100"...
Apr 27 13:28:25 volumac volumio[2607]: info: Loading plugin "webradio"...
Apr 27 13:28:25 volumac volumio[2607]: info: Loading plugin "i2s_dacs"...
Apr 27 13:28:25 volumac volumio[2607]: info: I2S DAC not set, start Auto-detection
Apr 27 13:28:25 volumac volumio[2607]: info: Loading plugin "volumiodiscovery"...
Apr 27 13:28:25 volumac volumio[2607]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 27 13:28:25 volumac node[2607]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 27 13:28:25 volumac volumio[2607]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 27 13:28:25 volumac node[2607]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 27 13:28:25 volumac volumio[2607]: *** WARNING *** For more information see
Apr 27 13:28:25 volumac node[2607]: *** WARNING *** For more information see
Apr 27 13:28:25 volumac volumio[2607]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 27 13:28:25 volumac node[2607]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 27 13:28:25 volumac volumio[2607]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 27 13:28:25 volumac node[2607]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 27 13:28:25 volumac volumio[2607]: *** WARNING *** For more information see
Apr 27 13:28:25 volumac node[2607]: *** WARNING *** For more information see
Apr 27 13:28:25 volumac volumio[2607]: info: Applying required configuration parameters for plugin volumiodiscovery
Apr 27 13:28:25 volumac volumio[2607]: info: Discovery: Started advertising with name: Volumac
Apr 27 13:28:25 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 27 13:28:25 volumac volumio[2607]: info: Loading plugin "calmradio"...
Apr 27 13:28:25 volumac volumio[2607]: info: Loading plugin "spop"...
Apr 27 13:28:26 volumac volumio[2607]: info: Loading plugin "youtube2"...
Apr 27 13:28:26 volumac lircd[2410]: lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:26 volumac lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:26 volumac lircd[2410]: lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:26 volumac lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:26 volumac volumio[2607]: info: Loading plugin "ytmusic"...
Apr 27 13:28:27 volumac volumio[2607]: info: Loading plugin "autostart"...
Apr 27 13:28:27 volumac lircd[2410]: lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:27 volumac lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:27 volumac lircd[2410]: lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:27 volumac lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:27 volumac volumio[2607]: info: Applying required configuration parameters for plugin autostart
Apr 27 13:28:27 volumac volumio[2607]: info: AutoStart - onVolumioStart - read config.json
Apr 27 13:28:27 volumac volumio[2607]: info: Loading plugin "outputs"...
Apr 27 13:28:27 volumac volumio[2607]: info: Loading plugin "albumart"...
Apr 27 13:28:27 volumac volumio[2607]: info: Plugin example_plugin is not enabled
Apr 27 13:28:27 volumac volumio[2607]: info: Loading plugin "inputs"...
Apr 27 13:28:27 volumac volumio[2607]: info: Loading plugin "updater_comm"...
Apr 27 13:28:27 volumac volumio[2607]: info: Plugin mpdemulation is not enabled
Apr 27 13:28:27 volumac volumio[2607]: info: Loading plugin "rest_api"...
Apr 27 13:28:27 volumac volumio[2607]: info: Loading plugin "websocket"...
Apr 27 13:28:27 volumac volumio[2607]: info: Loading plugin "fusiondsp"...
Apr 27 13:28:27 volumac volumio[2607]: Forking 1 albumart workers
Apr 27 13:28:27 volumac volumio[2607]: info: Applying required configuration parameters for plugin fusiondsp
Apr 27 13:28:27 volumac systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Apr 27 13:28:27 volumac systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4.
Apr 27 13:28:27 volumac systemd[1]: Stopped go-librespot Daemon.
Apr 27 13:28:27 volumac systemd[1]: Started go-librespot Daemon.
Apr 27 13:28:27 volumac go-librespot[2662]: Librespot-go daemon starting...
Apr 27 13:28:27 volumac go-librespot[2662]: time="2024-04-27T13:28:27-04:00" level=info msg="generated new device id: 7279894ce1e43d0373cb36c067230c7595c25f56"
Apr 27 13:28:27 volumac go-librespot[2662]: time="2024-04-27T13:28:27-04:00" level=debug msg="stored credentials found for 1249171035"
Apr 27 13:28:27 volumac volumio[2607]: info: Loading plugin "m3u_importer"...
Apr 27 13:28:27 volumac volumio[2607]: info: Applying required configuration parameters for plugin m3u_importer
Apr 27 13:28:27 volumac volumio[2607]: info: Loading plugin "80s80s"...
Apr 27 13:28:27 volumac volumio[2607]: Starting albumart workers
Apr 27 13:28:28 volumac volumio[2607]: info: Applying required configuration parameters for plugin 80s80s
Apr 27 13:28:28 volumac volumio[2607]: info: [1714238908023] [80s80s] API delay: 30
Apr 27 13:28:28 volumac volumio[2607]: info: Loading plugin "minidlna"...
Apr 27 13:28:28 volumac volumio[2607]: info: Applying required configuration parameters for plugin minidlna
Apr 27 13:28:28 volumac lircd[2410]: lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:28 volumac lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:28 volumac lircd[2410]: lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:28 volumac lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:28 volumac volumio-remote-updater[486]: [2024-04-27 13:28:28] [connect] Successful connection
Apr 27 13:28:28 volumac volumio[2607]: info: Loading plugin "nowyswiat"...
Apr 27 13:28:28 volumac volumio[2607]: info: Applying required configuration parameters for plugin nowyswiat
Apr 27 13:28:28 volumac volumio[2607]: info: [1714238908342] [RadioNowySwiat] API delay: 5
Apr 27 13:28:28 volumac volumio[2607]: info: Loading plugin "pandora"...
Apr 27 13:28:28 volumac volumio[2607]: info: Applying required configuration parameters for plugin pandora
Apr 27 13:28:28 volumac volumio[2607]: info: Loading plugin "rad357pl"...
Apr 27 13:28:28 volumac volumio[2607]: info: Applying required configuration parameters for plugin rad357pl
Apr 27 13:28:28 volumac volumio[2607]: info: [1714238908795] [rad357pl] API delay: 5
Apr 27 13:28:28 volumac volumio[2607]: info: Loading plugin "radrocksrvfm"...
Apr 27 13:28:28 volumac volumio[2607]: info: Applying required configuration parameters for plugin radrocksrvfm
Apr 27 13:28:28 volumac volumio[2607]: info: [1714238908859] [radrocksrvfm] API delay: 5
Apr 27 13:28:28 volumac volumio[2607]: info: Loading plugin "swarmstation"...
Apr 27 13:28:28 volumac volumio[2607]: info: Applying required configuration parameters for plugin swarmstation
Apr 27 13:28:28 volumac volumio[2607]: info: [1714238908950] [Swarmstation] API delay: 5
Apr 27 13:28:28 volumac volumio[2607]: info: Loading plugin "tunein_radio"...
Apr 27 13:28:29 volumac volumio[2607]: info: Applying required configuration parameters for plugin tunein_radio
Apr 27 13:28:29 volumac volumio[2607]: info: Loading plugin "volusonic"...
Apr 27 13:28:29 volumac lircd[2410]: lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:29 volumac lircd[2410]: lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:29 volumac lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:29 volumac lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:29 volumac volumio[2607]: info: Applying required configuration parameters for plugin volusonic
Apr 27 13:28:29 volumac volumio[2607]: info: Loading plugin "crossfader_switch"...
Apr 27 13:28:29 volumac volumio[2607]: info: Applying required configuration parameters for plugin crossfader_switch
Apr 27 13:28:29 volumac volumio[2607]: info: Loading plugin "ir_controller"...
Apr 27 13:28:29 volumac volumio[2607]: info: Applying required configuration parameters for plugin ir_controller
Apr 27 13:28:29 volumac volumio[2607]: info: Loading plugin "music_services_shield"...
Apr 27 13:28:29 volumac volumio[2607]: info: Applying required configuration parameters for plugin music_services_shield
Apr 27 13:28:29 volumac volumio[2607]: info: Loading plugin "lastfm"...
Apr 27 13:28:29 volumac volumio[2607]: info: Loading plugin "randomizer"...
Apr 27 13:28:29 volumac volumio[2607]: info: Applying required configuration parameters for plugin randomizer
Apr 27 13:28:29 volumac volumio[2607]: info: Loading i18n strings for locale en
Apr 27 13:28:29 volumac volumio[2607]: info: Plugin volusonic has duplicated i18n key SAVE. It is ignored.
Apr 27 13:28:29 volumac volumio[2607]: Updating browse sources language
Apr 27 13:28:29 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 27 13:28:29 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 27 13:28:29 volumac volumio[2607]: info: CoreCommandRouter::initPlayerControls
Apr 27 13:28:29 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 27 13:28:29 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 27 13:28:29 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 27 13:28:29 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 27 13:28:29 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 27 13:28:29 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 27 13:28:29 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 27 13:28:29 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 27 13:28:29 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 27 13:28:29 volumac volumio[2607]: Express server listening on port 3000
Apr 27 13:28:29 volumac volumio[2607]: [Metrics] WebUI: 6s 142.52ms
Apr 27 13:28:29 volumac volumio[2607]: info: Setting Device type: x86
Apr 27 13:28:29 volumac volumio[2607]: info: CoreStateMachine::resetVolumioState
Apr 27 13:28:29 volumac volumio[2607]: info: CoreStateMachine::getcurrentVolume
Apr 27 13:28:29 volumac volumio[2607]: info: CoreCommandRouter::volumioRetrievevolume
Apr 27 13:28:29 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 27 13:28:29 volumac volumio[2607]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt'
Apr 27 13:28:29 volumac volumio[2607]: info: Completed loading Core Plugins
Apr 27 13:28:29 volumac volumio[2607]: info: Preparing to generate the ALSA configuration file
Apr 27 13:28:30 volumac volumio[2607]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision
Apr 27 13:28:30 volumac volumio[2607]: info: Cannot mount NAS Music at system boot, trial number 2 ,retrying in 5 seconds
Apr 27 13:28:30 volumac volumio[2607]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Apr 27 13:28:30 volumac volumio[2607]: info: Reading ALSA contributions from plugins.
Apr 27 13:28:30 volumac volumio-remote-updater[486]: [2024-04-27 13:28:30] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1714238908 101
Apr 27 13:28:30 volumac lircd[2410]: lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:30 volumac lircd[2410]: lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:30 volumac lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:30 volumac lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:30 volumac volumio[2607]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 1
Apr 27 13:28:30 volumac volumio[2607]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 2
Apr 27 13:28:30 volumac volumio[2607]: info: Reloading queue from file
Apr 27 13:28:30 volumac volumio[2607]: info: VolumeController:: Volume=30 Mute =false
Apr 27 13:28:30 volumac volumio[2607]: info: CoreStateMachine::pushState
Apr 27 13:28:30 volumac volumio[2607]: info: CorePlayQueue::getTrack 0
Apr 27 13:28:30 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 27 13:28:30 volumac volumio[2607]: info: CoreCommandRouter::volumioPushState
Apr 27 13:28:30 volumac volumio[2607]: info: CoreStateMachine::updateTrackBlock
Apr 27 13:28:30 volumac volumio[2607]: info: CorePlayQueue::getTrackBlock
Apr 27 13:28:30 volumac volumio[2607]: info: CoreCommandRouter::volumioRetrievevolume
Apr 27 13:28:30 volumac volumio[2607]: info: CoreStateMachine::setRepeat null single undefined
Apr 27 13:28:30 volumac volumio[2607]: info: CoreStateMachine::pushState
Apr 27 13:28:30 volumac volumio[2607]: info: CorePlayQueue::getTrack 0
Apr 27 13:28:30 volumac volumio[2607]: info: CoreCommandRouter::volumioPushState
Apr 27 13:28:30 volumac volumio[2607]: info: CoreStateMachine::setRandom null
Apr 27 13:28:30 volumac volumio[2607]: info: CoreStateMachine::pushState
Apr 27 13:28:30 volumac volumio[2607]: info: CorePlayQueue::getTrack 0
Apr 27 13:28:30 volumac volumio[2607]: info: CoreCommandRouter::volumioPushState
Apr 27 13:28:30 volumac volumio[2607]: info: VolumeController:: Volume=30 Mute =false
Apr 27 13:28:30 volumac volumio[2607]: info: CoreStateMachine::pushState
Apr 27 13:28:30 volumac volumio[2607]: info: CorePlayQueue::getTrack 0
Apr 27 13:28:30 volumac volumio[2607]: info: CoreCommandRouter::volumioPushState
Apr 27 13:28:30 volumac volumio[2607]: info: Asound.conf file unchanged, so no further update is needed
Apr 27 13:28:30 volumac volumio[2607]: info: Output device has changed, restarting MPD
Apr 27 13:28:30 volumac sudo[2685]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 27 13:28:30 volumac sudo[2685]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 27 13:28:30 volumac sudo[2685]: pam_unix(sudo:session): session closed for user root
Apr 27 13:28:30 volumac volumio[2607]: info: Output device has changed, restarting Shairport Sync
Apr 27 13:28:30 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 27 13:28:30 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 27 13:28:30 volumac sudo[2688]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 27 13:28:30 volumac sudo[2688]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 27 13:28:30 volumac systemd[1]: musicservicesshield.service: Succeeded.
Apr 27 13:28:30 volumac systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set.
Apr 27 13:28:30 volumac systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set...
Apr 27 13:28:30 volumac systemd[1]: Stopping Music Player Daemon...
Apr 27 13:28:30 volumac volumio[2607]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 27 13:28:30 volumac volumio[2607]: info: ___________ START PLUGINS ___________
Apr 27 13:28:30 volumac volumio[2607]: info: ControllerMpd::onStart: Initializing MPD
Apr 27 13:28:30 volumac volumio[2607]: info: Creating MPD Configuration file
Apr 27 13:28:30 volumac sudo[2694]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 27 13:28:30 volumac sudo[2694]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 27 13:28:30 volumac sudo[2694]: pam_unix(sudo:session): session closed for user root
Apr 27 13:28:30 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 27 13:28:30 volumac volumio[2607]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 27 13:28:30 volumac volumio[2607]: info: [1714238910717] CoreMusicLibrary::Adding element Media Servers
Apr 27 13:28:30 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 27 13:28:30 volumac sudo[2697]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 27 13:28:30 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 27 13:28:30 volumac sudo[2697]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 27 13:28:30 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 27 13:28:30 volumac volumio[2607]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 27 13:28:30 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 27 13:28:30 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 27 13:28:30 volumac volumio[2607]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 27 13:28:30 volumac volumio[2607]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 27 13:28:30 volumac volumio[2607]: info: [1714238910816] CoreMusicLibrary::Adding element Last_100
Apr 27 13:28:30 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 27 13:28:30 volumac volumio[2607]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 27 13:28:30 volumac volumio[2607]: info: [1714238910818] CoreMusicLibrary::Adding element Webradio
Apr 27 13:28:30 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 27 13:28:30 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 27 13:28:30 volumac volumio[2607]: info: Adding Calm Radio to Browse Sources
Apr 27 13:28:30 volumac volumio[2607]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 27 13:28:30 volumac volumio[2607]: info: [1714238910823] CoreMusicLibrary::Adding element Calm Radio
Apr 27 13:28:30 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source Calm Radio
Apr 27 13:28:30 volumac volumio[2607]: info: Creating Spotify config file
Apr 27 13:28:30 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 27 13:28:30 volumac volumio[2607]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 27 13:28:30 volumac volumio[2607]: info: [1714238910862] CoreMusicLibrary::Adding element YouTube2
Apr 27 13:28:30 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source Calm Radio
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source YouTube2
Apr 27 13:28:30 volumac volumio[2607]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 27 13:28:30 volumac volumio[2607]: info: [1714238910866] CoreMusicLibrary::Adding element YouTube Music
Apr 27 13:28:30 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source Calm Radio
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source YouTube2
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source YouTube Music
Apr 27 13:28:30 volumac volumio[2607]: info: AutoStart - onStart
Apr 27 13:28:30 volumac volumio[2607]: info: Loading i18n strings for locale en
Apr 27 13:28:30 volumac volumio[2607]: info: Plugin volusonic has duplicated i18n key SAVE. It is ignored.
Apr 27 13:28:30 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
Apr 27 13:28:30 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 27 13:28:30 volumac volumio[2607]: info: FusionDsp - mixtype--------------------- Hardware
Apr 27 13:28:30 volumac volumio[2607]: info: Loading i18n strings for locale en
Apr 27 13:28:30 volumac volumio[2607]: info: Plugin volusonic has duplicated i18n key SAVE. It is ignored.
Apr 27 13:28:30 volumac volumio[2607]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 27 13:28:30 volumac volumio[2607]: info: [1714238910885] CoreMusicLibrary::Adding element 80s80s Radio
Apr 27 13:28:30 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source Calm Radio
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source YouTube2
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source YouTube Music
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source 80s80s Radio
Apr 27 13:28:30 volumac volumio[2607]: info: Loading i18n strings for locale en
Apr 27 13:28:30 volumac volumio[2607]: info: Plugin volusonic has duplicated i18n key SAVE. It is ignored.
Apr 27 13:28:30 volumac volumio[2607]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 27 13:28:30 volumac volumio[2607]: info: [1714238910920] CoreMusicLibrary::Adding element Radio Nowy Swiat
Apr 27 13:28:30 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source Calm Radio
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source YouTube2
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source YouTube Music
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source 80s80s Radio
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source Radio Nowy Swiat
Apr 27 13:28:30 volumac volumio[2607]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 27 13:28:30 volumac volumio[2607]: info: [1714238910923] CoreMusicLibrary::Adding element Pandora Radio
Apr 27 13:28:30 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source Calm Radio
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source YouTube2
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source YouTube Music
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source 80s80s Radio
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source Radio Nowy Swiat
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source Pandora Radio
Apr 27 13:28:30 volumac volumio[2607]: info: [1714238910929] ControllerPandora::initializeMQTT
Apr 27 13:28:30 volumac volumio[2607]: info: [1714238910929] [Pandora] initializeMQTT: MQTT is not enabled in Plugin Configuration
Apr 27 13:28:30 volumac volumio[2607]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 27 13:28:30 volumac volumio[2607]: info: [1714238910931] CoreMusicLibrary::Adding element RADIO 357
Apr 27 13:28:30 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source Calm Radio
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source YouTube2
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source YouTube Music
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source 80s80s Radio
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source Radio Nowy Swiat
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source Pandora Radio
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source RADIO 357
Apr 27 13:28:30 volumac volumio[2607]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 27 13:28:30 volumac volumio[2607]: info: [1714238910937] CoreMusicLibrary::Adding element Radio Rockserwis FM
Apr 27 13:28:30 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source Calm Radio
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source YouTube2
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source YouTube Music
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source 80s80s Radio
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source Radio Nowy Swiat
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source Pandora Radio
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source RADIO 357
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source Radio Rockserwis FM
Apr 27 13:28:30 volumac volumio[2607]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 27 13:28:30 volumac volumio[2607]: info: [1714238910948] CoreMusicLibrary::Adding element SWARM Station
Apr 27 13:28:30 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source Calm Radio
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source YouTube2
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source YouTube Music
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source 80s80s Radio
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source Radio Nowy Swiat
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source Pandora Radio
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source RADIO 357
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source Radio Rockserwis FM
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source SWARM Station
Apr 27 13:28:30 volumac volumio[2607]: info: TuneIn addToBrowseSources
Apr 27 13:28:30 volumac volumio[2607]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 27 13:28:30 volumac volumio[2607]: info: [1714238910950] CoreMusicLibrary::Adding element TuneIn Radio
Apr 27 13:28:30 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source Calm Radio
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source YouTube2
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source YouTube Music
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source 80s80s Radio
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source Radio Nowy Swiat
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source Pandora Radio
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source RADIO 357
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source Radio Rockserwis FM
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source SWARM Station
Apr 27 13:28:30 volumac volumio[2607]: Cannot find translation for source TuneIn Radio
Apr 27 13:28:30 volumac volumio[2607]: info: [object Object]
Apr 27 13:28:30 volumac volumio[2607]: info: Loading i18n strings for locale en
Apr 27 13:28:31 volumac volumio[2607]: info: Plugin volusonic has duplicated i18n key SAVE. It is ignored.
Apr 27 13:28:31 volumac volumio[2607]: Updating browse sources language
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source Calm Radio
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source YouTube2
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source YouTube Music
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source 80s80s Radio
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source Radio Nowy Swiat
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source Pandora Radio
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source RADIO 357
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source Radio Rockserwis FM
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source SWARM Station
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source TuneIn Radio
Apr 27 13:28:31 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source Calm Radio
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source YouTube2
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source YouTube Music
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source 80s80s Radio
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source Radio Nowy Swiat
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source Pandora Radio
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source RADIO 357
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source Radio Rockserwis FM
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source SWARM Station
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source TuneIn Radio
Apr 27 13:28:31 volumac volumio[2607]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 27 13:28:31 volumac volumio[2607]: info: [1714238911004] CoreMusicLibrary::Adding element Volusonic
Apr 27 13:28:31 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source Calm Radio
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source YouTube2
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source YouTube Music
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source 80s80s Radio
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source Radio Nowy Swiat
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source Pandora Radio
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source RADIO 357
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source Radio Rockserwis FM
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source SWARM Station
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source TuneIn Radio
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source Volusonic
Apr 27 13:28:31 volumac volumio[2607]: info: Loading i18n strings for locale en
Apr 27 13:28:31 volumac volumio[2607]: info: Plugin volusonic has duplicated i18n key SAVE. It is ignored.
Apr 27 13:28:31 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 27 13:28:31 volumac lircd[2410]: lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:31 volumac lircd[2410]: lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:31 volumac lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:31 volumac lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:31 volumac sudo[2710]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R a+rwX /etc/lirc/irexec.lircrc /etc/lirc/lirc_options.conf /etc/lirc/lircd.conf /etc/lirc/lircd.conf.d /etc/lirc/lircmd.conf /etc/lirc/lircrc
Apr 27 13:28:31 volumac sudo[2710]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 27 13:28:31 volumac sudo[2710]: pam_unix(sudo:session): session closed for user root
Apr 27 13:28:31 volumac volumio[2607]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 27 13:28:31 volumac volumio[2607]: info: [1714238911316] CoreMusicLibrary::Adding element LastFM
Apr 27 13:28:31 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source Calm Radio
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source YouTube2
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source YouTube Music
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source 80s80s Radio
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source Radio Nowy Swiat
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source Pandora Radio
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source RADIO 357
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source Radio Rockserwis FM
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source SWARM Station
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source TuneIn Radio
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source Volusonic
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source LastFM
Apr 27 13:28:31 volumac volumio[2607]: info: [LastFM] scrobbler initiated!
Apr 27 13:28:31 volumac volumio[2607]: info: [LastFM] extended logging: false
Apr 27 13:28:31 volumac volumio[2607]: info: [LastFM] try scrobble stream/radio plays: false
Apr 27 13:28:31 volumac volumio[2607]: info: [LastFM] Left init routine
Apr 27 13:28:31 volumac volumio[2607]: info: [LastFM] Socket already connected: true
Apr 27 13:28:31 volumac sudo[2738]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/moveallprocesses.sh
Apr 27 13:28:31 volumac sudo[2738]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 27 13:28:31 volumac volumio[2607]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 27 13:28:31 volumac volumio[2607]: info: [1714238911349] CoreMusicLibrary::Adding element Randomizer
Apr 27 13:28:31 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source Calm Radio
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source YouTube2
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source YouTube Music
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source 80s80s Radio
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source Radio Nowy Swiat
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source Pandora Radio
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source RADIO 357
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source Radio Rockserwis FM
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source SWARM Station
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source TuneIn Radio
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source Volusonic
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source LastFM
Apr 27 13:28:31 volumac volumio[2607]: Cannot find translation for source Randomizer
Apr 27 13:28:31 volumac volumio[2607]: info: Volumio Calling Home
Apr 27 13:28:31 volumac systemd[1]: mpd.service: Succeeded.
Apr 27 13:28:31 volumac systemd[1]: Stopped Music Player Daemon.
Apr 27 13:28:31 volumac systemd[1]: Starting Music Player Daemon...
Apr 27 13:28:31 volumac volumio[2607]: info: Preparing to generate the ALSA configuration file
Apr 27 13:28:31 volumac volumio[2607]: info: [1714238911614] ControllerPandora::initialSetup
Apr 27 13:28:31 volumac volumio[2607]: info: [1714238911629] ControllerPandora::PandoraHandler::init
Apr 27 13:28:31 volumac volumio[2607]: info: [1714238911631] ControllerPandora::PandoraHandler::loadErrorCodes
Apr 27 13:28:31 volumac volumio[2607]: info: [1714238911650] [Pandora] PandoraHandler::setMaxStationTracks: 16
Apr 27 13:28:31 volumac volumio[2607]: info: [1714238911658] [Pandora] PandoraHandler::setBandFilter: bandfilter is empty
Apr 27 13:28:31 volumac volumio[2607]: info: [1714238911659] ControllerPandora::flushPandora
Apr 27 13:28:31 volumac volumio[2607]: info: CorePlayQueue::getQueue
Apr 27 13:28:31 volumac volumio[2607]: info: CorePlayQueue::clearAddPlayQueue
Apr 27 13:28:31 volumac volumio[2607]: info: CorePlayQueue::saveQueue
Apr 27 13:28:31 volumac volumio[2607]: info: CoreCommandRouter::serviceClearAddPlayTracks
Apr 27 13:28:31 volumac volumio[2607]: error: WARNING: No clearAddPlayTracks method for service mpd
Apr 27 13:28:31 volumac volumio[2607]: info: CoreCommandRouter::volumioPushQueue
Apr 27 13:28:31 volumac volumio[2607]: info: [1714238911676] ControllerPandora::validateAndSetAccountOptions
Apr 27 13:28:31 volumac volumio[2607]: info: [1714238911677] ControllerPandora::PandoraHandler::setAccountOptions
Apr 27 13:28:31 volumac volumio[2607]: info: [1714238911677] ControllerPandora::flushPandora
Apr 27 13:28:31 volumac volumio[2607]: info: CorePlayQueue::getQueue
Apr 27 13:28:31 volumac volumio[2607]: info: CorePlayQueue::clearAddPlayQueue
Apr 27 13:28:31 volumac volumio[2607]: info: CorePlayQueue::saveQueue
Apr 27 13:28:31 volumac volumio[2607]: info: CoreCommandRouter::serviceClearAddPlayTracks
Apr 27 13:28:31 volumac volumio[2607]: error: WARNING: No clearAddPlayTracks method for service mpd
Apr 27 13:28:31 volumac volumio[2607]: info: CoreCommandRouter::volumioPushQueue
Apr 27 13:28:31 volumac volumio[2607]: info: [1714238911689] [Pandora] PreventAuthTimeout::init: Timer loaded
Apr 27 13:28:31 volumac volumio[2607]: info: [1714238911695] [Pandora] PreventAuthTimeout::init: Interval set to 10800000 ms
Apr 27 13:28:31 volumac volumio[2607]: info: [1714238911695] [Pandora] PreventAuthTimeout::init: Starting delayed timer after next interval
Apr 27 13:28:31 volumac volumio[2607]: info: [1714238911696] ControllerPandora::PandoraHandler::pandoraLoginAndGetStations
Apr 27 13:28:31 volumac volumio[2607]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Apr 27 13:28:31 volumac volumio[2607]: info: Reading ALSA contributions from plugins.
Apr 27 13:28:31 volumac volumio[2607]: info: ir_controller: File permissions successfully set on /etc/lirc/*.
Apr 27 13:28:31 volumac volumio[2607]: info: minidlna: Found miniDLNA version 1.2.1
Apr 27 13:28:31 volumac volumio[2607]: info: minidlna: Starting minidlna.service
Apr 27 13:28:31 volumac volumio[2607]: info: MPD Permissions set
Apr 27 13:28:31 volumac volumio[2607]: info: MPD Permissions set
Apr 27 13:28:31 volumac sudo[2759]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start minidlna.service
Apr 27 13:28:31 volumac sudo[2759]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 27 13:28:32 volumac systemd[1]: Started MiniDLNA lightweight DLNA/UPnP-AV server.
Apr 27 13:28:32 volumac sudo[2759]: pam_unix(sudo:session): session closed for user root
Apr 27 13:28:32 volumac mpd[2748]: Apr 27 13:28 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Apr 27 13:28:32 volumac lircd[2410]: lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:32 volumac lircd[2410]: lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:32 volumac lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:32 volumac lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:32 volumac systemd[1]: Started Music Player Daemon.
Apr 27 13:28:32 volumac sudo[2688]: pam_unix(sudo:session): session closed for user root
Apr 27 13:28:32 volumac sudo[2697]: pam_unix(sudo:session): session closed for user root
Apr 27 13:28:32 volumac systemd[1]: Starting Shield Volumio Music Services in the User CPU Set...
Apr 27 13:28:32 volumac volumio[2607]: info: Spotify config file written
Apr 27 13:28:32 volumac sudo[2738]: pam_unix(sudo:session): session closed for user root
Apr 27 13:28:32 volumac systemd[1]: minidlna.service: Succeeded.
Apr 27 13:28:32 volumac sudo[2781]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service
Apr 27 13:28:32 volumac sudo[2781]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 27 13:28:32 volumac systemd[1]: Stopping go-librespot Daemon...
Apr 27 13:28:32 volumac systemd[1]: go-librespot-daemon.service: Main process exited, code=killed, status=15/TERM
Apr 27 13:28:32 volumac systemd[1]: go-librespot-daemon.service: Succeeded.
Apr 27 13:28:32 volumac systemd[1]: Stopped go-librespot Daemon.
Apr 27 13:28:32 volumac systemd[1]: Started go-librespot Daemon.
Apr 27 13:28:32 volumac go-librespot[2784]: Librespot-go daemon starting...
Apr 27 13:28:32 volumac sudo[2781]: pam_unix(sudo:session): session closed for user root
Apr 27 13:28:32 volumac volumio[2607]: info: minidlna: systemctl start minidlna.service succeeded.
Apr 27 13:28:32 volumac go-librespot[2784]: time="2024-04-27T13:28:32-04:00" level=info msg="generated new device id: 681cdaebc3b5b3457bf4781322d2d7eaa914e81b"
Apr 27 13:28:32 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 27 13:28:32 volumac go-librespot[2784]: time="2024-04-27T13:28:32-04:00" level=debug msg="stored credentials found for 1249171035"
Apr 27 13:28:32 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 27 13:28:32 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 27 13:28:32 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 27 13:28:32 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Apr 27 13:28:32 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 27 13:28:32 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 27 13:28:32 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 27 13:28:32 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 27 13:28:32 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 27 13:28:32 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 27 13:28:32 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 27 13:28:32 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 27 13:28:32 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 27 13:28:32 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 27 13:28:32 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Apr 27 13:28:32 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 27 13:28:32 volumac volumio[2768]: cset: --> shielding system active with
Apr 27 13:28:32 volumac volumio[2768]: cset: "system" cpuset of CPUSPEC(1) with 147 tasks running
Apr 27 13:28:32 volumac volumio[2768]: cset: "user" cpuset of CPUSPEC(0) with 3 tasks running
Apr 27 13:28:32 volumac sudo[2810]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/addservice.sh
Apr 27 13:28:32 volumac sudo[2810]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 27 13:28:32 volumac systemd[1]: Started Shield Volumio Music Services in the User CPU Set.
Apr 27 13:28:32 volumac volumio[2607]: error: MPD error: The expression evaluated to a falsy value:
Apr 27 13:28:32 volumac volumio[2607]: assert.ok(self.idling)
Apr 27 13:28:32 volumac volumio[2607]: error: The expression evaluated to a falsy value:
Apr 27 13:28:32 volumac volumio[2607]: assert.ok(self.idling)
Apr 27 13:28:32 volumac systemd[1]: Reloading.
Apr 27 13:28:32 volumac volumio[2607]: info: MPD running with PID2748
Apr 27 13:28:32 volumac volumio[2607]: ,establishing connection
Apr 27 13:28:32 volumac volumio[2607]: error: updateQueue error: null
Apr 27 13:28:32 volumac volumio[2607]: info: Starting Shairport Sync
Apr 27 13:28:32 volumac volumio[2607]: info: Starting Shairport Sync
Apr 27 13:28:32 volumac sudo[2823]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 27 13:28:32 volumac sudo[2823]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 27 13:28:32 volumac volumio[2607]: info: Starting Shairport Sync
Apr 27 13:28:32 volumac sudo[2834]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 27 13:28:32 volumac sudo[2834]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 27 13:28:33 volumac sudo[2842]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 27 13:28:33 volumac sudo[2842]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 27 13:28:33 volumac volumio[2607]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists
Apr 27 13:28:33 volumac volumio[2607]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo
Apr 27 13:28:33 volumac volumio[2607]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists
Apr 27 13:28:33 volumac volumio[2607]: info: camilladsp spawned new process with pid 2850, instance 1, run: true
Apr 27 13:28:33 volumac volumio[2607]: info: camilladsp service started and running in background, instance 1
Apr 27 13:28:33 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 27 13:28:33 volumac lircd[2410]: lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:33 volumac lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:33 volumac lircd[2410]: lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:33 volumac lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:33 volumac volumio[2607]: cannot open device 'volumioHw': Device or resource busy
Apr 27 13:28:33 volumac volumio[2607]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json
Apr 27 13:28:33 volumac volumio[2607]: cannot open device 'volumioHw': Device or resource busy
Apr 27 13:28:33 volumac volumio[2607]: info: FusionDsp loaded
Apr 27 13:28:33 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 27 13:28:33 volumac volumio[2607]: info: FusionDsp - Reporting Fusion DSP Enabled
Apr 27 13:28:33 volumac systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly.
Apr 27 13:28:33 volumac sudo[2860]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service
Apr 27 13:28:33 volumac sudo[2860]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 27 13:28:33 volumac volumio[2607]: info: Adding Signal Path Element [object Object]
Apr 27 13:28:33 volumac volumio[2607]: info: Adding fusiondspeq DSP Signal Path Element
Apr 27 13:28:33 volumac volumio[2607]: info: FusionDsp - ---- installed callbackRead
Apr 27 13:28:33 volumac volumio[2607]: info: FusionDsp - If filter freq >samplerate/2 then disable it
Apr 27 13:28:33 volumac volumio[2607]: info: ir_controller: LIRC correctly updated.
Apr 27 13:28:33 volumac volumio[2607]: error: updateQueue error: null
Apr 27 13:28:33 volumac volumio[2607]: info: Asound.conf file unchanged, so no further update is needed
Apr 27 13:28:33 volumac volumio[2607]: info: Output device has changed, restarting MPD
Apr 27 13:28:33 volumac sudo[2863]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 27 13:28:33 volumac sudo[2863]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 27 13:28:33 volumac volumio[2607]: info: Output device has changed, restarting Shairport Sync
Apr 27 13:28:33 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 27 13:28:33 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 27 13:28:33 volumac sudo[2863]: pam_unix(sudo:session): session closed for user root
Apr 27 13:28:33 volumac sudo[2866]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 27 13:28:33 volumac sudo[2866]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 27 13:28:33 volumac volumio[2607]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 27 13:28:33 volumac volumio[2607]: info: MPD Permissions set
Apr 27 13:28:33 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 27 13:28:33 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 27 13:28:33 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 27 13:28:33 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 27 13:28:33 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 27 13:28:33 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 27 13:28:33 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 27 13:28:33 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Apr 27 13:28:33 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 27 13:28:33 volumac volumio[2607]: info: Starting Shairport Sync
Apr 27 13:28:33 volumac sudo[2878]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 27 13:28:33 volumac sudo[2878]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 27 13:28:33 volumac sudo[2810]: pam_unix(sudo:session): session closed for user root
Apr 27 13:28:33 volumac volumio[2607]: info: succeeded
Apr 27 13:28:33 volumac systemd[1]: musicservicesshield.service: Succeeded.
Apr 27 13:28:33 volumac systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set.
Apr 27 13:28:33 volumac systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set...
Apr 27 13:28:33 volumac systemd[1]: Stopping Music Player Daemon...
Apr 27 13:28:33 volumac systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Apr 27 13:28:33 volumac systemd[1]: shairport-sync.service: Succeeded.
Apr 27 13:28:33 volumac systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Apr 27 13:28:33 volumac systemd[1]: mpd.service: Succeeded.
Apr 27 13:28:33 volumac systemd[1]: Stopped Music Player Daemon.
Apr 27 13:28:33 volumac sudo[2860]: pam_unix(sudo:session): session closed for user root
Apr 27 13:28:33 volumac systemd[1]: Starting Music Player Daemon...
Apr 27 13:28:33 volumac systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Apr 27 13:28:33 volumac sudo[2834]: pam_unix(sudo:session): session closed for user root
Apr 27 13:28:33 volumac volumio[2607]: info: Shairport-Sync Started
Apr 27 13:28:33 volumac volumio[2607]: Error adding Membership: Error: addMembership EINVAL
Apr 27 13:28:33 volumac sudo[2823]: pam_unix(sudo:session): session closed for user root
Apr 27 13:28:33 volumac sudo[2842]: pam_unix(sudo:session): session closed for user root
Apr 27 13:28:33 volumac sudo[2878]: pam_unix(sudo:session): session closed for user root
Apr 27 13:28:33 volumac volumio[2607]: info: Shairport-Sync Started
Apr 27 13:28:33 volumac volumio[2607]: info: Shairport-Sync Started
Apr 27 13:28:33 volumac volumio[2607]: info: Shairport-Sync Started
Apr 27 13:28:33 volumac sudo[2639]: pam_unix(sudo:session): session closed for user root
Apr 27 13:28:34 volumac lircd[2410]: lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:34 volumac lircd-0.10.1[2410]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:34 volumac lircd[2410]: lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:34 volumac lircd-0.10.1[2410]: default_init(): No such file or directory
Apr 27 13:28:34 volumac mpd[2880]: Apr 27 13:28 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Apr 27 13:28:34 volumac systemd[1]: Started Music Player Daemon.
Apr 27 13:28:34 volumac sudo[2866]: pam_unix(sudo:session): session closed for user root
Apr 27 13:28:34 volumac volumio[2607]: error: updateQueue error: null
Apr 27 13:28:34 volumac systemd[1]: Starting Shield Volumio Music Services in the User CPU Set...
Apr 27 13:28:34 volumac sudo[2889]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart lircd.service
Apr 27 13:28:34 volumac sudo[2889]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 27 13:28:34 volumac systemd[1]: Stopping Flexible IR remote input/output application support...
Apr 27 13:28:34 volumac lircd[2410]: lircd-0.10.1[2410]: Notice: caught signal
Apr 27 13:28:34 volumac lircd-0.10.1[2410]: Notice: caught signal
Apr 27 13:28:34 volumac systemd[1]: irexec.service: Succeeded.
Apr 27 13:28:34 volumac systemd[1]: lircd.service: Main process exited, code=killed, status=15/TERM
Apr 27 13:28:34 volumac systemd[1]: lircd.service: Succeeded.
Apr 27 13:28:34 volumac systemd[1]: Stopped Flexible IR remote input/output application support.
Apr 27 13:28:34 volumac systemd[1]: Starting lircd(8) initialization helper tool...
Apr 27 13:28:34 volumac lircd-setup[2899]: /usr/sbin/lircd-setup:37: DeprecationWarning: The SafeConfigParser class has been renamed to ConfigParser in Python 3.2. This alias will be removed in future versions. Use ConfigParser directly instead.
Apr 27 13:28:34 volumac lircd-setup[2899]: parser = configparser.SafeConfigParser()
Apr 27 13:28:34 volumac systemd[1]: lircd-setup.service: Succeeded.
Apr 27 13:28:34 volumac systemd[1]: Started lircd(8) initialization helper tool.
Apr 27 13:28:34 volumac systemd[1]: Starting Flexible IR remote input/output application support...
Apr 27 13:28:34 volumac lircd-0.10.1[2903]: Info: lircd: Opening log, level: Info
Apr 27 13:28:34 volumac lircd-0.10.1[2903]: Notice: Version: lircd 0.10.1
Apr 27 13:28:34 volumac lircd-0.10.1[2903]: Notice: System info: Linux volumac 6.6.25-volumio #2 SMP PREEMPT_DYNAMIC Sun Apr 7 20:18:18 CEST 2024 x86_64 GNU/Linux
Apr 27 13:28:34 volumac lircd-0.10.1[2903]: Info: Initial device: /dev/lirc0
Apr 27 13:28:34 volumac lircd-0.10.1[2903]: Warning: Cannot access device: /dev/lirc0
Apr 27 13:28:34 volumac lircd-0.10.1[2903]: Info: Initial device: /dev/lirc0
Apr 27 13:28:34 volumac lircd-0.10.1[2903]: Warning: Cannot access device: /dev/lirc0
Apr 27 13:28:34 volumac lircd-0.10.1[2903]: Notice: Options: driver: default
Apr 27 13:28:34 volumac lircd-0.10.1[2903]: Notice: Options: output: /var/run/lirc/lircd
Apr 27 13:28:34 volumac lircd-0.10.1[2903]: Notice: Options: nodaemon: 1
Apr 27 13:28:34 volumac lircd-0.10.1[2903]: Notice: Options: plugindir: /usr/lib/x86_64-linux-gnu/lirc/plugins
Apr 27 13:28:34 volumac lircd-0.10.1[2903]: Notice: Options: logfile: syslog
Apr 27 13:28:34 volumac lircd-0.10.1[2903]: Notice: Options: immediate-init: 0
Apr 27 13:28:34 volumac lircd-0.10.1[2903]: Notice: Options: permission: 666
Apr 27 13:28:34 volumac lircd-0.10.1[2903]: Notice: Options: driver-options:
Apr 27 13:28:34 volumac lircd-0.10.1[2903]: Notice: Options: pidfile: /var/run/lirc/lircd.pid
Apr 27 13:28:34 volumac lircd-0.10.1[2903]: Notice: Options: listen: 0
Apr 27 13:28:34 volumac lircd-0.10.1[2903]: Notice: Options: connect: (null)
Apr 27 13:28:34 volumac lircd-0.10.1[2903]: Notice: Options: userelease: 0
Apr 27 13:28:34 volumac lircd-0.10.1[2903]: Notice: Options: effective_user: (null)
Apr 27 13:28:34 volumac lircd-0.10.1[2903]: Notice: Options: release_suffix: _EVUP
Apr 27 13:28:34 volumac lircd-0.10.1[2903]: Notice: Options: allow_simulate: 0
Apr 27 13:28:34 volumac lircd-0.10.1[2903]: Notice: Options: repeat_max: 600
Apr 27 13:28:34 volumac lircd-0.10.1[2903]: Notice: Options: configfile: /etc/lirc/lircd.conf
Apr 27 13:28:34 volumac lircd-0.10.1[2903]: Notice: Options: dynamic_codes: (null)
Apr 27 13:28:34 volumac lircd-0.10.1[2903]: Notice: Current driver: default
Apr 27 13:28:34 volumac lircd-0.10.1[2903]: Notice: Driver API version: 3
Apr 27 13:28:34 volumac lircd-0.10.1[2903]: Notice: Driver version: 0.10.0
Apr 27 13:28:34 volumac lircd-0.10.1[2903]: Notice: Driver info: See file:///usr/share/doc/lirc/plugindocs/default.html
Apr 27 13:28:34 volumac lircd[2903]: lircd-0.10.1[2903]: Info: lircd: Opening log, level: Info
Apr 27 13:28:34 volumac lircd-0.10.1[2903]: Info: lircd: Opening log, level: Info
Apr 27 13:28:34 volumac lircd[2903]: lircd-0.10.1[2903]: Notice: Using systemd fd
Apr 27 13:28:34 volumac lircd-0.10.1[2903]: Notice: Using systemd fd
Apr 27 13:28:34 volumac lircd[2903]: lircd-0.10.1[2903]: Warning: Running as root
Apr 27 13:28:34 volumac lircd-0.10.1[2903]: Warning: Running as root
Apr 27 13:28:34 volumac lircd[2903]: lircd-0.10.1[2903]: Info: Using remote: iremote.
Apr 27 13:28:34 volumac lircd-0.10.1[2903]: Info: Using remote: iremote.
Apr 27 13:28:34 volumac lircd[2903]: lircd-0.10.1[2903]: Notice: lircd(default) ready, using /var/run/lirc/lircd
Apr 27 13:28:34 volumac lircd-0.10.1[2903]: Notice: lircd(default) ready, using /var/run/lirc/lircd
Apr 27 13:28:34 volumac systemd[1]: Started Flexible IR remote input/output application support.
Apr 27 13:28:34 volumac sudo[2889]: pam_unix(sudo:session): session closed for user root
Apr 27 13:28:34 volumac volumio[2607]: info: ir_controller: systemctl restart lircd.service succeeded.
Apr 27 13:28:34 volumac sudo[2909]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart irexec.service
Apr 27 13:28:34 volumac sudo[2909]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 27 13:28:34 volumac systemd[1]: Started Handle events from IR remotes decoded by lircd(8).
Apr 27 13:28:34 volumac sudo[2909]: pam_unix(sudo:session): session closed for user root
Apr 27 13:28:34 volumac lircd[2903]: lircd-0.10.1[2903]: Notice: accepted new client on /var/run/lirc/lircd
Apr 27 13:28:34 volumac volumio[2607]: info: ir_controller: systemctl restart irexec.service succeeded.
Apr 27 13:28:34 volumac lircd-0.10.1[2903]: Notice: accepted new client on /var/run/lirc/lircd
Apr 27 13:28:34 volumac lircd[2903]: lircd-0.10.1[2903]: Info: Cannot configure the rc device for /dev/lirc0
Apr 27 13:28:34 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:34 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:34 volumac lircd[2903]: lircd-0.10.1[2903]: Warning: Failed to initialize hardware
Apr 27 13:28:34 volumac lircd-0.10.1[2903]: Info: Cannot configure the rc device for /dev/lirc0
Apr 27 13:28:34 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:34 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:34 volumac lircd-0.10.1[2903]: Warning: Failed to initialize hardware
Apr 27 13:28:34 volumac volumio[2888]: cset: --> shielding system active with
Apr 27 13:28:34 volumac volumio[2888]: cset: "system" cpuset of CPUSPEC(1) with 149 tasks running
Apr 27 13:28:34 volumac volumio[2888]: cset: "user" cpuset of CPUSPEC(0) with 3 tasks running
Apr 27 13:28:34 volumac systemd[1]: Started Shield Volumio Music Services in the User CPU Set.
Apr 27 13:28:34 volumac sudo[2920]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 27 13:28:34 volumac sudo[2920]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 27 13:28:34 volumac sudo[2920]: pam_unix(sudo:session): session closed for user root
Apr 27 13:28:35 volumac sudo[2923]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 27 13:28:35 volumac sudo[2923]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 27 13:28:35 volumac sudo[2923]: pam_unix(sudo:session): session closed for user root
Apr 27 13:28:35 volumac sudo[2926]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Apr 27 13:28:35 volumac sudo[2926]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 27 13:28:35 volumac sudo[2926]: pam_unix(sudo:session): session closed for user root
Apr 27 13:28:35 volumac volumio[2607]: info: Upmpdcli Daemon Started
Apr 27 13:28:35 volumac volumio[2607]: info: Cannot mount NAS Music at system boot, trial number 3 ,retrying in 5 seconds
Apr 27 13:28:35 volumac volumio[2607]: info: go-librespot daemon successfully initialized
Apr 27 13:28:35 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:35 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:35 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:35 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:36 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:36 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:36 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:36 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:37 volumac volumio[2607]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory
Apr 27 13:28:37 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:37 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:37 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:37 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:38 volumac volumio[2607]: info: Initializing connection to go-librespot Websocket
Apr 27 13:28:38 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:38 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:38 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:38 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:39 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:39 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:39 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:39 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:40 volumac volumio[2607]: info: Cannot mount NAS Music at system boot, trial number 4 ,retrying in 5 seconds
Apr 27 13:28:40 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:40 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:40 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:40 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:41 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:41 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:41 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:41 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:42 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:42 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:42 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:42 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:43 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:43 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:43 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:43 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:44 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:44 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:44 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:44 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:45 volumac volumio[2607]: info: Cannot mount NAS at system boot, trial number 4 ,stopping
Apr 27 13:28:45 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:45 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:45 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:45 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:46 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:46 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:46 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:46 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:47 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:47 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:47 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:47 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:48 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:48 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:48 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:48 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:49 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:49 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:49 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:49 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:50 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:50 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:50 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:50 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:50 volumac volumio[2607]: info: AutoStart - Plugin is starting
Apr 27 13:28:50 volumac volumio[2607]: info: CoreCommandRouter::volumioGetQueue
Apr 27 13:28:50 volumac volumio[2607]: info: CoreStateMachine::getQueue
Apr 27 13:28:50 volumac volumio[2607]: info: CorePlayQueue::getQueue
Apr 27 13:28:50 volumac volumio[2607]: info: AutoStart - start playing
Apr 27 13:28:50 volumac volumio[2607]: info: AutoStart - start playing with no specific position
Apr 27 13:28:50 volumac volumio[2607]: info: CoreCommandRouter::volumioPlay
Apr 27 13:28:50 volumac volumio[2607]: info: CoreStateMachine::play index 0
Apr 27 13:28:50 volumac volumio[2607]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 27 13:28:50 volumac volumio[2607]: info: CoreStateMachine::stop
Apr 27 13:28:50 volumac volumio[2607]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 27 13:28:50 volumac volumio[2607]: info: CoreStateMachine::play index undefined
Apr 27 13:28:50 volumac volumio[2607]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 27 13:28:50 volumac volumio[2607]: info: CorePlayQueue::getTrack 0
Apr 27 13:28:50 volumac volumio[2607]: info: CoreStateMachine::startPlaybackTimer
Apr 27 13:28:50 volumac volumio[2607]: info: CorePlayQueue::getTrack 0
Apr 27 13:28:50 volumac volumio[2607]: verbose: ControllerMpd::clearAddPlayTracks NAS/Music/Dio/The Very Beast Of/01. Stand Up And Shout.mp3
Apr 27 13:28:50 volumac volumio[2607]: verbose: ControllerMpd::sendMpdCommand stop
Apr 27 13:28:50 volumac volumio[2607]: info: sendMpdCommand stop took 1 milliseconds
Apr 27 13:28:50 volumac volumio[2607]: verbose: ControllerMpd::sendMpdCommand clear
Apr 27 13:28:50 volumac volumio[2607]: info:
Apr 27 13:28:50 volumac volumio[2607]: ---------------------------- MPD announces system playlist update
Apr 27 13:28:50 volumac volumio[2607]: info: Ignoring MPD Status Update
Apr 27 13:28:50 volumac volumio[2607]: info: sendMpdCommand clear took 1 milliseconds
Apr 27 13:28:50 volumac volumio[2607]: verbose: ControllerMpd::sendMpdCommand add "NAS/Music/Dio/The Very Beast Of/01. Stand Up And Shout.mp3"
Apr 27 13:28:50 volumac volumio[2607]: error: updateQueue error: null
Apr 27 13:28:50 volumac volumio[2607]: info:
Apr 27 13:28:50 volumac volumio[2607]: ---------------------------- MPD announces system playlist update
Apr 27 13:28:50 volumac volumio[2607]: info: Ignoring MPD Status Update
Apr 27 13:28:50 volumac volumio[2607]: info: ------------------------------ 3ms
Apr 27 13:28:50 volumac volumio[2607]: info: sendMpdCommand add "NAS/Music/Dio/The Very Beast Of/01. Stand Up And Shout.mp3" took 1 milliseconds
Apr 27 13:28:50 volumac volumio[2607]: verbose: ControllerMpd::sendMpdCommand play
Apr 27 13:28:50 volumac volumio[2607]: info: ------------------------------ 2ms
Apr 27 13:28:50 volumac volumio[2607]: info: sendMpdCommand play took 1 milliseconds
Apr 27 13:28:51 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:51 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:51 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:51 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:52 volumac volumio[2607]: info:
Apr 27 13:28:52 volumac volumio[2607]: ---------------------------- MPD announces state update: player
Apr 27 13:28:52 volumac volumio[2607]: info: ControllerMpd::getState
Apr 27 13:28:52 volumac volumio[2607]: verbose: ControllerMpd::sendMpdCommand status
Apr 27 13:28:52 volumac volumio[2607]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32
Apr 27 13:28:52 volumac volumio[2607]: info: FusionDsp - ---- read samplerate from file: 44100
Apr 27 13:28:52 volumac volumio[2607]: info: camilladsp stopping service pid 2850...
Apr 27 13:28:52 volumac volumio[2607]: info: camilladsp service terminated, instance 1
Apr 27 13:28:52 volumac volumio[2607]: info: FusionDsp - If filter freq >samplerate/2 then disable it
Apr 27 13:28:52 volumac volumio[2607]: info: camilladsp service started and running in background, instance 1
Apr 27 13:28:52 volumac volumio[2607]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32
Apr 27 13:28:52 volumac volumio[2607]: info: FusionDsp - ---- read samplerate from file: 44100
Apr 27 13:28:52 volumac volumio[2607]: info: FusionDsp - If filter freq >samplerate/2 then disable it
Apr 27 13:28:52 volumac volumio[2607]: info:
Apr 27 13:28:52 volumac volumio[2607]: ---------------------------- MPD announces state update: player
Apr 27 13:28:52 volumac volumio[2607]: info: sendMpdCommand status took 71 milliseconds
Apr 27 13:28:52 volumac volumio[2607]: info: ControllerMpd::getState
Apr 27 13:28:52 volumac volumio[2607]: verbose: ControllerMpd::sendMpdCommand status
Apr 27 13:28:52 volumac volumio[2607]: verbose: ControllerMpd::parseState
Apr 27 13:28:52 volumac volumio[2607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 27 13:28:52 volumac volumio[2607]: info: sendMpdCommand status took 3 milliseconds
Apr 27 13:28:52 volumac volumio[2607]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 27 13:28:52 volumac volumio[2607]: verbose: ControllerMpd::parseState
Apr 27 13:28:52 volumac volumio[2607]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 27 13:28:52 volumac volumio[2607]: verbose: ControllerMpd::parseTrackInfo
Apr 27 13:28:52 volumac volumio[2607]: info: ControllerMpd::pushState
Apr 27 13:28:52 volumac volumio[2607]: info: CoreCommandRouter::servicePushState
Apr 27 13:28:52 volumac volumio[2607]: info: CorePlayQueue::getTrack 0
Apr 27 13:28:52 volumac volumio[2607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":198,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Stand Up And Shout","artist":"Dio","album":"The Very Beast Of Dio","uri":"NAS/Music/Dio/The Very Beast Of/01. Stand Up And Shout.mp3","trackType":"mp3"}
Apr 27 13:28:52 volumac volumio[2607]: verbose: CURRENT POSITION 0
Apr 27 13:28:52 volumac volumio[2607]: info: CoreStateMachine::syncState stateService play
Apr 27 13:28:52 volumac volumio[2607]: info: CoreStateMachine::syncState currentStatus stop
Apr 27 13:28:52 volumac volumio[2607]: info: ------------------------------ 81ms
Apr 27 13:28:52 volumac volumio[2607]: info: camilladsp spawned new process with pid 2981, instance 1, run: true
Apr 27 13:28:52 volumac volumio[2607]: info: sendMpdCommand playlistinfo took 25 milliseconds
Apr 27 13:28:52 volumac volumio[2607]: verbose: ControllerMpd::parseTrackInfo
Apr 27 13:28:52 volumac volumio[2607]: info: ControllerMpd::pushState
Apr 27 13:28:52 volumac volumio[2607]: info: CoreCommandRouter::servicePushState
Apr 27 13:28:52 volumac volumio[2607]: info: CorePlayQueue::getTrack 0
Apr 27 13:28:52 volumac volumio[2607]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1104,"duration":198,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Stand Up And Shout","artist":"Dio","album":"The Very Beast Of Dio","uri":"NAS/Music/Dio/The Very Beast Of/01. Stand Up And Shout.mp3","trackType":"mp3"}
Apr 27 13:28:52 volumac volumio[2607]: verbose: CURRENT POSITION 0
Apr 27 13:28:52 volumac volumio[2607]: info: CoreStateMachine::syncState stateService play
Apr 27 13:28:52 volumac volumio[2607]: info: CoreStateMachine::syncState currentStatus play
Apr 27 13:28:52 volumac volumio[2607]: info: Received an update from plugin. extracting info from payload
Apr 27 13:28:52 volumac volumio[2607]: info: CoreStateMachine::pushState
Apr 27 13:28:52 volumac volumio[2607]: info: CorePlayQueue::getTrack 0
Apr 27 13:28:52 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 27 13:28:52 volumac volumio[2607]: info: CoreCommandRouter::volumioPushState
Apr 27 13:28:52 volumac volumio[2607]: info: CoreStateMachine::pushState
Apr 27 13:28:52 volumac volumio[2607]: info: CorePlayQueue::getTrack 0
Apr 27 13:28:52 volumac volumio[2607]: info: CoreCommandRouter::volumioPushState
Apr 27 13:28:52 volumac volumio[2607]: info: ------------------------------ 46ms
Apr 27 13:28:52 volumac volumio[2607]: info: [LastFM] Current track has sufficient metadata: title (Stand Up And Shout) and artist (Dio) passed on explicitly
Apr 27 13:28:52 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:52 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:52 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:52 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:53 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:53 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:53 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:53 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:54 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:54 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:54 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:54 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:55 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:55 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:55 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:55 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:56 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:56 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:56 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:56 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:57 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:57 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:57 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:57 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:58 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:58 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:58 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:58 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:59 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:59 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:28:59 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:28:59 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:00 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:00 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:00 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:00 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:00 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 27 13:29:00 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 27 13:29:00 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Apr 27 13:29:01 volumac volumio[2607]: error: Plugin music_service pandora failed to complete 'onStart' in a timely fashion
Apr 27 13:29:01 volumac volumio[2607]: error: Plugin music_service tunein_radio failed to complete 'onStart' in a timely fashion
Apr 27 13:29:01 volumac volumio[2607]: info: -------------------------------------------
Apr 27 13:29:01 volumac volumio[2607]: info: ----- MyVolumio plugins startup ----
Apr 27 13:29:01 volumac volumio[2607]: info: -------------------------------------------
Apr 27 13:29:01 volumac volumio[2607]: info: [MyVolumio PluginManager] Fetching plans data....
Apr 27 13:29:01 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:01 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:01 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:01 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:02 volumac go-librespot[2784]: time="2024-04-27T13:29:02-04:00" level=fatal msg="failed running with username and spotify token" error="failed obtaining client token: failed requesting clienttoken: Post \"https://clienttoken.spotify.com/v1/clienttoken\": dial tcp: lookup clienttoken.spotify.com: i/o timeout"
Apr 27 13:29:02 volumac systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Apr 27 13:29:02 volumac systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Apr 27 13:29:02 volumac volumio[2607]: info: Discovery: adding 01adf3d4-6813-42d7-8b29-ad3e4c408fe9
Apr 27 13:29:02 volumac volumio[2607]: info: Discovery: Found device Volumac
Apr 27 13:29:02 volumac volumio[2607]: info: CoreCommandRouter::volumioGetState
Apr 27 13:29:02 volumac volumio[2607]: info: CorePlayQueue::getTrack 0
Apr 27 13:29:02 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:02 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:02 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:02 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:02 volumac volumio[2607]: info: An error occurred while refreshing Spotify Token Error: getaddrinfo ENOTFOUND oauth-performer.dfs.volumio.org
Apr 27 13:29:02 volumac volumio[2607]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 3
Apr 27 13:29:02 volumac volumio[2607]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 4
Apr 27 13:29:03 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:03 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:03 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:03 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:04 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:04 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:04 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:04 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:05 volumac volumio[2607]: verbose: New Socket.io Connection to 172.16.22.103 from 172.16.22.241 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Safari/537.36 Total Clients: 5
Apr 27 13:29:05 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 27 13:29:05 volumac systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
Apr 27 13:29:05 volumac systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1.
Apr 27 13:29:05 volumac systemd[1]: Stopped go-librespot Daemon.
Apr 27 13:29:05 volumac systemd[1]: Started go-librespot Daemon.
Apr 27 13:29:05 volumac go-librespot[2990]: Librespot-go daemon starting...
Apr 27 13:29:05 volumac go-librespot[2990]: time="2024-04-27T13:29:05-04:00" level=info msg="generated new device id: f60e755acfabc7da1926503e782e4ca6df3146fe"
Apr 27 13:29:05 volumac go-librespot[2990]: time="2024-04-27T13:29:05-04:00" level=debug msg="stored credentials found for 1249171035"
Apr 27 13:29:05 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 27 13:29:05 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 27 13:29:05 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 27 13:29:05 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 27 13:29:05 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Apr 27 13:29:05 volumac volumio[2607]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 27 13:29:05 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 27 13:29:05 volumac volumio[2607]: info: CoreCommandRouter::volumioGetState
Apr 27 13:29:05 volumac volumio[2607]: info: CorePlayQueue::getTrack 0
Apr 27 13:29:05 volumac volumio[2607]: info: CoreCommandRouter::volumioGetState
Apr 27 13:29:05 volumac volumio[2607]: info: CorePlayQueue::getTrack 0
Apr 27 13:29:05 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Apr 27 13:29:05 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Apr 27 13:29:05 volumac volumio[2607]: info: Received Get System Info
Apr 27 13:29:05 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 27 13:29:05 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 27 13:29:05 volumac volumio[2607]: info: Discovery: Getting this device information
Apr 27 13:29:05 volumac volumio[2607]: info: CoreCommandRouter::volumioGetState
Apr 27 13:29:05 volumac volumio[2607]: info: CorePlayQueue::getTrack 0
Apr 27 13:29:05 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 27 13:29:05 volumac volumio[2607]: info: CoreCommandRouter::volumioGetState
Apr 27 13:29:05 volumac volumio[2607]: info: CorePlayQueue::getTrack 0
Apr 27 13:29:05 volumac volumio[2607]: info: Listing playlists
Apr 27 13:29:05 volumac volumio[2607]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 27 13:29:05 volumac volumio[2607]: info: FusionDsp - IP adress is ---------------------------172.16.22.103
Apr 27 13:29:05 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:05 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:05 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:05 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:05 volumac volumio[2607]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 27 13:29:05 volumac volumio[2607]: info: FusionDsp - IP adress is ---------------------------172.16.22.103
Apr 27 13:29:06 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 27 13:29:06 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:06 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:06 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:06 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:07 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:07 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:07 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:07 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:08 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:08 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:08 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:08 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:09 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:09 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:09 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:09 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:10 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:10 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:10 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:10 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:11 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:11 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:11 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:11 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:12 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:12 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:12 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:12 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:13 volumac volumio[2607]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=x86_amd64&variante=volumio&version=3.661&uuid=47e990b15b658f061d824f174dd6966e" http://updates.volumio.org/downloader-v1/track-device
Apr 27 13:29:13 volumac volumio[2607]: % Total % Received % Xferd Average Speed Time Time Time Current
Apr 27 13:29:13 volumac volumio[2607]: Dload Upload Total Spent Left Speed
Apr 27 13:29:13 volumac volumio[2607]: [2.5K blob data]
Apr 27 13:29:13 volumac volumio[2607]: retrying in 5 seconds, trial 0
Apr 27 13:29:13 volumac volumio[2607]: info: Volumio Calling Home
Apr 27 13:29:13 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:13 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:13 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:13 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:14 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:14 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:14 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:14 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:15 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:15 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:15 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:15 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:16 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:16 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:16 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:16 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:17 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:17 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:17 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:17 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:18 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:18 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:18 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:18 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:19 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:19 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:19 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:19 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:20 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:20 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:20 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:20 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:21 volumac volumio[2607]: error: MyVolumio Plugin failed to start in a timely fashion
Apr 27 13:29:21 volumac volumio[2607]: info: BOOT COMPLETED
Apr 27 13:29:21 volumac volumio[2607]: [Metrics] CommandRouter: 57s 383.25ms
Apr 27 13:29:21 volumac volumio[2607]: info: CoreCommandRouter::volumiosetStartupVolume
Apr 27 13:29:21 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 27 13:29:21 volumac volumio[2607]: info: VolumeController:: Setting startup Volume 30
Apr 27 13:29:21 volumac volumio[2607]: info: VolumeController::SetAlsaVolume30
Apr 27 13:29:21 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 27 13:29:21 volumac volumio[2607]: info: CoreCommandRouter::Close All Modals sent
Apr 27 13:29:21 volumac volumio[2607]: info: CoreCommandRouter::Close All Modals sent
Apr 27 13:29:21 volumac volumio[2607]: info: CoreStateMachine::pushState
Apr 27 13:29:21 volumac volumio[2607]: info: CorePlayQueue::getTrack 0
Apr 27 13:29:21 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 27 13:29:21 volumac volumio[2607]: info: CoreCommandRouter::volumioPushState
Apr 27 13:29:21 volumac volumio[2607]: info: FusionDsp - ---- read samplerate, raw:
Apr 27 13:29:21 volumac volumio[2607]: error: FusionDsp - invalid sample rate
Apr 27 13:29:21 volumac volumio[2607]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32
Apr 27 13:29:21 volumac volumio[2607]: info: FusionDsp - ---- read samplerate from file: 44100
Apr 27 13:29:21 volumac volumio[2607]: info: FusionDsp - If filter freq >samplerate/2 then disable it
Apr 27 13:29:21 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:21 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:21 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:21 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:22 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Apr 27 13:29:22 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Apr 27 13:29:22 volumac volumio[2607]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Apr 27 13:29:22 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:22 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:22 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:22 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:23 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:23 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:23 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:23 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:24 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:24 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:24 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:24 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:25 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:25 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:25 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:25 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:26 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:26 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:26 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:26 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:27 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:27 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:27 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:27 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:28 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:28 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:28 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:28 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:29 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:29 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:29 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:29 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:30 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:30 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:30 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:30 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:31 volumac volumio[2607]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 27 13:29:31 volumac volumio[2607]: Error: getaddrinfo ENOTFOUND ws.audioscrobbler.com
Apr 27 13:29:31 volumac volumio[2607]: at GetAddrInfoReqWrap.onlookup [as oncomplete] (dns.js:71:26) {
Apr 27 13:29:31 volumac volumio[2607]: errno: -3007,
Apr 27 13:29:31 volumac volumio[2607]: code: 'ENOTFOUND',
Apr 27 13:29:31 volumac volumio[2607]: syscall: 'getaddrinfo',
Apr 27 13:29:31 volumac volumio[2607]: hostname: 'ws.audioscrobbler.com'
Apr 27 13:29:31 volumac volumio[2607]: }
Apr 27 13:29:31 volumac volumio[2607]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 27 13:29:31 volumac lircd[2903]: lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:31 volumac lircd-0.10.1[2903]: Error: could not get file information for /dev/lirc0
Apr 27 13:29:31 volumac lircd[2903]: lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:31 volumac lircd-0.10.1[2903]: default_init(): No such file or directory
Apr 27 13:29:31 volumac sudo[3016]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-27 13:28
Apr 27 13:29:31 volumac sudo[3016]: 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="e7445fab547cd22e23d9bef72406cfb610bc1d7d"
VOLUMIO_FE_VERSION="5d5e99f8f803b3ec5fc5e8ca13bb4023600f3eee"
VOLUMIO_FE3_VERSION="a6ae210575eae1ff43f06ab71e1cd17576840623"
VOLUMIO_BE_VERSION="a9e1e1dd6072ffb15c0fcb8938d9ea0d8900c0da"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed 24 Apr 2024 02:42:03 PM CEST"
VOLUMIO_VERSION="3.661"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="c434411fe8754b648dc7feb1d8f43761"