-- Logs begin at Fri 2024-03-29 12:52:52 CET, end at Fri 2024-03-29 12:54:59 CET. --
Mar 29 12:53:00 main ntpd[710]: error resolving pool 0.debian.pool.ntp.org: System error (-11)
Mar 29 12:53:00 main haveged[469]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.2.0 CTV); collect: 128K
Mar 29 12:53:00 main haveged[469]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 11/40; sz: 14768/63488
Mar 29 12:53:00 main haveged[469]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.99911
Mar 29 12:53:00 main haveged[469]: haveged: fills: 0, generated: 0
Mar 29 12:53:00 main nmbd[648]: [2024/03/29 12:53:00.246624, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns)
Mar 29 12:53:00 main nmbd[648]: started asyncdns process 735
Mar 29 12:53:00 main nmbd[648]: [2024/03/29 12:53:00.248514, 0] ../lib/util/become_daemon.c:149(daemon_status)
Mar 29 12:53:00 main nmbd[648]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ...
Mar 29 12:53:00 main nmbd[648]: [2024/03/29 12:53:00.248636, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets)
Mar 29 12:53:00 main nmbd[648]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6).
Mar 29 12:53:00 main kernel: new mount options do not match the existing superblock, will be ignored
Mar 29 12:53:00 main volumio[529]: cset: --> shielding system active with
Mar 29 12:53:00 main volumio[529]: cset: "system" cpuset of CPUSPEC(1-3) with 69 tasks running
Mar 29 12:53:00 main volumio[529]: cset: "user" cpuset of CPUSPEC(0) with 0 tasks running
Mar 29 12:53:00 main wireless.js[547]: Cleaning previous...
Mar 29 12:53:00 main systemd[1]: Started Shield Volumio Music Services in the User CPU Set.
Mar 29 12:53:00 main sudo[755]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0
Mar 29 12:53:00 main sudo[755]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 29 12:53:00 main sudo[755]: pam_unix(sudo:session): session closed for user root
Mar 29 12:53:00 main sudo[757]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down
Mar 29 12:53:00 main sudo[757]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 29 12:53:00 main kernel: bcmgenet fd580000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx
Mar 29 12:53:01 main systemd[1]: systemd-rfkill.service: Succeeded.
Mar 29 12:53:01 main ntpd[710]: error resolving pool 1.debian.pool.ntp.org: System error (-11)
Mar 29 12:53:01 main dhcpcd[606]: eth0: carrier acquired
Mar 29 12:53:01 main sudo[757]: pam_unix(sudo:session): session closed for user root
Mar 29 12:53:01 main dhcpcd[606]: DUID 00:01:00:01:2d:69:1c:d0:e4:5f:01:59:93:04
Mar 29 12:53:01 main dhcpcd[606]: eth0: IAID 01:59:93:04
Mar 29 12:53:01 main dhcpcd[606]: eth0: adding address fe80::e65f:1ff:fe59:9304
Mar 29 12:53:01 main dhcpcd[606]: ipv6_addaddr1: Permission denied
Mar 29 12:53:01 main dhcpcd[606]: eth0: probing address 192.168.0.171/24
Mar 29 12:53:01 main ifplugd(eth0)[712]: Link beat detected.
Mar 29 12:53:01 main wireless.js[547]: Stopped aP
Mar 29 12:53:01 main wireless.js[547]: Wireless Networking DISABLED, not starting wireless flow
Mar 29 12:53:01 main systemd[1]: wireless.service: Succeeded.
Mar 29 12:53:01 main systemd[1]: Started Wireless Services.
Mar 29 12:53:01 main systemd[1]: Started Volumio Backend Module.
Mar 29 12:53:01 main systemd[1]: Started Volumio Cpu Tweaker.
Mar 29 12:53:01 main ifplugd(eth0)[712]: Executing '/etc/ifplugd/ifplugd.action eth0 up'.
Mar 29 12:53:01 main ifplugd(eth0)[712]: client: ifup: interface eth0 already configured
Mar 29 12:53:01 main volumio-cpu-tweak[767]: Setting RT Priority for mpd
Mar 29 12:53:01 main volumio-cpu-tweak[767]: pid 35's current scheduling policy: SCHED_OTHER
Mar 29 12:53:01 main volumio-cpu-tweak[767]: pid 35's current scheduling priority: 0
Mar 29 12:53:01 main volumio-cpu-tweak[767]: Setting MPD Affinity
Mar 29 12:53:01 main volumio-cpu-tweak[767]: pid 3's current affinity mask: f
Mar 29 12:53:01 main volumio-cpu-tweak[767]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input
Mar 29 12:53:01 main volumio-cpu-tweak[767]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance
Mar 29 12:53:01 main systemd[1]: volumio_cpu_tweak.service: Succeeded.
Mar 29 12:53:01 main ifplugd(eth0)[712]: Program executed successfully.
Mar 29 12:53:01 main dhcpcd[606]: eth0: soliciting an IPv6 router
Mar 29 12:53:02 main ntpd[710]: error resolving pool 2.debian.pool.ntp.org: System error (-11)
Mar 29 12:53:02 main bthelper[567]: Changing power off succeeded
Mar 29 12:53:02 main bthelper[567]: [CHG] Controller E4:5F:01:59:93:08 Powered: no
Mar 29 12:53:02 main bthelper[567]: [CHG] Controller E4:5F:01:59:93:08 Discovering: no
Mar 29 12:53:02 main bthelper[567]: [CHG] Controller E4:5F:01:59:93:08 Class: 0x00000000
Mar 29 12:53:02 main bthelper[567]: [CHG] Controller E4:5F:01:59:93:08 Class: 0x0000041c
Mar 29 12:53:02 main bthelper[567]: Changing power on succeeded
Mar 29 12:53:03 main volumio[766]: info: -------------------------------------------
Mar 29 12:53:03 main volumio[766]: info: ----- Volumio3 ----
Mar 29 12:53:03 main volumio[766]: info: -------------------------------------------
Mar 29 12:53:03 main volumio[766]: info: ----- System startup ----
Mar 29 12:53:03 main volumio[766]: info: -------------------------------------------
Mar 29 12:53:03 main ntpd[710]: error resolving pool 3.debian.pool.ntp.org: System error (-11)
Mar 29 12:53:03 main volumio-remote-updater[527]: [2024-03-29 12:53:03] [connect] Successful connection
Mar 29 12:53:03 main volumio[766]: info: MYVOLUMIO Environment detected
Mar 29 12:53:03 main volumio[766]: info: Plugin folders cleanup
Mar 29 12:53:03 main volumio[766]: info: Scanning into folder /volumio/app/plugins/
Mar 29 12:53:03 main volumio[766]: info: Scanning category audio_interface
Mar 29 12:53:03 main volumio[766]: info: Scanning category miscellanea
Mar 29 12:53:03 main volumio[766]: info: Scanning category music_service
Mar 29 12:53:03 main volumio[766]: info: Scanning category plugins.json
Mar 29 12:53:03 main volumio[766]: info: Scanning category system_controller
Mar 29 12:53:03 main volumio[766]: info: Scanning category user_interface
Mar 29 12:53:03 main volumio[766]: info: Scanning into folder /data/plugins/
Mar 29 12:53:03 main volumio[766]: info: Scanning category audio_interface
Mar 29 12:53:03 main volumio[766]: info: Scanning category system_hardware
Mar 29 12:53:03 main volumio[766]: info: Plugin folders cleanup completed
Mar 29 12:53:03 main volumio[766]: info: -------------------------------------------
Mar 29 12:53:03 main volumio[766]: info: ----- Core plugins startup ----
Mar 29 12:53:03 main volumio[766]: info: -------------------------------------------
Mar 29 12:53:03 main volumio[766]: info: Loading plugins from folder /volumio/app/plugins/
Mar 29 12:53:03 main volumio[766]: info: Adding plugin upnp to MyMusic Plugins
Mar 29 12:53:03 main volumio[766]: info: Adding plugin airplay_emulation to MyMusic Plugins
Mar 29 12:53:03 main volumio[766]: info: Adding plugin upnp_browser to MyMusic Plugins
Mar 29 12:53:03 main volumio[766]: info: Loading plugins from folder /data/plugins/
Mar 29 12:53:03 main volumio[766]: info: Loading plugin "system"...
Mar 29 12:53:04 main volumio[766]: info: Loading plugin "appearance"...
Mar 29 12:53:04 main volumio[766]: info: Loading plugin "network"...
Mar 29 12:53:04 main volumio[766]: info: Refreshing Cached IP Addresses
Mar 29 12:53:05 main volumio[766]: info: Loading plugin "services"...
Mar 29 12:53:05 main sudo[808]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Mar 29 12:53:05 main sudo[808]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 29 12:53:05 main volumio[766]: info: Loading plugin "alsa_controller"...
Mar 29 12:53:05 main sudo[808]: pam_unix(sudo:session): session closed for user root
Mar 29 12:53:05 main sudo[810]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Mar 29 12:53:05 main sudo[810]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 29 12:53:05 main sudo[810]: pam_unix(sudo:session): session closed for user root
Mar 29 12:53:05 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Mar 29 12:53:05 main volumio[766]: info: Loading plugin "wizard"...
Mar 29 12:53:05 main volumio[766]: info: Loading plugin "networkfs"...
Mar 29 12:53:05 main volumio[766]: info: Starting Udev Watcher for removable devices
Mar 29 12:53:05 main volumio[766]: info: Ignoring mount for partition: boot
Mar 29 12:53:05 main volumio[766]: info: Ignoring mount for partition: volumio
Mar 29 12:53:05 main volumio[766]: info: Ignoring mount for partition: volumio_data
Mar 29 12:53:05 main volumio[766]: info: Mounting Device T7_Shield
Mar 29 12:53:05 main sudo[819]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/T7_Shield -o noatime
Mar 29 12:53:05 main sudo[819]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 29 12:53:05 main mount.exfat[821]: volume was not unmounted cleanly
Mar 29 12:53:05 main kernel: fuse: init (API version 7.37)
Mar 29 12:53:05 main sudo[819]: pam_unix(sudo:session): session closed for user root
Mar 29 12:53:05 main volumio[766]: WARN: volume was not unmounted cleanly.
Mar 29 12:53:05 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Mar 29 12:53:05 main volumio[766]: info: Loading plugin "volumio_command_line_client"...
Mar 29 12:53:05 main volumio[766]: info: Plugin upnp is not enabled
Mar 29 12:53:05 main volumio[766]: info: Loading plugin "my_music"...
Mar 29 12:53:05 main volumio[766]: info: Loading plugin "mpd"...
Mar 29 12:53:05 main systemd[1]: Mounting FUSE Control File System...
Mar 29 12:53:05 main systemd[1]: Mounted FUSE Control File System.
Mar 29 12:53:05 main volumio[766]: info: Plugin upnp_browser is not enabled
Mar 29 12:53:05 main volumio[766]: info: Loading plugin "alarm-clock"...
Mar 29 12:53:05 main volumio[766]: info: Plugin airplay_emulation is not enabled
Mar 29 12:53:05 main volumio[766]: info: Loading plugin "last_100"...
Mar 29 12:53:05 main volumio[766]: info: Loading plugin "webradio"...
Mar 29 12:53:06 main volumio[766]: info: Loading plugin "i2s_dacs"...
Mar 29 12:53:06 main volumio[766]: info: Loading plugin "volumiodiscovery"...
Mar 29 12:53:06 main volumio[766]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Mar 29 12:53:06 main node[766]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Mar 29 12:53:06 main volumio[766]: *** WARNING *** Please fix your application to use the native API of Avahi!
Mar 29 12:53:06 main node[766]: *** WARNING *** Please fix your application to use the native API of Avahi!
Mar 29 12:53:06 main volumio[766]: *** WARNING *** For more information see
Mar 29 12:53:06 main node[766]: *** WARNING *** For more information see
Mar 29 12:53:06 main volumio[766]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Mar 29 12:53:06 main node[766]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Mar 29 12:53:06 main volumio[766]: *** WARNING *** Please fix your application to use the native API of Avahi!
Mar 29 12:53:06 main node[766]: *** WARNING *** Please fix your application to use the native API of Avahi!
Mar 29 12:53:06 main volumio[766]: *** WARNING *** For more information see
Mar 29 12:53:06 main node[766]: *** WARNING *** For more information see
Mar 29 12:53:06 main volumio[766]: info: Applying required configuration parameters for plugin volumiodiscovery
Mar 29 12:53:06 main volumio[766]: info: Discovery: Started advertising with name: MAIN
Mar 29 12:53:06 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Mar 29 12:53:06 main volumio[766]: info: Loading plugin "outputs"...
Mar 29 12:53:06 main volumio[766]: info: Loading plugin "albumart"...
Mar 29 12:53:06 main volumio[766]: info: Plugin example_plugin is not enabled
Mar 29 12:53:06 main volumio[766]: info: Loading plugin "inputs"...
Mar 29 12:53:06 main volumio[766]: info: Loading plugin "updater_comm"...
Mar 29 12:53:06 main volumio[766]: info: Plugin mpdemulation is not enabled
Mar 29 12:53:06 main volumio[766]: info: Loading plugin "rest_api"...
Mar 29 12:53:06 main volumio[766]: info: Loading plugin "websocket"...
Mar 29 12:53:06 main volumio[766]: info: Loading plugin "fusiondsp"...
Mar 29 12:53:06 main volumio[766]: Forking 3 albumart workers
Mar 29 12:53:06 main dhcpcd[606]: eth0: using static address 192.168.0.171/24
Mar 29 12:53:06 main avahi-daemon[541]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.0.171.
Mar 29 12:53:06 main dhcpcd[606]: eth0: adding route to 192.168.0.0/24
Mar 29 12:53:06 main avahi-daemon[541]: New relevant interface eth0.IPv4 for mDNS.
Mar 29 12:53:06 main dhcpcd[606]: eth0: adding default route via 192.168.0.1
Mar 29 12:53:06 main avahi-daemon[541]: Registering new address record for 192.168.0.171 on eth0.IPv4.
Mar 29 12:53:06 main volumio[766]: info: Applying required configuration parameters for plugin fusiondsp
Mar 29 12:53:06 main volumio[766]: info: Loading plugin "music_services_shield"...
Mar 29 12:53:07 main volumio[766]: Starting albumart workers
Mar 29 12:53:07 main volumio[766]: Starting albumart workers
Mar 29 12:53:07 main volumio[766]: info: Applying required configuration parameters for plugin music_services_shield
Mar 29 12:53:07 main volumio[766]: Starting albumart workers
Mar 29 12:53:07 main volumio[766]: info: Loading i18n strings for locale en
Mar 29 12:53:07 main volumio[766]: Updating browse sources language
Mar 29 12:53:07 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 29 12:53:07 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Mar 29 12:53:07 main volumio[766]: info: CoreCommandRouter::initPlayerControls
Mar 29 12:53:07 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 29 12:53:07 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 29 12:53:07 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 29 12:53:07 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 29 12:53:07 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 29 12:53:07 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 29 12:53:07 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 29 12:53:07 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 29 12:53:07 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Mar 29 12:53:07 main volumio[766]: Express server listening on port 3000
Mar 29 12:53:07 main volumio[766]: [Metrics] WebUI: 5s 66.03ms
Mar 29 12:53:07 main volumio[766]: info: CoreStateMachine::resetVolumioState
Mar 29 12:53:07 main volumio[766]: info: CoreStateMachine::getcurrentVolume
Mar 29 12:53:07 main volumio[766]: info: CoreCommandRouter::volumioRetrievevolume
Mar 29 12:53:07 main volumio[766]: info: CoreStateMachine::pushState
Mar 29 12:53:07 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:07 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 29 12:53:07 main volumio[766]: info: CoreCommandRouter::volumioPushState
Mar 29 12:53:07 main volumio-remote-updater[527]: [2024-03-29 12:53:07] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1711713183 101
Mar 29 12:53:07 main volumio[766]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 1
Mar 29 12:53:07 main volumio[766]: verbose: New Socket.io Connection to 192.168.0.171 from 192.168.0.196 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:124.0) Gecko/20100101 Firefox/124.0 Total Clients: 2
Mar 29 12:53:07 main volumio[766]: verbose: New Socket.io Connection to 192.168.0.171 from 192.168.0.196 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:124.0) Gecko/20100101 Firefox/124.0 Total Clients: 3
Mar 29 12:53:07 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 29 12:53:07 main volumio[766]: info: Reloading queue from file
Mar 29 12:53:07 main volumio[766]: verbose: New Socket.io Connection to 192.168.0.171 from 192.168.0.196 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:124.0) Gecko/20100101 Firefox/124.0 Total Clients: 4
Mar 29 12:53:07 main volumio[766]: verbose: New Socket.io Connection to 192.168.0.171 from 192.168.0.196 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:124.0) Gecko/20100101 Firefox/124.0 Total Clients: 5
Mar 29 12:53:07 main volumio[766]: info: CoreStateMachine::setRepeat null single undefined
Mar 29 12:53:07 main volumio[766]: info: CoreStateMachine::pushState
Mar 29 12:53:07 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:07 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 29 12:53:07 main volumio[766]: info: CoreCommandRouter::volumioPushState
Mar 29 12:53:07 main volumio[766]: info: CoreStateMachine::setRandom null
Mar 29 12:53:07 main volumio[766]: info: CoreStateMachine::pushState
Mar 29 12:53:07 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:07 main volumio[766]: info: CoreCommandRouter::volumioPushState
Mar 29 12:53:07 main volumio[766]: info: Setting Device type: Raspberry PI
Mar 29 12:53:07 main volumio[766]: verbose: New Socket.io Connection to 192.168.0.171 from 192.168.0.196 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:124.0) Gecko/20100101 Firefox/124.0 Total Clients: 6
Mar 29 12:53:07 main volumio[766]: verbose: New Socket.io Connection to 192.168.0.171 from 192.168.0.196 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:124.0) Gecko/20100101 Firefox/124.0 Total Clients: 7
Mar 29 12:53:07 main volumio[766]: info: Completed loading Core Plugins
Mar 29 12:53:07 main volumio[766]: info: Preparing to generate the ALSA configuration file
Mar 29 12:53:07 main volumio[766]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Mar 29 12:53:07 main volumio[766]: info: Reading ALSA contributions from plugins.
Mar 29 12:53:07 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:07 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:07 main volumio[766]: info: CoreCommandRouter::volumioGetQueue
Mar 29 12:53:07 main volumio[766]: info: CoreStateMachine::getQueue
Mar 29 12:53:07 main volumio[766]: info: CorePlayQueue::getQueue
Mar 29 12:53:07 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid
Mar 29 12:53:07 main volumio[766]: info: CALLMETHOD: music_service inputs serialMonitorAction [object Object]
Mar 29 12:53:07 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: inputs , serialMonitorAction
Mar 29 12:53:07 main volumio[766]: info: Error : CoreCommandRouter::executeOnPlugin: No method [serialMonitorAction] in plugin inputs
Mar 29 12:53:07 main volumio[766]: info: CALLMETHOD: system_controller motivocontrol displaySelection [object Object]
Mar 29 12:53:07 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: motivocontrol , displaySelection
Mar 29 12:53:08 main volumio[766]: info: Discovery: adding f0377915-0688-4464-901b-010d80af48c7
Mar 29 12:53:08 main volumio[766]: info: Discovery: Found device MAIN
Mar 29 12:53:08 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:08 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:08 main volumio[766]: info: Asound.conf file unchanged, so no further update is needed
Mar 29 12:53:08 main volumio[766]: info: Output device has changed, restarting MPD
Mar 29 12:53:08 main sudo[908]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Mar 29 12:53:08 main volumio[766]: info: ___________ START PLUGINS ___________
Mar 29 12:53:08 main sudo[908]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 29 12:53:08 main volumio[766]: info: ControllerMpd::onStart: Initializing MPD
Mar 29 12:53:08 main volumio[766]: info: Creating MPD Configuration file
Mar 29 12:53:08 main sudo[908]: pam_unix(sudo:session): session closed for user root
Mar 29 12:53:08 main sudo[910]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Mar 29 12:53:08 main sudo[910]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 29 12:53:08 main systemd[1]: musicservicesshield.service: Succeeded.
Mar 29 12:53:08 main systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set.
Mar 29 12:53:08 main systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set...
Mar 29 12:53:08 main volumio[766]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Mar 29 12:53:08 main volumio[766]: info: [1711713188077] CoreMusicLibrary::Adding element Last_100
Mar 29 12:53:08 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 29 12:53:08 main volumio[766]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Mar 29 12:53:08 main volumio[766]: info: [1711713188080] CoreMusicLibrary::Adding element Webradio
Mar 29 12:53:08 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 29 12:53:08 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Mar 29 12:53:08 main sudo[914]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Mar 29 12:53:08 main sudo[914]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 29 12:53:08 main volumio[766]: info: Loading i18n strings for locale en
Mar 29 12:53:08 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
Mar 29 12:53:08 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 29 12:53:08 main volumio[766]: info: FusionDsp - mixtype--------------------- None
Mar 29 12:53:08 main sudo[914]: pam_unix(sudo:session): session closed for user root
Mar 29 12:53:08 main sudo[916]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Mar 29 12:53:08 main sudo[916]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 29 12:53:08 main systemd[1]: Listening on mpd.socket.
Mar 29 12:53:08 main systemd[1]: Starting Music Player Daemon...
Mar 29 12:53:08 main ntpd[710]: Listen normally on 3 eth0 192.168.0.171:123
Mar 29 12:53:08 main ntpd[710]: new interface(s) found: waking up resolver
Mar 29 12:53:08 main systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Mar 29 12:53:08 main systemd[1]: mpd.service: Succeeded.
Mar 29 12:53:08 main systemd[1]: Stopped Music Player Daemon.
Mar 29 12:53:08 main systemd[1]: Starting Music Player Daemon...
Mar 29 12:53:08 main volumio[766]: info: Volumio Calling Home
Mar 29 12:53:08 main volumio[766]: info: Preparing to generate the ALSA configuration file
Mar 29 12:53:08 main sudo[948]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/moveallprocesses.sh
Mar 29 12:53:08 main sudo[948]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 29 12:53:08 main volumio[766]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Mar 29 12:53:08 main volumio[766]: info: Reading ALSA contributions from plugins.
Mar 29 12:53:08 main volumio[766]: info: MPD Permissions set
Mar 29 12:53:08 main volumio[766]: info: MPD Permissions set
Mar 29 12:53:08 main volumio[766]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 8
Mar 29 12:53:08 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 29 12:53:08 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 29 12:53:08 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 29 12:53:08 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 29 12:53:08 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 29 12:53:08 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 29 12:53:08 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 29 12:53:08 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 29 12:53:08 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 29 12:53:08 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 29 12:53:08 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 29 12:53:08 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 29 12:53:08 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 29 12:53:08 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 29 12:53:08 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 29 12:53:08 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 29 12:53:08 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 29 12:53:08 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 29 12:53:08 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 29 12:53:08 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 29 12:53:08 main volumio[766]: info: Volumio called home
Mar 29 12:53:08 main volumio[766]: info: Asound.conf file unchanged, so no further update is needed
Mar 29 12:53:08 main volumio[766]: info: Output device has changed, restarting MPD
Mar 29 12:53:08 main sudo[973]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Mar 29 12:53:08 main sudo[973]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 29 12:53:08 main sudo[973]: pam_unix(sudo:session): session closed for user root
Mar 29 12:53:08 main sudo[975]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Mar 29 12:53:08 main sudo[975]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 29 12:53:08 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:08 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:08 main volumio[766]: info: MPD Permissions set
Mar 29 12:53:08 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 29 12:53:08 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 29 12:53:08 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 29 12:53:08 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 29 12:53:08 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 29 12:53:08 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 29 12:53:08 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 29 12:53:08 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 29 12:53:08 main systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Mar 29 12:53:08 main systemd[1]: mpd.service: Succeeded.
Mar 29 12:53:08 main systemd[1]: Stopped Music Player Daemon.
Mar 29 12:53:08 main systemd[1]: Starting Music Player Daemon...
Mar 29 12:53:08 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 29 12:53:08 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 29 12:53:08 main sudo[948]: pam_unix(sudo:session): session closed for user root
Mar 29 12:53:08 main sudo[994]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/addservice.sh
Mar 29 12:53:08 main sudo[994]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 29 12:53:10 main mpd[982]: Mar 29 12:53 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Mar 29 12:53:10 main systemd[1]: Started Music Player Daemon.
Mar 29 12:53:10 main sudo[910]: pam_unix(sudo:session): session closed for user root
Mar 29 12:53:10 main sudo[975]: pam_unix(sudo:session): session closed for user root
Mar 29 12:53:10 main sudo[916]: pam_unix(sudo:session): session closed for user root
Mar 29 12:53:10 main volumio[766]: info: camilladsp spawned new process with pid 1007, instance 1, run: true
Mar 29 12:53:10 main volumio[766]: info: camilladsp service started and running in background, instance 1
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 29 12:53:10 main systemd[1]: Starting Shield Volumio Music Services in the User CPU Set...
Mar 29 12:53:10 main volumio[766]: info: FusionDsp - AAAAAAAAAAAAAA-> 22050 44100 48000 88200 96000 176400 192000 384000 <-AAAAAAAAAAAAA
Mar 29 12:53:10 main volumio[766]: info: FusionDsp loaded
Mar 29 12:53:10 main systemd[1]: Started Samba NMB Daemon.
Mar 29 12:53:10 main nmbd[648]: [2024/03/29 12:53:10.254393, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Mar 29 12:53:10 main nmbd[648]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections
Mar 29 12:53:10 main systemd[1]: Starting Samba Winbind Daemon...
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 29 12:53:10 main sudo[1019]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service
Mar 29 12:53:10 main sudo[1019]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 29 12:53:10 main volumio[766]: info: FusionDsp - Reporting Fusion DSP Enabled
Mar 29 12:53:10 main volumio[766]: info: Adding Signal Path Element [object Object]
Mar 29 12:53:10 main volumio[766]: info: Adding fusiondspeq DSP Signal Path Element
Mar 29 12:53:10 main volumio[766]: info: FusionDsp - ---- installed callbackRead
Mar 29 12:53:10 main volumio[766]: verbose: New Socket.io Connection to 192.168.0.171 from 192.168.0.196 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:124.0) Gecko/20100101 Firefox/124.0 Total Clients: 9
Mar 29 12:53:10 main systemd[1]: Started FusionDsp Daemon.
Mar 29 12:53:10 main sudo[1019]: pam_unix(sudo:session): session closed for user root
Mar 29 12:53:10 main volumio[766]: info: Completed starting Core Plugins
Mar 29 12:53:10 main volumio[766]: info: -------------------------------------------
Mar 29 12:53:10 main volumio[766]: info: ----- MyVolumio plugins startup ----
Mar 29 12:53:10 main volumio[766]: info: -------------------------------------------
Mar 29 12:53:10 main volumio[766]: info: [MyVolumio PluginManager] Fetching plans data....
Mar 29 12:53:10 main volumio[766]: info: FusionDsp - If filter freq >samplerate/2 then disable it
Mar 29 12:53:10 main volumio[766]: info: FusionDsp - else 1 -2.5
Mar 29 12:53:10 main volumio[766]: info: MPD running with PID982
Mar 29 12:53:10 main volumio[766]: ,establishing connection
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:10 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:10 main volumio[766]: error: MPD error: The expression evaluated to a falsy value:
Mar 29 12:53:10 main volumio[766]: assert.ok(self.idling)
Mar 29 12:53:10 main volumio[766]: error: The expression evaluated to a falsy value:
Mar 29 12:53:10 main volumio[766]: assert.ok(self.idling)
Mar 29 12:53:10 main volumio[766]: error: MPD error: The expression evaluated to a falsy value:
Mar 29 12:53:10 main volumio[766]: assert.ok(self.idling)
Mar 29 12:53:10 main volumio[766]: error: The expression evaluated to a falsy value:
Mar 29 12:53:10 main volumio[766]: assert.ok(self.idling)
Mar 29 12:53:10 main volumio[766]: error: MPD error: The expression evaluated to a falsy value:
Mar 29 12:53:10 main volumio[766]: assert.ok(self.idling)
Mar 29 12:53:10 main volumio[766]: error: The expression evaluated to a falsy value:
Mar 29 12:53:10 main volumio[766]: assert.ok(self.idling)
Mar 29 12:53:10 main volumio[766]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 10
Mar 29 12:53:10 main volumio[766]: info: Received Get System Info
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 29 12:53:10 main volumio[766]: info: Discovery: Getting this device information
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:10 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:10 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::volumioGetVisibleSources
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:10 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:10 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Mar 29 12:53:10 main volumio[766]: info: Received Get System Info
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 29 12:53:10 main volumio[766]: info: Discovery: Getting this device information
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:10 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:10 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:10 main volumio[766]: info: Listing playlists
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::volumioGetQueue
Mar 29 12:53:10 main volumio[766]: info: CoreStateMachine::getQueue
Mar 29 12:53:10 main volumio[766]: info: CorePlayQueue::getQueue
Mar 29 12:53:10 main volumio[766]: info: Received Get System Info
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 29 12:53:10 main volumio[766]: info: Discovery: Getting this device information
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:10 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:10 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:10 main winbindd[1020]: [2024/03/29 12:53:10.627116, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache)
Mar 29 12:53:10 main winbindd[1020]: initialize_winbindd_cache: clearing cache and re-creating with version number 2
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::volumioGetVisibleSources
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:10 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:10 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Mar 29 12:53:10 main volumio[766]: info: Received Get System Info
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 29 12:53:10 main volumio[766]: info: Discovery: Getting this device information
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:10 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:10 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:10 main volumio[766]: info: Listing playlists
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::volumioGetQueue
Mar 29 12:53:10 main volumio[766]: info: CoreStateMachine::getQueue
Mar 29 12:53:10 main volumio[766]: info: CorePlayQueue::getQueue
Mar 29 12:53:10 main winbindd[1020]: [2024/03/29 12:53:10.651277, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Mar 29 12:53:10 main systemd[1]: Started Samba Winbind Daemon.
Mar 29 12:53:10 main winbindd[1020]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections
Mar 29 12:53:10 main systemd[1]: Starting Samba SMB Daemon...
Mar 29 12:53:10 main volumio[766]: info: Received Get System Info
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 29 12:53:10 main volumio[766]: info: Discovery: Getting this device information
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:10 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:10 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::volumioGetVisibleSources
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:10 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:10 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Mar 29 12:53:10 main volumio[766]: info: Received Get System Info
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 29 12:53:10 main volumio[766]: info: Discovery: Getting this device information
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:10 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:10 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:10 main volumio[766]: info: Listing playlists
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::volumioGetQueue
Mar 29 12:53:10 main volumio[766]: info: CoreStateMachine::getQueue
Mar 29 12:53:10 main volumio[766]: info: CorePlayQueue::getQueue
Mar 29 12:53:10 main volumio[766]: info: Received Get System Info
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 29 12:53:10 main volumio[766]: info: Discovery: Getting this device information
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:10 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 29 12:53:10 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:10 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:10 main volumio[1006]: cset: --> shielding system active with
Mar 29 12:53:10 main volumio[1006]: cset: "system" cpuset of CPUSPEC(1-3) with 102 tasks running
Mar 29 12:53:10 main volumio[1006]: cset: "user" cpuset of CPUSPEC(0) with 3 tasks running
Mar 29 12:53:10 main systemd[1]: Started Shield Volumio Music Services in the User CPU Set.
Mar 29 12:53:10 main systemd[1]: Reloading.
Mar 29 12:53:11 main volumio[766]: info: FusionDsp - {"Reload":{"result":"Ok"}}
Mar 29 12:53:11 main winbindd[1020]: [2024/03/29 12:53:11.164842, 0] ../source3/winbindd/wb_lookupsids.c:659(wb_lookupsids_recv)
Mar 29 12:53:11 main winbindd[1020]: res_names->count = 3, expected 4
Mar 29 12:53:11 main volumio[766]: error: updateQueue error: null
Mar 29 12:53:11 main smbd[1042]: [2024/03/29 12:53:11.233496, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Mar 29 12:53:11 main smbd[1042]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections
Mar 29 12:53:11 main 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.
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:11 main systemd[1]: getty@tty1.service: Current command vanished from the unit file, execution of the command list won't be resumed.
Mar 29 12:53:11 main systemd[1]: Started Samba SMB Daemon.
Mar 29 12:53:11 main systemd[1]: Reached target Multi-User System.
Mar 29 12:53:11 main systemd[1]: Reached target Graphical Interface.
Mar 29 12:53:11 main systemd[1]: Starting Update UTMP about System Runlevel Changes...
Mar 29 12:53:11 main sudo[994]: pam_unix(sudo:session): session closed for user root
Mar 29 12:53:11 main systemd[1]: systemd-update-utmp-runlevel.service: Succeeded.
Mar 29 12:53:11 main systemd[1]: Started Update UTMP about System Runlevel Changes.
Mar 29 12:53:11 main systemd[1]: Startup finished in 9.189s (kernel) + 21.391s (userspace) = 30.580s.
Mar 29 12:53:16 main volumio[766]: info: succeeded
Mar 29 12:53:22 main volumio[766]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
Mar 29 12:53:22 main volumio[766]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
Mar 29 12:53:22 main volumio[766]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
Mar 29 12:53:22 main volumio[766]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
Mar 29 12:53:22 main volumio[766]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
Mar 29 12:53:22 main volumio[766]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
Mar 29 12:53:22 main volumio[766]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
Mar 29 12:53:22 main volumio[766]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
Mar 29 12:53:22 main volumio[766]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
Mar 29 12:53:22 main volumio[766]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
Mar 29 12:53:22 main volumio[766]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
Mar 29 12:53:22 main volumio[766]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
Mar 29 12:53:22 main volumio[766]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
Mar 29 12:53:22 main volumio[766]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
Mar 29 12:53:22 main volumio[766]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
Mar 29 12:53:22 main volumio[766]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
Mar 29 12:53:22 main volumio[766]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
Mar 29 12:53:22 main volumio[766]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
Mar 29 12:53:22 main volumio[766]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
Mar 29 12:53:22 main volumio[766]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
Mar 29 12:53:22 main volumio[766]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
Mar 29 12:53:22 main volumio[766]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
Mar 29 12:53:22 main volumio[766]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
Mar 29 12:53:22 main volumio[766]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
Mar 29 12:53:22 main volumio[766]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
Mar 29 12:53:22 main volumio[766]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
Mar 29 12:53:22 main volumio[766]: info: Adding plugin bluetooth to MyMusic Plugins
Mar 29 12:53:22 main volumio[766]: info: Adding plugin multiroom to MyMusic Plugins
Mar 29 12:53:22 main volumio[766]: info: Adding plugin metavolumio to MyMusic Plugins
Mar 29 12:53:22 main volumio[766]: info: Adding plugin cd_controller to MyMusic Plugins
Mar 29 12:53:22 main volumio[766]: info: Adding plugin smart_inputs to MyMusic Plugins
Mar 29 12:53:22 main volumio[766]: info: Adding plugin tidalconnect to MyMusic Plugins
Mar 29 12:53:22 main volumio[766]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
Mar 29 12:53:23 main volumio[766]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
Mar 29 12:53:23 main volumio[766]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
Mar 29 12:53:23 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 29 12:53:23 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 29 12:53:23 main volumio[766]: info: Starting MyVolumio Remote Streaming Endpoints
Mar 29 12:53:23 main volumio[766]: info: MyVolumio login type: Token
Mar 29 12:53:23 main volumio[766]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
Mar 29 12:53:23 main volumio[766]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
Mar 29 12:53:24 main volumio[766]: info: Starting Streaming Service Transparent Proxy
Mar 29 12:53:24 main volumio[766]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Mar 29 12:53:24 main volumio[766]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Mar 29 12:53:24 main volumio[766]: info: Streaming services startup
Mar 29 12:53:24 main volumio[766]: info: Starting Streaming Daemon
Mar 29 12:53:24 main sudo[1078]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Mar 29 12:53:24 main sudo[1078]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 29 12:53:24 main volumio[766]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
Mar 29 12:53:24 main sudo[1078]: pam_unix(sudo:session): session closed for user root
Mar 29 12:53:24 main volumio[766]: error: Cannot start Volumio Streaming Daemon
Mar 29 12:53:24 main volumio[766]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Mar 29 12:53:24 main volumio[766]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Mar 29 12:53:25 main volumio[766]: STREAMING PROXY: Starting server on port 3245
Mar 29 12:53:25 main volumio[766]: Node JS runtime: 14
Mar 29 12:53:25 main volumio[766]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN
Mar 29 12:53:25 main volumio[766]: info: MyVolumio token set successfully
Mar 29 12:53:25 main volumio[766]: info: MYVOLUMIO: Adding device
Mar 29 12:53:25 main volumio[766]: info: MYVOLUMIO: Evaluating Server
Mar 29 12:53:26 main systemd[1]: systemd-fsckd.service: Succeeded.
Mar 29 12:53:26 main volumio[766]: info: MyVolumio Plan changed: premium
Mar 29 12:53:26 main volumio[766]: info: [MyVolumio PluginManager] Subscribed plan changed to premium
Mar 29 12:53:26 main volumio[766]: info: Removing browser output: myVolumio user plan is not superstar
Mar 29 12:53:26 main volumio[766]: info: Removing audio output:
Mar 29 12:53:26 main volumio[766]: info: MYVOLUMIO: Adding device
Mar 29 12:53:26 main volumio[766]: info: MYVOLUMIO: Evaluating Server
Mar 29 12:53:26 main volumio[766]: info: Remote config written successfully
Mar 29 12:53:26 main volumio[766]: info: Starting Tunnel 1
Mar 29 12:53:26 main volumio[766]: info: Starting Tunnel Connection Checker
Mar 29 12:53:26 main volumio[766]: info: Completed starting MyVolumio Plugin
Mar 29 12:53:26 main volumio[766]: info: MYVolumio Device enabled
Mar 29 12:53:26 main volumio[766]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins...
Mar 29 12:53:26 main volumio[766]: info: MyVolumio status changed
Mar 29 12:53:26 main volumio[766]: info: Streaming services startup
Mar 29 12:53:26 main volumio[766]: info: Starting Streaming Daemon
Mar 29 12:53:26 main sudo[1118]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Mar 29 12:53:26 main sudo[1118]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 29 12:53:26 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid
Mar 29 12:53:26 main sudo[1118]: pam_unix(sudo:session): session closed for user root
Mar 29 12:53:26 main volumio[766]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"...
Mar 29 12:53:27 main volumio[766]: info: [1711713207124] Starting BluetoothController
Mar 29 12:53:27 main volumio[766]: info: [MyVolumio PluginManager] Loading plugin "multiroom"...
Mar 29 12:53:28 main volumio[766]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom
Mar 29 12:53:28 main sudo[1121]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom
Mar 29 12:53:28 main sudo[1121]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 29 12:53:28 main sudo[1121]: pam_unix(sudo:session): session closed for user root
Mar 29 12:53:28 main volumio[766]: info: MRS: MultiRoom plugin initialized
Mar 29 12:53:28 main volumio[766]: info: MRS: STOPPING SNAPCLIENT
Mar 29 12:53:28 main volumio[766]: info: MRS: Snap server stop
Mar 29 12:53:28 main sudo[1137]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient
Mar 29 12:53:28 main sudo[1137]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 29 12:53:28 main volumio[766]: info: MRS: STOPPING volumioStreaming
Mar 29 12:53:28 main sudo[1140]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver
Mar 29 12:53:28 main sudo[1140]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 29 12:53:28 main sudo[1137]: pam_unix(sudo:session): session closed for user root
Mar 29 12:53:28 main sudo[1143]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming
Mar 29 12:53:28 main sudo[1140]: pam_unix(sudo:session): session closed for user root
Mar 29 12:53:28 main sudo[1143]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 29 12:53:28 main volumio[766]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"...
Mar 29 12:53:28 main sudo[1146]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/*
Mar 29 12:53:28 main sudo[1146]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 29 12:53:28 main sudo[1143]: pam_unix(sudo:session): session closed for user root
Mar 29 12:53:28 main sudo[1146]: pam_unix(sudo:session): session closed for user root
Mar 29 12:53:28 main volumio[766]: info: [MyVolumio PluginManager] Loading plugin "manifestui"...
Mar 29 12:53:28 main volumio[766]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"...
Mar 29 12:53:28 main volumio[766]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"...
Mar 29 12:53:28 main volumio[766]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"...
Mar 29 12:53:28 main volumio[766]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio
Mar 29 12:53:28 main volumio[766]: info: [MyVolumio PluginManager] Loading plugin "tidal"...
Mar 29 12:53:28 main volumio[766]: info: [MyVolumio PluginManager] Loading plugin "qobuz"...
Mar 29 12:53:28 main volumio[766]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"...
Mar 29 12:53:28 main volumio[766]: info: Preparing to generate the ALSA configuration file
Mar 29 12:53:28 main volumio[766]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Mar 29 12:53:28 main volumio[766]: info: Reading ALSA contributions from plugins.
Mar 29 12:53:28 main volumio[766]: info: Setting Geolocation for MyVolumio to eu6
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 29 12:53:28 main volumio[766]: info: Setting Geolocation for MyVolumio to eu4
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 29 12:53:28 main volumio[766]: verbose: New Socket.io Connection to 192.168.0.171 from 192.168.0.196 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:124.0) Gecko/20100101 Firefox/124.0 Total Clients: 11
Mar 29 12:53:28 main volumio[766]: info: MRS: Removed streaming files
Mar 29 12:53:28 main volumio[766]: info: MRS: volumioStreaming STOPPED
Mar 29 12:53:28 main volumio[766]: info: MRS: SNAPSERVER STOPPED
Mar 29 12:53:28 main volumio[766]: info: MRS: SNAPCLIENT STOPPED
Mar 29 12:53:28 main volumio[766]: error: Cannot start Volumio Streaming Daemon
Mar 29 12:53:28 main volumio[766]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Mar 29 12:53:28 main volumio[766]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:28 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:28 main volumio[766]: info: Received Get System Info
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 29 12:53:28 main volumio[766]: info: Discovery: Getting this device information
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:28 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:28 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::volumioGetVisibleSources
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:28 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:28 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Mar 29 12:53:28 main volumio[766]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Mar 29 12:53:28 main volumio[766]: info: Received Get System Info
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 29 12:53:28 main volumio[766]: info: Discovery: Getting this device information
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:28 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:28 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:28 main volumio[766]: info: Listing playlists
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::volumioGetQueue
Mar 29 12:53:28 main volumio[766]: info: CoreStateMachine::getQueue
Mar 29 12:53:28 main volumio[766]: info: CorePlayQueue::getQueue
Mar 29 12:53:28 main volumio[766]: info: Received Get System Info
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 29 12:53:28 main volumio[766]: info: Discovery: Getting this device information
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:28 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:28 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::volumioGetVisibleSources
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:28 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:28 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Mar 29 12:53:28 main volumio[766]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Mar 29 12:53:28 main volumio[766]: info: Received Get System Info
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 29 12:53:28 main volumio[766]: info: Discovery: Getting this device information
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:28 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:28 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:28 main volumio[766]: info: Listing playlists
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::volumioGetQueue
Mar 29 12:53:28 main volumio[766]: info: CoreStateMachine::getQueue
Mar 29 12:53:28 main volumio[766]: info: CorePlayQueue::getQueue
Mar 29 12:53:28 main volumio[766]: info: Received Get System Info
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 29 12:53:28 main volumio[766]: info: Discovery: Getting this device information
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:28 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:28 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::volumioGetVisibleSources
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:28 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:28 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Mar 29 12:53:28 main volumio[766]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Mar 29 12:53:28 main volumio[766]: info: Received Get System Info
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 29 12:53:28 main volumio[766]: info: Discovery: Getting this device information
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:28 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:28 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:28 main volumio[766]: info: Listing playlists
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::volumioGetQueue
Mar 29 12:53:28 main volumio[766]: info: CoreStateMachine::getQueue
Mar 29 12:53:28 main volumio[766]: info: CorePlayQueue::getQueue
Mar 29 12:53:28 main volumio[766]: info: Received Get System Info
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 29 12:53:28 main volumio[766]: info: Discovery: Getting this device information
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:28 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 29 12:53:28 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:28 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:29 main volumio[766]: info: Asound.conf file unchanged, so no further update is needed
Mar 29 12:53:29 main volumio[766]: info: Output device has changed, restarting MPD
Mar 29 12:53:29 main sudo[1149]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Mar 29 12:53:29 main sudo[1149]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 29 12:53:29 main sudo[1149]: pam_unix(sudo:session): session closed for user root
Mar 29 12:53:29 main volumio[766]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Mar 29 12:53:29 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 29 12:53:29 main sudo[1152]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Mar 29 12:53:29 main sudo[1152]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 29 12:53:29 main volumio[766]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth
Mar 29 12:53:29 main volumio[766]: info: [MyVolumio PluginManager] Plugin bluetooth disabled by user. Not starting
Mar 29 12:53:29 main volumio[766]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom
Mar 29 12:53:29 main volumio[766]: info: [MyVolumio PluginManager] Plugin multiroom disabled by user. Not starting
Mar 29 12:53:29 main systemd[1]: musicservicesshield.service: Succeeded.
Mar 29 12:53:29 main volumio[766]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio
Mar 29 12:53:29 main volumio[766]: info: [MyVolumio PluginManager] Plugin metavolumio disabled by user. Not starting
Mar 29 12:53:29 main volumio[766]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui
Mar 29 12:53:29 main systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set.
Mar 29 12:53:29 main volumio[766]: info: Adding Manifest REST API Endpoints
Mar 29 12:53:29 main systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set...
Mar 29 12:53:29 main systemd[1]: Stopping Music Player Daemon...
Mar 29 12:53:29 main volumio[766]: info: Adding manifestui REST Endpoint for plugin: miscellanea/manifestui
Mar 29 12:53:29 main volumio[766]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller
Mar 29 12:53:29 main volumio[766]: info: [MyVolumio PluginManager] Plugin cd_controller disabled by user. Not starting
Mar 29 12:53:29 main volumio[766]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs
Mar 29 12:53:29 main volumio[766]: info: [MyVolumio PluginManager] Plugin smart_inputs disabled by user. Not starting
Mar 29 12:53:29 main volumio[766]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio
Mar 29 12:53:29 main volumio[766]: error: Hi Res Audio Failed Login: Missing Login Data
Mar 29 12:53:29 main volumio[766]: info: Adding HIGHRESAUDIO REST API Endpoints
Mar 29 12:53:29 main volumio[766]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio
Mar 29 12:53:29 main volumio[766]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal
Mar 29 12:53:29 main volumio[766]: info: Refreshing TIDAL token
Mar 29 12:53:29 main volumio[766]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz
Mar 29 12:53:29 main volumio[766]: info: Refreshing QOBUZ token
Mar 29 12:53:29 main volumio[766]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect
Mar 29 12:53:29 main volumio[766]: info: [MyVolumio PluginManager] Plugin tidalconnect disabled by user. Not starting
Mar 29 12:53:29 main volumio[766]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined
Mar 29 12:53:29 main volumio[766]: info: MPD Permissions set
Mar 29 12:53:29 main systemd[1]: mpd.service: Succeeded.
Mar 29 12:53:29 main systemd[1]: Stopped Music Player Daemon.
Mar 29 12:53:29 main systemd[1]: Starting Music Player Daemon...
Mar 29 12:53:29 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 29 12:53:29 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 29 12:53:29 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 29 12:53:29 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 29 12:53:29 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 29 12:53:29 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:29 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:29 main volumio[766]: info: Access Token successfully retrieved
Mar 29 12:53:29 main volumio[766]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Mar 29 12:53:29 main volumio[766]: info: [1711713209533] CoreMusicLibrary::Adding element QOBUZ
Mar 29 12:53:29 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 29 12:53:29 main volumio[766]: Cannot find translation for source QOBUZ
Mar 29 12:53:29 main volumio[766]: info: Stopping AccessToken refresher cron for QOBUZ
Mar 29 12:53:29 main volumio[766]: info: AccessToken refresher cron started for QOBUZ
Mar 29 12:53:29 main volumio[766]: info: Adding QOBUZ REST API Endpoints
Mar 29 12:53:29 main volumio[766]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz
Mar 29 12:53:29 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:29 main volumio[766]: info: Successfully Added MyVolumio device
Mar 29 12:53:29 main volumio[766]: info: Successfully Added MyVolumio device
Mar 29 12:53:29 main volumio[766]: info: Updating MyVolumio device info
Mar 29 12:53:29 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 29 12:53:29 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 29 12:53:29 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 29 12:53:29 main volumio[766]: info: Updating MyVolumio device info
Mar 29 12:53:29 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 29 12:53:29 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 29 12:53:29 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 29 12:53:29 main volumio[766]: info: Access Token successfully retrieved
Mar 29 12:53:29 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:29 main systemd[1]: systemd-hostnamed.service: Succeeded.
Mar 29 12:53:29 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Mar 29 12:53:29 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Mar 29 12:53:29 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Mar 29 12:53:29 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:30 main mpd[1156]: Mar 29 12:53 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Mar 29 12:53:30 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:30 main systemd[1]: Started Music Player Daemon.
Mar 29 12:53:30 main sudo[1152]: pam_unix(sudo:session): session closed for user root
Mar 29 12:53:30 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:30 main systemd[1]: Starting Shield Volumio Music Services in the User CPU Set...
Mar 29 12:53:30 main volumio[766]: error: updateQueue error: null
Mar 29 12:53:30 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:30 main volumio[766]: info: Successfully Updated MyVolumio device
Mar 29 12:53:30 main volumio[766]: info: Successfully retrieved User Session From TIDAL
Mar 29 12:53:30 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:30 main volumio[766]: info: Successfully Updated MyVolumio device
Mar 29 12:53:30 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:30 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:30 main volumio[1166]: cset: --> shielding system active with
Mar 29 12:53:30 main volumio[1166]: cset: "system" cpuset of CPUSPEC(1-3) with 108 tasks running
Mar 29 12:53:30 main volumio[1166]: cset: "user" cpuset of CPUSPEC(0) with 3 tasks running
Mar 29 12:53:30 main systemd[1]: Started Shield Volumio Music Services in the User CPU Set.
Mar 29 12:53:30 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:30 main volumio[766]: info: Successfully retrieved User Subscription From TIDAL
Mar 29 12:53:30 main volumio[766]: info: Adding TIDAL to Browse Sources
Mar 29 12:53:30 main volumio[766]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Mar 29 12:53:30 main volumio[766]: info: [1711713210921] CoreMusicLibrary::Adding element TIDAL
Mar 29 12:53:30 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 29 12:53:30 main volumio[766]: Cannot find translation for source QOBUZ
Mar 29 12:53:30 main volumio[766]: Cannot find translation for source TIDAL
Mar 29 12:53:30 main volumio[766]: info: Stopping AccessToken refresher cron
Mar 29 12:53:30 main volumio[766]: info: AccessToken refresher cron started
Mar 29 12:53:30 main volumio[766]: info: Adding TIDAL REST API Endpoints
Mar 29 12:53:30 main volumio[766]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal
Mar 29 12:53:30 main volumio[766]: info: BOOT COMPLETED
Mar 29 12:53:30 main volumio[766]: [Metrics] CommandRouter: 27s 823.36ms
Mar 29 12:53:30 main volumio[766]: info: CoreCommandRouter::volumiosetStartupVolume
Mar 29 12:53:30 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 29 12:53:30 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 29 12:53:30 main volumio[766]: info: CoreCommandRouter::Close All Modals sent
Mar 29 12:53:30 main volumio[766]: info: CoreCommandRouter::Close All Modals sent
Mar 29 12:53:30 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:31 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:31 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:31 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:31 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:31 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:31 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:31 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:31 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:31 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:31 main sudo[1192]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service
Mar 29 12:53:31 main sudo[1192]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 29 12:53:31 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:31 main systemd[1]: Started MyVolumio SSH Tunnel.
Mar 29 12:53:31 main sudo[1192]: pam_unix(sudo:session): session closed for user root
Mar 29 12:53:31 main autossh[1195]: port set to 0, monitoring disabled
Mar 29 12:53:31 main autossh[1195]: starting ssh (count 1)
Mar 29 12:53:31 main autossh[1195]: ssh child pid is 1198
Mar 29 12:53:31 main volumio[766]: info: Remote SSH Started
Mar 29 12:53:31 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Mar 29 12:53:31 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Mar 29 12:53:31 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Mar 29 12:53:31 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:32 main volumiossh-tunnel[1194]: Warning: Permanently added '[eu4.myvolumio.org]:2222,[167.172.103.77]:2222' (RSA) to the list of known hosts.
Mar 29 12:53:32 main volumio[766]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 12
Mar 29 12:53:32 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:32 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:32 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:32 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:32 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:32 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:32 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:32 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:32 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:32 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:32 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:32 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:32 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:32 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:33 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:33 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:33 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:33 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:33 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:33 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:33 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:33 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:33 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:33 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:33 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:33 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:33 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:33 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:34 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:34 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:34 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:34 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:34 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:34 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:34 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:34 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:34 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:34 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:34 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:34 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:34 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:34 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:34 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:35 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:35 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:35 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:35 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:35 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:35 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:35 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:35 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:35 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:35 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:35 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:35 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:35 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:35 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:36 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:36 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:36 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:36 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:36 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:36 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:36 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:36 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:36 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:36 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:36 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:36 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:36 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:37 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:37 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:37 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:37 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:37 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:37 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:37 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:37 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:37 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:37 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:37 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:37 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:37 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:37 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:37 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:38 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:38 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Mar 29 12:53:38 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 29 12:53:38 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Mar 29 12:53:38 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:38 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:38 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:38 main volumio-remote-updater[527]: Test mode enabled
Mar 29 12:53:38 main volumio-remote-updater[527]: No alpha test mode
Mar 29 12:53:38 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Mar 29 12:53:38 main volumio[766]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 29 12:53:38 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:38 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:38 main volumio[766]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false}
Mar 29 12:53:38 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Mar 29 12:53:38 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Mar 29 12:53:38 main volumio[766]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 13
Mar 29 12:53:38 main volumio[766]: info: CoreCommandRouter::volumioGetState
Mar 29 12:53:38 main volumio[766]: info: CorePlayQueue::getTrack 0
Mar 29 12:53:43 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 29 12:53:43 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 29 12:53:43 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Mar 29 12:53:43 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Mar 29 12:53:43 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Mar 29 12:53:43 main volumio[766]: info: CoreCommandRouter::volumioGetBrowseSources
Mar 29 12:53:43 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Mar 29 12:53:50 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Mar 29 12:53:50 main volumio[766]: info: CURURI: music-library
Mar 29 12:53:51 main volumio[766]: info: Preload queue cleared
Mar 29 12:53:51 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Mar 29 12:53:51 main volumio[766]: info: CURURI: music-library/USB
Mar 29 12:53:52 main volumio[766]: info: Preload queue cleared
Mar 29 12:53:53 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Mar 29 12:53:53 main volumio[766]: info: CURURI: music-library/USB/T7_Shield
Mar 29 12:53:53 main volumio[766]: info: Preload queue cleared
Mar 29 12:53:53 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Mar 29 12:53:53 main volumio[766]: info: CURURI: music-library/USB/T7_Shield/MUSIK
Mar 29 12:53:53 main volumio[766]: info: Preload queue cleared
Mar 29 12:53:58 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Mar 29 12:53:58 main volumio[766]: info: CURURI: music-library/USB/T7_Shield/MUSIK/ACID
Mar 29 12:53:58 main volumio[766]: info: Preload queue cleared
Mar 29 12:54:00 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Mar 29 12:54:00 main volumio[766]: info: CURURI: music-library/USB/T7_Shield/MUSIK/ACID/Maniac
Mar 29 12:54:01 main volumio[766]: info: Preload queue cleared
Mar 29 12:54:04 main ntpd[710]: Soliciting pool server 217.175.196.134
Mar 29 12:54:05 main ntpd[710]: Soliciting pool server 162.159.200.1
Mar 29 12:54:05 main ntpd[710]: Soliciting pool server 178.251.64.52
Mar 29 12:54:06 main ntpd[710]: Soliciting pool server 162.159.200.123
Mar 29 12:54:06 main ntpd[710]: Soliciting pool server 91.206.8.36
Mar 29 12:54:06 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Mar 29 12:54:06 main volumio[766]: info: CURURI: music-library/USB/T7_Shield/MUSIK/ACID/Maniac/Maniac.cuetools.wav.cue
Mar 29 12:54:06 main volumio[766]: info: Preload queue cleared
Mar 29 12:54:06 main volumio[766]: info: Preloading song: music-library/USB/T7_Shield/MUSIK/ACID/Maniac/Maniac.cuetools.wav.cue/track0001
Mar 29 12:54:06 main volumio[766]: info: Preloading song: music-library/USB/T7_Shield/MUSIK/ACID/Maniac/Maniac.cuetools.wav.cue/track0002
Mar 29 12:54:06 main volumio[766]: info: Preloading song: music-library/USB/T7_Shield/MUSIK/ACID/Maniac/Maniac.cuetools.wav.cue/track0003
Mar 29 12:54:06 main volumio[766]: info: Preloading song: music-library/USB/T7_Shield/MUSIK/ACID/Maniac/Maniac.cuetools.wav.cue/track0004
Mar 29 12:54:06 main volumio[766]: info: Preloading song: music-library/USB/T7_Shield/MUSIK/ACID/Maniac/Maniac.cuetools.wav.cue/track0005
Mar 29 12:54:06 main volumio[766]: info: Preloading song: music-library/USB/T7_Shield/MUSIK/ACID/Maniac/Maniac.cuetools.wav.cue/track0006
Mar 29 12:54:06 main volumio[766]: info: Preloading song: music-library/USB/T7_Shield/MUSIK/ACID/Maniac/Maniac.cuetools.wav.cue/track0007
Mar 29 12:54:06 main volumio[766]: info: Preloading song: music-library/USB/T7_Shield/MUSIK/ACID/Maniac/Maniac.cuetools.wav.cue/track0008
Mar 29 12:54:06 main volumio[766]: info: Preloading song: music-library/USB/T7_Shield/MUSIK/ACID/Maniac/Maniac.cuetools.wav.cue/track0009
Mar 29 12:54:06 main volumio[766]: info: Preloading song: music-library/USB/T7_Shield/MUSIK/ACID/Maniac/Maniac.cuetools.wav.cue/track0010
Mar 29 12:54:06 main volumio[766]: info: Preloading song: music-library/USB/T7_Shield/MUSIK/ACID/Maniac/Maniac.cuetools.wav.cue/track0011
Mar 29 12:54:06 main volumio[766]: info: Exploding uri music-library/USB/T7_Shield/MUSIK/ACID/Maniac/Maniac.cuetools.wav.cue/track0001 in service mpd
Mar 29 12:54:06 main volumio[766]: error: scanFolder - failure to stat '/mnt/USB/T7_Shield/MUSIK/ACID/Maniac/Maniac.cuetools.wav.cue/track0001'
Mar 29 12:54:06 main volumio[766]: info: Exploding uri music-library/USB/T7_Shield/MUSIK/ACID/Maniac/Maniac.cuetools.wav.cue/track0002 in service mpd
Mar 29 12:54:06 main volumio[766]: error: scanFolder - failure to stat '/mnt/USB/T7_Shield/MUSIK/ACID/Maniac/Maniac.cuetools.wav.cue/track0002'
Mar 29 12:54:06 main volumio[766]: info: Exploding uri music-library/USB/T7_Shield/MUSIK/ACID/Maniac/Maniac.cuetools.wav.cue/track0003 in service mpd
Mar 29 12:54:06 main volumio[766]: error: scanFolder - failure to stat '/mnt/USB/T7_Shield/MUSIK/ACID/Maniac/Maniac.cuetools.wav.cue/track0003'
Mar 29 12:54:06 main volumio[766]: info: Exploding uri music-library/USB/T7_Shield/MUSIK/ACID/Maniac/Maniac.cuetools.wav.cue/track0004 in service mpd
Mar 29 12:54:06 main volumio[766]: error: scanFolder - failure to stat '/mnt/USB/T7_Shield/MUSIK/ACID/Maniac/Maniac.cuetools.wav.cue/track0004'
Mar 29 12:54:06 main volumio[766]: info: Exploding uri music-library/USB/T7_Shield/MUSIK/ACID/Maniac/Maniac.cuetools.wav.cue/track0005 in service mpd
Mar 29 12:54:06 main volumio[766]: error: scanFolder - failure to stat '/mnt/USB/T7_Shield/MUSIK/ACID/Maniac/Maniac.cuetools.wav.cue/track0005'
Mar 29 12:54:06 main volumio[766]: info: Exploding uri music-library/USB/T7_Shield/MUSIK/ACID/Maniac/Maniac.cuetools.wav.cue/track0006 in service mpd
Mar 29 12:54:06 main volumio[766]: error: scanFolder - failure to stat '/mnt/USB/T7_Shield/MUSIK/ACID/Maniac/Maniac.cuetools.wav.cue/track0006'
Mar 29 12:54:06 main volumio[766]: info: Exploding uri music-library/USB/T7_Shield/MUSIK/ACID/Maniac/Maniac.cuetools.wav.cue/track0007 in service mpd
Mar 29 12:54:06 main volumio[766]: error: scanFolder - failure to stat '/mnt/USB/T7_Shield/MUSIK/ACID/Maniac/Maniac.cuetools.wav.cue/track0007'
Mar 29 12:54:07 main volumio[766]: info: Exploding uri music-library/USB/T7_Shield/MUSIK/ACID/Maniac/Maniac.cuetools.wav.cue/track0008 in service mpd
Mar 29 12:54:07 main volumio[766]: error: scanFolder - failure to stat '/mnt/USB/T7_Shield/MUSIK/ACID/Maniac/Maniac.cuetools.wav.cue/track0008'
Mar 29 12:54:07 main volumio[766]: info: Exploding uri music-library/USB/T7_Shield/MUSIK/ACID/Maniac/Maniac.cuetools.wav.cue/track0009 in service mpd
Mar 29 12:54:07 main volumio[766]: error: scanFolder - failure to stat '/mnt/USB/T7_Shield/MUSIK/ACID/Maniac/Maniac.cuetools.wav.cue/track0009'
Mar 29 12:54:07 main volumio[766]: info: Exploding uri music-library/USB/T7_Shield/MUSIK/ACID/Maniac/Maniac.cuetools.wav.cue/track0010 in service mpd
Mar 29 12:54:07 main volumio[766]: error: scanFolder - failure to stat '/mnt/USB/T7_Shield/MUSIK/ACID/Maniac/Maniac.cuetools.wav.cue/track0010'
Mar 29 12:54:07 main ntpd[710]: Soliciting pool server 185.242.177.6
Mar 29 12:54:07 main ntpd[710]: Soliciting pool server 91.206.8.34
Mar 29 12:54:07 main volumio[766]: info: Exploding uri music-library/USB/T7_Shield/MUSIK/ACID/Maniac/Maniac.cuetools.wav.cue/track0011 in service mpd
Mar 29 12:54:07 main volumio[766]: error: scanFolder - failure to stat '/mnt/USB/T7_Shield/MUSIK/ACID/Maniac/Maniac.cuetools.wav.cue/track0011'
Mar 29 12:54:08 main ntpd[710]: Soliciting pool server 86.59.80.170
Mar 29 12:54:09 main ntpd[710]: Soliciting pool server 185.144.161.170
Mar 29 12:54:09 main ntpd[710]: Soliciting pool server 144.76.197.108
Mar 29 12:54:10 main ntpd[710]: Soliciting pool server 152.53.15.127
Mar 29 12:54:10 main ntpd[710]: Soliciting pool server 46.102.157.67
Mar 29 12:54:10 main volumio[766]: info: Preload queue cleared
Mar 29 12:54:10 main volumio[766]: info:
Mar 29 12:54:10 main volumio[766]: [1711713250304] ---------------------------- Client requests add and Play Volumio CUE entry
Mar 29 12:54:10 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: mpd , addPlayCue
Mar 29 12:54:10 main volumio[766]: info: Adding CUE individual entry: 0 USB/T7_Shield/MUSIK/ACID/Maniac/Maniac.cuetools.wav.cue
Mar 29 12:54:10 main volumio[766]: info: CoreCommandRouter::volumioAddQueueItems
Mar 29 12:54:10 main volumio[766]: info: CoreStateMachine::addQueueItems
Mar 29 12:54:10 main volumio[766]: info: CorePlayQueue::addQueueItems
Mar 29 12:54:10 main volumio[766]: info: Preload queue cleared
Mar 29 12:54:10 main volumio[766]: info: Adding Item to queue: cue://USB/T7_Shield/MUSIK/ACID/Maniac/Maniac.cuetools.wav.cue@0
Mar 29 12:54:10 main volumio[766]: info: Exploding uri cue://USB/T7_Shield/MUSIK/ACID/Maniac/Maniac.cuetools.wav.cue@0 in service mpd
Mar 29 12:54:10 main volumio[766]: info: CoreCommandRouter::volumioPlay
Mar 29 12:54:10 main volumio[766]: info: CoreStateMachine::play index 271
Mar 29 12:54:10 main volumio[766]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 29 12:54:10 main volumio[766]: info: CoreStateMachine::stop
Mar 29 12:54:10 main volumio[766]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 29 12:54:10 main volumio[766]: info: CoreStateMachine::play index undefined
Mar 29 12:54:10 main volumio[766]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 29 12:54:10 main volumio[766]: info: CorePlayQueue::getTrack 271
Mar 29 12:54:10 main volumio[766]: info: CoreCommandRouter::volumioPushQueue
Mar 29 12:54:10 main volumio[766]: info: CorePlayQueue::saveQueue
Mar 29 12:54:10 main volumio[766]: info: CoreStateMachine::updateTrackBlock
Mar 29 12:54:10 main volumio[766]: info: CorePlayQueue::getTrackBlock
Mar 29 12:54:11 main ntpd[710]: Soliciting pool server 83.215.130.11
Mar 29 12:54:11 main ntpd[710]: Soliciting pool server 2606:4700:f1::123
Mar 29 12:54:37 main ntpd[710]: receive: Unexpected origin timestamp 0xe9b12a64.29e5b59f does not match aorg 0000000000.00000000 from server@162.159.200.1 xmt 0xe9b12a7d.1e7bda75
Mar 29 12:54:37 main ntpd[710]: receive: Unexpected origin timestamp 0xe9b12a64.29e28ba8 does not match aorg 0000000000.00000000 from server@86.59.80.170 xmt 0xe9b12a7d.1e48c0d5
Mar 29 12:54:37 main ntpd[710]: receive: Unexpected origin timestamp 0xe9b12a64.29e3aacb does not match aorg 0000000000.00000000 from server@185.242.177.6 xmt 0xe9b12a7d.1ef7cc21
Mar 29 12:54:37 main ntpd[710]: receive: Unexpected origin timestamp 0xe9b12a64.29e0060c does not match aorg 0000000000.00000000 from server@144.76.197.108 xmt 0xe9b12a7d.1f348ac8
Mar 29 12:54:39 main volumio[766]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Mar 29 12:54:39 main volumio[766]: info: CURURI: music-library/USB/T7_Shield/MUSIK/ACID/Maniac/Maniac.cuetools.wav.cue
Mar 29 12:54:39 main volumio[766]: info: Preload queue cleared
Mar 29 12:54:59 main volumio[766]: info: CoreCommandRouter::volumioReplaceandPlayItems
Mar 29 12:54:59 main volumio[766]: info: CoreStateMachine::ClearQueue
Mar 29 12:54:59 main volumio[766]: info: CoreStateMachine::stop
Mar 29 12:54:59 main volumio[766]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 29 12:54:59 main volumio[766]: info: CorePlayQueue::clearPlayQueue
Mar 29 12:54:59 main volumio[766]: info: CorePlayQueue::saveQueue
Mar 29 12:54:59 main volumio[766]: info: CoreCommandRouter::volumioPushQueue
Mar 29 12:54:59 main volumio[766]: info: CoreStateMachine::addQueueItems
Mar 29 12:54:59 main volumio[766]: info: CorePlayQueue::addQueueItems
Mar 29 12:54:59 main volumio[766]: info: Preload queue cleared
Mar 29 12:54:59 main volumio[766]: info: Adding Item to queue: music-library/USB/T7_Shield/MUSIK/ACID/Maniac
Mar 29 12:54:59 main volumio[766]: info: Exploding uri music-library/USB/T7_Shield/MUSIK/ACID/Maniac in service mpd
Mar 29 12:54:59 main volumio[766]: info: ALBUMART /albumart?cacheid=200&path=%2Fmnt%2FUSB%2FT7_Shield%2FMUSIK%2FACID%2FManiac%2F01%20Max%20Overload.wav&metadata=false
Mar 29 12:54:59 main volumio[766]: info: URI /mnt/USB/T7_Shield/MUSIK/ACID/Maniac/01 Max Overload.wav
Mar 29 12:54:59 main volumio[766]: info: ALBUMART /albumart?cacheid=200&path=%2Fmnt%2FUSB%2FT7_Shield%2FMUSIK%2FACID%2FManiac%2F02%20Maniac.wav&metadata=false
Mar 29 12:54:59 main volumio[766]: info: URI /mnt/USB/T7_Shield/MUSIK/ACID/Maniac/02 Maniac.wav
Mar 29 12:54:59 main volumio[766]: info: ALBUMART /albumart?cacheid=200&path=%2Fmnt%2FUSB%2FT7_Shield%2FMUSIK%2FACID%2FManiac%2F03%20Black%20Car.wav&metadata=false
Mar 29 12:54:59 main volumio[766]: info: URI /mnt/USB/T7_Shield/MUSIK/ACID/Maniac/03 Black Car.wav
Mar 29 12:54:59 main volumio[766]: info: ALBUMART /albumart?cacheid=200&path=%2Fmnt%2FUSB%2FT7_Shield%2FMUSIK%2FACID%2FManiac%2F04%20America.wav&metadata=false
Mar 29 12:54:59 main volumio[766]: info: URI /mnt/USB/T7_Shield/MUSIK/ACID/Maniac/04 America.wav
Mar 29 12:54:59 main volumio[766]: info: ALBUMART /albumart?cacheid=200&path=%2Fmnt%2FUSB%2FT7_Shield%2FMUSIK%2FACID%2FManiac%2F05%20Lucifera.wav&metadata=false
Mar 29 12:54:59 main volumio[766]: info: URI /mnt/USB/T7_Shield/MUSIK/ACID/Maniac/05 Lucifera.wav
Mar 29 12:54:59 main volumio[766]: info: ALBUMART /albumart?cacheid=200&path=%2Fmnt%2FUSB%2FT7_Shield%2FMUSIK%2FACID%2FManiac%2F06%20No%20Time.wav&metadata=false
Mar 29 12:54:59 main volumio[766]: info: URI /mnt/USB/T7_Shield/MUSIK/ACID/Maniac/06 No Time.wav
Mar 29 12:54:59 main volumio[766]: info: ALBUMART /albumart?cacheid=200&path=%2Fmnt%2FUSB%2FT7_Shield%2FMUSIK%2FACID%2FManiac%2F07%20Prince%20of%20Hell%20and%20Fire.wav&metadata=false
Mar 29 12:54:59 main volumio[766]: info: URI /mnt/USB/T7_Shield/MUSIK/ACID/Maniac/07 Prince of Hell and Fire.wav
Mar 29 12:54:59 main volumio[766]: info: ALBUMART /albumart?cacheid=200&path=%2Fmnt%2FUSB%2FT7_Shield%2FMUSIK%2FACID%2FManiac%2F08%20Bottoms%20Up.wav&metadata=false
Mar 29 12:54:59 main volumio[766]: info: URI /mnt/USB/T7_Shield/MUSIK/ACID/Maniac/08 Bottoms Up.wav
Mar 29 12:54:59 main volumio[766]: info: ALBUMART /albumart?cacheid=200&path=%2Fmnt%2FUSB%2FT7_Shield%2FMUSIK%2FACID%2FManiac%2F09%20Drop%20Dead.wav&metadata=false
Mar 29 12:54:59 main volumio[766]: info: URI /mnt/USB/T7_Shield/MUSIK/ACID/Maniac/09 Drop Dead.wav
Mar 29 12:54:59 main volumio[766]: info: ALBUMART /albumart?cacheid=200&path=%2Fmnt%2FUSB%2FT7_Shield%2FMUSIK%2FACID%2FManiac%2F10%20The%20Day%20You%20Die.wav&metadata=false
Mar 29 12:54:59 main volumio[766]: info: URI /mnt/USB/T7_Shield/MUSIK/ACID/Maniac/10 The Day You Die.wav
Mar 29 12:54:59 main volumio[766]: info: ALBUMART /albumart?cacheid=200&path=%2Fmnt%2FUSB%2FT7_Shield%2FMUSIK%2FACID%2FManiac%2F11%20Exterminator.wav&metadata=false
Mar 29 12:54:59 main volumio[766]: info: URI /mnt/USB/T7_Shield/MUSIK/ACID/Maniac/11 Exterminator.wav
Mar 29 12:54:59 main volumio[766]: info: ALBUMART /albumart?cacheid=200&path=%2Fmnt%2FUSB%2FT7_Shield%2FMUSIK%2FACID%2FManiac%2FManiac.cuetools.wav.cue&metadata=false
Mar 29 12:54:59 main volumio[766]: info: URI /mnt/USB/T7_Shield/MUSIK/ACID/Maniac/Maniac.cuetools.wav.cue
Mar 29 12:54:59 main volumio[766]: info: ALBUMART /albumart?cacheid=200&path=%2Fmnt%2FUSB%2FT7_Shield%2FMUSIK%2FACID%2FManiac%2FManiac.cuetools.wav.cue&metadata=false
Mar 29 12:54:59 main volumio[766]: info: URI /mnt/USB/T7_Shield/MUSIK/ACID/Maniac/Maniac.cuetools.wav.cue
Mar 29 12:54:59 main volumio[766]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 29 12:54:59 main volumio[766]: Error: Unable to resolve or reject the same promise twice
Mar 29 12:54:59 main volumio[766]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43)
Mar 29 12:54:59 main volumio[766]: at /volumio/app/plugins/music_service/mpd/index.js:2568:21
Mar 29 12:54:59 main volumio[766]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3)
Mar 29 12:54:59 main volumio[766]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12)
Mar 29 12:54:59 main volumio[766]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12)
Mar 29 12:54:59 main volumio[766]: at Socket.emit (events.js:315:20)
Mar 29 12:54:59 main volumio[766]: at addChunk (internal/streams/readable.js:309:12)
Mar 29 12:54:59 main volumio[766]: at readableAddChunk (internal/streams/readable.js:280:11)
Mar 29 12:54:59 main volumio[766]: at Socket.Readable.push (internal/streams/readable.js:223:10)
Mar 29 12:54:59 main volumio[766]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23)
Mar 29 12:54:59 main volumio[766]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 29 12:54:59 main sudo[1249]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-03-29 12:53
Mar 29 12:54:59 main sudo[1249]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="17fcb754ddd6bd152b01008c46cc4ba1ca48bf35"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="a641dd71dd22f560f71c5c8af897751297274d11"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed 13 Mar 2024 10:44:09 PM CET"
VOLUMIO_VERSION="3.636"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="10aad550287be934f715117e7cad5535"