-- 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"