-- Logs begin at Sun 2024-09-01 09:59:40 CST, end at Sun 2024-09-01 10:01:30 CST. --
Sep 01 10:00:00 volumio volumio[1219]: info: -------------------------------------------
Sep 01 10:00:00 volumio volumio[1219]: info: ----- Volumio3 ----
Sep 01 10:00:00 volumio volumio[1219]: info: -------------------------------------------
Sep 01 10:00:00 volumio volumio[1219]: info: ----- System startup ----
Sep 01 10:00:00 volumio volumio[1219]: info: -------------------------------------------
Sep 01 10:00:00 volumio ntpd[1214]: Soliciting pool server 202.182.111.234
Sep 01 10:00:00 volumio ntpd[1214]: Soliciting pool server 45.76.221.157
Sep 01 10:00:00 volumio ntpd[1214]: Soliciting pool server 163.44.97.196
Sep 01 10:00:01 volumio volumio[1219]: info: MYVOLUMIO Environment detected
Sep 01 10:00:01 volumio volumio[1219]: info: Plugin folders cleanup
Sep 01 10:00:01 volumio volumio[1219]: info: Scanning into folder /volumio/app/plugins/
Sep 01 10:00:01 volumio volumio[1219]: info: Scanning category audio_interface
Sep 01 10:00:01 volumio volumio[1219]: info: Scanning category miscellanea
Sep 01 10:00:01 volumio volumio[1219]: info: Scanning category music_service
Sep 01 10:00:01 volumio volumio[1219]: info: Scanning category plugins.json
Sep 01 10:00:01 volumio volumio[1219]: info: Scanning category system_controller
Sep 01 10:00:01 volumio ntpd[1214]: Soliciting pool server 162.159.200.1
Sep 01 10:00:01 volumio ntpd[1214]: Soliciting pool server 45.76.211.39
Sep 01 10:00:01 volumio volumio[1219]: info: Scanning category user_interface
Sep 01 10:00:01 volumio volumio[1219]: info: Scanning into folder /data/plugins/
Sep 01 10:00:01 volumio volumio[1219]: info: Scanning category music_service
Sep 01 10:00:01 volumio volumio[1219]: info: Scanning category user_interface
Sep 01 10:00:01 volumio volumio[1219]: info: Plugin folders cleanup completed
Sep 01 10:00:01 volumio volumio[1219]: info: -------------------------------------------
Sep 01 10:00:01 volumio volumio[1219]: info: ----- Core plugins startup ----
Sep 01 10:00:01 volumio volumio[1219]: info: -------------------------------------------
Sep 01 10:00:01 volumio volumio[1219]: info: Loading plugins from folder /volumio/app/plugins/
Sep 01 10:00:01 volumio volumio[1219]: info: Adding plugin upnp to MyMusic Plugins
Sep 01 10:00:01 volumio volumio[1219]: info: Adding plugin airplay_emulation to MyMusic Plugins
Sep 01 10:00:01 volumio volumio[1219]: info: Adding plugin upnp_browser to MyMusic Plugins
Sep 01 10:00:01 volumio volumio[1219]: info: Loading plugins from folder /data/plugins/
Sep 01 10:00:01 volumio volumio[1219]: info: Loading plugin "system"...
Sep 01 10:00:01 volumio ntpd[1214]: Soliciting pool server 133.243.238.163
Sep 01 10:00:02 volumio volumio[1219]: info: Loading plugin "appearance"...
Sep 01 10:00:02 volumio ntpd[1214]: Soliciting pool server 167.179.119.205
Sep 01 10:00:02 volumio ntpd[1214]: Soliciting pool server 45.76.218.37
Sep 01 10:00:02 volumio ntpd[1214]: Soliciting pool server 129.250.35.251
Sep 01 10:00:02 volumio ntpd[1214]: Soliciting pool server 133.243.238.243
Sep 01 10:00:03 volumio volumio[1219]: info: Loading plugin "network"...
Sep 01 10:00:03 volumio volumio[1219]: info: Refreshing Cached IP Addresses
Sep 01 10:00:03 volumio sudo[1470]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Sep 01 10:00:03 volumio sudo[1470]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 10:00:03 volumio volumio[1219]: info: Loading plugin "services"...
Sep 01 10:00:03 volumio sudo[1472]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Sep 01 10:00:03 volumio sudo[1470]: pam_unix(sudo:session): session closed for user root
Sep 01 10:00:03 volumio sudo[1472]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 10:00:03 volumio volumio[1219]: info: Loading plugin "alsa_controller"...
Sep 01 10:00:03 volumio sudo[1472]: pam_unix(sudo:session): session closed for user root
Sep 01 10:00:03 volumio sudo[1475]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Sep 01 10:00:03 volumio sudo[1475]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 10:00:03 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 01 10:00:03 volumio volumio[1219]: info: Loading plugin "wizard"...
Sep 01 10:00:03 volumio volumio[1219]: info: Loading plugin "networkfs"...
Sep 01 10:00:03 volumio sudo[1491]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=readonly,password=readonly,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.8/Download/2_Audio/Pop /mnt/NAS/QNap-Pop
Sep 01 10:00:03 volumio sudo[1491]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 10:00:03 volumio sudo[1493]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=readonly,password=readonly,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.8/Download/2_Audio/Demo /mnt/NAS/QNap-Demo
Sep 01 10:00:03 volumio sudo[1493]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 10:00:03 volumio sudo[1496]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=readonly,password=readonly,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.8/Download/2_Audio/Classical /mnt/NAS/QNap-Classical
Sep 01 10:00:03 volumio sudo[1496]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 10:00:03 volumio sudo[1504]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=readonly,password=readonly,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.8/Download/2_Audio/Chinese /mnt/NAS/QNap-Chinese
Sep 01 10:00:03 volumio sudo[1504]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 10:00:03 volumio kernel: FS-Cache: Loaded
Sep 01 10:00:03 volumio sudo[1516]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=readonly,password=readonly,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.8/Download/2_Audio/Jazz /mnt/NAS/QNap-Jazz
Sep 01 10:00:03 volumio sudo[1516]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 10:00:03 volumio sudo[1518]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=readonly,password=readonly,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.8/Download/2_Audio/CD_Hot /mnt/NAS/QNap-CD-Hot
Sep 01 10:00:03 volumio kernel: Key type dns_resolver registered
Sep 01 10:00:03 volumio sudo[1518]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 10:00:03 volumio volumio[1219]: info: Starting Udev Watcher for removable devices
Sep 01 10:00:03 volumio sudo[1523]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.8/Download/2_Audio/rutracker /mnt/NAS/rutracker
Sep 01 10:00:03 volumio sudo[1523]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 10:00:03 volumio volumio[1219]: info: Ignoring mount for partition: boot
Sep 01 10:00:03 volumio volumio[1219]: info: Ignoring mount for partition: volumio
Sep 01 10:00:03 volumio volumio[1219]: info: Ignoring mount for partition: volumio_data
Sep 01 10:00:03 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 01 10:00:03 volumio volumio[1219]: info: Loading plugin "volumio_command_line_client"...
Sep 01 10:00:03 volumio volumio[1219]: info: Loading plugin "upnp"...
Sep 01 10:00:03 volumio volumio[1219]: info: [1725156003902] Starting Upmpd Daemon
Sep 01 10:00:03 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 01 10:00:03 volumio volumio[1219]: info: Loading plugin "my_music"...
Sep 01 10:00:03 volumio volumio[1219]: info: Loading plugin "mpd"...
Sep 01 10:00:03 volumio ntpd[1214]: Soliciting pool server 129.250.35.250
Sep 01 10:00:03 volumio ntpd[1214]: Soliciting pool server 45.77.20.103
Sep 01 10:00:03 volumio kernel: Key type cifs.spnego registered
Sep 01 10:00:03 volumio kernel: Key type cifs.idmap registered
Sep 01 10:00:03 volumio kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount.
Sep 01 10:00:03 volumio kernel: CIFS: Attempting to mount //192.168.0.8/Download/2_Audio/rutracker
Sep 01 10:00:04 volumio volumio[1219]: info: Loading plugin "upnp_browser"...
Sep 01 10:00:04 volumio volumio[1219]: info: Loading plugin "alarm-clock"...
Sep 01 10:00:04 volumio volumio[1219]: info: Loading plugin "airplay_emulation"...
Sep 01 10:00:04 volumio volumio[1219]: info: Starting Shairport Sync
Sep 01 10:00:04 volumio volumio[1219]: info: Loading plugin "last_100"...
Sep 01 10:00:04 volumio volumio[1219]: info: Loading plugin "webradio"...
Sep 01 10:00:04 volumio volumio[1219]: info: Loading plugin "i2s_dacs"...
Sep 01 10:00:04 volumio volumio[1219]: info: I2S DAC not set, start Auto-detection
Sep 01 10:00:04 volumio volumio[1219]: info: Loading plugin "volumiodiscovery"...
Sep 01 10:00:04 volumio volumio[1219]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Sep 01 10:00:04 volumio volumio[1219]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 01 10:00:04 volumio node[1219]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Sep 01 10:00:04 volumio volumio[1219]: *** WARNING *** For more information see
Sep 01 10:00:04 volumio volumio[1219]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Sep 01 10:00:04 volumio volumio[1219]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 01 10:00:04 volumio volumio[1219]: *** WARNING *** For more information see
Sep 01 10:00:04 volumio node[1219]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 01 10:00:04 volumio node[1219]: *** WARNING *** For more information see
Sep 01 10:00:04 volumio node[1219]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Sep 01 10:00:04 volumio node[1219]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 01 10:00:04 volumio node[1219]: *** WARNING *** For more information see
Sep 01 10:00:04 volumio volumio[1219]: info: Applying required configuration parameters for plugin volumiodiscovery
Sep 01 10:00:04 volumio volumio[1219]: info: Discovery: Started advertising with name: Volumio
Sep 01 10:00:04 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 01 10:00:04 volumio volumio[1219]: info: Loading plugin "spop"...
Sep 01 10:00:04 volumio ntpd[1214]: Soliciting pool server 172.105.204.105
Sep 01 10:00:04 volumio ntpd[1214]: Soliciting pool server 133.130.121.141
Sep 01 10:00:05 volumio volumio-remote-updater[781]: [2024-09-01 10:00:05] [connect] Successful connection
Sep 01 10:00:05 volumio volumio[1219]: info: Loading plugin "now_playing"...
Sep 01 10:00:05 volumio sudo[1475]: pam_unix(sudo:session): session closed for user root
Sep 01 10:00:05 volumio ntpd[1214]: Soliciting pool server 2400:8902:e001:347:0:a789:b456:c123
Sep 01 10:00:05 volumio ntpd[1214]: receive: Unexpected origin timestamp 0xea7e4925.f4dffaf5 does not match aorg 0000000000.00000000 from server@163.44.97.196 xmt 0xea7e4925.a688a0e0
Sep 01 10:00:06 volumio volumio[1219]: info: Loading plugin "outputs"...
Sep 01 10:00:06 volumio volumio[1219]: info: Loading plugin "albumart"...
Sep 01 10:00:06 volumio volumio[1219]: info: Plugin example_plugin is not enabled
Sep 01 10:00:06 volumio volumio[1219]: info: Loading plugin "inputs"...
Sep 01 10:00:06 volumio volumio[1219]: info: Loading plugin "updater_comm"...
Sep 01 10:00:06 volumio volumio[1219]: Forking 3 albumart workers
Sep 01 10:00:06 volumio volumio[1219]: info: Plugin mpdemulation is not enabled
Sep 01 10:00:06 volumio volumio[1219]: info: Loading plugin "rest_api"...
Sep 01 10:00:06 volumio volumio[1219]: info: Loading plugin "websocket"...
Sep 01 10:00:06 volumio volumio[1219]: info: Starting Socket.io Server version 2.3.0
Sep 01 10:00:06 volumio volumio[1219]: info: Loading plugin "Systeminfo"...
Sep 01 10:00:06 volumio volumio[1219]: Starting albumart workers
Sep 01 10:00:06 volumio volumio[1219]: Starting albumart workers
Sep 01 10:00:06 volumio volumio[1219]: Starting albumart workers
Sep 01 10:00:06 volumio volumio[1219]: info: Loading i18n strings for locale en
Sep 01 10:00:06 volumio volumio[1219]: Updating browse sources language
Sep 01 10:00:06 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 01 10:00:06 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 01 10:00:06 volumio volumio[1219]: info: CoreCommandRouter::initPlayerControls
Sep 01 10:00:06 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 01 10:00:06 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 01 10:00:06 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 01 10:00:06 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 01 10:00:06 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 01 10:00:06 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 01 10:00:06 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 01 10:00:06 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 01 10:00:06 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 01 10:00:06 volumio volumio[1219]: Express server listening on port 3000
Sep 01 10:00:06 volumio volumio[1219]: [Metrics] WebUI: 7s 736.37ms
Sep 01 10:00:06 volumio volumio[1219]: info: Setting Device type: x86
Sep 01 10:00:06 volumio volumio[1219]: info: CoreStateMachine::resetVolumioState
Sep 01 10:00:06 volumio volumio[1219]: info: CoreStateMachine::getcurrentVolume
Sep 01 10:00:06 volumio volumio[1219]: info: CoreCommandRouter::volumioRetrievevolume
Sep 01 10:00:06 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 01 10:00:06 volumio volumio[1219]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt'
Sep 01 10:00:06 volumio volumio[1219]: info: Completed loading Core Plugins
Sep 01 10:00:06 volumio volumio[1219]: info: Preparing to generate the ALSA configuration file
Sep 01 10:00:06 volumio volumio[1219]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision
Sep 01 10:00:07 volumio volumio[1219]: verbose: New Socket.io Connection to 192.168.61.180 from 192.168.0.99 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/109.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1
Sep 01 10:00:07 volumio volumio-remote-updater[781]: [2024-09-01 10:00:07] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1725156005 101
Sep 01 10:00:07 volumio volumio[1219]: 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: 2
Sep 01 10:00:07 volumio volumio[1219]: verbose: New Socket.io Connection to 192.168.61.180 from 192.168.0.99 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/109.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3
Sep 01 10:00:07 volumio volumio[1219]: info: Reloading queue from file
Sep 01 10:00:07 volumio volumio[1219]: verbose: New Socket.io Connection to 192.168.61.180 from 192.168.0.99 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/109.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4
Sep 01 10:00:07 volumio volumio[1219]: verbose: New Socket.io Connection to 192.168.61.180 from 192.168.0.99 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/109.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5
Sep 01 10:00:07 volumio volumio[1219]: info: CoreStateMachine::setRepeat null single undefined
Sep 01 10:00:07 volumio volumio[1219]: info: CoreStateMachine::pushState
Sep 01 10:00:07 volumio volumio[1219]: info: CorePlayQueue::getTrack 0
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::volumioPushState
Sep 01 10:00:07 volumio volumio[1219]: info: CoreStateMachine::setRandom null
Sep 01 10:00:07 volumio volumio[1219]: info: CoreStateMachine::pushState
Sep 01 10:00:07 volumio volumio[1219]: info: CorePlayQueue::getTrack 0
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::volumioPushState
Sep 01 10:00:07 volumio volumio[1219]: verbose: New Socket.io Connection to 192.168.61.180 from 192.168.0.99 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/109.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6
Sep 01 10:00:07 volumio volumio[1219]: info: VolumeController:: Volume=50 Mute =false
Sep 01 10:00:07 volumio volumio[1219]: info: CoreStateMachine::pushState
Sep 01 10:00:07 volumio volumio[1219]: info: CorePlayQueue::getTrack 0
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::volumioPushState
Sep 01 10:00:07 volumio volumio[1219]: info: CoreStateMachine::updateTrackBlock
Sep 01 10:00:07 volumio volumio[1219]: info: CorePlayQueue::getTrackBlock
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::volumioRetrievevolume
Sep 01 10:00:07 volumio volumio[1219]: info: Asound.conf file unchanged, so no further update is needed
Sep 01 10:00:07 volumio volumio[1219]: info: Output device has changed, restarting MPD
Sep 01 10:00:07 volumio sudo[1700]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Sep 01 10:00:07 volumio sudo[1700]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 10:00:07 volumio sudo[1700]: pam_unix(sudo:session): session closed for user root
Sep 01 10:00:07 volumio volumio[1219]: info: Output device has changed, restarting Shairport Sync
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 01 10:00:07 volumio sudo[1703]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Sep 01 10:00:07 volumio sudo[1703]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 10:00:07 volumio systemd[1]: Listening on mpd.socket.
Sep 01 10:00:07 volumio volumio[1219]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 01 10:00:07 volumio volumio[1219]: info: ___________ START PLUGINS ___________
Sep 01 10:00:07 volumio volumio[1219]: info: ControllerMpd::onStart: Initializing MPD
Sep 01 10:00:07 volumio volumio[1219]: info: Creating MPD Configuration file
Sep 01 10:00:07 volumio systemd[1]: Starting Music Player Daemon...
Sep 01 10:00:07 volumio sudo[1710]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Sep 01 10:00:07 volumio sudo[1710]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 10:00:07 volumio sudo[1710]: pam_unix(sudo:session): session closed for user root
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 01 10:00:07 volumio volumio[1219]: info: [1725156007308] CoreMusicLibrary::Adding element Media Servers
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 01 10:00:07 volumio sudo[1713]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Sep 01 10:00:07 volumio sudo[1713]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 01 10:00:07 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM
Sep 01 10:00:07 volumio systemd[1]: mpd.service: Succeeded.
Sep 01 10:00:07 volumio systemd[1]: Stopped Music Player Daemon.
Sep 01 10:00:07 volumio systemd[1]: Starting Music Player Daemon...
Sep 01 10:00:07 volumio volumio[1219]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 01 10:00:07 volumio volumio[1219]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 01 10:00:07 volumio volumio[1219]: info: [1725156007387] CoreMusicLibrary::Adding element Last_100
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 01 10:00:07 volumio volumio[1219]: info: [1725156007389] CoreMusicLibrary::Adding element Webradio
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 01 10:00:07 volumio volumio[1219]: info: Initializing BBC Radios
Sep 01 10:00:07 volumio sudo[1715]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Sep 01 10:00:07 volumio sudo[1715]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 10:00:07 volumio sudo[1715]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory
Sep 01 10:00:07 volumio sudo[1715]: pam_unix(sudo:session): session closed for user root
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 01 10:00:07 volumio volumio[1219]: info: Checking for old spotify connect plugin installed
Sep 01 10:00:07 volumio volumio[1219]: info: [now-playing-config] Config is up to date.
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 01 10:00:07 volumio volumio[1219]: info: Discovery: Getting this device information
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::volumioGetState
Sep 01 10:00:07 volumio volumio[1219]: info: CorePlayQueue::getTrack 0
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 01 10:00:07 volumio volumio[1219]: info: Volumio Calling Home
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 01 10:00:07 volumio volumio[1219]: [SpotifyConnect] Creating VLS config file
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 01 10:00:07 volumio volumio[1219]: [SpotifyConnect] Starting metadata listener
Sep 01 10:00:07 volumio volumio[1219]: info: [now-playing-app] App is listening on port 4004.
Sep 01 10:00:07 volumio sudo[1738]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect.service
Sep 01 10:00:07 volumio sudo[1738]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 10:00:07 volumio systemd[1]: Started Volspotconnect2 Daemon.
Sep 01 10:00:07 volumio sudo[1738]: pam_unix(sudo:session): session closed for user root
Sep 01 10:00:07 volumio volumio[1219]: verbose: New Socket.io Connection to 192.168.61.180 from 192.168.0.99 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/109.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7
Sep 01 10:00:07 volumio volumio[1740]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31
Sep 01 10:00:07 volumio volumio[1740]: Reading Config from "/tmp/volspotify.toml"
Sep 01 10:00:07 volumio volumio[1219]: [SpotifyConnect] Vollibrespot Daemon service started!
Sep 01 10:00:07 volumio volumio[1219]: [Metrics] SpotifyConnect: 0s 111.09ms
Sep 01 10:00:07 volumio volumio[1219]: info: MPD Permissions set
Sep 01 10:00:07 volumio volumio[1219]: info: MPD Permissions set
Sep 01 10:00:07 volumio volumio[1740]: [Vollibrespot] : Using Alsa backend with device: volumio
Sep 01 10:00:07 volumio volumio[1219]: verbose: New Socket.io Connection to 192.168.61.180 from 192.168.0.99 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/109.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8
Sep 01 10:00:07 volumio volumio[1740]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" }
Sep 01 10:00:07 volumio volumio[1219]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Sep 01 10:00:07 volumio volumio[1219]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 01 10:00:07 volumio volumio[1219]: verbose: New Socket.io Connection to 192.168.61.180 from 192.168.0.99 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/109.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11
Sep 01 10:00:07 volumio volumio[1219]: info: VolumeController:: Volume=50 Mute =false
Sep 01 10:00:07 volumio volumio[1219]: info: CoreStateMachine::pushState
Sep 01 10:00:07 volumio volumio[1219]: info: CorePlayQueue::getTrack 0
Sep 01 10:00:07 volumio volumio[1219]: info: CoreCommandRouter::volumioPushState
Sep 01 10:00:07 volumio volumio[1219]: info: Starting Shairport Sync
Sep 01 10:00:07 volumio volumio[1219]: info: Starting Shairport Sync
Sep 01 10:00:07 volumio volumio[1740]: [Vollibrespot] : Connecting to AP "ap-gae2.spotify.com:443"
Sep 01 10:00:07 volumio sudo[1760]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 01 10:00:07 volumio sudo[1760]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 10:00:07 volumio volumio[1219]: info: Starting Shairport Sync
Sep 01 10:00:07 volumio sudo[1763]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 01 10:00:07 volumio sudo[1763]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 10:00:07 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Sep 01 10:00:07 volumio systemd[1]: shairport-sync.service: Succeeded.
Sep 01 10:00:07 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Sep 01 10:00:07 volumio sudo[1766]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 01 10:00:07 volumio sudo[1766]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 10:00:07 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Sep 01 10:00:07 volumio sudo[1760]: pam_unix(sudo:session): session closed for user root
Sep 01 10:00:07 volumio volumio[1219]: info: Shairport-Sync Started
Sep 01 10:00:07 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Sep 01 10:00:07 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM
Sep 01 10:00:07 volumio systemd[1]: shairport-sync.service: Succeeded.
Sep 01 10:00:07 volumio volumio[1219]: Error adding Membership: Error: addMembership EINVAL
Sep 01 10:00:07 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Sep 01 10:00:07 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Sep 01 10:00:08 volumio sudo[1766]: pam_unix(sudo:session): session closed for user root
Sep 01 10:00:08 volumio sudo[1763]: pam_unix(sudo:session): session closed for user root
Sep 01 10:00:08 volumio volumio[1219]: info: Shairport-Sync Started
Sep 01 10:00:08 volumio volumio[1219]: info: Shairport-Sync Started
Sep 01 10:00:08 volumio volumio[1219]: info: Discovery: adding 1ed8ef5b-c8f3-4a7f-8dce-20438af0ca7a
Sep 01 10:00:08 volumio volumio[1219]: info: Discovery: Found device Volumio
Sep 01 10:00:08 volumio volumio[1219]: info: CoreCommandRouter::volumioGetState
Sep 01 10:00:08 volumio volumio[1219]: info: CorePlayQueue::getTrack 0
Sep 01 10:00:08 volumio volumio[1219]: info: CoreCommandRouter::volumioGetState
Sep 01 10:00:08 volumio volumio[1219]: info: CorePlayQueue::getTrack 0
Sep 01 10:00:08 volumio volumio[1740]: thread 'main' panicked at 'Authentication failed with reason: BadCredentials', /build/cache/git/checkouts/librespot-6f197fd632ef9380/08d8bcc/core/src/connection/mod.rs:93:21
Sep 01 10:00:08 volumio volumio[1740]: stack backtrace:
Sep 01 10:00:08 volumio volumio[1740]: 0: 0x55655f0a30cd - std::backtrace_rs::backtrace::libunwind::trace::hee598835bc88d35b
Sep 01 10:00:08 volumio volumio[1740]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/../../backtrace/src/backtrace/libunwind.rs:93:5
Sep 01 10:00:08 volumio volumio[1740]: 1: 0x55655f0a30cd - std::backtrace_rs::backtrace::trace_unsynchronized::h9cdc730ba5cf5d72
Sep 01 10:00:08 volumio volumio[1740]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
Sep 01 10:00:08 volumio volumio[1740]: 2: 0x55655f0a30cd - std::sys_common::backtrace::_print_fmt::h75aeaf7ed30e43fa
Sep 01 10:00:08 volumio volumio[1740]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:66:5
Sep 01 10:00:08 volumio volumio[1740]: 3: 0x55655f0a30cd - ::fmt::h606862f787600875
Sep 01 10:00:08 volumio volumio[1740]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:45:22
Sep 01 10:00:08 volumio volumio[1740]: 4: 0x55655f0c8f5c - core::fmt::write::he803f0f418caf762
Sep 01 10:00:08 volumio volumio[1740]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/fmt/mod.rs:1190:17
Sep 01 10:00:08 volumio volumio[1740]: 5: 0x55655f09bcb8 - std::io::Write::write_fmt::h70bc45872f37e7bb
Sep 01 10:00:08 volumio volumio[1740]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/io/mod.rs:1657:15
Sep 01 10:00:08 volumio volumio[1740]: 6: 0x55655f0a55a7 - std::sys_common::backtrace::_print::h64d038cf8ac3e13e
Sep 01 10:00:08 volumio volumio[1740]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:48:5
Sep 01 10:00:08 volumio volumio[1740]: 7: 0x55655f0a55a7 - std::sys_common::backtrace::print::h359300b4a7fccf65
Sep 01 10:00:08 volumio volumio[1740]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:35:9
Sep 01 10:00:08 volumio volumio[1740]: 8: 0x55655f0a55a7 - std::panicking::default_hook::{{closure}}::hf51be35e2f510149
Sep 01 10:00:08 volumio volumio[1740]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:295:22
Sep 01 10:00:08 volumio volumio[1740]: 9: 0x55655f0a5270 - std::panicking::default_hook::h03ca0f22e1d2d25e
Sep 01 10:00:08 volumio volumio[1740]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:314:9
Sep 01 10:00:08 volumio volumio[1740]: 10: 0x55655f0a5cf9 - std::panicking::rust_panic_with_hook::h3b7380e99b825b63
Sep 01 10:00:08 volumio volumio[1740]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:698:17
Sep 01 10:00:08 volumio volumio[1740]: 11: 0x55655f0a59e7 - std::panicking::begin_panic_handler::{{closure}}::h8e849d0710154ce0
Sep 01 10:00:08 volumio volumio[1740]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:588:13
Sep 01 10:00:08 volumio volumio[1740]: 12: 0x55655f0a3594 - std::sys_common::backtrace::__rust_end_short_backtrace::hedcdaddbd4c46cc5
Sep 01 10:00:08 volumio volumio[1740]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:138:18
Sep 01 10:00:08 volumio volumio[1740]: 13: 0x55655f0a56f9 - rust_begin_unwind
Sep 01 10:00:08 volumio volumio[1740]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:584:5
Sep 01 10:00:08 volumio volumio[1740]: 14: 0x55655ebaef53 - core::panicking::panic_fmt::he1bbc7336d49a357
Sep 01 10:00:08 volumio volumio[1740]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/panicking.rs:143:14
Sep 01 10:00:08 volumio volumio[1740]: 15: 0x55655ed7ef56 - futures::future::chain::Chain::poll::hf0e729e3d4d8df0d
Sep 01 10:00:08 volumio volumio[1740]: 16: 0x55655edf1a19 - as futures::future::Future>::poll::hb2bebc352335cc1a
Sep 01 10:00:08 volumio volumio[1740]: 17: 0x55655ed7d8e6 - futures::future::chain::Chain::poll::hda5263cfb178296b
Sep 01 10:00:08 volumio volumio[1740]: 18: 0x55655edf2fe1 - as futures::future::Future>::poll::h7445370ea1c2ee99
Sep 01 10:00:08 volumio volumio[1740]: 19: 0x55655ebdc736 - ::poll::hdecdb1a04917de4b
Sep 01 10:00:08 volumio volumio[1740]: 20: 0x55655ebf4149 - futures::task_impl::std::set::h6dd4b73f744a06d4
Sep 01 10:00:08 volumio volumio[1740]: 21: 0x55655ec0a3bd - std::thread::local::LocalKey::with::hc9bf2e930c1fdc36
Sep 01 10:00:08 volumio volumio[1740]: 22: 0x55655ebf0c56 - tokio_current_thread::Entered::block_on::h372d7b837fe25d26
Sep 01 10:00:08 volumio volumio[1740]: 23: 0x55655ec09b48 - std::thread::local::LocalKey::with::h247079172a6ad00b
Sep 01 10:00:08 volumio volumio[1740]: 24: 0x55655ebf38c5 - tokio::runtime::current_thread::runtime::Runtime::block_on::h538e89536cb974b3
Sep 01 10:00:08 volumio volumio[1740]: 25: 0x55655ebde7e9 - vollibrespot::main::hf67292b633164777
Sep 01 10:00:08 volumio volumio[1740]: 26: 0x55655ebf8c73 - std::sys_common::backtrace::__rust_begin_short_backtrace::h9396fe1ba8d4dd7f
Sep 01 10:00:08 volumio volumio[1740]: 27: 0x55655ec1bce9 - std::rt::lang_start::{{closure}}::h0862538761d46dbc
Sep 01 10:00:08 volumio volumio[1740]: 28: 0x55655f0a27b1 - core::ops::function::impls:: for &F>::call_once::hb7014f43484a8b4e
Sep 01 10:00:08 volumio volumio[1740]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/ops/function.rs:259:13
Sep 01 10:00:08 volumio volumio[1740]: 29: 0x55655f0a27b1 - std::panicking::try::do_call::h7bc9dc436daeb8c7
Sep 01 10:00:08 volumio volumio[1740]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:492:40
Sep 01 10:00:08 volumio volumio[1740]: 30: 0x55655f0a27b1 - std::panicking::try::h653d68a27ff5f175
Sep 01 10:00:08 volumio volumio[1740]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:456:19
Sep 01 10:00:08 volumio volumio[1740]: 31: 0x55655f0a27b1 - std::panic::catch_unwind::h9d739f9f59895e68
Sep 01 10:00:08 volumio volumio[1740]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panic.rs:137:14
Sep 01 10:00:08 volumio volumio[1740]: 32: 0x55655f0a27b1 - std::rt::lang_start_internal::{{closure}}::hf006f2bc7ce22bbe
Sep 01 10:00:08 volumio volumio[1740]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/rt.rs:128:48
Sep 01 10:00:08 volumio volumio[1740]: 33: 0x55655f0a27b1 - std::panicking::try::do_call::hfb39d6df61a2e69f
Sep 01 10:00:08 volumio volumio[1740]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:492:40
Sep 01 10:00:08 volumio volumio[1740]: 34: 0x55655f0a27b1 - std::panicking::try::h13e2d225134958ac
Sep 01 10:00:08 volumio volumio[1740]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:456:19
Sep 01 10:00:08 volumio volumio[1740]: 35: 0x55655f0a27b1 - std::panic::catch_unwind::h3bd49b5a5dfb1a50
Sep 01 10:00:08 volumio volumio[1740]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panic.rs:137:14
Sep 01 10:00:08 volumio volumio[1740]: 36: 0x55655f0a27b1 - std::rt::lang_start_internal::h2ba92edce36c035e
Sep 01 10:00:08 volumio volumio[1740]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/rt.rs:128:20
Sep 01 10:00:08 volumio volumio[1740]: 37: 0x55655ebe1562 - main
Sep 01 10:00:08 volumio volumio[1740]: 38: 0x7ff8d10a309b - __libc_start_main
Sep 01 10:00:08 volumio volumio[1740]: 39: 0x55655ebaf78a - _start
Sep 01 10:00:08 volumio volumio[1740]: 40: 0x0 -
Sep 01 10:00:08 volumio systemd[1]: volspotconnect.service: Main process exited, code=exited, status=101/n/a
Sep 01 10:00:08 volumio systemd[1]: volspotconnect.service: Failed with result 'exit-code'.
Sep 01 10:00:08 volumio sudo[1773]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Sep 01 10:00:08 volumio sudo[1773]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 10:00:08 volumio sudo[1775]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Sep 01 10:00:08 volumio sudo[1775]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 10:00:08 volumio sudo[1773]: pam_unix(sudo:session): session closed for user root
Sep 01 10:00:08 volumio sudo[1775]: pam_unix(sudo:session): session closed for user root
Sep 01 10:00:08 volumio volumio[1219]: info: Volumio called home
Sep 01 10:00:08 volumio volumio[1219]: verbose: New Socket.io Connection to 192.168.61.180 from 192.168.0.99 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/109.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12
Sep 01 10:00:08 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Sep 01 10:00:08 volumio mpd[1725]: Sep 01 10:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Sep 01 10:00:08 volumio systemd[1]: Started Music Player Daemon.
Sep 01 10:00:08 volumio sudo[1703]: pam_unix(sudo:session): session closed for user root
Sep 01 10:00:08 volumio sudo[1713]: pam_unix(sudo:session): session closed for user root
Sep 01 10:00:08 volumio volumio[1219]: info: Completed starting Core Plugins
Sep 01 10:00:08 volumio volumio[1219]: info: -------------------------------------------
Sep 01 10:00:08 volumio volumio[1219]: info: ----- MyVolumio plugins startup ----
Sep 01 10:00:08 volumio volumio[1219]: info: -------------------------------------------
Sep 01 10:00:08 volumio volumio[1219]: info: [MyVolumio PluginManager] Fetching plans data....
Sep 01 10:00:08 volumio volumio[1219]: error: MPD error: The expression evaluated to a falsy value:
Sep 01 10:00:08 volumio volumio[1219]: assert.ok(self.idling)
Sep 01 10:00:08 volumio volumio[1219]: error: The expression evaluated to a falsy value:
Sep 01 10:00:08 volumio volumio[1219]: assert.ok(self.idling)
Sep 01 10:00:08 volumio volumio[1219]: info: MPD running with PID1725
Sep 01 10:00:08 volumio volumio[1219]: ,establishing connection
Sep 01 10:00:08 volumio volumio[1219]: error: updateQueue error: null
Sep 01 10:00:08 volumio sudo[1783]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Sep 01 10:00:08 volumio sudo[1783]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 10:00:08 volumio volumio[1219]: error: updateQueue error: null
Sep 01 10:00:08 volumio sudo[1783]: pam_unix(sudo:session): session closed for user root
Sep 01 10:00:08 volumio sudo[1786]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Sep 01 10:00:08 volumio sudo[1786]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 10:00:08 volumio sudo[1786]: pam_unix(sudo:session): session closed for user root
Sep 01 10:00:08 volumio volumio[1219]: verbose: New Socket.io Connection to 192.168.61.180 from 192.168.0.99 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/109.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 13
Sep 01 10:00:08 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Sep 01 10:00:08 volumio volumio[1219]: info: CoreCommandRouter::volumioGetVisibleSources
Sep 01 10:00:08 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 01 10:00:08 volumio volumio[1219]: info: CoreCommandRouter::volumioGetState
Sep 01 10:00:08 volumio volumio[1219]: info: CorePlayQueue::getTrack 0
Sep 01 10:00:08 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Sep 01 10:00:08 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Sep 01 10:00:08 volumio volumio[1219]: info: Received Get System Info
Sep 01 10:00:08 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 01 10:00:08 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 01 10:00:08 volumio volumio[1219]: info: Discovery: Getting this device information
Sep 01 10:00:08 volumio volumio[1219]: info: CoreCommandRouter::volumioGetState
Sep 01 10:00:08 volumio volumio[1219]: info: CorePlayQueue::getTrack 0
Sep 01 10:00:08 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 01 10:00:08 volumio volumio[1219]: info: CoreCommandRouter::volumioGetState
Sep 01 10:00:08 volumio volumio[1219]: info: CorePlayQueue::getTrack 0
Sep 01 10:00:08 volumio volumio[1219]: info: Listing playlists
Sep 01 10:00:09 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Sep 01 10:00:09 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Sep 01 10:00:09 volumio volumio[1219]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 14
Sep 01 10:00:09 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Sep 01 10:00:09 volumio volumio[1219]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 15
Sep 01 10:00:09 volumio volumio[1219]: info: CoreCommandRouter::volumioGetState
Sep 01 10:00:09 volumio volumio[1219]: info: CorePlayQueue::getTrack 0
Sep 01 10:00:10 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Sep 01 10:00:10 volumio systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart.
Sep 01 10:00:10 volumio systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 1.
Sep 01 10:00:10 volumio systemd[1]: Stopped Volspotconnect2 Daemon.
Sep 01 10:00:10 volumio systemd[1]: Started Volspotconnect2 Daemon.
Sep 01 10:00:10 volumio volumio[1792]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31
Sep 01 10:00:10 volumio volumio[1792]: Reading Config from "/tmp/volspotify.toml"
Sep 01 10:00:10 volumio volumio[1792]: [Vollibrespot] : Using Alsa backend with device: volumio
Sep 01 10:00:10 volumio volumio[1792]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" }
Sep 01 10:00:10 volumio volumio[1792]: [Vollibrespot] : Connecting to AP "ap-gae2.spotify.com:443"
Sep 01 10:00:10 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Sep 01 10:00:10 volumio volumio[1219]: info: CoreCommandRouter::volumioGetVisibleSources
Sep 01 10:00:10 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 01 10:00:10 volumio volumio[1219]: info: CoreCommandRouter::volumioGetState
Sep 01 10:00:10 volumio volumio[1219]: info: CorePlayQueue::getTrack 0
Sep 01 10:00:10 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Sep 01 10:00:10 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Sep 01 10:00:10 volumio volumio[1219]: info: Received Get System Info
Sep 01 10:00:10 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 01 10:00:10 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 01 10:00:10 volumio volumio[1219]: info: Discovery: Getting this device information
Sep 01 10:00:10 volumio volumio[1219]: info: CoreCommandRouter::volumioGetState
Sep 01 10:00:10 volumio volumio[1219]: info: CorePlayQueue::getTrack 0
Sep 01 10:00:10 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 01 10:00:10 volumio volumio[1219]: info: CoreCommandRouter::volumioGetState
Sep 01 10:00:10 volumio volumio[1219]: info: CorePlayQueue::getTrack 0
Sep 01 10:00:10 volumio volumio[1792]: thread 'main' panicked at 'Authentication failed with reason: BadCredentials', /build/cache/git/checkouts/librespot-6f197fd632ef9380/08d8bcc/core/src/connection/mod.rs:93:21
Sep 01 10:00:10 volumio volumio[1792]: stack backtrace:
Sep 01 10:00:10 volumio volumio[1219]: info: Listing playlists
Sep 01 10:00:10 volumio volumio[1792]: 0: 0x5653fef260cd - std::backtrace_rs::backtrace::libunwind::trace::hee598835bc88d35b
Sep 01 10:00:10 volumio volumio[1792]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/../../backtrace/src/backtrace/libunwind.rs:93:5
Sep 01 10:00:10 volumio volumio[1792]: 1: 0x5653fef260cd - std::backtrace_rs::backtrace::trace_unsynchronized::h9cdc730ba5cf5d72
Sep 01 10:00:10 volumio volumio[1792]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
Sep 01 10:00:10 volumio volumio[1792]: 2: 0x5653fef260cd - std::sys_common::backtrace::_print_fmt::h75aeaf7ed30e43fa
Sep 01 10:00:10 volumio volumio[1792]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:66:5
Sep 01 10:00:10 volumio volumio[1792]: 3: 0x5653fef260cd - ::fmt::h606862f787600875
Sep 01 10:00:10 volumio volumio[1792]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:45:22
Sep 01 10:00:10 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Sep 01 10:00:10 volumio volumio[1792]: 4: 0x5653fef4bf5c - core::fmt::write::he803f0f418caf762
Sep 01 10:00:10 volumio volumio[1792]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/fmt/mod.rs:1190:17
Sep 01 10:00:10 volumio volumio[1792]: 5: 0x5653fef1ecb8 - std::io::Write::write_fmt::h70bc45872f37e7bb
Sep 01 10:00:10 volumio volumio[1792]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/io/mod.rs:1657:15
Sep 01 10:00:10 volumio volumio[1792]: 6: 0x5653fef285a7 - std::sys_common::backtrace::_print::h64d038cf8ac3e13e
Sep 01 10:00:10 volumio volumio[1792]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:48:5
Sep 01 10:00:10 volumio volumio[1792]: 7: 0x5653fef285a7 - std::sys_common::backtrace::print::h359300b4a7fccf65
Sep 01 10:00:10 volumio volumio[1792]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:35:9
Sep 01 10:00:10 volumio volumio[1792]: 8: 0x5653fef285a7 - std::panicking::default_hook::{{closure}}::hf51be35e2f510149
Sep 01 10:00:10 volumio volumio[1792]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:295:22
Sep 01 10:00:10 volumio volumio[1792]: 9: 0x5653fef28270 - std::panicking::default_hook::h03ca0f22e1d2d25e
Sep 01 10:00:10 volumio volumio[1792]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:314:9
Sep 01 10:00:10 volumio volumio[1792]: 10: 0x5653fef28cf9 - std::panicking::rust_panic_with_hook::h3b7380e99b825b63
Sep 01 10:00:10 volumio volumio[1792]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:698:17
Sep 01 10:00:10 volumio volumio[1792]: 11: 0x5653fef289e7 - std::panicking::begin_panic_handler::{{closure}}::h8e849d0710154ce0
Sep 01 10:00:10 volumio volumio[1792]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:588:13
Sep 01 10:00:10 volumio volumio[1792]: 12: 0x5653fef26594 - std::sys_common::backtrace::__rust_end_short_backtrace::hedcdaddbd4c46cc5
Sep 01 10:00:10 volumio volumio[1792]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:138:18
Sep 01 10:00:10 volumio volumio[1792]: 13: 0x5653fef286f9 - rust_begin_unwind
Sep 01 10:00:10 volumio volumio[1792]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:584:5
Sep 01 10:00:10 volumio volumio[1792]: 14: 0x5653fea31f53 - core::panicking::panic_fmt::he1bbc7336d49a357
Sep 01 10:00:10 volumio volumio[1792]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/panicking.rs:143:14
Sep 01 10:00:10 volumio volumio[1792]: 15: 0x5653fec01f56 - futures::future::chain::Chain::poll::hf0e729e3d4d8df0d
Sep 01 10:00:10 volumio volumio[1792]: 16: 0x5653fec74a19 - as futures::future::Future>::poll::hb2bebc352335cc1a
Sep 01 10:00:10 volumio volumio[1792]: 17: 0x5653fec008e6 - futures::future::chain::Chain::poll::hda5263cfb178296b
Sep 01 10:00:10 volumio volumio[1792]: 18: 0x5653fec75fe1 - as futures::future::Future>::poll::h7445370ea1c2ee99
Sep 01 10:00:10 volumio volumio[1792]: 19: 0x5653fea5f736 - ::poll::hdecdb1a04917de4b
Sep 01 10:00:10 volumio volumio[1792]: 20: 0x5653fea77149 - futures::task_impl::std::set::h6dd4b73f744a06d4
Sep 01 10:00:10 volumio volumio[1792]: 21: 0x5653fea8d3bd - std::thread::local::LocalKey::with::hc9bf2e930c1fdc36
Sep 01 10:00:10 volumio volumio[1792]: 22: 0x5653fea73c56 - tokio_current_thread::Entered::block_on::h372d7b837fe25d26
Sep 01 10:00:10 volumio volumio[1792]: 23: 0x5653fea8cb48 - std::thread::local::LocalKey::with::h247079172a6ad00b
Sep 01 10:00:10 volumio volumio[1792]: 24: 0x5653fea768c5 - tokio::runtime::current_thread::runtime::Runtime::block_on::h538e89536cb974b3
Sep 01 10:00:10 volumio volumio[1792]: 25: 0x5653fea617e9 - vollibrespot::main::hf67292b633164777
Sep 01 10:00:10 volumio volumio[1792]: 26: 0x5653fea7bc73 - std::sys_common::backtrace::__rust_begin_short_backtrace::h9396fe1ba8d4dd7f
Sep 01 10:00:10 volumio volumio[1792]: 27: 0x5653fea9ece9 - std::rt::lang_start::{{closure}}::h0862538761d46dbc
Sep 01 10:00:10 volumio volumio[1219]: info: Received Get System Info
Sep 01 10:00:10 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 01 10:00:10 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 01 10:00:10 volumio volumio[1219]: info: Discovery: Getting this device information
Sep 01 10:00:10 volumio volumio[1219]: info: CoreCommandRouter::volumioGetState
Sep 01 10:00:10 volumio volumio[1219]: info: CorePlayQueue::getTrack 0
Sep 01 10:00:10 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 01 10:00:10 volumio volumio[1792]: 28: 0x5653fef257b1 - core::ops::function::impls:: for &F>::call_once::hb7014f43484a8b4e
Sep 01 10:00:10 volumio volumio[1792]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/ops/function.rs:259:13
Sep 01 10:00:10 volumio volumio[1792]: 29: 0x5653fef257b1 - std::panicking::try::do_call::h7bc9dc436daeb8c7
Sep 01 10:00:10 volumio volumio[1792]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:492:40
Sep 01 10:00:10 volumio volumio[1792]: 30: 0x5653fef257b1 - std::panicking::try::h653d68a27ff5f175
Sep 01 10:00:10 volumio volumio[1792]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:456:19
Sep 01 10:00:10 volumio volumio[1792]: 31: 0x5653fef257b1 - std::panic::catch_unwind::h9d739f9f59895e68
Sep 01 10:00:10 volumio volumio[1792]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panic.rs:137:14
Sep 01 10:00:10 volumio volumio[1792]: 32: 0x5653fef257b1 - std::rt::lang_start_internal::{{closure}}::hf006f2bc7ce22bbe
Sep 01 10:00:10 volumio volumio[1792]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/rt.rs:128:48
Sep 01 10:00:10 volumio volumio[1792]: 33: 0x5653fef257b1 - std::panicking::try::do_call::hfb39d6df61a2e69f
Sep 01 10:00:10 volumio volumio[1792]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:492:40
Sep 01 10:00:10 volumio volumio[1792]: 34: 0x5653fef257b1 - std::panicking::try::h13e2d225134958ac
Sep 01 10:00:10 volumio volumio[1792]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:456:19
Sep 01 10:00:10 volumio volumio[1792]: 35: 0x5653fef257b1 - std::panic::catch_unwind::h3bd49b5a5dfb1a50
Sep 01 10:00:10 volumio volumio[1792]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panic.rs:137:14
Sep 01 10:00:10 volumio volumio[1792]: 36: 0x5653fef257b1 - std::rt::lang_start_internal::h2ba92edce36c035e
Sep 01 10:00:10 volumio volumio[1792]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/rt.rs:128:20
Sep 01 10:00:10 volumio volumio[1792]: 37: 0x5653fea64562 - main
Sep 01 10:00:10 volumio volumio[1792]: 38: 0x7f339d8d309b - __libc_start_main
Sep 01 10:00:10 volumio volumio[1792]: 39: 0x5653fea3278a - _start
Sep 01 10:00:10 volumio volumio[1792]: 40: 0x0 -
Sep 01 10:00:10 volumio systemd[1]: volspotconnect.service: Main process exited, code=exited, status=101/n/a
Sep 01 10:00:10 volumio systemd[1]: volspotconnect.service: Failed with result 'exit-code'.
Sep 01 10:00:10 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Sep 01 10:00:10 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Sep 01 10:00:10 volumio volumio[1219]: info: CoreCommandRouter::volumioGetState
Sep 01 10:00:10 volumio volumio[1219]: info: CorePlayQueue::getTrack 0
Sep 01 10:00:11 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Sep 01 10:00:11 volumio volumio[1219]: info: Received Get System Info
Sep 01 10:00:11 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 01 10:00:11 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 01 10:00:11 volumio volumio[1219]: info: Discovery: Getting this device information
Sep 01 10:00:11 volumio volumio[1219]: info: CoreCommandRouter::volumioGetState
Sep 01 10:00:11 volumio volumio[1219]: info: CorePlayQueue::getTrack 0
Sep 01 10:00:11 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 01 10:00:11 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken
Sep 01 10:00:11 volumio volumio[1219]: info: Checking Spotify Web API
Sep 01 10:00:11 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Sep 01 10:00:11 volumio volumio[1219]: info: Received Get System Info
Sep 01 10:00:11 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 01 10:00:11 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 01 10:00:11 volumio volumio[1219]: info: Discovery: Getting this device information
Sep 01 10:00:11 volumio volumio[1219]: info: CoreCommandRouter::volumioGetState
Sep 01 10:00:11 volumio volumio[1219]: info: CorePlayQueue::getTrack 0
Sep 01 10:00:11 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 01 10:00:11 volumio systemd[1]: systemd-fsckd.service: Succeeded.
Sep 01 10:00:12 volumio volumio[1219]: verbose: New Socket.io Connection to 192.168.61.180 from 192.168.0.99 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/109.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 16
Sep 01 10:00:12 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Sep 01 10:00:12 volumio volumio[1219]: info: CoreCommandRouter::volumioGetVisibleSources
Sep 01 10:00:12 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 01 10:00:12 volumio volumio[1219]: info: CoreCommandRouter::volumioGetState
Sep 01 10:00:12 volumio volumio[1219]: info: CorePlayQueue::getTrack 0
Sep 01 10:00:12 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Sep 01 10:00:12 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Sep 01 10:00:12 volumio volumio[1219]: info: Received Get System Info
Sep 01 10:00:12 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 01 10:00:12 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 01 10:00:12 volumio volumio[1219]: info: Discovery: Getting this device information
Sep 01 10:00:12 volumio volumio[1219]: info: CoreCommandRouter::volumioGetState
Sep 01 10:00:12 volumio volumio[1219]: info: CorePlayQueue::getTrack 0
Sep 01 10:00:12 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 01 10:00:12 volumio volumio[1219]: info: CoreCommandRouter::volumioGetState
Sep 01 10:00:12 volumio volumio[1219]: info: CorePlayQueue::getTrack 0
Sep 01 10:00:12 volumio volumio[1219]: info: Listing playlists
Sep 01 10:00:12 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Sep 01 10:00:12 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken
Sep 01 10:00:12 volumio sh[735]: timed out
Sep 01 10:00:12 volumio dhcpcd[770]: timed out
Sep 01 10:00:12 volumio sh[735]: dhcpcd exited
Sep 01 10:00:12 volumio dhcpcd[770]: dhcpcd exited
Sep 01 10:00:12 volumio sh[735]: ifup: failed to bring up eth0
Sep 01 10:00:12 volumio systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE
Sep 01 10:00:12 volumio systemd[1]: ifup@eth0.service: Failed with result 'exit-code'.
Sep 01 10:00:12 volumio systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart.
Sep 01 10:00:12 volumio systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 2.
Sep 01 10:00:12 volumio systemd[1]: Stopped Volspotconnect2 Daemon.
Sep 01 10:00:12 volumio systemd[1]: Started Volspotconnect2 Daemon.
Sep 01 10:00:12 volumio volumio[1974]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31
Sep 01 10:00:12 volumio volumio[1974]: Reading Config from "/tmp/volspotify.toml"
Sep 01 10:00:12 volumio volumio[1974]: [Vollibrespot] : Using Alsa backend with device: volumio
Sep 01 10:00:12 volumio volumio[1974]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" }
Sep 01 10:00:12 volumio volumio[1974]: [Vollibrespot] : Connecting to AP "ap-gae2.spotify.com:443"
Sep 01 10:00:13 volumio systemd[1]: systemd-hostnamed.service: Succeeded.
Sep 01 10:00:13 volumio volumio[1974]: thread 'main' panicked at 'Authentication failed with reason: BadCredentials', /build/cache/git/checkouts/librespot-6f197fd632ef9380/08d8bcc/core/src/connection/mod.rs:93:21
Sep 01 10:00:13 volumio volumio[1974]: stack backtrace:
Sep 01 10:00:13 volumio volumio[1974]: 0: 0x564c36a810cd - std::backtrace_rs::backtrace::libunwind::trace::hee598835bc88d35b
Sep 01 10:00:13 volumio volumio[1974]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/../../backtrace/src/backtrace/libunwind.rs:93:5
Sep 01 10:00:13 volumio volumio[1974]: 1: 0x564c36a810cd - std::backtrace_rs::backtrace::trace_unsynchronized::h9cdc730ba5cf5d72
Sep 01 10:00:13 volumio volumio[1974]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
Sep 01 10:00:13 volumio volumio[1974]: 2: 0x564c36a810cd - std::sys_common::backtrace::_print_fmt::h75aeaf7ed30e43fa
Sep 01 10:00:13 volumio volumio[1974]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:66:5
Sep 01 10:00:13 volumio volumio[1974]: 3: 0x564c36a810cd - ::fmt::h606862f787600875
Sep 01 10:00:13 volumio volumio[1974]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:45:22
Sep 01 10:00:13 volumio volumio[1974]: 4: 0x564c36aa6f5c - core::fmt::write::he803f0f418caf762
Sep 01 10:00:13 volumio volumio[1974]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/fmt/mod.rs:1190:17
Sep 01 10:00:13 volumio volumio[1974]: 5: 0x564c36a79cb8 - std::io::Write::write_fmt::h70bc45872f37e7bb
Sep 01 10:00:13 volumio volumio[1974]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/io/mod.rs:1657:15
Sep 01 10:00:13 volumio volumio[1974]: 6: 0x564c36a835a7 - std::sys_common::backtrace::_print::h64d038cf8ac3e13e
Sep 01 10:00:13 volumio volumio[1974]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:48:5
Sep 01 10:00:13 volumio volumio[1974]: 7: 0x564c36a835a7 - std::sys_common::backtrace::print::h359300b4a7fccf65
Sep 01 10:00:13 volumio volumio[1974]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:35:9
Sep 01 10:00:13 volumio volumio[1974]: 8: 0x564c36a835a7 - std::panicking::default_hook::{{closure}}::hf51be35e2f510149
Sep 01 10:00:13 volumio volumio[1974]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:295:22
Sep 01 10:00:13 volumio volumio[1974]: 9: 0x564c36a83270 - std::panicking::default_hook::h03ca0f22e1d2d25e
Sep 01 10:00:13 volumio volumio[1974]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:314:9
Sep 01 10:00:13 volumio volumio[1974]: 10: 0x564c36a83cf9 - std::panicking::rust_panic_with_hook::h3b7380e99b825b63
Sep 01 10:00:13 volumio volumio[1974]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:698:17
Sep 01 10:00:13 volumio volumio[1974]: 11: 0x564c36a839e7 - std::panicking::begin_panic_handler::{{closure}}::h8e849d0710154ce0
Sep 01 10:00:13 volumio volumio[1974]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:588:13
Sep 01 10:00:13 volumio volumio[1974]: 12: 0x564c36a81594 - std::sys_common::backtrace::__rust_end_short_backtrace::hedcdaddbd4c46cc5
Sep 01 10:00:13 volumio volumio[1974]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:138:18
Sep 01 10:00:13 volumio volumio[1974]: 13: 0x564c36a836f9 - rust_begin_unwind
Sep 01 10:00:13 volumio volumio[1974]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:584:5
Sep 01 10:00:13 volumio volumio[1974]: 14: 0x564c3658cf53 - core::panicking::panic_fmt::he1bbc7336d49a357
Sep 01 10:00:13 volumio volumio[1974]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/panicking.rs:143:14
Sep 01 10:00:13 volumio volumio[1974]: 15: 0x564c3675cf56 - futures::future::chain::Chain::poll::hf0e729e3d4d8df0d
Sep 01 10:00:13 volumio volumio[1974]: 16: 0x564c367cfa19 - as futures::future::Future>::poll::hb2bebc352335cc1a
Sep 01 10:00:13 volumio volumio[1974]: 17: 0x564c3675b8e6 - futures::future::chain::Chain::poll::hda5263cfb178296b
Sep 01 10:00:13 volumio volumio[1974]: 18: 0x564c367d0fe1 - as futures::future::Future>::poll::h7445370ea1c2ee99
Sep 01 10:00:13 volumio volumio[1974]: 19: 0x564c365ba736 - ::poll::hdecdb1a04917de4b
Sep 01 10:00:13 volumio volumio[1974]: 20: 0x564c365d2149 - futures::task_impl::std::set::h6dd4b73f744a06d4
Sep 01 10:00:13 volumio volumio[1974]: 21: 0x564c365e83bd - std::thread::local::LocalKey::with::hc9bf2e930c1fdc36
Sep 01 10:00:13 volumio volumio[1974]: 22: 0x564c365cec56 - tokio_current_thread::Entered::block_on::h372d7b837fe25d26
Sep 01 10:00:13 volumio volumio[1974]: 23: 0x564c365e7b48 - std::thread::local::LocalKey::with::h247079172a6ad00b
Sep 01 10:00:13 volumio volumio[1974]: 24: 0x564c365d18c5 - tokio::runtime::current_thread::runtime::Runtime::block_on::h538e89536cb974b3
Sep 01 10:00:13 volumio volumio[1974]: 25: 0x564c365bc7e9 - vollibrespot::main::hf67292b633164777
Sep 01 10:00:13 volumio volumio[1974]: 26: 0x564c365d6c73 - std::sys_common::backtrace::__rust_begin_short_backtrace::h9396fe1ba8d4dd7f
Sep 01 10:00:13 volumio volumio[1974]: 27: 0x564c365f9ce9 - std::rt::lang_start::{{closure}}::h0862538761d46dbc
Sep 01 10:00:13 volumio volumio[1974]: 28: 0x564c36a807b1 - core::ops::function::impls:: for &F>::call_once::hb7014f43484a8b4e
Sep 01 10:00:13 volumio volumio[1974]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/ops/function.rs:259:13
Sep 01 10:00:13 volumio volumio[1974]: 29: 0x564c36a807b1 - std::panicking::try::do_call::h7bc9dc436daeb8c7
Sep 01 10:00:13 volumio volumio[1974]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:492:40
Sep 01 10:00:13 volumio volumio[1974]: 30: 0x564c36a807b1 - std::panicking::try::h653d68a27ff5f175
Sep 01 10:00:13 volumio volumio[1974]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:456:19
Sep 01 10:00:13 volumio volumio[1974]: 31: 0x564c36a807b1 - std::panic::catch_unwind::h9d739f9f59895e68
Sep 01 10:00:13 volumio volumio[1974]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panic.rs:137:14
Sep 01 10:00:13 volumio volumio[1974]: 32: 0x564c36a807b1 - std::rt::lang_start_internal::{{closure}}::hf006f2bc7ce22bbe
Sep 01 10:00:13 volumio volumio[1974]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/rt.rs:128:48
Sep 01 10:00:13 volumio volumio[1974]: 33: 0x564c36a807b1 - std::panicking::try::do_call::hfb39d6df61a2e69f
Sep 01 10:00:13 volumio volumio[1974]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:492:40
Sep 01 10:00:13 volumio volumio[1974]: 34: 0x564c36a807b1 - std::panicking::try::h13e2d225134958ac
Sep 01 10:00:13 volumio volumio[1974]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:456:19
Sep 01 10:00:13 volumio volumio[1974]: 35: 0x564c36a807b1 - std::panic::catch_unwind::h3bd49b5a5dfb1a50
Sep 01 10:00:13 volumio volumio[1974]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panic.rs:137:14
Sep 01 10:00:13 volumio volumio[1974]: 36: 0x564c36a807b1 - std::rt::lang_start_internal::h2ba92edce36c035e
Sep 01 10:00:13 volumio volumio[1974]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/rt.rs:128:20
Sep 01 10:00:13 volumio volumio[1974]: 37: 0x564c365bf562 - main
Sep 01 10:00:13 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Sep 01 10:00:13 volumio volumio[1974]: 38: 0x7f394e43309b - __libc_start_main
Sep 01 10:00:13 volumio volumio[1974]: 39: 0x564c3658d78a - _start
Sep 01 10:00:13 volumio volumio[1974]: 40: 0x0 -
Sep 01 10:00:13 volumio volumio[1219]: info: Received Get System Info
Sep 01 10:00:13 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 01 10:00:13 volumio systemd[1]: volspotconnect.service: Main process exited, code=exited, status=101/n/a
Sep 01 10:00:13 volumio systemd[1]: volspotconnect.service: Failed with result 'exit-code'.
Sep 01 10:00:13 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 01 10:00:13 volumio volumio[1219]: info: Discovery: Getting this device information
Sep 01 10:00:13 volumio volumio[1219]: info: CoreCommandRouter::volumioGetState
Sep 01 10:00:13 volumio volumio[1219]: info: CorePlayQueue::getTrack 0
Sep 01 10:00:13 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 01 10:00:13 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken
Sep 01 10:00:13 volumio sudo[1983]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Sep 01 10:00:13 volumio sudo[1983]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 10:00:13 volumio sudo[1983]: pam_unix(sudo:session): session closed for user root
Sep 01 10:00:13 volumio sudo[1986]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Sep 01 10:00:13 volumio sudo[1986]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 10:00:13 volumio sudo[1986]: pam_unix(sudo:session): session closed for user root
Sep 01 10:00:13 volumio sudo[1989]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Sep 01 10:00:13 volumio sudo[1989]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 10:00:13 volumio systemd[1]: Started UPnP Renderer front-end to MPD.
Sep 01 10:00:13 volumio sudo[1989]: pam_unix(sudo:session): session closed for user root
Sep 01 10:00:13 volumio volumio[1219]: info: Upmpdcli Daemon Started
Sep 01 10:00:13 volumio volumio[1219]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory
Sep 01 10:00:13 volumio sudo[1523]: pam_unix(sudo:session): session closed for user root
Sep 01 10:00:13 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation.
Sep 01 10:00:13 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -115
Sep 01 10:00:13 volumio kernel: CIFS: Attempting to mount //192.168.0.8/Download/2_Audio/Demo
Sep 01 10:00:13 volumio volumio[1219]: info: Cannot mount NAS rutracker at system boot, trial number 1 ,retrying in 5 seconds
Sep 01 10:00:14 volumio volumio[1991]: Generating RSA private key, 4096 bit long modulus (2 primes)
Sep 01 10:00:15 volumio systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart.
Sep 01 10:00:15 volumio systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 3.
Sep 01 10:00:15 volumio systemd[1]: Stopped Volspotconnect2 Daemon.
Sep 01 10:00:15 volumio systemd[1]: Started Volspotconnect2 Daemon.
Sep 01 10:00:15 volumio volumio[2007]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31
Sep 01 10:00:15 volumio volumio[2007]: Reading Config from "/tmp/volspotify.toml"
Sep 01 10:00:15 volumio volumio[2007]: [Vollibrespot] : Using Alsa backend with device: volumio
Sep 01 10:00:15 volumio volumio[2007]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" }
Sep 01 10:00:15 volumio volumio[2007]: [Vollibrespot] : Connecting to AP "ap-gae2.spotify.com:443"
Sep 01 10:00:15 volumio volumio[2007]: [Vollibrespot] : Could not connect to server: bytes remaining on stream
Sep 01 10:00:15 volumio volumio[1991]: ......................................................................................................++++
Sep 01 10:00:16 volumio volumio[1219]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 01 10:00:16 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Sep 01 10:00:16 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken
Sep 01 10:00:16 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Sep 01 10:00:16 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Sep 01 10:00:16 volumio volumio[1219]: info: Received Get System Version
Sep 01 10:00:16 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 01 10:00:17 volumio volumio[1219]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
Sep 01 10:00:17 volumio volumio[1219]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
Sep 01 10:00:17 volumio volumio[1219]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
Sep 01 10:00:17 volumio volumio[1219]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
Sep 01 10:00:17 volumio volumio[1219]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
Sep 01 10:00:17 volumio volumio[1219]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
Sep 01 10:00:17 volumio volumio[1219]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
Sep 01 10:00:17 volumio volumio[1219]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
Sep 01 10:00:17 volumio volumio[1219]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
Sep 01 10:00:17 volumio volumio[1219]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
Sep 01 10:00:17 volumio volumio[1219]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
Sep 01 10:00:17 volumio volumio[1219]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
Sep 01 10:00:17 volumio volumio[1219]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
Sep 01 10:00:17 volumio volumio[1219]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
Sep 01 10:00:17 volumio volumio[1219]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
Sep 01 10:00:17 volumio volumio[1219]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
Sep 01 10:00:17 volumio volumio[1219]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
Sep 01 10:00:17 volumio volumio[1219]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
Sep 01 10:00:17 volumio volumio[1219]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
Sep 01 10:00:17 volumio volumio[1219]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
Sep 01 10:00:17 volumio volumio[1219]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
Sep 01 10:00:17 volumio volumio[1219]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
Sep 01 10:00:17 volumio volumio[1219]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
Sep 01 10:00:17 volumio volumio[1219]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
Sep 01 10:00:17 volumio volumio[1219]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
Sep 01 10:00:17 volumio volumio[1219]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
Sep 01 10:00:17 volumio volumio[1219]: info: Adding plugin bluetooth to MyMusic Plugins
Sep 01 10:00:17 volumio volumio[1219]: info: Adding plugin multiroom to MyMusic Plugins
Sep 01 10:00:17 volumio volumio[1219]: info: Adding plugin metavolumio to MyMusic Plugins
Sep 01 10:00:17 volumio volumio[1219]: info: Adding plugin cd_controller to MyMusic Plugins
Sep 01 10:00:17 volumio volumio[1219]: info: Adding plugin smart_inputs to MyMusic Plugins
Sep 01 10:00:17 volumio volumio[1219]: info: Adding plugin tidalconnect to MyMusic Plugins
Sep 01 10:00:17 volumio volumio[1219]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
Sep 01 10:00:17 volumio volumio[1991]: ............................................................................................................................................++++
Sep 01 10:00:17 volumio volumio[1991]: e is 65537 (0x010001)
Sep 01 10:00:17 volumio volumio[1991]: writing RSA key
Sep 01 10:00:17 volumio volumio[1219]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
Sep 01 10:00:17 volumio volumio[1219]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
Sep 01 10:00:17 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 01 10:00:17 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 01 10:00:17 volumio volumio[1219]: info: Starting MyVolumio Remote Streaming Endpoints
Sep 01 10:00:17 volumio volumio[1219]: info: MyVolumio login type: Token
Sep 01 10:00:17 volumio volumio[1219]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
Sep 01 10:00:17 volumio volumio[1219]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
Sep 01 10:00:18 volumio volumio[1219]: info: Starting Streaming Service Transparent Proxy
Sep 01 10:00:18 volumio volumio[1219]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Sep 01 10:00:18 volumio volumio[1219]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Sep 01 10:00:18 volumio volumio[1219]: info: Streaming services startup
Sep 01 10:00:18 volumio volumio[1219]: info: Starting Streaming Daemon
Sep 01 10:00:18 volumio sudo[2042]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Sep 01 10:00:18 volumio sudo[2042]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 10:00:18 volumio sudo[2042]: pam_unix(sudo:session): session closed for user root
Sep 01 10:00:18 volumio volumio[1219]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
Sep 01 10:00:18 volumio volumio[1219]: error: Cannot start Volumio Streaming Daemon
Sep 01 10:00:18 volumio volumio[1219]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Sep 01 10:00:18 volumio volumio[1219]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Sep 01 10:00:18 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 01 10:00:18 volumio sudo[2050]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.8/Download/2_Audio/rutracker /mnt/NAS/rutracker
Sep 01 10:00:18 volumio sudo[2050]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 10:00:19 volumio volumio[1219]: STREAMING PROXY: Starting server on port 3245
Sep 01 10:00:19 volumio volumio[1219]: Node JS runtime: 14
Sep 01 10:00:19 volumio volumio[1219]: error: MyVolumio Custom Token format not valid, refreshing it
Sep 01 10:00:19 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 01 10:00:20 volumio volumio[1219]: info: MyVolumio login type: Token
Sep 01 10:00:21 volumio volumio[1219]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN
Sep 01 10:00:22 volumio volumio[1219]: info: MyVolumio token set successfully
Sep 01 10:00:22 volumio volumio[1219]: info: MYVOLUMIO: Adding device
Sep 01 10:00:22 volumio volumio[1219]: info: MYVOLUMIO: Evaluating Server
Sep 01 10:00:22 volumio volumio[1219]: info: MyVolumio status changed
Sep 01 10:00:22 volumio volumio[1219]: info: Streaming services startup
Sep 01 10:00:22 volumio volumio[1219]: info: Starting Streaming Daemon
Sep 01 10:00:22 volumio volumio[1219]: info: Removing browser output: myVolumio user plan is not superstar
Sep 01 10:00:22 volumio volumio[1219]: info: Removing audio output:
Sep 01 10:00:22 volumio volumio[1219]: info: Stoppping Tunnel 1
Sep 01 10:00:22 volumio sudo[2072]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Sep 01 10:00:22 volumio sudo[2072]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 10:00:22 volumio sudo[2072]: pam_unix(sudo:session): session closed for user root
Sep 01 10:00:22 volumio volumio[1219]: error: Cannot start Volumio Streaming Daemon
Sep 01 10:00:22 volumio volumio[1219]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Sep 01 10:00:22 volumio volumio[1219]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Sep 01 10:00:22 volumio sudo[2075]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service
Sep 01 10:00:22 volumio sudo[2075]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 10:00:22 volumio sudo[2075]: pam_unix(sudo:session): session closed for user root
Sep 01 10:00:22 volumio volumio[1219]: info: Remote SSH Stopped
Sep 01 10:00:22 volumio volumio[1219]: info: Setting Geolocation for MyVolumio to as1
Sep 01 10:00:22 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 01 10:00:22 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 01 10:00:22 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 01 10:00:23 volumio volumio[1219]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"}
Sep 01 10:00:23 volumio volumio[1219]: info: Updating MyVolumio device info
Sep 01 10:00:23 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 01 10:00:23 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 01 10:00:24 volumio sudo[1493]: pam_unix(sudo:session): session closed for user root
Sep 01 10:00:24 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation.
Sep 01 10:00:24 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -115
Sep 01 10:00:24 volumio kernel: CIFS: Attempting to mount //192.168.0.8/Download/2_Audio/Pop
Sep 01 10:00:24 volumio volumio[1219]: info: Cannot mount NAS QNap-Demo at system boot, trial number 1 ,retrying in 5 seconds
Sep 01 10:00:24 volumio volumio[1219]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"}
Sep 01 10:00:26 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Sep 01 10:00:26 volumio volumio[1219]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Sep 01 10:00:26 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Sep 01 10:00:26 volumio volumio[1219]: info: Received Get System Version
Sep 01 10:00:26 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 01 10:00:26 volumio volumio[1219]: info: Received Get System Info
Sep 01 10:00:26 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 01 10:00:26 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 01 10:00:26 volumio volumio[1219]: info: Discovery: Getting this device information
Sep 01 10:00:26 volumio volumio[1219]: info: CoreCommandRouter::volumioGetState
Sep 01 10:00:26 volumio volumio[1219]: info: CorePlayQueue::getTrack 0
Sep 01 10:00:26 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 01 10:00:27 volumio volumio[1219]: info: MYVOLUMIO: Adding device
Sep 01 10:00:27 volumio volumio[1219]: info: MYVOLUMIO: Evaluating Server
Sep 01 10:00:28 volumio volumio[1219]: info: Setting Geolocation for MyVolumio to as1
Sep 01 10:00:28 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 01 10:00:28 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Sep 01 10:00:28 volumio volumio[1219]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Sep 01 10:00:28 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Sep 01 10:00:28 volumio volumio[1219]: info: Received Get System Version
Sep 01 10:00:28 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 01 10:00:28 volumio volumio[1219]: info: Received Get System Info
Sep 01 10:00:28 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 01 10:00:28 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 01 10:00:28 volumio volumio[1219]: info: Discovery: Getting this device information
Sep 01 10:00:28 volumio volumio[1219]: info: CoreCommandRouter::volumioGetState
Sep 01 10:00:28 volumio volumio[1219]: info: CorePlayQueue::getTrack 0
Sep 01 10:00:28 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 01 10:00:29 volumio volumio[1219]: info: Updating MyVolumio device info
Sep 01 10:00:29 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 01 10:00:29 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 01 10:00:29 volumio sudo[2093]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=readonly,password=readonly,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.8/Download/2_Audio/Demo /mnt/NAS/QNap-Demo
Sep 01 10:00:29 volumio sudo[2093]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 10:00:29 volumio volumio[1219]: info: CoreCommandRouter::volumioGetState
Sep 01 10:00:29 volumio volumio[1219]: info: CorePlayQueue::getTrack 0
Sep 01 10:00:30 volumio volumio[1219]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"}
Sep 01 10:00:30 volumio volumio[1219]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"}
Sep 01 10:00:32 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Sep 01 10:00:32 volumio volumio[1219]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 17
Sep 01 10:00:33 volumio volumio[1219]: info: CoreCommandRouter::volumioGetState
Sep 01 10:00:33 volumio volumio[1219]: info: CorePlayQueue::getTrack 0
Sep 01 10:00:34 volumio sudo[1491]: pam_unix(sudo:session): session closed for user root
Sep 01 10:00:34 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation.
Sep 01 10:00:34 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -115
Sep 01 10:00:34 volumio kernel: CIFS: Attempting to mount //192.168.0.8/Download/2_Audio/CD_Hot
Sep 01 10:00:34 volumio volumio[1219]: info: Cannot mount NAS QNap-Pop at system boot, trial number 1 ,retrying in 5 seconds
Sep 01 10:00:35 volumio volumio[1219]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 01 10:00:35 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Sep 01 10:00:35 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork
Sep 01 10:00:35 volumio sudo[2100]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0
Sep 01 10:00:35 volumio sudo[2100]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 10:00:35 volumio sudo[2100]: pam_unix(sudo:session): session closed for user root
Sep 01 10:00:35 volumio sudo[2107]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Sep 01 10:00:35 volumio sudo[2107]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 10:00:35 volumio sudo[2107]: pam_unix(sudo:session): session closed for user root
Sep 01 10:00:35 volumio sudo[2115]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Sep 01 10:00:35 volumio sudo[2115]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 10:00:35 volumio sudo[2115]: pam_unix(sudo:session): session closed for user root
Sep 01 10:00:35 volumio sudo[2120]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Sep 01 10:00:35 volumio sudo[2120]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 10:00:35 volumio sudo[2120]: pam_unix(sudo:session): session closed for user root
Sep 01 10:00:35 volumio sudo[2126]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Sep 01 10:00:35 volumio sudo[2126]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 10:00:35 volumio sudo[2126]: pam_unix(sudo:session): session closed for user root
Sep 01 10:00:35 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache
Sep 01 10:00:35 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks
Sep 01 10:00:35 volumio sudo[2129]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Sep 01 10:00:35 volumio sudo[2129]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 10:00:35 volumio sudo[2129]: pam_unix(sudo:session): session closed for user root
Sep 01 10:00:35 volumio sudo[2132]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Sep 01 10:00:35 volumio sudo[2132]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 10:00:37 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 01 10:00:37 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 01 10:00:37 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Sep 01 10:00:37 volumio volumio-remote-updater[781]: No test mode
Sep 01 10:00:37 volumio volumio-remote-updater[781]: No alpha test mode
Sep 01 10:00:37 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Sep 01 10:00:37 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 01 10:00:37 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 01 10:00:37 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Sep 01 10:00:37 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Sep 01 10:00:37 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Sep 01 10:00:37 volumio volumio[1219]: info: CoreCommandRouter::volumioGetBrowseSources
Sep 01 10:00:37 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 01 10:00:38 volumio volumio[1219]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES
- Improved translations
- Fix for controlling Volumio device from another one
- Improved speed for default albumart
- Fix for Supersearch bar on Iphone
- Fix for Network connection on Wizard
NEW ADDITIONS
- Kanji conversion for Japanese Keyboard
- Facility for third party UIs
- Add zoom setting on Vivaldi kiosk
","title":"Update v3.742","updateavailable":true}
Sep 01 10:00:38 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Sep 01 10:00:38 volumio sudo[2132]: pam_unix(sudo:session): session closed for user root
Sep 01 10:00:38 volumio volumio[1219]: error: MyVolumio Plugin failed to authenticate in a timely fashion
Sep 01 10:00:38 volumio volumio[1219]: info: Completed starting MyVolumio Plugin
Sep 01 10:00:38 volumio volumio[1219]: info: BOOT COMPLETED
Sep 01 10:00:38 volumio volumio[1219]: [Metrics] CommandRouter: 38s 921.96ms
Sep 01 10:00:38 volumio volumio[1219]: info: CoreCommandRouter::volumiosetStartupVolume
Sep 01 10:00:38 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 01 10:00:38 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 01 10:00:38 volumio volumio[1219]: info: CoreCommandRouter::Close All Modals sent
Sep 01 10:00:38 volumio volumio[1219]: info: CoreCommandRouter::Close All Modals sent
Sep 01 10:00:39 volumio sudo[2140]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=readonly,password=readonly,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.8/Download/2_Audio/Pop /mnt/NAS/QNap-Pop
Sep 01 10:00:39 volumio sudo[2140]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 10:00:39 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Sep 01 10:00:39 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Sep 01 10:00:39 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Sep 01 10:00:44 volumio sudo[1518]: pam_unix(sudo:session): session closed for user root
Sep 01 10:00:44 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation.
Sep 01 10:00:44 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -115
Sep 01 10:00:44 volumio kernel: CIFS: Attempting to mount //192.168.0.8/Download/2_Audio/Classical
Sep 01 10:00:44 volumio volumio[1219]: info: Cannot mount NAS QNap-CD-Hot at system boot, trial number 1 ,retrying in 5 seconds
Sep 01 10:00:49 volumio sudo[2191]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=readonly,password=readonly,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.8/Download/2_Audio/CD_Hot /mnt/NAS/QNap-CD-Hot
Sep 01 10:00:49 volumio sudo[2191]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 10:00:54 volumio sudo[1496]: pam_unix(sudo:session): session closed for user root
Sep 01 10:00:54 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation.
Sep 01 10:00:54 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -115
Sep 01 10:00:54 volumio kernel: CIFS: Attempting to mount //192.168.0.8/Download/2_Audio/Jazz
Sep 01 10:00:54 volumio volumio[1219]: info: Cannot mount NAS QNap-Classical at system boot, trial number 1 ,retrying in 5 seconds
Sep 01 10:00:55 volumio volumio[1219]: info: CoreCommandRouter::volumioGetState
Sep 01 10:00:55 volumio volumio[1219]: info: CorePlayQueue::getTrack 0
Sep 01 10:00:57 volumio volumio[1219]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 01 10:00:57 volumio volumio[1219]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 01 10:00:57 volumio volumio[1219]: info: Retrieving Cloud Streaming UI
Sep 01 10:00:57 volumio volumio[1219]: info: Getting Tidal Cloud Configuration
Sep 01 10:00:57 volumio volumio[1219]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 01 10:00:57 volumio volumio[1219]: info: Getting Qobuz Cloud Configuration
Sep 01 10:00:57 volumio volumio[1219]: info: Asking plugin for UI Config
Sep 01 10:00:57 volumio volumio[1219]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 01 10:00:57 volumio volumio[1219]: info: Getting Spotify Cloud Configuration
Sep 01 10:00:57 volumio volumio[1219]: info: Asking plugin for UI Config
Sep 01 10:00:57 volumio volumio[1219]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 01 10:00:57 volumio volumio[1219]: info: Saving Spotify Acccount
Sep 01 10:00:57 volumio volumio[1219]: info: Got Tidal Cloud Configuration
Sep 01 10:00:57 volumio volumio[1219]: info: Got it
Sep 01 10:00:57 volumio volumio[1219]: info: Got it
Sep 01 10:00:57 volumio volumio[1219]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Sep 01 10:00:57 volumio volumio[1219]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 01 10:00:57 volumio volumio[1219]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
Sep 01 10:00:57 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Sep 01 10:00:57 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Sep 01 10:00:57 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Sep 01 10:00:57 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Sep 01 10:00:57 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 01 10:00:57 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 01 10:00:57 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 01 10:00:57 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 01 10:00:57 volumio volumio[1219]: info: CoreCommandRouter::volumioGetBrowseSources
Sep 01 10:00:57 volumio volumio[1219]: info: CoreCommandRouter::volumioGetBrowseSources
Sep 01 10:00:57 volumio volumio[1219]: info: CoreCommandRouter::volumioGetBrowseSources
Sep 01 10:00:57 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Sep 01 10:00:57 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Sep 01 10:00:59 volumio sudo[2217]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=readonly,password=readonly,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.8/Download/2_Audio/Classical /mnt/NAS/QNap-Classical
Sep 01 10:00:59 volumio sudo[2217]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 10:01:01 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Sep 01 10:01:05 volumio sudo[1516]: pam_unix(sudo:session): session closed for user root
Sep 01 10:01:05 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation.
Sep 01 10:01:05 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -115
Sep 01 10:01:05 volumio kernel: CIFS: Attempting to mount //192.168.0.8/Download/2_Audio/Chinese
Sep 01 10:01:05 volumio volumio[1219]: info: Cannot mount NAS QNap-Jazz at system boot, trial number 1 ,retrying in 5 seconds
Sep 01 10:01:05 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Sep 01 10:01:07 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare
Sep 01 10:01:08 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Sep 01 10:01:09 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Sep 01 10:01:10 volumio sudo[2247]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=readonly,password=readonly,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.8/Download/2_Audio/Jazz /mnt/NAS/QNap-Jazz
Sep 01 10:01:10 volumio sudo[2247]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 10:01:13 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Sep 01 10:01:14 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare
Sep 01 10:01:15 volumio sudo[1504]: pam_unix(sudo:session): session closed for user root
Sep 01 10:01:15 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation.
Sep 01 10:01:15 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -115
Sep 01 10:01:15 volumio kernel: CIFS: Attempting to mount //192.168.0.8/Download/2_Audio/rutracker
Sep 01 10:01:15 volumio volumio[1219]: info: Cannot mount NAS QNap-Chinese at system boot, trial number 1 ,retrying in 5 seconds
Sep 01 10:01:15 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Sep 01 10:01:17 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare
Sep 01 10:01:17 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Sep 01 10:01:18 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Sep 01 10:01:20 volumio sudo[2284]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=readonly,password=readonly,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.8/Download/2_Audio/Chinese /mnt/NAS/QNap-Chinese
Sep 01 10:01:20 volumio sudo[2284]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 01 10:01:20 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare
Sep 01 10:01:21 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Sep 01 10:01:21 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Sep 01 10:01:23 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare
Sep 01 10:01:24 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Sep 01 10:01:25 volumio sudo[2050]: pam_unix(sudo:session): session closed for user root
Sep 01 10:01:25 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation.
Sep 01 10:01:25 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -115
Sep 01 10:01:25 volumio kernel: CIFS: Attempting to mount //192.168.0.8/Download/2_Audio/Demo
Sep 01 10:01:25 volumio volumio[1219]: info: Cannot mount NAS rutracker at system boot, trial number 2 ,retrying in 5 seconds
Sep 01 10:01:25 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Sep 01 10:01:26 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare
Sep 01 10:01:27 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Sep 01 10:01:28 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare
Sep 01 10:01:29 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Sep 01 10:01:29 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Sep 01 10:01:30 volumio volumio[1219]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 01 10:01:30 volumio volumio[1219]: TypeError: Cannot read property 'replace' of undefined
Sep 01 10:01:30 volumio volumio[1219]: at ControllerNetworkfs.mountShare (/volumio/app/plugins/system_controller/networkfs/index.js:202:28)
Sep 01 10:01:30 volumio volumio[1219]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/networkfs/index.js:255:20)
Sep 01 10:01:30 volumio volumio[1219]: at listOnTimeout (internal/timers.js:557:17)
Sep 01 10:01:30 volumio volumio[1219]: at processTimers (internal/timers.js:500:7)
Sep 01 10:01:30 volumio volumio[1219]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 01 10:01:30 volumio sudo[2323]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-01 10:00
Sep 01 10:01:30 volumio sudo[2323]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 10 (buster)"
NAME="Debian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="4b122b2365bb8c09786cd63b50d1ea6db780eb4e"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 09:13:11 PM CEST"
VOLUMIO_VERSION="3.703"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="ac782621640fcc70c07e91a81b6d958b"