-- Logs begin at Wed 2024-08-21 00:04:25 UTC, end at Wed 2024-08-21 00:06:07 UTC. --
Aug 21 00:05:00 volumio ntpd[983]: Soliciting pool server 5.129.211.151
Aug 21 00:05:00 volumio ntpd[983]: Listen normally on 5 wlan0 169.254.21.112:123
Aug 21 00:05:00 volumio ntpd[983]: new interface(s) found: waking up resolver
Aug 21 00:05:01 volumio ntpd[983]: Soliciting pool server 46.146.231.187
Aug 21 00:05:01 volumio volumio[754]: info: -------------------------------------------
Aug 21 00:05:01 volumio volumio[754]: info: ----- Volumio3 ----
Aug 21 00:05:01 volumio volumio[754]: info: -------------------------------------------
Aug 21 00:05:01 volumio volumio[754]: info: ----- System startup ----
Aug 21 00:05:01 volumio volumio[754]: info: -------------------------------------------
Aug 21 00:05:03 volumio volumio-remote-updater[476]: [2024-08-21 00:05:03] [connect] Successful connection
Aug 21 00:05:05 volumio volumio[754]: info: MYVOLUMIO Environment detected
Aug 21 00:05:05 volumio volumio[754]: info: Plugin folders cleanup
Aug 21 00:05:05 volumio volumio[754]: info: Scanning into folder /volumio/app/plugins/
Aug 21 00:05:05 volumio volumio[754]: info: Scanning category audio_interface
Aug 21 00:05:05 volumio volumio[754]: info: Scanning category miscellanea
Aug 21 00:05:05 volumio volumio[754]: info: Scanning category music_service
Aug 21 00:05:05 volumio volumio[754]: info: Scanning category plugins.json
Aug 21 00:05:05 volumio volumio[754]: info: Scanning category system_controller
Aug 21 00:05:05 volumio volumio[754]: info: Scanning category user_interface
Aug 21 00:05:05 volumio volumio[754]: info: Scanning into folder /data/plugins/
Aug 21 00:05:05 volumio volumio[754]: info: Plugin folders cleanup completed
Aug 21 00:05:05 volumio volumio[754]: info: -------------------------------------------
Aug 21 00:05:05 volumio volumio[754]: info: ----- Core plugins startup ----
Aug 21 00:05:05 volumio volumio[754]: info: -------------------------------------------
Aug 21 00:05:05 volumio volumio[754]: info: Loading plugins from folder /volumio/app/plugins/
Aug 21 00:05:05 volumio volumio[754]: info: Adding plugin upnp to MyMusic Plugins
Aug 21 00:05:05 volumio volumio[754]: info: Adding plugin airplay_emulation to MyMusic Plugins
Aug 21 00:05:05 volumio volumio[754]: info: Adding plugin upnp_browser to MyMusic Plugins
Aug 21 00:05:05 volumio volumio[754]: info: Loading plugins from folder /data/plugins/
Aug 21 00:05:05 volumio volumio[754]: info: Loading plugin "system"...
Aug 21 00:05:05 volumio volumio[754]: info: Loading plugin "appearance"...
Aug 21 00:05:08 volumio volumio[754]: info: Loading plugin "network"...
Aug 21 00:05:08 volumio volumio[754]: info: Refreshing Cached IP Addresses
Aug 21 00:05:08 volumio sudo[1124]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Aug 21 00:05:08 volumio sudo[1124]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 21 00:05:08 volumio sudo[1127]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Aug 21 00:05:08 volumio sudo[1127]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 21 00:05:08 volumio sudo[1124]: pam_unix(sudo:session): session closed for user root
Aug 21 00:05:08 volumio volumio[754]: info: Loading plugin "services"...
Aug 21 00:05:08 volumio sudo[1127]: pam_unix(sudo:session): session closed for user root
Aug 21 00:05:08 volumio volumio[754]: info: Loading plugin "alsa_controller"...
Aug 21 00:05:08 volumio sudo[1132]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Aug 21 00:05:08 volumio sudo[1132]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 21 00:05:08 volumio sudo[1132]: pam_unix(sudo:session): session closed for user root
Aug 21 00:05:08 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Aug 21 00:05:08 volumio volumio[754]: info: Loading plugin "wizard"...
Aug 21 00:05:08 volumio volumio[754]: info: Loading plugin "networkfs"...
Aug 21 00:05:09 volumio volumio[754]: info: Starting Udev Watcher for removable devices
Aug 21 00:05:09 volumio volumio[754]: info: Ignoring mount for partition: boot
Aug 21 00:05:09 volumio volumio[754]: info: Ignoring mount for partition: volumio
Aug 21 00:05:09 volumio volumio[754]: info: Ignoring mount for partition: volumio_data
Aug 21 00:05:09 volumio systemd[1]: systemd-fsckd.service: Succeeded.
Aug 21 00:05:09 volumio volumio[754]: info: Ignoring mount for partition: Зарезервировано_системой
Aug 21 00:05:09 volumio volumio[754]: info: Ignoring mount for partition: 7C9E0AB19E0A63CC
Aug 21 00:05:09 volumio volumio[754]: info: Ignoring mount for partition: 509B-5EDA
Aug 21 00:05:09 volumio volumio[754]: error: Cannot associate FS Label, not mounting
Aug 21 00:05:09 volumio volumio[754]: info: Ignoring mount for partition: 5ebcdf76-37e0-4213-8746-3c16af353257
Aug 21 00:05:09 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Aug 21 00:05:09 volumio volumio[754]: info: Loading plugin "volumio_command_line_client"...
Aug 21 00:05:09 volumio volumio[754]: info: Loading plugin "upnp"...
Aug 21 00:05:09 volumio volumio[754]: info: [1724198709307] Starting Upmpd Daemon
Aug 21 00:05:09 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Aug 21 00:05:09 volumio volumio[754]: info: Loading plugin "my_music"...
Aug 21 00:05:09 volumio volumio[754]: info: Loading plugin "mpd"...
Aug 21 00:05:10 volumio volumio[754]: info: Loading plugin "upnp_browser"...
Aug 21 00:05:11 volumio volumio[754]: info: Loading plugin "alarm-clock"...
Aug 21 00:05:12 volumio volumio[754]: info: Loading plugin "airplay_emulation"...
Aug 21 00:05:12 volumio volumio[754]: info: Starting Shairport Sync
Aug 21 00:05:12 volumio volumio[754]: info: Loading plugin "last_100"...
Aug 21 00:05:12 volumio volumio[754]: info: Loading plugin "webradio"...
Aug 21 00:05:12 volumio dbus-daemon[472]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' requested by ':1.7' (uid=0 pid=1096 comm="/usr/lib/chromium/chromium --show-component-extens")
Aug 21 00:05:12 volumio systemd[1]: Starting Bluetooth service...
Aug 21 00:05:12 volumio volumio[754]: info: Loading plugin "i2s_dacs"...
Aug 21 00:05:12 volumio volumio[754]: info: I2S DAC not set, start Auto-detection
Aug 21 00:05:12 volumio volumio[754]: info: Loading plugin "volumiodiscovery"...
Aug 21 00:05:13 volumio kernel: cryptd: max_cpu_qlen set to 1000
Aug 21 00:05:13 volumio volumio[754]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Aug 21 00:05:13 volumio node[754]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Aug 21 00:05:13 volumio volumio[754]: *** WARNING *** Please fix your application to use the native API of Avahi!
Aug 21 00:05:13 volumio volumio[754]: *** WARNING *** For more information see
Aug 21 00:05:13 volumio volumio[754]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Aug 21 00:05:13 volumio volumio[754]: *** WARNING *** Please fix your application to use the native API of Avahi!
Aug 21 00:05:13 volumio volumio[754]: *** WARNING *** For more information see
Aug 21 00:05:13 volumio node[754]: *** WARNING *** Please fix your application to use the native API of Avahi!
Aug 21 00:05:13 volumio node[754]: *** WARNING *** For more information see
Aug 21 00:05:13 volumio node[754]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Aug 21 00:05:13 volumio node[754]: *** WARNING *** Please fix your application to use the native API of Avahi!
Aug 21 00:05:13 volumio node[754]: *** WARNING *** For more information see
Aug 21 00:05:13 volumio volumio[754]: info: Applying required configuration parameters for plugin volumiodiscovery
Aug 21 00:05:13 volumio volumio[754]: info: Discovery: Started advertising with name: Volumio
Aug 21 00:05:13 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Aug 21 00:05:13 volumio volumio[754]: info: Loading plugin "outputs"...
Aug 21 00:05:13 volumio volumio[754]: info: Loading plugin "albumart"...
Aug 21 00:05:14 volumio volumio[754]: info: Plugin example_plugin is not enabled
Aug 21 00:05:14 volumio volumio[754]: info: Loading plugin "inputs"...
Aug 21 00:05:14 volumio volumio[754]: info: Loading plugin "updater_comm"...
Aug 21 00:05:14 volumio volumio[754]: Forking 3 albumart workers
Aug 21 00:05:14 volumio kernel: Bluetooth: Core ver 2.22
Aug 21 00:05:14 volumio kernel: NET: Registered PF_BLUETOOTH protocol family
Aug 21 00:05:14 volumio kernel: Bluetooth: HCI device and connection manager initialized
Aug 21 00:05:14 volumio kernel: Bluetooth: HCI socket layer initialized
Aug 21 00:05:14 volumio kernel: Bluetooth: L2CAP socket layer initialized
Aug 21 00:05:14 volumio kernel: Bluetooth: SCO socket layer initialized
Aug 21 00:05:14 volumio bluetoothd[1163]: Bluetooth daemon 5.50
Aug 21 00:05:14 volumio bluetoothd[1163]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf
Aug 21 00:05:14 volumio dbus-daemon[472]: [system] Successfully activated service 'org.bluez'
Aug 21 00:05:14 volumio systemd[1]: Started Bluetooth service.
Aug 21 00:05:14 volumio bluetoothd[1163]: Starting SDP server
Aug 21 00:05:14 volumio bluetoothd[1163]: Excluding (cli) sap
Aug 21 00:05:14 volumio kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3
Aug 21 00:05:14 volumio kernel: Bluetooth: BNEP filters: protocol multicast
Aug 21 00:05:14 volumio kernel: Bluetooth: BNEP socket layer initialized
Aug 21 00:05:14 volumio dbus-daemon[472]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.10' (uid=0 pid=1163 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ")
Aug 21 00:05:14 volumio bluetoothd[1163]: Bluetooth management interface 1.22 initialized
Aug 21 00:05:14 volumio volumio[754]: info: Plugin mpdemulation is not enabled
Aug 21 00:05:15 volumio volumio[754]: info: Loading plugin "rest_api"...
Aug 21 00:05:15 volumio systemd[1]: Starting Hostname Service...
Aug 21 00:05:15 volumio volumio[754]: info: Loading plugin "websocket"...
Aug 21 00:05:15 volumio volumio[754]: info: Loading i18n strings for locale en
Aug 21 00:05:15 volumio volumio[754]: Updating browse sources language
Aug 21 00:05:15 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Aug 21 00:05:15 volumio dbus-daemon[472]: [system] Successfully activated service 'org.freedesktop.hostname1'
Aug 21 00:05:15 volumio systemd[1]: Started Hostname Service.
Aug 21 00:05:16 volumio volumio[754]: Starting albumart workers
Aug 21 00:05:16 volumio volumio[754]: Starting albumart workers
Aug 21 00:05:16 volumio volumio[754]: Starting albumart workers
Aug 21 00:05:18 volumio volumio-remote-updater[476]: [2024-08-21 00:05:18] [connect] Successful connection
Aug 21 00:05:18 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 21 00:05:18 volumio volumio[754]: info: CoreCommandRouter::initPlayerControls
Aug 21 00:05:18 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 21 00:05:18 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 21 00:05:18 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 21 00:05:18 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 21 00:05:18 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 21 00:05:18 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 21 00:05:18 volumio volumio[754]: Express server listening on port 3000
Aug 21 00:05:18 volumio volumio[754]: [Metrics] WebUI: 17s 802.03ms
Aug 21 00:05:18 volumio volumio[754]: info: Setting Device type: x86
Aug 21 00:05:18 volumio volumio[754]: info: CoreStateMachine::resetVolumioState
Aug 21 00:05:18 volumio volumio[754]: info: CoreStateMachine::getcurrentVolume
Aug 21 00:05:18 volumio volumio[754]: info: CoreCommandRouter::volumioRetrievevolume
Aug 21 00:05:18 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 21 00:05:18 volumio volumio[754]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt'
Aug 21 00:05:18 volumio volumio[754]: info: Completed loading Core Plugins
Aug 21 00:05:18 volumio volumio[754]: info: Preparing to generate the ALSA configuration file
Aug 21 00:05:18 volumio volumio[754]: info: Cannot read play queue from file
Aug 21 00:05:18 volumio volumio[754]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan
Aug 21 00:05:18 volumio volumio[754]: wlan0 Interface doesn't support scanning : Operation not supported
Aug 21 00:05:18 volumio volumio[754]: info: Cannot use regular scanning, forcing with ap-force
Aug 21 00:05:18 volumio sudo[1338]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force
Aug 21 00:05:18 volumio sudo[1338]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 21 00:05:19 volumio sudo[1338]: pam_unix(sudo:session): session closed for user root
Aug 21 00:05:19 volumio volumio[754]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision
Aug 21 00:05:19 volumio sudo[1341]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Aug 21 00:05:19 volumio sudo[1341]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 21 00:05:19 volumio sudo[1341]: pam_unix(sudo:session): session closed for user root
Aug 21 00:05:19 volumio sudo[1343]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Aug 21 00:05:19 volumio sudo[1343]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 21 00:05:19 volumio sudo[1343]: pam_unix(sudo:session): session closed for user root
Aug 21 00:05:19 volumio volumio-remote-updater[476]: [2024-08-21 00:05:19] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1724198718 101
Aug 21 00:05:19 volumio volumio[754]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 1
Aug 21 00:05:19 volumio volumio[754]: info: Asound.conf file unchanged, so no further update is needed
Aug 21 00:05:19 volumio volumio[754]: info: Output device has changed, restarting MPD
Aug 21 00:05:19 volumio sudo[1353]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Aug 21 00:05:19 volumio sudo[1353]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 21 00:05:19 volumio volumio[754]: info: Output device has changed, restarting Shairport Sync
Aug 21 00:05:19 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 21 00:05:19 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 21 00:05:19 volumio sudo[1353]: pam_unix(sudo:session): session closed for user root
Aug 21 00:05:19 volumio sudo[1355]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Aug 21 00:05:19 volumio sudo[1355]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 21 00:05:19 volumio systemd[1]: Listening on mpd.socket.
Aug 21 00:05:19 volumio volumio[754]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Aug 21 00:05:19 volumio volumio[754]: info: ___________ START PLUGINS ___________
Aug 21 00:05:19 volumio volumio[754]: info: ControllerMpd::onStart: Initializing MPD
Aug 21 00:05:19 volumio volumio[754]: info: Creating MPD Configuration file
Aug 21 00:05:19 volumio systemd[1]: Starting Music Player Daemon...
Aug 21 00:05:19 volumio sudo[1363]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Aug 21 00:05:19 volumio sudo[1363]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 21 00:05:19 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 21 00:05:19 volumio volumio[754]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Aug 21 00:05:19 volumio volumio[754]: info: [1724198719843] CoreMusicLibrary::Adding element Media Servers
Aug 21 00:05:19 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Aug 21 00:05:19 volumio sudo[1363]: pam_unix(sudo:session): session closed for user root
Aug 21 00:05:19 volumio sudo[1365]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Aug 21 00:05:19 volumio sudo[1365]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 21 00:05:19 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Aug 21 00:05:19 volumio systemd[1]: mpd.service: Succeeded.
Aug 21 00:05:19 volumio systemd[1]: Stopped Music Player Daemon.
Aug 21 00:05:19 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 21 00:05:19 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 21 00:05:19 volumio systemd[1]: Starting Music Player Daemon...
Aug 21 00:05:19 volumio volumio[754]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Aug 21 00:05:19 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 21 00:05:19 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 21 00:05:19 volumio volumio[754]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Aug 21 00:05:19 volumio volumio[754]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Aug 21 00:05:19 volumio volumio[754]: info: [1724198719994] CoreMusicLibrary::Adding element Last_100
Aug 21 00:05:19 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Aug 21 00:05:19 volumio volumio[754]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Aug 21 00:05:19 volumio volumio[754]: info: [1724198719998] CoreMusicLibrary::Adding element Webradio
Aug 21 00:05:19 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Aug 21 00:05:20 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Aug 21 00:05:20 volumio volumio[754]: info: Volumio Calling Home
Aug 21 00:05:20 volumio volumio[754]: info: CoreStateMachine::setRepeat null single undefined
Aug 21 00:05:20 volumio volumio[754]: info: CoreStateMachine::pushState
Aug 21 00:05:20 volumio volumio[754]: info: CorePlayQueue::getTrack 0
Aug 21 00:05:20 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 21 00:05:20 volumio volumio[754]: info: CoreCommandRouter::volumioPushState
Aug 21 00:05:20 volumio volumio[754]: info: CoreStateMachine::setRandom null
Aug 21 00:05:20 volumio volumio[754]: info: CoreStateMachine::pushState
Aug 21 00:05:20 volumio volumio[754]: info: CorePlayQueue::getTrack 0
Aug 21 00:05:20 volumio volumio[754]: info: CoreCommandRouter::volumioPushState
Aug 21 00:05:20 volumio volumio[754]: info: VolumeController:: Volume=41 Mute =false
Aug 21 00:05:20 volumio volumio[754]: info: CoreStateMachine::pushState
Aug 21 00:05:20 volumio volumio[754]: info: CorePlayQueue::getTrack 0
Aug 21 00:05:20 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 21 00:05:20 volumio volumio[754]: info: CoreCommandRouter::volumioPushState
Aug 21 00:05:20 volumio volumio[754]: info: CoreStateMachine::updateTrackBlock
Aug 21 00:05:20 volumio volumio[754]: info: CorePlayQueue::getTrackBlock
Aug 21 00:05:20 volumio volumio[754]: info: CoreCommandRouter::volumioRetrievevolume
Aug 21 00:05:20 volumio volumio[754]: info: MPD Permissions set
Aug 21 00:05:20 volumio volumio[754]: info: MPD Permissions set
Aug 21 00:05:20 volumio volumio[754]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 2
Aug 21 00:05:20 volumio sudo[1381]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Aug 21 00:05:20 volumio sudo[1381]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 21 00:05:20 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 21 00:05:20 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 21 00:05:20 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 21 00:05:20 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 21 00:05:20 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 21 00:05:20 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 21 00:05:20 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 21 00:05:20 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Aug 21 00:05:20 volumio systemd[1]: Started UPnP Renderer front-end to MPD.
Aug 21 00:05:20 volumio sudo[1381]: pam_unix(sudo:session): session closed for user root
Aug 21 00:05:20 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 21 00:05:20 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 21 00:05:20 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 21 00:05:20 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 21 00:05:20 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 21 00:05:20 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Aug 21 00:05:20 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 21 00:05:20 volumio volumio[754]: info: Volumio called home
Aug 21 00:05:20 volumio volumio[754]: info: Discovery: adding 83ec8cbd-bc98-45a5-b2ba-f7bedb2097f7
Aug 21 00:05:20 volumio volumio[754]: info: Discovery: Found device Volumio
Aug 21 00:05:20 volumio volumio[754]: info: CoreCommandRouter::volumioGetState
Aug 21 00:05:20 volumio volumio[754]: info: CorePlayQueue::getTrack 0
Aug 21 00:05:20 volumio volumio[754]: info: Discovery: this is already registered, 83ec8cbd-bc98-45a5-b2ba-f7bedb2097f7
Aug 21 00:05:20 volumio volumio[754]: info: Discovery: Found device Volumio
Aug 21 00:05:20 volumio volumio[754]: info: CoreCommandRouter::volumioGetState
Aug 21 00:05:20 volumio volumio[754]: info: CorePlayQueue::getTrack 0
Aug 21 00:05:20 volumio volumio[754]: info: Upmpdcli Daemon Started
Aug 21 00:05:20 volumio volumio[754]: info: VolumeController:: Volume=41 Mute =false
Aug 21 00:05:20 volumio volumio[754]: info: CoreStateMachine::pushState
Aug 21 00:05:20 volumio volumio[754]: info: CorePlayQueue::getTrack 0
Aug 21 00:05:20 volumio volumio[754]: info: CoreCommandRouter::volumioPushState
Aug 21 00:05:20 volumio volumio[754]: info: Starting Shairport Sync
Aug 21 00:05:20 volumio volumio[754]: info: Starting Shairport Sync
Aug 21 00:05:20 volumio volumio[754]: info: Starting Shairport Sync
Aug 21 00:05:20 volumio sudo[1398]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Aug 21 00:05:20 volumio sudo[1398]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 21 00:05:20 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Aug 21 00:05:20 volumio systemd[1]: shairport-sync.service: Succeeded.
Aug 21 00:05:20 volumio sudo[1403]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Aug 21 00:05:20 volumio sudo[1400]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Aug 21 00:05:20 volumio sudo[1403]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 21 00:05:20 volumio sudo[1400]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 21 00:05:20 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Aug 21 00:05:20 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Aug 21 00:05:20 volumio sudo[1398]: pam_unix(sudo:session): session closed for user root
Aug 21 00:05:20 volumio shairport-sync[1406]: free(): double free detected in tcache 2
Aug 21 00:05:20 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Aug 21 00:05:20 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=6/ABRT
Aug 21 00:05:20 volumio systemd[1]: shairport-sync.service: Failed with result 'signal'.
Aug 21 00:05:20 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Aug 21 00:05:21 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Aug 21 00:05:21 volumio sudo[1403]: pam_unix(sudo:session): session closed for user root
Aug 21 00:05:21 volumio sudo[1400]: pam_unix(sudo:session): session closed for user root
Aug 21 00:05:21 volumio volumio[754]: info: Shairport-Sync Started
Aug 21 00:05:21 volumio volumio[754]: Error adding Membership: Error: addMembership EINVAL
Aug 21 00:05:21 volumio volumio[754]: info: Shairport-Sync Started
Aug 21 00:05:21 volumio volumio[754]: info: Shairport-Sync Started
Aug 21 00:05:21 volumio volumio[754]: info: CoreCommandRouter::volumioGetState
Aug 21 00:05:21 volumio volumio[754]: info: CorePlayQueue::getTrack 0
Aug 21 00:05:24 volumio volumio[754]: 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 Total Clients: 3
Aug 21 00:05:25 volumio mpd[1368]: Aug 21 00:05 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Aug 21 00:05:25 volumio systemd[1]: Started Music Player Daemon.
Aug 21 00:05:25 volumio volumio[754]: Upnp client error: Error: This socket has been ended by the other party
Aug 21 00:05:25 volumio sudo[1365]: pam_unix(sudo:session): session closed for user root
Aug 21 00:05:25 volumio sudo[1355]: pam_unix(sudo:session): session closed for user root
Aug 21 00:05:25 volumio volumio[754]: info: Completed starting Core Plugins
Aug 21 00:05:25 volumio volumio[754]: info: -------------------------------------------
Aug 21 00:05:25 volumio volumio[754]: info: ----- MyVolumio plugins startup ----
Aug 21 00:05:25 volumio volumio[754]: info: -------------------------------------------
Aug 21 00:05:25 volumio volumio[754]: info: [MyVolumio PluginManager] Fetching plans data....
Aug 21 00:05:25 volumio volumio[754]: error: MPD error: The expression evaluated to a falsy value:
Aug 21 00:05:25 volumio volumio[754]: assert.ok(self.idling)
Aug 21 00:05:25 volumio volumio[754]: error: The expression evaluated to a falsy value:
Aug 21 00:05:25 volumio volumio[754]: assert.ok(self.idling)
Aug 21 00:05:25 volumio volumio[754]: info: MPD running with PID1368
Aug 21 00:05:25 volumio volumio[754]: ,establishing connection
Aug 21 00:05:25 volumio volumio[754]: error: MPD error: The expression evaluated to a falsy value:
Aug 21 00:05:25 volumio volumio[754]: assert.ok(self.idling)
Aug 21 00:05:25 volumio volumio[754]: error: The expression evaluated to a falsy value:
Aug 21 00:05:25 volumio volumio[754]: assert.ok(self.idling)
Aug 21 00:05:25 volumio volumio[754]: info: CoreCommandRouter::volumioGetVisibleSources
Aug 21 00:05:25 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Aug 21 00:05:25 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps
Aug 21 00:05:25 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode
Aug 21 00:05:25 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages
Aug 21 00:05:25 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones
Aug 21 00:05:25 volumio volumio[754]: info: Received Get System Info
Aug 21 00:05:25 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 21 00:05:25 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 21 00:05:25 volumio volumio[754]: info: Discovery: Getting this device information
Aug 21 00:05:25 volumio volumio[754]: info: CoreCommandRouter::volumioGetState
Aug 21 00:05:25 volumio volumio[754]: info: CorePlayQueue::getTrack 0
Aug 21 00:05:25 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 21 00:05:25 volumio volumio-remote-updater[476]: No test mode
Aug 21 00:05:25 volumio volumio-remote-updater[476]: No alpha test mode
Aug 21 00:05:25 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Aug 21 00:05:25 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Aug 21 00:05:25 volumio volumio[754]: error: updateQueue error: null
Aug 21 00:05:25 volumio volumio[1387]: Generating RSA private key, 4096 bit long modulus (2 primes)
Aug 21 00:05:25 volumio volumio[754]: 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}
Aug 21 00:05:25 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Aug 21 00:05:26 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Aug 21 00:05:30 volumio volumio[754]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory
Aug 21 00:05:31 volumio volumio[1387]: ........................................................................................................++++
Aug 21 00:05:34 volumio volumio[754]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
Aug 21 00:05:34 volumio volumio[754]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
Aug 21 00:05:34 volumio volumio[754]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
Aug 21 00:05:34 volumio volumio[754]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
Aug 21 00:05:34 volumio volumio[754]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
Aug 21 00:05:34 volumio volumio[754]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
Aug 21 00:05:34 volumio volumio[754]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
Aug 21 00:05:34 volumio volumio[754]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
Aug 21 00:05:34 volumio volumio[754]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
Aug 21 00:05:34 volumio volumio[754]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
Aug 21 00:05:34 volumio volumio[754]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
Aug 21 00:05:34 volumio volumio[754]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
Aug 21 00:05:34 volumio volumio[754]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
Aug 21 00:05:34 volumio volumio[754]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
Aug 21 00:05:34 volumio volumio[754]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
Aug 21 00:05:34 volumio volumio[754]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
Aug 21 00:05:34 volumio volumio[754]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
Aug 21 00:05:34 volumio volumio[754]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
Aug 21 00:05:34 volumio volumio[754]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
Aug 21 00:05:34 volumio volumio[754]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
Aug 21 00:05:34 volumio volumio[754]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
Aug 21 00:05:34 volumio volumio[754]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
Aug 21 00:05:34 volumio volumio[754]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
Aug 21 00:05:34 volumio volumio[754]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
Aug 21 00:05:34 volumio volumio[754]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
Aug 21 00:05:34 volumio volumio[754]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
Aug 21 00:05:34 volumio volumio[754]: info: Adding plugin bluetooth to MyMusic Plugins
Aug 21 00:05:34 volumio volumio[754]: info: Adding plugin multiroom to MyMusic Plugins
Aug 21 00:05:34 volumio volumio[754]: info: Adding plugin metavolumio to MyMusic Plugins
Aug 21 00:05:34 volumio volumio[754]: info: Adding plugin cd_controller to MyMusic Plugins
Aug 21 00:05:34 volumio volumio[754]: info: Adding plugin smart_inputs to MyMusic Plugins
Aug 21 00:05:34 volumio volumio[754]: info: Adding plugin tidalconnect to MyMusic Plugins
Aug 21 00:05:34 volumio volumio[754]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
Aug 21 00:05:35 volumio volumio[754]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
Aug 21 00:05:35 volumio volumio[754]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
Aug 21 00:05:35 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 21 00:05:35 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 21 00:05:35 volumio volumio[754]: info: Starting MyVolumio Remote Streaming Endpoints
Aug 21 00:05:35 volumio volumio[754]: info: MyVolumio not started
Aug 21 00:05:35 volumio volumio[754]: info: Initializing device activation check
Aug 21 00:05:35 volumio volumio[754]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
Aug 21 00:05:35 volumio volumio[754]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
Aug 21 00:05:37 volumio volumio[754]: info: Starting Streaming Service Transparent Proxy
Aug 21 00:05:37 volumio volumio[754]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Aug 21 00:05:37 volumio volumio[754]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Aug 21 00:05:37 volumio volumio[754]: info: Streaming services startup
Aug 21 00:05:37 volumio volumio[754]: info: Starting Streaming Daemon
Aug 21 00:05:37 volumio sudo[1616]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Aug 21 00:05:37 volumio sudo[1616]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 21 00:05:37 volumio sudo[1616]: pam_unix(sudo:session): session closed for user root
Aug 21 00:05:37 volumio volumio[754]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
Aug 21 00:05:37 volumio volumio[754]: error: Cannot start Volumio Streaming Daemon
Aug 21 00:05:37 volumio volumio[754]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Aug 21 00:05:37 volumio volumio[754]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Aug 21 00:05:38 volumio volumio[754]: STREAMING PROXY: Starting server on port 3245
Aug 21 00:05:38 volumio volumio[754]: Node JS runtime: 14
Aug 21 00:05:39 volumio volumio[1387]: ...............................................................................................................................................++++
Aug 21 00:05:39 volumio volumio[1387]: e is 65537 (0x010001)
Aug 21 00:05:39 volumio volumio[1387]: writing RSA key
Aug 21 00:05:39 volumio sudo[1632]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Aug 21 00:05:39 volumio sudo[1632]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 21 00:05:39 volumio sudo[1632]: pam_unix(sudo:session): session closed for user root
Aug 21 00:05:39 volumio sudo[1635]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Aug 21 00:05:39 volumio sudo[1635]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 21 00:05:39 volumio sudo[1635]: pam_unix(sudo:session): session closed for user root
Aug 21 00:05:40 volumio volumio[754]: verbose: New Socket.io Connection to 192.168.1.49 from 192.168.1.36 UA: Mozilla/5.0 (Linux; U; Android 5.1; zh-CN; MZ-m3 note Build/MRA58K) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/57.0.2987.108 MZBrowser/8.5.110-2021020110 UWS/2.15.0.4 Mobile Safari/537.36 Total Clients: 4
Aug 21 00:05:40 volumio volumio[754]: info: CoreCommandRouter::volumioGetVisibleSources
Aug 21 00:05:40 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Aug 21 00:05:40 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps
Aug 21 00:05:40 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode
Aug 21 00:05:40 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages
Aug 21 00:05:40 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones
Aug 21 00:05:40 volumio volumio[754]: info: Received Get System Info
Aug 21 00:05:40 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 21 00:05:40 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 21 00:05:40 volumio volumio[754]: info: Discovery: Getting this device information
Aug 21 00:05:40 volumio volumio[754]: info: CoreCommandRouter::volumioGetState
Aug 21 00:05:40 volumio volumio[754]: info: CorePlayQueue::getTrack 0
Aug 21 00:05:40 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 21 00:05:40 volumio volumio-remote-updater[476]: No test mode
Aug 21 00:05:40 volumio volumio-remote-updater[476]: No alpha test mode
Aug 21 00:05:40 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Aug 21 00:05:40 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Aug 21 00:05:41 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Aug 21 00:05:41 volumio volumio[754]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Aug 21 00:05:41 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Aug 21 00:05:41 volumio volumio[754]: info: Received Get System Version
Aug 21 00:05:41 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Aug 21 00:05:41 volumio volumio[754]: info: Received Get System Info
Aug 21 00:05:41 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 21 00:05:41 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 21 00:05:41 volumio volumio[754]: info: Discovery: Getting this device information
Aug 21 00:05:41 volumio volumio[754]: info: CoreCommandRouter::volumioGetState
Aug 21 00:05:41 volumio volumio[754]: info: CorePlayQueue::getTrack 0
Aug 21 00:05:41 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 21 00:05:42 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Aug 21 00:05:42 volumio volumio[754]: 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}
Aug 21 00:05:42 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Aug 21 00:05:45 volumio systemd[1]: systemd-hostnamed.service: Succeeded.
Aug 21 00:05:45 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Aug 21 00:05:46 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken
Aug 21 00:05:46 volumio volumio[754]: info: MyVolumio login type: Token
Aug 21 00:05:47 volumio volumio[754]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN
Aug 21 00:05:49 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Aug 21 00:05:50 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Aug 21 00:05:50 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 21 00:05:50 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Aug 21 00:05:50 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Aug 21 00:05:50 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Aug 21 00:05:50 volumio volumio-remote-updater[476]: No test mode
Aug 21 00:05:50 volumio volumio-remote-updater[476]: No alpha test mode
Aug 21 00:05:50 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Aug 21 00:05:50 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Aug 21 00:05:50 volumio volumio[754]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 5
Aug 21 00:05:50 volumio volumio[754]: info: CoreCommandRouter::volumioGetState
Aug 21 00:05:50 volumio volumio[754]: info: CorePlayQueue::getTrack 0
Aug 21 00:05:51 volumio volumio[754]: 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}
Aug 21 00:05:51 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Aug 21 00:05:53 volumio volumio[754]: info: MyVolumio token set successfully
Aug 21 00:05:53 volumio volumio[754]: info: MYVOLUMIO: Adding device
Aug 21 00:05:53 volumio volumio[754]: info: MYVOLUMIO: Evaluating Server
Aug 21 00:05:54 volumio volumio[754]: info: MyVolumio status changed
Aug 21 00:05:54 volumio volumio[754]: info: Streaming services startup
Aug 21 00:05:54 volumio volumio[754]: info: Starting Streaming Daemon
Aug 21 00:05:54 volumio volumio[754]: info: Removing browser output: myVolumio user plan is not superstar
Aug 21 00:05:54 volumio volumio[754]: info: Removing audio output:
Aug 21 00:05:54 volumio volumio[754]: info: Stoppping Tunnel 1
Aug 21 00:05:54 volumio sudo[1721]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Aug 21 00:05:54 volumio sudo[1721]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 21 00:05:54 volumio sudo[1721]: pam_unix(sudo:session): session closed for user root
Aug 21 00:05:54 volumio volumio[754]: error: Cannot start Volumio Streaming Daemon
Aug 21 00:05:54 volumio volumio[754]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Aug 21 00:05:54 volumio volumio[754]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Aug 21 00:05:54 volumio sudo[1724]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service
Aug 21 00:05:54 volumio sudo[1724]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 21 00:05:54 volumio sudo[1724]: pam_unix(sudo:session): session closed for user root
Aug 21 00:05:54 volumio volumio[754]: info: Remote SSH Stopped
Aug 21 00:05:54 volumio volumio[754]: info: Setting Geolocation for MyVolumio to eu7
Aug 21 00:05:54 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 21 00:05:54 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 21 00:05:54 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 21 00:05:55 volumio volumio[754]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"}
Aug 21 00:05:55 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 21 00:05:55 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 21 00:05:55 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Aug 21 00:05:55 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Aug 21 00:05:55 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Aug 21 00:05:55 volumio volumio[754]: info: CoreCommandRouter::volumioGetBrowseSources
Aug 21 00:05:55 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Aug 21 00:05:55 volumio volumio[754]: info: Updating MyVolumio device info
Aug 21 00:05:55 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 21 00:05:56 volumio volumio[754]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"}
Aug 21 00:05:57 volumio volumio[754]: error: MyVolumio Plugin failed to authenticate in a timely fashion
Aug 21 00:05:57 volumio volumio[754]: info: Completed starting MyVolumio Plugin
Aug 21 00:05:57 volumio volumio[754]: info: BOOT COMPLETED
Aug 21 00:05:57 volumio volumio[754]: [Metrics] CommandRouter: 55s 701.80ms
Aug 21 00:05:57 volumio volumio[754]: info: CoreCommandRouter::volumiosetStartupVolume
Aug 21 00:05:57 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 21 00:05:57 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 21 00:05:57 volumio volumio[754]: info: CoreCommandRouter::Close All Modals sent
Aug 21 00:05:57 volumio volumio[754]: info: CoreCommandRouter::Close All Modals sent
Aug 21 00:05:58 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Aug 21 00:05:58 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Aug 21 00:05:58 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Aug 21 00:05:59 volumio volumio[754]: info: MYVOLUMIO: Adding device
Aug 21 00:05:59 volumio volumio[754]: info: MYVOLUMIO: Evaluating Server
Aug 21 00:05:59 volumio kernel: snd_hda_intel 0000:00:1b.0: IRQ timing workaround is activated for card #0. Suggest a bigger bdl_pos_adj.
Aug 21 00:06:02 volumio volumio[754]: info: Setting Geolocation for MyVolumio to eu7
Aug 21 00:06:02 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 21 00:06:02 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 21 00:06:02 volumio volumio[754]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"}
Aug 21 00:06:03 volumio volumio[754]: info: Updating MyVolumio device info
Aug 21 00:06:03 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 21 00:06:03 volumio volumio[754]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"}
Aug 21 00:06:04 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage
Aug 21 00:06:04 volumio volumio[754]: info: Loading i18n strings for locale ru
Aug 21 00:06:04 volumio volumio[754]: Updating browse sources language
Aug 21 00:06:04 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Aug 21 00:06:04 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone
Aug 21 00:06:04 volumio volumio[754]: info: Setting timezone to null
Aug 21 00:06:04 volumio sudo[1746]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime
Aug 21 00:06:04 volumio sudo[1746]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 21 00:06:04 volumio sudo[1746]: pam_unix(sudo:session): session closed for user root
Aug 21 00:06:04 volumio sudo[1749]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/null /etc/localtime
Aug 21 00:06:04 volumio sudo[1749]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 21 00:06:04 volumio sudo[1749]: pam_unix(sudo:session): session closed for user root
Aug 21 00:06:04 volumio sudo[1752]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime
Aug 21 00:06:04 volumio sudo[1752]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 21 00:06:04 volumio sudo[1752]: pam_unix(sudo:session): session closed for user root
Aug 21 00:06:04 volumio volumio[754]: /bin/chmod: cannot operate on dangling symlink '/etc/localtime'
Aug 21 00:06:04 volumio volumio[754]: error: Could not set timezone: Error: Command failed: /usr/bin/sudo /bin/chmod 777 /etc/localtime
Aug 21 00:06:04 volumio volumio[754]: /bin/chmod: cannot operate on dangling symlink '/etc/localtime'
Aug 21 00:06:05 volumio sudo[1755]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone null
Aug 21 00:06:05 volumio sudo[1755]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 21 00:06:05 volumio dbus-daemon[472]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.16' (uid=0 pid=1756 comm="/usr/bin/timedatectl set-timezone null ")
Aug 21 00:06:05 volumio systemd[1]: Starting Time & Date Service...
Aug 21 00:06:05 volumio systemd-timedated[1757]: /etc/localtime should be a symbolic link to a time zone data file in /usr/share/zoneinfo/.
Aug 21 00:06:05 volumio dbus-daemon[472]: [system] Successfully activated service 'org.freedesktop.timedate1'
Aug 21 00:06:05 volumio systemd[1]: Started Time & Date Service.
Aug 21 00:06:05 volumio sudo[1755]: pam_unix(sudo:session): session closed for user root
Aug 21 00:06:05 volumio volumio[754]: Failed to set time zone: Invalid time zone 'null'
Aug 21 00:06:05 volumio volumio[754]: info: Could not set timezone, retrying
Aug 21 00:06:05 volumio volumio[754]: info: Fetching Streaming Services browse cache
Aug 21 00:06:05 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache
Aug 21 00:06:05 volumio volumio[754]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks
Aug 21 00:06:05 volumio sudo[1759]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Aug 21 00:06:05 volumio sudo[1759]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 21 00:06:05 volumio sudo[1759]: pam_unix(sudo:session): session closed for user root
Aug 21 00:06:05 volumio volumio[754]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan
Aug 21 00:06:05 volumio volumio[754]: wlan0 Interface doesn't support scanning : Operation not supported
Aug 21 00:06:05 volumio volumio[754]: info: Cannot use regular scanning, forcing with ap-force
Aug 21 00:06:05 volumio sudo[1762]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force
Aug 21 00:06:05 volumio sudo[1762]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 21 00:06:06 volumio sudo[1762]: pam_unix(sudo:session): session closed for user root
Aug 21 00:06:06 volumio sudo[1765]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone null
Aug 21 00:06:06 volumio sudo[1765]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 21 00:06:06 volumio sudo[1765]: pam_unix(sudo:session): session closed for user root
Aug 21 00:06:06 volumio volumio[754]: Failed to set time zone: Invalid time zone 'null'
Aug 21 00:06:06 volumio volumio[754]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Aug 21 00:06:06 volumio volumio[754]: Error: Command failed: /usr/bin/sudo /usr/bin/timedatectl set-timezone 'null'
Aug 21 00:06:06 volumio volumio[754]: Failed to set time zone: Invalid time zone 'null'
Aug 21 00:06:06 volumio volumio[754]: at checkExecSyncError (child_process.js:790:11)
Aug 21 00:06:06 volumio volumio[754]: at execSync (child_process.js:863:15)
Aug 21 00:06:06 volumio volumio[754]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/system/index.js:1557:9)
Aug 21 00:06:06 volumio volumio[754]: at listOnTimeout (internal/timers.js:557:17)
Aug 21 00:06:06 volumio volumio[754]: at processTimers (internal/timers.js:500:7) {
Aug 21 00:06:06 volumio volumio[754]: status: 1,
Aug 21 00:06:06 volumio volumio[754]: signal: null,
Aug 21 00:06:06 volumio volumio[754]: output: [ null, '', "Failed to set time zone: Invalid time zone 'null'\n" ],
Aug 21 00:06:06 volumio volumio[754]: pid: 1764,
Aug 21 00:06:06 volumio volumio[754]: stdout: '',
Aug 21 00:06:06 volumio volumio[754]: stderr: "Failed to set time zone: Invalid time zone 'null'\n"
Aug 21 00:06:06 volumio volumio[754]: }
Aug 21 00:06:06 volumio volumio[754]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Aug 21 00:06:07 volumio sudo[1776]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-21 00:05
Aug 21 00:06:07 volumio sudo[1776]: 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="7b9cb4a8b52fb7148a38d6ac651c1c29e09bb92c"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="b1dcc17f6d31bf91f0abd3c3fa57506d1e0d2b6b"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri 01 Mar 2024 08:52:33 PM CET"
VOLUMIO_VERSION="3.634"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="93edfc70711724967af109c0a39fa069"