-- Logs begin at Wed 2024-07-24 21:59:08 +06, end at Thu 2024-07-25 16:46:03 +06. -- Jul 25 16:45:18 chimera volumio[5380]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Jul 25 16:45:18 chimera volumio[5380]: info: MyVolumio login type: Token Jul 25 16:45:22 chimera volumio[5380]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Jul 25 16:45:23 chimera volumio[5380]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 25 16:45:23 chimera volumio[5380]: info: Received Get System Info Jul 25 16:45:23 chimera volumio[5380]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 25 16:45:23 chimera volumio[5380]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 25 16:45:23 chimera volumio[5380]: info: Discovery: Getting this device information Jul 25 16:45:23 chimera volumio[5380]: info: CoreCommandRouter::volumioGetState Jul 25 16:45:23 chimera volumio[5380]: info: CorePlayQueue::getTrack 0 Jul 25 16:45:23 chimera volumio[5380]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 25 16:45:25 chimera sudo[28179]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 25 16:45:25 chimera sudo[28179]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 25 16:45:25 chimera sudo[28179]: pam_unix(sudo:session): session closed for user root Jul 25 16:45:25 chimera sudo[28182]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 25 16:45:25 chimera sudo[28182]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 25 16:45:25 chimera sudo[28182]: pam_unix(sudo:session): session closed for user root Jul 25 16:45:25 chimera volumio[5380]: verbose: New Socket.io Connection to 192.168.0.234 from 192.168.0.153 UA: Mozilla/5.0 (iPod touch; CPU iPhone OS 12_5_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 8 Jul 25 16:45:26 chimera volumio[5380]: info: Received Get System Info Jul 25 16:45:26 chimera volumio[5380]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 25 16:45:26 chimera volumio[5380]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 25 16:45:26 chimera volumio[5380]: info: Discovery: Getting this device information Jul 25 16:45:26 chimera volumio[5380]: info: CoreCommandRouter::volumioGetState Jul 25 16:45:26 chimera volumio[5380]: info: CorePlayQueue::getTrack 0 Jul 25 16:45:26 chimera volumio[5380]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 25 16:45:26 chimera volumio[5380]: info: CoreCommandRouter::volumioGetState Jul 25 16:45:26 chimera volumio[5380]: info: CorePlayQueue::getTrack 0 Jul 25 16:45:26 chimera volumio[5380]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 25 16:45:26 chimera volumio[5380]: info: CoreCommandRouter::volumioGetVisibleSources Jul 25 16:45:26 chimera volumio[5380]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 25 16:45:26 chimera volumio[5380]: info: CoreCommandRouter::volumioGetState Jul 25 16:45:26 chimera volumio[5380]: info: CorePlayQueue::getTrack 0 Jul 25 16:45:26 chimera volumio[5380]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 25 16:45:26 chimera volumio[5380]: info: CoreCommandRouter::volumioGetQueue Jul 25 16:45:26 chimera volumio[5380]: info: CoreStateMachine::getQueue Jul 25 16:45:26 chimera volumio[5380]: info: CorePlayQueue::getQueue Jul 25 16:45:26 chimera volumio[5380]: info: Listing playlists Jul 25 16:45:26 chimera volumio[5380]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 25 16:45:26 chimera volumio[5380]: info: Received Get System Info Jul 25 16:45:26 chimera volumio[5380]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 25 16:45:26 chimera volumio[5380]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 25 16:45:26 chimera volumio[5380]: info: Discovery: Getting this device information Jul 25 16:45:26 chimera volumio[5380]: info: CoreCommandRouter::volumioGetState Jul 25 16:45:26 chimera volumio[5380]: info: CorePlayQueue::getTrack 0 Jul 25 16:45:26 chimera volumio[5380]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 25 16:45:26 chimera volumio[5380]: info: CoreCommandRouter::volumioGetState Jul 25 16:45:26 chimera volumio[5380]: info: CorePlayQueue::getTrack 0 Jul 25 16:45:26 chimera volumio[5380]: info: Received Get System Info Jul 25 16:45:26 chimera volumio[5380]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 25 16:45:26 chimera volumio[5380]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 25 16:45:26 chimera volumio[5380]: info: Discovery: Getting this device information Jul 25 16:45:26 chimera volumio[5380]: info: CoreCommandRouter::volumioGetState Jul 25 16:45:26 chimera volumio[5380]: info: CorePlayQueue::getTrack 0 Jul 25 16:45:26 chimera volumio[5380]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 25 16:45:26 chimera volumio[5380]: info: CoreCommandRouter::volumioGetState Jul 25 16:45:26 chimera volumio[5380]: info: CorePlayQueue::getTrack 0 Jul 25 16:45:26 chimera volumio[5380]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jul 25 16:45:28 chimera volumio[5380]: info: MyVolumio token set successfully Jul 25 16:45:28 chimera volumio[5380]: info: MYVOLUMIO: Adding device Jul 25 16:45:28 chimera volumio[5380]: info: MYVOLUMIO: Evaluating Server Jul 25 16:45:29 chimera volumio[5380]: info: MyVolumio Plan changed: premium Jul 25 16:45:29 chimera volumio[5380]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Jul 25 16:45:29 chimera volumio[5380]: info: Removing browser output: myVolumio user plan is not superstar Jul 25 16:45:29 chimera volumio[5380]: info: Removing audio output: Jul 25 16:45:29 chimera volumio[5380]: info: MYVOLUMIO: Adding device Jul 25 16:45:29 chimera volumio[5380]: info: MYVOLUMIO: Evaluating Server Jul 25 16:45:29 chimera volumio[5380]: info: Remote config written successfully Jul 25 16:45:29 chimera volumio[5380]: info: Starting Tunnel 1 Jul 25 16:45:29 chimera volumio[5380]: info: Starting Tunnel Connection Checker Jul 25 16:45:29 chimera sudo[28208]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Jul 25 16:45:29 chimera sudo[28208]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 25 16:45:29 chimera systemd[1]: Started MyVolumio SSH Tunnel. Jul 25 16:45:29 chimera sudo[28208]: pam_unix(sudo:session): session closed for user root Jul 25 16:45:29 chimera autossh[28211]: port set to 0, monitoring disabled Jul 25 16:45:29 chimera autossh[28211]: starting ssh (count 1) Jul 25 16:45:29 chimera volumio[5380]: info: Remote SSH Started Jul 25 16:45:29 chimera autossh[28211]: ssh child pid is 28214 Jul 25 16:45:29 chimera volumio[5380]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Jul 25 16:45:29 chimera volumio[5380]: info: CoreCommandRouter::volumioGetState Jul 25 16:45:29 chimera volumio[5380]: info: CorePlayQueue::getTrack 0 Jul 25 16:45:30 chimera volumio[5380]: info: MYVolumio Device enabled Jul 25 16:45:30 chimera volumio[5380]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Jul 25 16:45:30 chimera volumio[5380]: info: MyVolumio status changed Jul 25 16:45:30 chimera volumio[5380]: info: Streaming services startup Jul 25 16:45:30 chimera volumio[5380]: info: Starting Streaming Daemon Jul 25 16:45:30 chimera volumio[5380]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Jul 25 16:45:30 chimera volumio[5380]: error: [MyVolumio PluginManager] Cache data is invalid! Jul 25 16:45:30 chimera sudo[28231]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jul 25 16:45:30 chimera sudo[28231]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 25 16:45:30 chimera sudo[28231]: pam_unix(sudo:session): session closed for user root Jul 25 16:45:30 chimera volumio[5380]: error: Cannot start Volumio Streaming Daemon Jul 25 16:45:30 chimera volumio[5380]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jul 25 16:45:30 chimera volumio[5380]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jul 25 16:45:31 chimera volumiossh-tunnel[28210]: Warning: Permanently added '[as1.myvolumio.org]:2222,[128.199.166.162]:2222' (RSA) to the list of known hosts. Jul 25 16:45:31 chimera volumio[5380]: info: Setting Geolocation for MyVolumio to as2 Jul 25 16:45:31 chimera volumio[5380]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 25 16:45:31 chimera volumio[5380]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 25 16:45:31 chimera volumio[5380]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 25 16:45:32 chimera volumio[5380]: info: Setting Geolocation for MyVolumio to as2 Jul 25 16:45:32 chimera volumio[5380]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 25 16:45:32 chimera volumio[5380]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 25 16:45:32 chimera volumio[5380]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 25 16:45:32 chimera volumio[5380]: info: Updating MyVolumio device info Jul 25 16:45:32 chimera volumio[5380]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 25 16:45:33 chimera volumio[5380]: info: Updating MyVolumio device info Jul 25 16:45:33 chimera volumio[5380]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 25 16:45:33 chimera volumio[5380]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 25 16:45:33 chimera volumio[5380]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 25 16:45:33 chimera volumio[5380]: info: Successfully Updated MyVolumio device Jul 25 16:45:34 chimera volumio[5380]: info: Successfully Added MyVolumio device Jul 25 16:45:35 chimera volumio[5380]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 25 16:45:35 chimera volumio[5380]: info: Successfully Updated MyVolumio device Jul 25 16:45:35 chimera volumio[5380]: info: Tunnel connection is inactive, restarting it Jul 25 16:45:35 chimera volumio[5380]: info: Starting Tunnel 1 Jul 25 16:45:35 chimera volumio[5380]: info: Starting Tunnel Connection Checker Jul 25 16:45:35 chimera sudo[28238]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Jul 25 16:45:35 chimera sudo[28238]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 25 16:45:35 chimera autossh[28211]: received signal to exit (15) Jul 25 16:45:35 chimera systemd[1]: Stopping MyVolumio SSH Tunnel... Jul 25 16:45:35 chimera systemd[1]: sshtunnel.service: Main process exited, code=killed, status=15/TERM Jul 25 16:45:35 chimera systemd[1]: sshtunnel.service: Succeeded. Jul 25 16:45:35 chimera volumio[5380]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 25 16:45:35 chimera systemd[1]: Stopped MyVolumio SSH Tunnel. Jul 25 16:45:35 chimera volumio[5380]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 25 16:45:35 chimera systemd[1]: Started MyVolumio SSH Tunnel. Jul 25 16:45:35 chimera sudo[28238]: pam_unix(sudo:session): session closed for user root Jul 25 16:45:35 chimera autossh[28242]: port set to 0, monitoring disabled Jul 25 16:45:35 chimera autossh[28242]: starting ssh (count 1) Jul 25 16:45:35 chimera autossh[28242]: ssh child pid is 28245 Jul 25 16:45:35 chimera volumio[5380]: info: Remote SSH Started Jul 25 16:45:35 chimera volumio[5380]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Jul 25 16:45:35 chimera volumio[5380]: info: CoreCommandRouter::volumioGetState Jul 25 16:45:35 chimera volumio[5380]: info: CorePlayQueue::getTrack 0 Jul 25 16:45:35 chimera volumio[5380]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 25 16:45:35 chimera volumio[5380]: info: CURURI: albums:// Jul 25 16:45:35 chimera volumio[5380]: info: listAlbums - loading Albums from cache Jul 25 16:45:35 chimera volumio[5380]: info: Preload queue cleared Jul 25 16:45:35 chimera volumio[5380]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 25 16:45:37 chimera volumiossh-tunnel[28240]: Warning: Permanently added '[as2.myvolumio.org]:2222,[165.232.189.9]:2222' (RSA) to the list of known hosts. Jul 25 16:45:37 chimera volumio[5380]: node: ../deps/uv/src/unix/linux-core.c:143: uv__platform_invalidate_fd: Assertion `loop->watchers != NULL' failed. Jul 25 16:45:37 chimera go-librespot[5611]: time="2024-07-25T16:45:37+06:00" level=error msg="websocket connection errored" error="failed to get reader: failed to read frame header: EOF" Jul 25 16:45:37 chimera volumio-remote-updater[868]: [2024-07-25 16:45:37] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jul 25 16:45:37 chimera volumio-remote-updater[868]: [2024-07-25 16:45:37] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jul 25 16:45:37 chimera systemd[1]: volumio.service: Main process exited, code=killed, status=6/ABRT Jul 25 16:45:37 chimera systemd[1]: volumio.service: Failed with result 'signal'. Jul 25 16:45:37 chimera systemd[1]: Started dynamicswap service. Jul 25 16:45:37 chimera systemd[1]: dynamicswap.service: Succeeded. Jul 25 16:45:37 chimera systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jul 25 16:45:37 chimera systemd[1]: volumio.service: Scheduled restart job, restart counter is at 2. Jul 25 16:45:37 chimera systemd[1]: Stopped Volumio Backend Module. Jul 25 16:45:38 chimera systemd[1]: Started Volumio Backend Module. Jul 25 16:45:38 chimera systemd[1]: Started dynamicswap service. Jul 25 16:45:38 chimera systemd[1]: dynamicswap.service: Succeeded. Jul 25 16:45:38 chimera volumio[28254]: info: ------------------------------------------- Jul 25 16:45:38 chimera volumio[28254]: info: ----- Volumio3 ---- Jul 25 16:45:38 chimera volumio[28254]: info: ------------------------------------------- Jul 25 16:45:38 chimera volumio[28254]: info: ----- System startup ---- Jul 25 16:45:38 chimera volumio[28254]: info: ------------------------------------------- Jul 25 16:45:38 chimera volumio[28254]: info: MYVOLUMIO Environment detected Jul 25 16:45:38 chimera volumio[28254]: info: Plugin folders cleanup Jul 25 16:45:38 chimera volumio[28254]: info: Scanning into folder /volumio/app/plugins/ Jul 25 16:45:38 chimera volumio[28254]: info: Scanning category audio_interface Jul 25 16:45:38 chimera volumio[28254]: info: Scanning category miscellanea Jul 25 16:45:38 chimera volumio[28254]: info: Scanning category music_service Jul 25 16:45:38 chimera volumio[28254]: info: Scanning category plugins.json Jul 25 16:45:38 chimera volumio[28254]: info: Scanning category system_controller Jul 25 16:45:38 chimera volumio[28254]: info: Scanning category user_interface Jul 25 16:45:38 chimera volumio[28254]: info: Scanning into folder /data/plugins/ Jul 25 16:45:38 chimera volumio[28254]: info: Scanning category music_service Jul 25 16:45:38 chimera volumio[28254]: info: Scanning category system_controller Jul 25 16:45:38 chimera volumio[28254]: info: Scanning category user_interface Jul 25 16:45:38 chimera volumio[28254]: info: Plugin folders cleanup completed Jul 25 16:45:38 chimera volumio[28254]: info: ------------------------------------------- Jul 25 16:45:38 chimera volumio[28254]: info: ----- Core plugins startup ---- Jul 25 16:45:38 chimera volumio[28254]: info: ------------------------------------------- Jul 25 16:45:38 chimera volumio[28254]: info: Loading plugins from folder /volumio/app/plugins/ Jul 25 16:45:38 chimera volumio[28254]: info: Adding plugin upnp to MyMusic Plugins Jul 25 16:45:38 chimera volumio[28254]: info: Adding plugin airplay_emulation to MyMusic Plugins Jul 25 16:45:38 chimera volumio[28254]: info: Adding plugin upnp_browser to MyMusic Plugins Jul 25 16:45:38 chimera volumio[28254]: info: Loading plugins from folder /data/plugins/ Jul 25 16:45:38 chimera volumio[28254]: info: Loading plugin "system"... Jul 25 16:45:38 chimera volumio[28254]: info: Loading plugin "appearance"... Jul 25 16:45:38 chimera volumio[28254]: info: Loading plugin "network"... Jul 25 16:45:38 chimera volumio[28254]: info: Refreshing Cached IP Addresses Jul 25 16:45:38 chimera sudo[28281]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 25 16:45:38 chimera sudo[28281]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 25 16:45:38 chimera sudo[28281]: pam_unix(sudo:session): session closed for user root Jul 25 16:45:38 chimera sudo[28283]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 25 16:45:38 chimera sudo[28283]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 25 16:45:38 chimera volumio[28254]: info: Loading plugin "services"... Jul 25 16:45:38 chimera sudo[28283]: pam_unix(sudo:session): session closed for user root Jul 25 16:45:38 chimera volumio[28254]: info: Loading plugin "alsa_controller"... Jul 25 16:45:38 chimera sudo[28286]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jul 25 16:45:38 chimera sudo[28286]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 25 16:45:38 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 25 16:45:38 chimera volumio[28254]: info: Loading plugin "wizard"... Jul 25 16:45:38 chimera volumio[28254]: info: Loading plugin "networkfs"... Jul 25 16:45:38 chimera volumio[28254]: info: Starting Udev Watcher for removable devices Jul 25 16:45:38 chimera volumio[28254]: info: Mounting Device 181D-115D Jul 25 16:45:38 chimera sudo[28297]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/181D-115D -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Jul 25 16:45:38 chimera sudo[28297]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 25 16:45:38 chimera sudo[28297]: pam_unix(sudo:session): session closed for user root Jul 25 16:45:38 chimera volumio[28254]: mount: /media/181D-115D: /dev/sda1 already mounted on /media/181D-115D. Jul 25 16:45:38 chimera volumio[28254]: error: Failed to mount 181D-115D: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sda1" "/mnt/USB/181D-115D" -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Jul 25 16:45:38 chimera volumio[28254]: mount: /media/181D-115D: /dev/sda1 already mounted on /media/181D-115D. Jul 25 16:45:38 chimera volumio[28254]: info: Ignoring mount for partition: boot Jul 25 16:45:38 chimera volumio[28254]: info: Ignoring mount for partition: volumio Jul 25 16:45:38 chimera volumio[28254]: info: Ignoring mount for partition: volumio_data Jul 25 16:45:38 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 25 16:45:38 chimera volumio[28254]: info: Loading plugin "volumio_command_line_client"... Jul 25 16:45:38 chimera volumio[28254]: info: Loading plugin "upnp"... Jul 25 16:45:38 chimera volumio[28254]: info: [1721904338892] Starting Upmpd Daemon Jul 25 16:45:38 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 25 16:45:38 chimera volumio[28254]: info: Loading plugin "my_music"... Jul 25 16:45:38 chimera volumio[28254]: info: Loading plugin "mpd"... Jul 25 16:45:38 chimera volumio[28254]: info: Loading plugin "upnp_browser"... Jul 25 16:45:39 chimera volumio[28254]: info: Loading plugin "alarm-clock"... Jul 25 16:45:39 chimera volumio[28254]: info: Loading plugin "airplay_emulation"... Jul 25 16:45:39 chimera volumio[28254]: info: Starting Shairport Sync Jul 25 16:45:39 chimera volumio[28254]: info: Loading plugin "last_100"... Jul 25 16:45:39 chimera volumio[28254]: info: Loading plugin "webradio"... Jul 25 16:45:39 chimera volumio[28254]: info: Loading plugin "i2s_dacs"... Jul 25 16:45:39 chimera volumio[28254]: info: Loading plugin "volumiodiscovery"... Jul 25 16:45:39 chimera volumio[28254]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 25 16:45:39 chimera node[28254]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 25 16:45:39 chimera node[28254]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 25 16:45:39 chimera volumio[28254]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 25 16:45:39 chimera volumio[28254]: *** WARNING *** For more information see Jul 25 16:45:39 chimera volumio[28254]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 25 16:45:39 chimera volumio[28254]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 25 16:45:39 chimera volumio[28254]: *** WARNING *** For more information see Jul 25 16:45:39 chimera node[28254]: *** WARNING *** For more information see Jul 25 16:45:39 chimera node[28254]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 25 16:45:39 chimera node[28254]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 25 16:45:39 chimera node[28254]: *** WARNING *** For more information see Jul 25 16:45:39 chimera volumio[28254]: info: Applying required configuration parameters for plugin volumiodiscovery Jul 25 16:45:39 chimera volumio[28254]: info: Discovery: Started advertising with name: Chimera Jul 25 16:45:39 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 25 16:45:39 chimera volumio[28254]: info: Loading plugin "spop"... Jul 25 16:45:39 chimera volumio[28254]: info: Loading plugin "youtube2"... Jul 25 16:45:39 chimera volumio[28254]: info: Loading plugin "ytcr"... Jul 25 16:45:40 chimera volumio[28254]: info: Loading plugin "outputs"... Jul 25 16:45:40 chimera volumio[28254]: info: Loading plugin "albumart"... Jul 25 16:45:40 chimera volumio[28254]: info: Plugin example_plugin is not enabled Jul 25 16:45:40 chimera volumio[28254]: info: Loading plugin "inputs"... Jul 25 16:45:40 chimera volumio[28254]: info: Loading plugin "updater_comm"... Jul 25 16:45:40 chimera volumio[28254]: info: Plugin mpdemulation is not enabled Jul 25 16:45:40 chimera volumio[28254]: info: Loading plugin "rest_api"... Jul 25 16:45:40 chimera volumio[28254]: info: Loading plugin "websocket"... Jul 25 16:45:40 chimera volumio[28254]: info: Starting Socket.io Server version 2.3.0 Jul 25 16:45:40 chimera volumio[28254]: info: Loading plugin "backup_restore"... Jul 25 16:45:40 chimera volumio[28254]: Forking 3 albumart workers Jul 25 16:45:40 chimera volumio[28254]: info: Applying required configuration parameters for plugin backup_restore Jul 25 16:45:40 chimera volumio[28254]: info: Loading plugin "Systeminfo"... Jul 25 16:45:40 chimera volumio[28254]: info: Loading plugin "touch_display"... Jul 25 16:45:40 chimera volumio[28254]: Starting albumart workers Jul 25 16:45:40 chimera volumio[28254]: Starting albumart workers Jul 25 16:45:40 chimera volumio[28254]: Starting albumart workers Jul 25 16:45:40 chimera volumio[28254]: info: Applying required configuration parameters for plugin touch_display Jul 25 16:45:40 chimera volumio[28254]: info: Loading i18n strings for locale en Jul 25 16:45:40 chimera volumio[28254]: Updating browse sources language Jul 25 16:45:40 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 25 16:45:40 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 25 16:45:40 chimera volumio[28254]: info: CoreCommandRouter::initPlayerControls Jul 25 16:45:40 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 25 16:45:40 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 25 16:45:40 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 25 16:45:40 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 25 16:45:40 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 25 16:45:40 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 25 16:45:40 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 25 16:45:40 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 25 16:45:40 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 25 16:45:40 chimera volumio[28254]: Express server listening on port 3000 Jul 25 16:45:40 chimera volumio[28254]: [Metrics] WebUI: 2s 187.20ms Jul 25 16:45:40 chimera volumio[28254]: info: CoreStateMachine::resetVolumioState Jul 25 16:45:40 chimera volumio[28254]: info: CoreStateMachine::getcurrentVolume Jul 25 16:45:40 chimera volumio[28254]: info: CoreCommandRouter::volumioRetrievevolume Jul 25 16:45:40 chimera volumio[28254]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS aarch64 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Jul 25 16:45:40 chimera volumio[28254]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Jul 25 16:45:40 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 25 16:45:40 chimera volumio[28254]: info: Executing start script for DAC IQaudIO DAC Plus Jul 25 16:45:40 chimera volumio[28254]: info: Reloading queue from file Jul 25 16:45:40 chimera volumio[28254]: info: VolumeController:: Volume=26 Mute =false Jul 25 16:45:40 chimera volumio[28254]: info: CoreStateMachine::pushState Jul 25 16:45:40 chimera volumio[28254]: info: CorePlayQueue::getTrack 0 Jul 25 16:45:40 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 25 16:45:40 chimera volumio[28254]: info: CoreCommandRouter::volumioPushState Jul 25 16:45:40 chimera volumio[28254]: info: CoreStateMachine::updateTrackBlock Jul 25 16:45:40 chimera volumio[28254]: info: CorePlayQueue::getTrackBlock Jul 25 16:45:40 chimera volumio[28254]: info: CoreCommandRouter::volumioRetrievevolume Jul 25 16:45:40 chimera volumio[28254]: info: CoreStateMachine::setRepeat null single undefined Jul 25 16:45:40 chimera volumio[28254]: info: CoreStateMachine::pushState Jul 25 16:45:40 chimera volumio[28254]: info: CorePlayQueue::getTrack 0 Jul 25 16:45:40 chimera volumio[28254]: info: CoreCommandRouter::volumioPushState Jul 25 16:45:40 chimera volumio[28254]: info: CoreStateMachine::setRandom true Jul 25 16:45:40 chimera volumio[28254]: info: CoreStateMachine::pushState Jul 25 16:45:40 chimera volumio[28254]: info: CorePlayQueue::getTrack 0 Jul 25 16:45:40 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 25 16:45:40 chimera volumio[28254]: info: CoreCommandRouter::volumioPushState Jul 25 16:45:40 chimera volumio[28254]: info: Setting Device type: Raspberry PI Jul 25 16:45:40 chimera volumio[28254]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Jul 25 16:45:40 chimera volumio[28254]: info: USB Boot Capable - System SBC Revision found in cpuinfo: d04170 Jul 25 16:45:40 chimera volumio[28254]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Jul 25 16:45:40 chimera volumio[28254]: error: Cannot execute DAC script: Error: Command failed: /volumio/app/plugins/system_controller/i2s_dacs/scripts/iqamp-unmute.sh Jul 25 16:45:40 chimera volumio[28254]: Oops: Unable to determine board revision from /proc/cpuinfo Jul 25 16:45:40 chimera volumio[28254]: -> No "Hardware" line Jul 25 16:45:40 chimera volumio[28254]: -> You'd best google the error to find out why. Jul 25 16:45:40 chimera volumio[28254]: Oops: Unable to determine board revision from /proc/cpuinfo Jul 25 16:45:40 chimera volumio[28254]: -> No "Hardware" line Jul 25 16:45:40 chimera volumio[28254]: -> You'd best google the error to find out why. Jul 25 16:45:40 chimera volumio[28254]: info: Completed loading Core Plugins Jul 25 16:45:40 chimera volumio[28254]: info: Preparing to generate the ALSA configuration file Jul 25 16:45:40 chimera volumio[28254]: info: VolumeController:: Volume=26 Mute =false Jul 25 16:45:40 chimera volumio[28254]: info: CoreStateMachine::pushState Jul 25 16:45:40 chimera volumio[28254]: info: CorePlayQueue::getTrack 0 Jul 25 16:45:40 chimera volumio[28254]: info: CoreCommandRouter::volumioPushState Jul 25 16:45:40 chimera volumio[28254]: info: Asound.conf file written Jul 25 16:45:40 chimera sudo[28374]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jul 25 16:45:40 chimera sudo[28374]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 25 16:45:40 chimera sudo[28374]: pam_unix(sudo:session): session closed for user root Jul 25 16:45:40 chimera volumio[28254]: info: Output device has changed, restarting MPD Jul 25 16:45:40 chimera sudo[28380]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 25 16:45:40 chimera sudo[28380]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 25 16:45:40 chimera sudo[28380]: pam_unix(sudo:session): session closed for user root Jul 25 16:45:40 chimera volumio[28254]: info: Output device has changed, restarting Shairport Sync Jul 25 16:45:40 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 25 16:45:40 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 25 16:45:40 chimera sudo[28383]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 25 16:45:40 chimera sudo[28383]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 25 16:45:40 chimera systemd[1]: Stopping Music Player Daemon... Jul 25 16:45:40 chimera volumio[28254]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 25 16:45:40 chimera volumio[28254]: info: ___________ START PLUGINS ___________ Jul 25 16:45:40 chimera volumio[28254]: info: ControllerMpd::onStart: Initializing MPD Jul 25 16:45:40 chimera volumio[28254]: info: Creating MPD Configuration file Jul 25 16:45:40 chimera sudo[28389]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 25 16:45:40 chimera sudo[28389]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 25 16:45:40 chimera sudo[28389]: pam_unix(sudo:session): session closed for user root Jul 25 16:45:40 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 25 16:45:40 chimera volumio[28254]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 25 16:45:40 chimera volumio[28254]: info: [1721904340794] CoreMusicLibrary::Adding element Media Servers Jul 25 16:45:40 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 25 16:45:40 chimera sudo[28392]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 25 16:45:40 chimera sudo[28392]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 25 16:45:40 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 25 16:45:40 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 25 16:45:40 chimera volumio[28254]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 25 16:45:40 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 25 16:45:40 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 25 16:45:40 chimera volumio[28254]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 25 16:45:40 chimera volumio[28254]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 25 16:45:40 chimera volumio[28254]: info: [1721904340837] CoreMusicLibrary::Adding element Last_100 Jul 25 16:45:40 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 25 16:45:40 chimera volumio[28254]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 25 16:45:40 chimera volumio[28254]: info: [1721904340837] CoreMusicLibrary::Adding element Webradio Jul 25 16:45:40 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 25 16:45:40 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 25 16:45:40 chimera volumio[28254]: info: Initializing BBC Radios Jul 25 16:45:40 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 25 16:45:40 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 25 16:45:40 chimera volumio[28254]: info: Creating Spotify config file Jul 25 16:45:40 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 25 16:45:40 chimera volumio[28254]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 25 16:45:40 chimera volumio[28254]: info: [1721904340892] CoreMusicLibrary::Adding element YouTube2 Jul 25 16:45:40 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 25 16:45:40 chimera volumio[28254]: Cannot find translation for source YouTube2 Jul 25 16:45:40 chimera volumio[28254]: info: Loading i18n strings for locale en Jul 25 16:45:40 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 25 16:45:40 chimera volumio[28254]: info: Volumio Calling Home Jul 25 16:45:40 chimera sudo[28414]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Jul 25 16:45:40 chimera sudo[28414]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 25 16:45:40 chimera sudo[28417]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Jul 25 16:45:40 chimera sudo[28417]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 25 16:45:40 chimera sudo[28414]: pam_unix(sudo:session): session closed for user root Jul 25 16:45:40 chimera systemd[1]: Reloading. Jul 25 16:45:40 chimera sudo[28420]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Jul 25 16:45:40 chimera sudo[28420]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 25 16:45:40 chimera volumio[28254]: info: touch_display: No backlight interface detected. Jul 25 16:45:40 chimera volumio[28254]: info: touch_display: systemctl stop getty@tty1.service succeeded. Jul 25 16:45:40 chimera volumio[28254]: info: MPD Permissions set Jul 25 16:45:40 chimera volumio[28254]: info: MPD Permissions set Jul 25 16:45:40 chimera volumio[28254]: info: Spotify config file written Jul 25 16:45:41 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 25 16:45:41 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 25 16:45:41 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 25 16:45:41 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 25 16:45:41 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 25 16:45:41 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 25 16:45:41 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 25 16:45:41 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 25 16:45:41 chimera sudo[28423]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Jul 25 16:45:41 chimera sudo[28423]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 25 16:45:41 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 25 16:45:41 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 25 16:45:41 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 25 16:45:41 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 25 16:45:41 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 25 16:45:41 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 25 16:45:41 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 25 16:45:41 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 25 16:45:41 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 25 16:45:41 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 25 16:45:41 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 25 16:45:41 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 25 16:45:41 chimera volumio[28254]: info: touch_display: No Raspberry Pi Foundation touch screen detected. Jul 25 16:45:41 chimera 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. Jul 25 16:45:41 chimera sudo[28449]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Jul 25 16:45:41 chimera sudo[28449]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 25 16:45:41 chimera sudo[28449]: pam_unix(sudo:session): session closed for user root Jul 25 16:45:41 chimera volumio[28254]: info: Starting Shairport Sync Jul 25 16:45:41 chimera sudo[28452]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf Jul 25 16:45:41 chimera sudo[28452]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 25 16:45:41 chimera sudo[28452]: pam_unix(sudo:session): session closed for user root Jul 25 16:45:41 chimera volumio[28254]: info: Starting Shairport Sync Jul 25 16:45:41 chimera sudo[28455]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 25 16:45:41 chimera sudo[28455]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 25 16:45:41 chimera volumio[28254]: info: Starting Shairport Sync Jul 25 16:45:41 chimera sudo[28458]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 25 16:45:41 chimera sudo[28458]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 25 16:45:41 chimera sudo[28461]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 25 16:45:41 chimera sudo[28461]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 25 16:45:41 chimera volumio[28254]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. Jul 25 16:45:41 chimera volumio[28254]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set. Jul 25 16:45:41 chimera sudo[28417]: pam_unix(sudo:session): session closed for user root Jul 25 16:45:41 chimera volumio[28254]: info: touch_display: systemctl disable getty@tty1.service succeeded. Jul 25 16:45:41 chimera systemd[1]: Reloading. Jul 25 16:45:41 chimera 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. Jul 25 16:45:41 chimera sudo[28420]: pam_unix(sudo:session): session closed for user root Jul 25 16:45:41 chimera volumio[28254]: info: touch_display: systemctl daemon-reload succeeded. Jul 25 16:45:41 chimera systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 25 16:45:41 chimera systemd[1]: Stopping go-librespot Daemon... Jul 25 16:45:41 chimera systemd[1]: go-librespot-daemon.service: Main process exited, code=killed, status=15/TERM Jul 25 16:45:41 chimera systemd[1]: go-librespot-daemon.service: Succeeded. Jul 25 16:45:41 chimera systemd[1]: Stopped go-librespot Daemon. Jul 25 16:45:41 chimera systemd[1]: shairport-sync.service: Succeeded. Jul 25 16:45:41 chimera systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 25 16:45:41 chimera sudo[28477]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Jul 25 16:45:41 chimera sudo[28477]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 25 16:45:41 chimera systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 25 16:45:41 chimera systemd[1]: Started go-librespot Daemon. Jul 25 16:45:41 chimera sudo[28458]: pam_unix(sudo:session): session closed for user root Jul 25 16:45:41 chimera go-librespot[28480]: Librespot-go daemon starting... Jul 25 16:45:41 chimera sudo[28423]: pam_unix(sudo:session): session closed for user root Jul 25 16:45:41 chimera sudo[28461]: pam_unix(sudo:session): session closed for user root Jul 25 16:45:41 chimera volumio[28254]: info: Shairport-Sync Started Jul 25 16:45:41 chimera volumio[28254]: Error adding Membership: Error: addMembership EINVAL Jul 25 16:45:41 chimera sudo[28455]: pam_unix(sudo:session): session closed for user root Jul 25 16:45:41 chimera go-librespot[28480]: time="2024-07-25T16:45:41+06:00" level=info msg="generated new device id: 6c73d1751d32467700df453c20f55f6e40abe86b" Jul 25 16:45:41 chimera go-librespot[28480]: time="2024-07-25T16:45:41+06:00" level=debug msg="stored credentials found for svoksdddss25ilm51tw81szee" Jul 25 16:45:41 chimera volumio[28254]: info: Shairport-Sync Started Jul 25 16:45:41 chimera volumio[28254]: info: Shairport-Sync Started Jul 25 16:45:41 chimera sudo[28477]: pam_unix(sudo:session): session closed for user root Jul 25 16:45:41 chimera volumio[28254]: info: touch_display: systemctl start volumio-kiosk.service succeeded. Jul 25 16:45:41 chimera volumio[28254]: info: touch_display: Volumio Kiosk started. Jul 25 16:45:41 chimera volumio[28254]: info: CoreCommandRouter::volumioGetState Jul 25 16:45:41 chimera volumio[28254]: info: CorePlayQueue::getTrack 0 Jul 25 16:45:41 chimera volumio[28254]: info: Discovery: adding 10814df4-268d-4d28-83f1-66321d7b806d Jul 25 16:45:41 chimera volumio[28254]: info: Discovery: Found device Chimera Jul 25 16:45:41 chimera volumio[28254]: info: CoreCommandRouter::volumioGetState Jul 25 16:45:41 chimera volumio[28254]: info: CorePlayQueue::getTrack 0 Jul 25 16:45:41 chimera volumio[28254]: info: CoreCommandRouter::volumioGetState Jul 25 16:45:41 chimera volumio[28254]: info: CorePlayQueue::getTrack 0 Jul 25 16:45:41 chimera volumio[28254]: info: touch_display: X display number found: 0 Jul 25 16:45:41 chimera volumio[28254]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Jul 25 16:45:41 chimera volumio[28254]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Jul 25 16:45:41 chimera volumio[28254]: info: touch_display: X display number found: 0 Jul 25 16:45:41 chimera volumio[28254]: info: CoreCommandRouter::volumioGetState Jul 25 16:45:41 chimera volumio[28254]: info: CorePlayQueue::getTrack 0 Jul 25 16:45:41 chimera volumio[28254]: info: touch_display: Setting screensaver timeout to 120 seconds. Jul 25 16:45:41 chimera volumio[28254]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS aarch64 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Jul 25 16:45:41 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 25 16:45:41 chimera volumio[28254]: info: CoreCommandRouter::volumioGetVisibleSources Jul 25 16:45:41 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 25 16:45:41 chimera volumio[28254]: info: CoreCommandRouter::volumioGetState Jul 25 16:45:41 chimera volumio[28254]: info: CorePlayQueue::getTrack 0 Jul 25 16:45:41 chimera volumio[28254]: info: CoreCommandRouter::volumioGetState Jul 25 16:45:41 chimera volumio[28254]: info: CorePlayQueue::getTrack 0 Jul 25 16:45:41 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 25 16:45:41 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 25 16:45:41 chimera volumio[28254]: info: Received Get System Info Jul 25 16:45:41 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 25 16:45:41 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 25 16:45:41 chimera volumio[28254]: info: Discovery: Getting this device information Jul 25 16:45:41 chimera volumio[28254]: info: CoreCommandRouter::volumioGetState Jul 25 16:45:41 chimera volumio[28254]: info: CorePlayQueue::getTrack 0 Jul 25 16:45:41 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 25 16:45:41 chimera volumio[28254]: info: CoreCommandRouter::volumioGetState Jul 25 16:45:41 chimera volumio[28254]: info: CorePlayQueue::getTrack 0 Jul 25 16:45:42 chimera volumio[28254]: info: Listing playlists Jul 25 16:45:42 chimera volumio-remote-updater[868]: [2024-07-25 16:45:42] [connect] Successful connection Jul 25 16:45:42 chimera volumio-remote-updater[868]: [2024-07-25 16:45:42] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1721904342 101 Jul 25 16:45:42 chimera volumio[28254]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 5 Jul 25 16:45:42 chimera sudo[28286]: pam_unix(sudo:session): session closed for user root Jul 25 16:45:43 chimera volumio[28254]: verbose: New Socket.io Connection to 192.168.0.234 from 192.168.0.153 UA: Mozilla/5.0 (iPod touch; CPU iPhone OS 12_5_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 6 Jul 25 16:45:43 chimera volumio[28254]: verbose: New Socket.io Connection to 192.168.0.234 from 192.168.0.153 UA: Mozilla/5.0 (iPod touch; CPU iPhone OS 12_5_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 7 Jul 25 16:45:44 chimera volumio[28254]: info: go-librespot daemon successfully initialized Jul 25 16:45:44 chimera volumio[28254]: info: CoreCommandRouter::volumioGetState Jul 25 16:45:44 chimera volumio[28254]: info: CorePlayQueue::getTrack 0 Jul 25 16:45:44 chimera volumio[28254]: info: Volumio called home Jul 25 16:45:45 chimera go-librespot[28480]: time="2024-07-25T16:45:45+06:00" level=debug msg="obtained new client token: AABZqhDfUlrTX8sZaibXkhejdQszKfOzERx1Mb5+noRRTDOMx6fAT0i7H88PDU7SnQub1j9Vv2DC3Sl/8ErOEhN4rzc4BJulJFLCUgHM5LfqwqTYNHuEio9uA/ylLOJR/gBQsvHCMRk317+b08WZEbGXM0UjDcwv6BxXmGYQreltUaXnaVtlsaJ6QHXPlhrDW7m67dECM2gDIG2GX8Ah8dDrqLvxdHZ9rs7ihRSuPN1cG953AgzoU0LiGyEzcA==" Jul 25 16:45:45 chimera volumio[28254]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Jul 25 16:45:45 chimera volumio[28254]: SPOTIFY: BQBlT1enbsNs1UnLLVHyYXtN3Vw_My5mzBxDg42s9VcTm7Jz0IGwfbSTnTm3PQDHM6DhlArQSy3IcwoHsNEGDvCJbOwac9Q5GwQgu_r6_5qUUIP3v4oqTxAKgtkqGkMJ5Yp1rwU8ptcibCtPLGYu2uUCcmGqKHWFP7qiJukc34LlLcO8MH3ODs3dPYo97M_lWHGLvOg7QHVH6raqPT_x5Amtb0aHtXPusHjWom-YB47oOLcnlZPb5Iv7n-emEwbVoh--cx1qgMMR Jul 25 16:45:45 chimera volumio[28254]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Jul 25 16:45:45 chimera volumio[28254]: info: New Spotify access token = BQBlT1enbsNs1UnLLVHyYXtN3Vw_My5mzBxDg42s9VcTm7Jz0IGwfbSTnTm3PQDHM6DhlArQSy3IcwoHsNEGDvCJbOwac9Q5GwQgu_r6_5qUUIP3v4oqTxAKgtkqGkMJ5Yp1rwU8ptcibCtPLGYu2uUCcmGqKHWFP7qiJukc34LlLcO8MH3ODs3dPYo97M_lWHGLvOg7QHVH6raqPT_x5Amtb0aHtXPusHjWom-YB47oOLcnlZPb5Iv7n-emEwbVoh--cx1qgMMR Jul 25 16:45:45 chimera volumio[28254]: info: Spotify credentials grant success - running version from March 24, 2019 Jul 25 16:45:46 chimera volumio[28254]: verbose: New Socket.io Connection to 192.168.0.234 from 192.168.0.153 UA: Mozilla/5.0 (iPod touch; CPU iPhone OS 12_5_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 8 Jul 25 16:45:47 chimera volumio[28254]: info: Received Get System Info Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 25 16:45:47 chimera volumio[28254]: info: Discovery: Getting this device information Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::volumioGetState Jul 25 16:45:47 chimera volumio[28254]: info: CorePlayQueue::getTrack 0 Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::volumioGetState Jul 25 16:45:47 chimera volumio[28254]: info: CorePlayQueue::getTrack 0 Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::volumioGetVisibleSources Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::volumioGetState Jul 25 16:45:47 chimera volumio[28254]: info: CorePlayQueue::getTrack 0 Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::volumioGetQueue Jul 25 16:45:47 chimera volumio[28254]: info: CoreStateMachine::getQueue Jul 25 16:45:47 chimera volumio[28254]: info: CorePlayQueue::getQueue Jul 25 16:45:47 chimera volumio[28254]: info: Listing playlists Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 25 16:45:47 chimera volumio[28254]: info: Received Get System Info Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 25 16:45:47 chimera volumio[28254]: info: Discovery: Getting this device information Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::volumioGetState Jul 25 16:45:47 chimera volumio[28254]: info: CorePlayQueue::getTrack 0 Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::volumioGetState Jul 25 16:45:47 chimera volumio[28254]: info: CorePlayQueue::getTrack 0 Jul 25 16:45:47 chimera volumio[28254]: info: Received Get System Info Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 25 16:45:47 chimera volumio[28254]: info: Discovery: Getting this device information Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::volumioGetState Jul 25 16:45:47 chimera volumio[28254]: info: CorePlayQueue::getTrack 0 Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::volumioGetState Jul 25 16:45:47 chimera volumio[28254]: info: CorePlayQueue::getTrack 0 Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::volumioGetVisibleSources Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::volumioGetState Jul 25 16:45:47 chimera volumio[28254]: info: CorePlayQueue::getTrack 0 Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::volumioGetQueue Jul 25 16:45:47 chimera volumio[28254]: info: CoreStateMachine::getQueue Jul 25 16:45:47 chimera volumio[28254]: info: CorePlayQueue::getQueue Jul 25 16:45:47 chimera volumio[28254]: info: Listing playlists Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 25 16:45:47 chimera volumio[28254]: info: Received Get System Info Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 25 16:45:47 chimera volumio[28254]: info: Discovery: Getting this device information Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::volumioGetState Jul 25 16:45:47 chimera volumio[28254]: info: CorePlayQueue::getTrack 0 Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::volumioGetState Jul 25 16:45:47 chimera volumio[28254]: info: CorePlayQueue::getTrack 0 Jul 25 16:45:47 chimera volumio[28254]: info: Received Get System Info Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 25 16:45:47 chimera volumio[28254]: info: Discovery: Getting this device information Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::volumioGetState Jul 25 16:45:47 chimera volumio[28254]: info: CorePlayQueue::getTrack 0 Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::volumioGetState Jul 25 16:45:47 chimera volumio[28254]: info: CorePlayQueue::getTrack 0 Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::volumioGetVisibleSources Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::volumioGetState Jul 25 16:45:47 chimera volumio[28254]: info: CorePlayQueue::getTrack 0 Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::volumioGetQueue Jul 25 16:45:47 chimera volumio[28254]: info: CoreStateMachine::getQueue Jul 25 16:45:47 chimera volumio[28254]: info: CorePlayQueue::getQueue Jul 25 16:45:47 chimera volumio[28254]: info: Listing playlists Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 25 16:45:47 chimera volumio[28254]: info: Received Get System Info Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 25 16:45:47 chimera volumio[28254]: info: Discovery: Getting this device information Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::volumioGetState Jul 25 16:45:47 chimera volumio[28254]: info: CorePlayQueue::getTrack 0 Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::volumioGetState Jul 25 16:45:47 chimera volumio[28254]: info: CorePlayQueue::getTrack 0 Jul 25 16:45:47 chimera volumio[28254]: info: Received Get System Info Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 25 16:45:47 chimera volumio[28254]: info: Discovery: Getting this device information Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::volumioGetState Jul 25 16:45:47 chimera volumio[28254]: info: CorePlayQueue::getTrack 0 Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 25 16:45:47 chimera volumio[28254]: info: CoreCommandRouter::volumioGetState Jul 25 16:45:47 chimera volumio[28254]: info: CorePlayQueue::getTrack 0 Jul 25 16:45:47 chimera volumio[28254]: info: Initializing connection to go-librespot Websocket Jul 25 16:45:47 chimera go-librespot[28480]: time="2024-07-25T16:45:47+06:00" level=debug msg="new websocket client" Jul 25 16:45:47 chimera volumio[28254]: info: Connection to go-librespot Websocket established Jul 25 16:45:47 chimera volumio[28254]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Bruce%20Springsteen/Born%20to%20Run/18e6112b-c72e-4e95-88a0-c7b342872f72.png' Jul 25 16:45:48 chimera volumio[28254]: SPOTIFY: User informations: {"display_name":"Partho","external_urls":{"spotify":"https://open.spotify.com/user/svoksdddss25ilm51tw81szee"},"href":"https://api.spotify.com/v1/users/svoksdddss25ilm51tw81szee","id":"svoksdddss25ilm51tw81szee","images":[],"type":"user","uri":"spotify:user:svoksdddss25ilm51tw81szee","followers":{"href":null,"total":0},"country":"BD","product":"premium","explicit_content":{"filter_enabled":false,"filter_locked":false},"email":"hamdyrabby@gmail.com"} Jul 25 16:45:48 chimera volumio[28254]: info: Spotify Successfully logged in Jul 25 16:45:48 chimera volumio[28254]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 25 16:45:48 chimera volumio[28254]: info: [1721904348276] CoreMusicLibrary::Adding element Spotify Jul 25 16:45:48 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 25 16:45:48 chimera volumio[28254]: Cannot find translation for source YouTube2 Jul 25 16:45:48 chimera volumio[28254]: Cannot find translation for source Spotify Jul 25 16:45:48 chimera sudo[28501]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 25 16:45:48 chimera sudo[28501]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 25 16:45:48 chimera sudo[28501]: pam_unix(sudo:session): session closed for user root Jul 25 16:45:48 chimera sudo[28504]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 25 16:45:48 chimera sudo[28504]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 25 16:45:48 chimera sudo[28504]: pam_unix(sudo:session): session closed for user root Jul 25 16:45:48 chimera sudo[28507]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jul 25 16:45:48 chimera sudo[28507]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 25 16:45:48 chimera sudo[28507]: pam_unix(sudo:session): session closed for user root Jul 25 16:45:48 chimera volumio[28254]: info: Upmpdcli Daemon Started Jul 25 16:45:50 chimera go-librespot[28480]: time="2024-07-25T16:45:50+06:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Jul 25 16:45:50 chimera volumio[28254]: info: Getting Spotify volume Jul 25 16:45:50 chimera volumio[28254]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Jul 25 16:45:50 chimera volumio[28254]: info: CoreCommandRouter::volumioGetState Jul 25 16:45:50 chimera volumio[28254]: info: CorePlayQueue::getTrack 0 Jul 25 16:45:50 chimera volumio[28254]: SPOTIFY: RECEIVED VOLUMIO VOLUME 26 Jul 25 16:45:50 chimera volumio[28254]: SPOTIFY: SPOTIFY VOLUME undefined Jul 25 16:45:50 chimera volumio[28254]: SPOTIFY: VOLUMIO VOLUME 26 Jul 25 16:45:50 chimera volumio[28254]: info: Aligning Spotify Volume to Volumio Volume Jul 25 16:45:50 chimera volumio[28254]: info: CoreCommandRouter::volumioGetState Jul 25 16:45:50 chimera volumio[28254]: info: CorePlayQueue::getTrack 0 Jul 25 16:45:50 chimera volumio[28254]: info: Setting Spotify Volume from Volumio: 26 Jul 25 16:45:51 chimera go-librespot[28480]: time="2024-07-25T16:45:51+06:00" level=debug msg="completed keyexchange" Jul 25 16:45:52 chimera go-librespot[28480]: time="2024-07-25T16:45:52+06:00" level=debug msg="completed challenge" Jul 25 16:45:52 chimera volumio[28254]: SPOTIFY: SETTING SPOTIFY VOLUME 26 Jul 25 16:45:52 chimera volumio[28254]: info: Sending Spotify command with payload to local API: /player/volume Jul 25 16:45:52 chimera volumio[28254]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 25 16:45:52 chimera volumio[28254]: info: CURURI: artists:// Jul 25 16:45:52 chimera volumio[28254]: error: Failed to execute browseSource, failure: TypeError: Cannot read property 'sendCommand' of undefined Jul 25 16:45:52 chimera volumio[28254]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Jimi%20Hendrix/Band%20of%20Gypsys/b81e3665-1496-44b1-bf50-312fc7f4e841.png' Jul 25 16:45:53 chimera volumio[28254]: error: [yt-cast-receiver] (YouTube) Failed to obtain lounge token with screen Id from stored MDX context (afausorts5ebgn78e58p354vr9): Jul 25 16:45:53 chimera volumio[28254]: (ConnectionError) (YouTube) Connection error in getting lounge token Jul 25 16:45:53 chimera volumio[28254]: Error info: { Jul 25 16:45:53 chimera volumio[28254]: url: 'https://www.youtube.com/api/lounge/pairing/get_lounge_token_batch' Jul 25 16:45:53 chimera volumio[28254]: } Jul 25 16:45:53 chimera volumio[28254]: --->(FetchError) request to https://www.youtube.com/api/lounge/pairing/get_lounge_token_batch failed, reason: socket hang up Jul 25 16:45:53 chimera volumio[28254]: Stack trace: Jul 25 16:45:53 chimera volumio[28254]: ConnectionError: (YouTube) Connection error in getting lounge token Jul 25 16:45:53 chimera volumio[28254]: at Session._Session_getLoungeToken (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:435:15) Jul 25 16:45:53 chimera volumio[28254]: at runMicrotasks () Jul 25 16:45:53 chimera volumio[28254]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Jul 25 16:45:53 chimera volumio[28254]: at async Session.begin (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/Session.js:131:31) Jul 25 16:45:53 chimera volumio[28254]: at async Promise.all (index 0) Jul 25 16:45:53 chimera volumio[28254]: at async YouTubeApp.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/app/YouTubeApp.js:110:13) Jul 25 16:45:53 chimera volumio[28254]: at async YouTubeCastReceiver.start (/data/plugins/music_service/ytcr/node_modules/yt-cast-receiver/dist/cjs/lib/YouTubeCastReceiver.js:91:13) Jul 25 16:45:53 chimera volumio[28254]: Going to generate fresh screen Id and try again... Jul 25 16:45:53 chimera go-librespot[28480]: time="2024-07-25T16:45:53+06:00" level=debug msg="authenticated as svoksdddss25ilm51tw81szee" Jul 25 16:45:53 chimera volumio[28254]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Joe%20Satriani/The%20Extremist/1044a6a3-8379-41b9-80b5-526de88d5e90.jpg' Jul 25 16:45:55 chimera go-librespot[28480]: time="2024-07-25T16:45:55+06:00" level=debug msg="authenticated as svoksdddss25ilm51tw81szee" Jul 25 16:45:55 chimera go-librespot[28480]: time="2024-07-25T16:45:55+06:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Jul 25 16:45:55 chimera go-librespot[28480]: time="2024-07-25T16:45:55+06:00" level=debug msg="fetched new dealers: [gae2-dealer2.spotify.com:443 guc3-dealer2.spotify.com:443 gew1-dealer2.spotify.com:443 gew4-dealer2.spotify.com:443]" Jul 25 16:46:03 chimera volumio[28254]: info: Preload queue cleared Jul 25 16:46:03 chimera volumio[28254]: info: Preloading song: mnt/USB/181D-115D/Zero 7/When It Falls/05 Passing By.flac Jul 25 16:46:03 chimera volumio[28254]: info: Preloading song: mnt/USB/181D-115D/Waldeck/Waldeck's Gramophone, Vol. 1/03 Amicalement Votre.wma Jul 25 16:46:03 chimera volumio[28254]: info: Preloading song: mnt/USB/181D-115D/Koop/Koop Islands [US Bonus Tracks]/02 Come to Me.wma Jul 25 16:46:03 chimera volumio[28254]: info: Preloading song: mnt/USB/181D-115D/Mono/Formica Blues/04 The Outsider.wma Jul 25 16:46:03 chimera volumio[28254]: info: Preloading song: mnt/USB/181D-115D/Quantic/Apricot Morning/01 Apricot Morning.wma Jul 25 16:46:03 chimera volumio[28254]: info: Preloading song: mnt/USB/181D-115D/Thievery Corporation/Versions/06 Desert.wma Jul 25 16:46:03 chimera volumio[28254]: info: Preloading song: mnt/USB/181D-115D/Thievery Corporation/The Mirror Conspiracy/02 Le Monde.wma Jul 25 16:46:03 chimera volumio[28254]: info: Preloading song: mnt/USB/181D-115D/Koop/Koop Islands [US Bonus Tracks]/08 Strange Love.wma Jul 25 16:46:03 chimera volumio[28254]: info: Preloading song: mnt/USB/181D-115D/Waldeck/Ballroom Stories/04 Addicted.wma Jul 25 16:46:03 chimera volumio[28254]: info: Preloading song: mnt/USB/181D-115D/Various Artists/Chilled Ibiza/01 Slip into Something More Comfortable.wma Jul 25 16:46:03 chimera volumio[28254]: info: Preloading song: mnt/USB/181D-115D/Bonobo/One Off Remixes and B-Sides/08 Four Ton Mantis.wma Jul 25 16:46:03 chimera volumio[28254]: info: Preloading song: mnt/USB/181D-115D/Moby/Go- The Very Best of Moby/03 Porcelain.wma Jul 25 16:46:03 chimera volumio[28254]: info: Preloading song: mnt/USB/181D-115D/Nortec Collective/The Tijuana Sessions, Vol. 1/04 El Vergel.wma Jul 25 16:46:03 chimera volumio[28254]: info: Preloading song: mnt/USB/181D-115D/Koop/Waltz for Koop-Waltz for Koop- Alternative Takes/01 Waltz for Koop.wma Jul 25 16:46:03 chimera volumio[28254]: info: Preloading song: mnt/USB/181D-115D/Koop/Waltz for Koop-Waltz for Koop- Alternative Takes/02 Tonight.wma Jul 25 16:46:03 chimera volumio[28254]: info: Preloading song: mnt/USB/181D-115D/Thievery Corporation/The Mirror Conspiracy/02 Le Monde.wma Jul 25 16:46:03 chimera volumio[28254]: info: Preloading song: mnt/USB/181D-115D/Quantic/Apricot Morning/05 Wider Than the Sky.wma Jul 25 16:46:03 chimera volumio[28254]: info: Preloading song: mnt/USB/181D-115D/Waldeck/Waldeck's Gramophone, Vol. 1/08 Petit Pays.wma Jul 25 16:46:03 chimera volumio[28254]: info: Preloading song: mnt/USB/181D-115D/Waldeck/Ballroom Stories/11 Our Day Will Come.wma Jul 25 16:46:03 chimera volumio[28254]: info: Preloading song: mnt/USB/181D-115D/Mono/Formica Blues/01 Life in Mono.wma Jul 25 16:46:03 chimera volumio[28254]: info: Preloading song: mnt/USB/181D-115D/Quantic/Apricot Morning/11 Off the Beaten Track.wma Jul 25 16:46:03 chimera volumio[28254]: info: Preloading song: mnt/USB/181D-115D/Thievery Corporation/Culture of Fear/11 Fragments.wma Jul 25 16:46:03 chimera volumio[28254]: info: Preloading song: mnt/USB/181D-115D/Waldeck/Ballroom Stories/03 Memories.wma Jul 25 16:46:03 chimera volumio[28254]: info: Preloading song: mnt/USB/181D-115D/Moby/Go- The Very Best of Moby/10 Extreme Ways.wma Jul 25 16:46:03 chimera volumio[28254]: info: Preloading song: mnt/USB/181D-115D/Aim - 1999 - Cold Water Music/02 - Cold Water Music.flac Jul 25 16:46:03 chimera volumio[28254]: info: Exploding uri mnt/USB/181D-115D/Zero 7/When It Falls/05 Passing By.flac in service mpd Jul 25 16:46:03 chimera volumio[28254]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 25 16:46:03 chimera volumio[28254]: TypeError: Cannot read property 'then' of undefined Jul 25 16:46:03 chimera volumio[28254]: at ControllerMpd.scanFolder (/volumio/app/plugins/music_service/mpd/index.js:2527:19) Jul 25 16:46:03 chimera volumio[28254]: at ControllerMpd.explodeUri (/volumio/app/plugins/music_service/mpd/index.js:2325:21) Jul 25 16:46:03 chimera volumio[28254]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1365:16) Jul 25 16:46:03 chimera volumio[28254]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24) Jul 25 16:46:03 chimera volumio[28254]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19) Jul 25 16:46:03 chimera volumio[28254]: at Timeout._onTimeout (/volumio/app/playqueue.js:146:100) Jul 25 16:46:03 chimera volumio[28254]: at listOnTimeout (internal/timers.js:554:17) Jul 25 16:46:03 chimera volumio[28254]: at processTimers (internal/timers.js:497:7) Jul 25 16:46:03 chimera volumio[28254]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 25 16:46:03 chimera sudo[28560]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-25 16:45 Jul 25 16:46:03 chimera sudo[28560]: 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="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:41:12 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="8e78a6e3f56f1bcbbd1760812129a8e9"