-- Logs begin at Thu 2019-02-14 13:11:58 +03, end at Tue 2024-12-03 01:56:46 +03. -- Dec 03 01:56:37 volumio systemd-timedated[1155]: Changed local time to Mon Dec 2 22:56:37 2024 Dec 03 01:56:37 volumio sudo[1109]: pam_unix(sudo:session): session closed for user root Dec 03 01:56:37 volumio volumio-time-update[802]: volumio-time-update-util: System time updated successfully. Dec 03 01:56:37 volumio systemd[1]: Starting Daily apt download activities... Dec 03 01:56:37 volumio systemd[1]: Started Volumio Time Update Utility. Dec 03 01:56:37 volumio systemd[1]: Reached target Multi-User System. Dec 03 01:56:37 volumio systemd[1]: Reached target Graphical Interface. Dec 03 01:56:37 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Dec 03 01:56:37 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Dec 03 01:56:37 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Dec 03 01:56:37 volumio ifplugd(eth0)[960]: Program executed successfully. Dec 03 01:56:37 volumio volumio[1072]: info: ------------------------------------------- Dec 03 01:56:37 volumio volumio[1072]: info: ----- Volumio3 ---- Dec 03 01:56:37 volumio volumio[1072]: info: ------------------------------------------- Dec 03 01:56:37 volumio volumio[1072]: info: ----- System startup ---- Dec 03 01:56:37 volumio volumio[1072]: info: ------------------------------------------- Dec 03 01:56:37 volumio systemd[1]: apt-daily.service: Succeeded. Dec 03 01:56:37 volumio systemd[1]: Started Daily apt download activities. Dec 03 01:56:37 volumio systemd[1]: Starting Daily apt upgrade and clean activities... Dec 03 01:56:37 volumio volumio[1072]: info: MYVOLUMIO Environment detected Dec 03 01:56:37 volumio systemd[1]: apt-daily-upgrade.service: Succeeded. Dec 03 01:56:37 volumio systemd[1]: Started Daily apt upgrade and clean activities. Dec 03 01:56:37 volumio systemd[1]: Startup finished in 14.023s (kernel) + 20.224s (userspace) = 34.247s. Dec 03 01:56:37 volumio volumio[1072]: info: Plugin folders cleanup Dec 03 01:56:37 volumio volumio[1072]: info: Scanning into folder /volumio/app/plugins/ Dec 03 01:56:37 volumio volumio[1072]: info: Scanning category audio_interface Dec 03 01:56:37 volumio volumio[1072]: info: Scanning category miscellanea Dec 03 01:56:37 volumio volumio[1072]: info: Scanning category music_service Dec 03 01:56:37 volumio volumio[1072]: info: Scanning category plugins.json Dec 03 01:56:37 volumio volumio[1072]: info: Scanning category system_controller Dec 03 01:56:37 volumio volumio[1072]: info: Scanning category user_interface Dec 03 01:56:37 volumio volumio[1072]: info: Scanning into folder /data/plugins/ Dec 03 01:56:37 volumio volumio[1072]: info: Plugin folders cleanup completed Dec 03 01:56:37 volumio volumio[1072]: info: ------------------------------------------- Dec 03 01:56:37 volumio volumio[1072]: info: ----- Core plugins startup ---- Dec 03 01:56:37 volumio volumio[1072]: info: ------------------------------------------- Dec 03 01:56:37 volumio volumio[1072]: info: Loading plugins from folder /volumio/app/plugins/ Dec 03 01:56:37 volumio volumio[1072]: info: Adding plugin upnp to MyMusic Plugins Dec 03 01:56:37 volumio volumio[1072]: info: Adding plugin airplay_emulation to MyMusic Plugins Dec 03 01:56:37 volumio volumio[1072]: info: Adding plugin upnp_browser to MyMusic Plugins Dec 03 01:56:37 volumio volumio[1072]: info: Loading plugins from folder /data/plugins/ Dec 03 01:56:37 volumio volumio[1072]: info: Loading plugin "system"... Dec 03 01:56:37 volumio volumio[1072]: info: Loading plugin "appearance"... Dec 03 01:56:38 volumio volumio[1072]: info: Loading plugin "network"... Dec 03 01:56:38 volumio volumio[1072]: info: Refreshing Cached IP Addresses Dec 03 01:56:38 volumio sudo[1287]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 03 01:56:38 volumio sudo[1287]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 03 01:56:38 volumio sudo[1287]: pam_unix(sudo:session): session closed for user root Dec 03 01:56:38 volumio sudo[1289]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 03 01:56:38 volumio sudo[1289]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 03 01:56:38 volumio sudo[1289]: pam_unix(sudo:session): session closed for user root Dec 03 01:56:38 volumio volumio[1072]: info: Loading plugin "services"... Dec 03 01:56:38 volumio volumio[1072]: info: Loading plugin "alsa_controller"... Dec 03 01:56:38 volumio sudo[1298]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 03 01:56:38 volumio sudo[1298]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 03 01:56:38 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 03 01:56:38 volumio volumio[1072]: info: Loading plugin "wizard"... Dec 03 01:56:38 volumio volumio[1072]: info: Loading plugin "networkfs"... Dec 03 01:56:38 volumio volumio[1072]: info: Starting Udev Watcher for removable devices Dec 03 01:56:38 volumio volumio[1072]: info: Ignoring mount for partition: boot Dec 03 01:56:38 volumio volumio[1072]: info: Ignoring mount for partition: volumio Dec 03 01:56:38 volumio volumio[1072]: info: Ignoring mount for partition: volumio_data Dec 03 01:56:38 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 03 01:56:38 volumio volumio[1072]: info: Loading plugin "volumio_command_line_client"... Dec 03 01:56:38 volumio volumio[1072]: info: Loading plugin "upnp"... Dec 03 01:56:38 volumio volumio[1072]: info: [1733180198114] Starting Upmpd Daemon Dec 03 01:56:38 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 03 01:56:38 volumio volumio[1072]: info: Loading plugin "my_music"... Dec 03 01:56:38 volumio volumio[1072]: info: Loading plugin "mpd"... Dec 03 01:56:38 volumio volumio[1072]: info: Loading plugin "upnp_browser"... Dec 03 01:56:38 volumio volumio[1072]: info: Loading plugin "alarm-clock"... Dec 03 01:56:38 volumio volumio[1072]: info: Loading plugin "airplay_emulation"... Dec 03 01:56:38 volumio volumio[1072]: info: Starting Shairport Sync Dec 03 01:56:38 volumio volumio[1072]: info: Loading plugin "last_100"... Dec 03 01:56:38 volumio volumio[1072]: info: Loading plugin "webradio"... Dec 03 01:56:38 volumio volumio[1072]: info: Loading plugin "i2s_dacs"... Dec 03 01:56:38 volumio volumio[1072]: info: I2S DAC not set, start Auto-detection Dec 03 01:56:38 volumio volumio[1072]: info: Loading plugin "volumiodiscovery"... Dec 03 01:56:38 volumio volumio[1072]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 03 01:56:38 volumio node[1072]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 03 01:56:38 volumio volumio[1072]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 03 01:56:38 volumio volumio[1072]: *** WARNING *** For more information see Dec 03 01:56:38 volumio volumio[1072]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 03 01:56:38 volumio volumio[1072]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 03 01:56:38 volumio volumio[1072]: *** WARNING *** For more information see Dec 03 01:56:38 volumio node[1072]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 03 01:56:38 volumio node[1072]: *** WARNING *** For more information see Dec 03 01:56:38 volumio node[1072]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 03 01:56:38 volumio node[1072]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 03 01:56:38 volumio node[1072]: *** WARNING *** For more information see Dec 03 01:56:38 volumio volumio[1072]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 03 01:56:38 volumio volumio[1072]: info: Discovery: Started advertising with name: Volumio Dec 03 01:56:38 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 03 01:56:38 volumio volumio[1072]: info: Loading plugin "outputs"... Dec 03 01:56:38 volumio volumio[1072]: info: Loading plugin "albumart"... Dec 03 01:56:38 volumio volumio[1072]: info: Plugin example_plugin is not enabled Dec 03 01:56:38 volumio volumio[1072]: info: Loading plugin "inputs"... Dec 03 01:56:38 volumio volumio[1072]: info: Loading plugin "updater_comm"... Dec 03 01:56:38 volumio volumio[1072]: Forking 3 albumart workers Dec 03 01:56:38 volumio volumio[1072]: info: Plugin mpdemulation is not enabled Dec 03 01:56:38 volumio volumio[1072]: info: Loading plugin "rest_api"... Dec 03 01:56:38 volumio volumio[1072]: info: Loading plugin "websocket"... Dec 03 01:56:38 volumio volumio[1072]: info: Starting Socket.io Server version 2.3.0 Dec 03 01:56:38 volumio volumio[1072]: info: Loading i18n strings for locale en Dec 03 01:56:38 volumio volumio[1072]: Updating browse sources language Dec 03 01:56:38 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 03 01:56:38 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 03 01:56:38 volumio volumio[1072]: info: CoreCommandRouter::initPlayerControls Dec 03 01:56:38 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 03 01:56:38 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 03 01:56:38 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 03 01:56:38 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 03 01:56:38 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 03 01:56:38 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 03 01:56:38 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 03 01:56:38 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 03 01:56:38 volumio volumio[1072]: Express server listening on port 3000 Dec 03 01:56:38 volumio volumio[1072]: [Metrics] WebUI: 7s 85.34ms Dec 03 01:56:38 volumio volumio[1072]: info: CoreStateMachine::resetVolumioState Dec 03 01:56:38 volumio volumio[1072]: info: CoreStateMachine::getcurrentVolume Dec 03 01:56:38 volumio volumio[1072]: info: CoreCommandRouter::volumioRetrievevolume Dec 03 01:56:38 volumio volumio[1072]: info: CoreStateMachine::pushState Dec 03 01:56:38 volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Dec 03 01:56:38 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 03 01:56:38 volumio volumio[1072]: info: CoreCommandRouter::volumioPushState Dec 03 01:56:38 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 03 01:56:38 volumio volumio[1072]: info: Cannot read play queue from file Dec 03 01:56:38 volumio volumio[1072]: info: Volumio Network Manager: Network status updated: 1 Dec 03 01:56:38 volumio volumio[1072]: Starting albumart workers Dec 03 01:56:38 volumio volumio[1072]: Starting albumart workers Dec 03 01:56:38 volumio volumio[1072]: Starting albumart workers Dec 03 01:56:38 volumio volumio[1072]: info: CoreStateMachine::setRepeat null single undefined Dec 03 01:56:38 volumio volumio[1072]: info: CoreStateMachine::pushState Dec 03 01:56:38 volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Dec 03 01:56:38 volumio volumio[1072]: info: CoreCommandRouter::volumioPushState Dec 03 01:56:38 volumio volumio[1072]: info: CoreStateMachine::setRandom null Dec 03 01:56:38 volumio volumio[1072]: info: CoreStateMachine::pushState Dec 03 01:56:38 volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Dec 03 01:56:38 volumio volumio[1072]: info: CoreCommandRouter::volumioPushState Dec 03 01:56:38 volumio volumio[1072]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Dec 03 01:56:38 volumio volumio[1072]: info: USB Boot Capable - System SBC Revision found in cpuinfo: d04170 Dec 03 01:56:38 volumio volumio[1072]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Dec 03 01:56:38 volumio volumio[1072]: info: Setting Device type: Raspberry PI Dec 03 01:56:38 volumio volumio[1072]: info: Completed loading Core Plugins Dec 03 01:56:38 volumio volumio[1072]: info: Preparing to generate the ALSA configuration file Dec 03 01:56:38 volumio volumio[1072]: info: Asound.conf file unchanged, so no further update is needed Dec 03 01:56:38 volumio volumio[1072]: info: Output device has changed, restarting MPD Dec 03 01:56:38 volumio sudo[1354]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 03 01:56:38 volumio sudo[1354]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 03 01:56:38 volumio volumio[1072]: info: Output device has changed, restarting Shairport Sync Dec 03 01:56:38 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 03 01:56:38 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 03 01:56:38 volumio sudo[1354]: pam_unix(sudo:session): session closed for user root Dec 03 01:56:38 volumio sudo[1356]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 03 01:56:38 volumio sudo[1356]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 03 01:56:38 volumio volumio[1072]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 03 01:56:38 volumio volumio[1072]: info: ___________ START PLUGINS ___________ Dec 03 01:56:38 volumio volumio[1072]: info: ControllerMpd::onStart: Initializing MPD Dec 03 01:56:38 volumio volumio[1072]: info: Creating MPD Configuration file Dec 03 01:56:38 volumio systemd[1]: Stopping Music Player Daemon... Dec 03 01:56:38 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 03 01:56:38 volumio volumio[1072]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 03 01:56:38 volumio volumio[1072]: info: [1733180198881] CoreMusicLibrary::Adding element Media Servers Dec 03 01:56:38 volumio sudo[1365]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 03 01:56:38 volumio sudo[1365]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 03 01:56:38 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 03 01:56:38 volumio sudo[1363]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 03 01:56:38 volumio sudo[1363]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 03 01:56:38 volumio sudo[1363]: pam_unix(sudo:session): session closed for user root Dec 03 01:56:38 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 03 01:56:38 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 03 01:56:38 volumio systemd[1]: mpd.service: Succeeded. Dec 03 01:56:38 volumio systemd[1]: Stopped Music Player Daemon. Dec 03 01:56:38 volumio volumio[1072]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 03 01:56:38 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 03 01:56:38 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 03 01:56:38 volumio volumio[1072]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 03 01:56:38 volumio volumio[1072]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 03 01:56:38 volumio volumio[1072]: info: [1733180198966] CoreMusicLibrary::Adding element Last_100 Dec 03 01:56:38 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 03 01:56:38 volumio volumio[1072]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 03 01:56:38 volumio volumio[1072]: info: [1733180198967] CoreMusicLibrary::Adding element Webradio Dec 03 01:56:38 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 03 01:56:38 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 03 01:56:38 volumio volumio[1072]: info: Initializing BBC Radios Dec 03 01:56:38 volumio systemd[1]: Starting Music Player Daemon... Dec 03 01:56:38 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 03 01:56:38 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 03 01:56:38 volumio volumio[1072]: info: Volumio Calling Home Dec 03 01:56:39 volumio sudo[1395]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 03 01:56:39 volumio sudo[1395]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 03 01:56:39 volumio sudo[1395]: pam_unix(sudo:session): session closed for user root Dec 03 01:56:39 volumio volumio[1072]: info: MPD Permissions set Dec 03 01:56:39 volumio volumio[1072]: info: MPD Permissions set Dec 03 01:56:39 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 03 01:56:39 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 03 01:56:39 volumio volumio[1072]: info: Discovery: Getting this device information Dec 03 01:56:39 volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Dec 03 01:56:39 volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Dec 03 01:56:39 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 03 01:56:39 volumio volumio[1072]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Dec 03 01:56:39 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 03 01:56:39 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 03 01:56:39 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 03 01:56:39 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 03 01:56:39 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 03 01:56:39 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 03 01:56:39 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 03 01:56:39 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 03 01:56:39 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 03 01:56:39 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 03 01:56:39 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 03 01:56:39 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 03 01:56:39 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 03 01:56:39 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 03 01:56:39 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 03 01:56:39 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 03 01:56:39 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 03 01:56:39 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 03 01:56:39 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 03 01:56:39 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 03 01:56:39 volumio volumio[1072]: verbose: New Socket.io Connection to 192.168.1.67:3000 from 192.168.1.74 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 2 Dec 03 01:56:39 volumio volumio[1072]: info: Starting Shairport Sync Dec 03 01:56:39 volumio volumio[1072]: info: Starting Shairport Sync Dec 03 01:56:39 volumio sudo[1424]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 03 01:56:39 volumio sudo[1424]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 03 01:56:39 volumio volumio[1072]: info: Starting Shairport Sync Dec 03 01:56:39 volumio sudo[1426]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 03 01:56:39 volumio sudo[1426]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 03 01:56:39 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 03 01:56:39 volumio systemd[1]: shairport-sync.service: Succeeded. Dec 03 01:56:39 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 03 01:56:39 volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Dec 03 01:56:39 volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Dec 03 01:56:39 volumio sudo[1430]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 03 01:56:39 volumio sudo[1430]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 03 01:56:39 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 03 01:56:39 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 03 01:56:39 volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Dec 03 01:56:39 volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Dec 03 01:56:39 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 03 01:56:39 volumio sudo[1426]: pam_unix(sudo:session): session closed for user root Dec 03 01:56:39 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 03 01:56:39 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Dec 03 01:56:39 volumio systemd[1]: shairport-sync.service: Succeeded. Dec 03 01:56:39 volumio sudo[1424]: pam_unix(sudo:session): session closed for user root Dec 03 01:56:39 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 03 01:56:39 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 03 01:56:39 volumio volumio[1072]: info: Shairport-Sync Started Dec 03 01:56:39 volumio volumio[1072]: Error adding Membership: Error: addMembership EINVAL Dec 03 01:56:39 volumio volumio[1072]: info: Shairport-Sync Started Dec 03 01:56:39 volumio volumio[1072]: info: Volumio called home Dec 03 01:56:39 volumio sudo[1430]: pam_unix(sudo:session): session closed for user root Dec 03 01:56:39 volumio volumio[1072]: info: Shairport-Sync Started Dec 03 01:56:39 volumio volumio[1072]: info: Discovery: adding 72fb573c-5849-4c30-9153-26e1a4137b5b Dec 03 01:56:39 volumio volumio[1072]: info: Discovery: Found device Volumio-New Dec 03 01:56:39 volumio volumio[1072]: info: Discovery: Connecting to remote: 192.168.1.58 Dec 03 01:56:39 volumio mpd[1413]: Dec 02 22:56 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 03 01:56:39 volumio systemd[1]: Started Music Player Daemon. Dec 03 01:56:39 volumio sudo[1356]: pam_unix(sudo:session): session closed for user root Dec 03 01:56:39 volumio sudo[1365]: pam_unix(sudo:session): session closed for user root Dec 03 01:56:39 volumio volumio[1072]: info: Completed starting Core Plugins Dec 03 01:56:39 volumio volumio[1072]: info: ------------------------------------------- Dec 03 01:56:39 volumio volumio[1072]: info: ----- MyVolumio plugins startup ---- Dec 03 01:56:39 volumio volumio[1072]: info: ------------------------------------------- Dec 03 01:56:39 volumio volumio[1072]: info: [MyVolumio PluginManager] Fetching plans data.... Dec 03 01:56:39 volumio volumio[1072]: error: MPD error: The expression evaluated to a falsy value: Dec 03 01:56:39 volumio volumio[1072]: assert.ok(self.idling) Dec 03 01:56:39 volumio volumio[1072]: error: The expression evaluated to a falsy value: Dec 03 01:56:39 volumio volumio[1072]: assert.ok(self.idling) Dec 03 01:56:39 volumio volumio[1072]: info: MPD running with PID1413 Dec 03 01:56:39 volumio volumio[1072]: ,establishing connection Dec 03 01:56:39 volumio volumio[1072]: error: MPD error: The expression evaluated to a falsy value: Dec 03 01:56:39 volumio volumio[1072]: assert.ok(self.idling) Dec 03 01:56:39 volumio volumio[1072]: error: The expression evaluated to a falsy value: Dec 03 01:56:39 volumio volumio[1072]: assert.ok(self.idling) Dec 03 01:56:39 volumio volumio[1072]: error: updateQueue error: null Dec 03 01:56:39 volumio volumio[1072]: info: Discovery: adding 0a2072bf-9767-4d6f-8245-5cd3f39186f4 Dec 03 01:56:39 volumio volumio[1072]: info: Discovery: Found device Volumio Dec 03 01:56:39 volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Dec 03 01:56:39 volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Dec 03 01:56:39 volumio volumio[1072]: info: Discovery: this is already registered, 0a2072bf-9767-4d6f-8245-5cd3f39186f4 Dec 03 01:56:39 volumio volumio[1072]: info: Discovery: Found device Volumio Dec 03 01:56:39 volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Dec 03 01:56:39 volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Dec 03 01:56:39 volumio volumio[1072]: info: Discovery: Connected to remote: 192.168.1.58 Dec 03 01:56:39 volumio volumio[1072]: verbose: New Socket.io Connection to 192.168.1.67:3000 from 192.168.1.58 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Dec 03 01:56:39 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Dec 03 01:56:39 volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Dec 03 01:56:39 volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Dec 03 01:56:41 volumio sudo[1298]: pam_unix(sudo:session): session closed for user root Dec 03 01:56:42 volumio sudo[1443]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 03 01:56:42 volumio sudo[1443]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 03 01:56:42 volumio sudo[1443]: pam_unix(sudo:session): session closed for user root Dec 03 01:56:42 volumio sudo[1445]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 03 01:56:42 volumio sudo[1445]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 03 01:56:42 volumio sudo[1445]: pam_unix(sudo:session): session closed for user root Dec 03 01:56:42 volumio volumio[1072]: verbose: New Socket.io Connection to 192.168.1.67 from 192.168.1.74 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 4 Dec 03 01:56:42 volumio volumio[1072]: info: CoreCommandRouter::volumioGetVisibleSources Dec 03 01:56:42 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 03 01:56:42 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Dec 03 01:56:42 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Dec 03 01:56:42 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Dec 03 01:56:42 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Dec 03 01:56:42 volumio volumio[1072]: info: Received Get System Info Dec 03 01:56:42 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 03 01:56:42 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 03 01:56:42 volumio volumio[1072]: info: Discovery: Getting this device information Dec 03 01:56:42 volumio volumio[1072]: info: CoreCommandRouter::volumioGetState Dec 03 01:56:42 volumio volumio[1072]: info: CorePlayQueue::getTrack 0 Dec 03 01:56:42 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 03 01:56:42 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 03 01:56:42 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 03 01:56:42 volumio volumio[1072]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 03 01:56:43 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Dec 03 01:56:43 volumio volumio[1072]: info: Loading i18n strings for locale tr Dec 03 01:56:43 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Dec 03 01:56:43 volumio volumio[1072]: info: Setting timezone to Europe/Istanbul Dec 03 01:56:43 volumio sudo[1449]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Dec 03 01:56:43 volumio sudo[1449]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 03 01:56:43 volumio sudo[1449]: pam_unix(sudo:session): session closed for user root Dec 03 01:56:43 volumio sudo[1452]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Istanbul /etc/localtime Dec 03 01:56:43 volumio sudo[1452]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 03 01:56:43 volumio sudo[1452]: pam_unix(sudo:session): session closed for user root Dec 03 01:56:43 volumio sudo[1455]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Dec 03 01:56:43 volumio sudo[1455]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 03 01:56:44 volumio sudo[1455]: pam_unix(sudo:session): session closed for user root Dec 03 01:56:44 volumio sudo[1458]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Istanbul Dec 03 01:56:44 volumio sudo[1458]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 03 01:56:44 volumio systemd-timedated[1155]: Failed to set time zone: Permission denied Dec 03 01:56:44 volumio sudo[1458]: pam_unix(sudo:session): session closed for user root Dec 03 01:56:44 volumio volumio[1072]: Failed to set time zone: Access denied Dec 03 01:56:44 volumio volumio[1072]: info: Could not set timezone, retrying Dec 03 01:56:44 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 03 01:56:44 volumio volumio[1072]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Dec 03 01:56:44 volumio volumio[1072]: Updating browse sources language Dec 03 01:56:44 volumio volumio[1072]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 03 01:56:46 volumio volumio[1072]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 03 01:56:46 volumio kernel: Unable to handle kernel paging request at virtual address 00000000047cbeb0 Dec 03 01:56:46 volumio kernel: Mem abort info: Dec 03 01:56:46 volumio kernel: ESR = 0x0000000096000005 Dec 03 01:56:46 volumio kernel: EC = 0x25: DABT (current EL), IL = 32 bits Dec 03 01:56:46 volumio kernel: SET = 0, FnV = 0 Dec 03 01:56:46 volumio kernel: EA = 0, S1PTW = 0 Dec 03 01:56:46 volumio kernel: FSC = 0x05: level 1 translation fault Dec 03 01:56:46 volumio kernel: Data abort info: Dec 03 01:56:46 volumio kernel: ISV = 0, ISS = 0x00000005, ISS2 = 0x00000000 Dec 03 01:56:46 volumio kernel: CM = 0, WnR = 0, TnD = 0, TagAccess = 0 Dec 03 01:56:46 volumio kernel: GCS = 0, Overlay = 0, DirtyBit = 0, Xs = 0 Dec 03 01:56:46 volumio kernel: user pgtable: 4k pages, 39-bit VAs, pgdp=0000000115984000 Dec 03 01:56:46 volumio kernel: [00000000047cbeb0] pgd=0000000000000000, p4d=0000000000000000, pud=0000000000000000 Dec 03 01:56:46 volumio kernel: Internal error: Oops: 0000000096000005 [#1] PREEMPT SMP Dec 03 01:56:46 volumio kernel: Modules linked in: bnep nft_chain_nat xt_REDIRECT nf_nat nf_conntrack nf_defrag_ipv6 nf_defrag_ipv4 xt_tcpudp nft_compat nf_tables nfnetlink 8021q garp stp llc vc4 snd_soc_hdmi_codec drm_display_helper snd_usb_audio cec drm_dma_helper brcmfmac_wcc drm_kms_helper snd_hwdep hci_uart btbcm bluetooth snd_usbmidi_lib snd_soc_core snd_seq_midi brcmfmac snd_seq_midi_event rpivid_hevc(C) snd_rawmidi snd_compress snd_pcm_dmaengine brcmutil snd_seq ecdh_generic aes_ce_blk snd_pcm aes_ce_cipher ghash_ce cfg80211 v4l2_mem2mem pisp_be gf128mul ecc snd_seq_device sha2_ce snd_timer libaes sha256_arm64 rfkill videobuf2_dma_contig videobuf2_memops videobuf2_v4l2 sha1_ce snd videodev raspberrypi_hwmon rp1_adc raspberrypi_gpiomem videobuf2_common mc pwm_fan nvmem_rmem uio_pdrv_genirq uio i2c_dev ip_tables x_tables ipv6 squashfs overlay nls_iso8859_1 fuse v3d gpu_sched drm_shmem_helper spidev drm i2c_brcmstb spi_bcm2835 drm_panel_orientation_quirks backlight gpio_keys i2c_designware_platform i2c_designware_core Dec 03 01:56:46 volumio kernel: CPU: 2 PID: 1460 Comm: node Tainted: G C 6.6.56-v8+ #1803 Dec 03 01:56:46 volumio kernel: Hardware name: Raspberry Pi 5 Model B Rev 1.0 (DT) Dec 03 01:56:46 volumio kernel: pstate: a0400009 (NzCv daif +PAN -UAO -TCO -DIT -SSBS BTYPE=--) Dec 03 01:56:46 volumio kernel: pc : free_pgd_range+0x15c/0x410 Dec 03 01:56:46 volumio kernel: lr : free_pgtables+0x140/0x1a8 Dec 03 01:56:46 volumio kernel: sp : ffffffc0819cb960 Dec 03 01:56:46 volumio kernel: x29: ffffffc0819cb960 x28: ffffffc0819cbb08 x27: 000000005d440000 Dec 03 01:56:46 volumio kernel: x26: 000000005d43ffff x25: fffffffe00000000 x24: ffffff8115896750 Dec 03 01:56:46 volumio kernel: x23: 000000005d440000 x22: ffffffd0850c82c8 x21: ffffffc0819cbac8 Dec 03 01:56:46 volumio kernel: x20: 00000000047cbe80 x19: 000000005d400000 x18: ffffffc0819cbac8 Dec 03 01:56:46 volumio kernel: x17: 0000000000000000 x16: ffffffd084e1c6b8 x15: 000000005bd00000 Dec 03 01:56:46 volumio kernel: x14: 000000000000000f x13: 00000000f2895fff x12: 000000005d401000 Dec 03 01:56:46 volumio kernel: x11: 0000000000000000 x10: ffffffffffffffff x9 : ffffffd0842e5a60 Dec 03 01:56:46 volumio kernel: x8 : 0000000000000001 x7 : 000000009d400000 x6 : 0000000000000075 Dec 03 01:56:46 volumio kernel: x5 : 0000000044001000 x4 : 00000000000000ea x3 : 000000005d600000 Dec 03 01:56:46 volumio kernel: x2 : 00000000ffffffff x1 : 00000002047cbe80 x0 : 0000000000000024 Dec 03 01:56:46 volumio kernel: Call trace: Dec 03 01:56:46 volumio kernel: free_pgd_range+0x15c/0x410 Dec 03 01:56:46 volumio kernel: free_pgtables+0x140/0x1a8 Dec 03 01:56:46 volumio kernel: exit_mmap+0x13c/0x3b8 Dec 03 01:56:46 volumio kernel: mmput+0x78/0x170 Dec 03 01:56:46 volumio kernel: begin_new_exec+0x448/0xa18 Dec 03 01:56:46 volumio kernel: load_elf_binary+0x320/0x14c8 Dec 03 01:56:46 volumio kernel: bprm_execve+0x22c/0x610 Dec 03 01:56:46 volumio kernel: do_execveat_common.isra.0+0x1a0/0x248 Dec 03 01:56:46 volumio kernel: __arm64_compat_sys_execve+0x48/0x68 Dec 03 01:56:46 volumio kernel: invoke_syscall+0x50/0x128 Dec 03 01:56:46 volumio kernel: el0_svc_common.constprop.0+0x48/0xf8 Dec 03 01:56:46 volumio kernel: do_el0_svc_compat+0x28/0x48 Dec 03 01:56:46 volumio kernel: el0_svc_compat+0x30/0x88 Dec 03 01:56:46 volumio kernel: el0t_32_sync_handler+0x98/0x148 Dec 03 01:56:46 volumio kernel: el0t_32_sync+0x194/0x198 Dec 03 01:56:46 volumio kernel: Code: eb0c015f 9a8c214a a9012b8b 12800002 (b9403286) Dec 03 01:56:46 volumio kernel: ---[ end trace 0000000000000000 ]--- Dec 03 01:56:46 volumio volumio[1072]: Error: Command failed: /usr/bin/sudo /usr/bin/timedatectl set-timezone 'Europe/Istanbul' Dec 03 01:56:46 volumio volumio[1072]: at checkExecSyncError (child_process.js:616:11) Dec 03 01:56:46 volumio volumio[1072]: at execSync (child_process.js:652:15) Dec 03 01:56:46 volumio volumio[1072]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/system/index.js:1575:9) Dec 03 01:56:46 volumio volumio[1072]: at listOnTimeout (internal/timers.js:554:17) Dec 03 01:56:46 volumio volumio[1072]: at processTimers (internal/timers.js:497:7) { Dec 03 01:56:46 volumio volumio[1072]: status: null, Dec 03 01:56:46 volumio volumio[1072]: signal: 'SIGSEGV', Dec 03 01:56:46 volumio volumio[1072]: output: [ null, '', '' ], Dec 03 01:56:46 volumio volumio[1072]: pid: 1460, Dec 03 01:56:46 volumio volumio[1072]: stdout: '', Dec 03 01:56:46 volumio volumio[1072]: stderr: '' Dec 03 01:56:46 volumio volumio[1072]: } Dec 03 01:56:46 volumio volumio[1072]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 03 01:56:46 volumio sudo[1470]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-12-03 01:55 Dec 03 01:56:46 volumio sudo[1470]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 06:51:56 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="b9009e0280f50389e80a537357ff3961"