-- Logs begin at Sat 2024-03-30 12:56:10 UTC, end at Sat 2024-03-30 13:03:54 UTC. --
Mar 30 13:03:31 volumio systemd[1]: Time has been changed
Mar 30 13:03:31 volumio volumio[956]: info: Loading plugin "network"...
Mar 30 13:03:32 volumio volumio[956]: info: Loading plugin "services"...
Mar 30 13:03:32 volumio volumio[956]: info: Loading plugin "alsa_controller"...
Mar 30 13:03:32 volumio volumio[956]: info: Loading plugin "wizard"...
Mar 30 13:03:32 volumio volumio[956]: info: Loading plugin "volumio_command_line_client"...
Mar 30 13:03:32 volumio volumio[956]: info: Loading plugin "upnp"...
Mar 30 13:03:32 volumio volumio[956]: info: [1711803812718] Starting Upmpd Daemon
Mar 30 13:03:32 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Mar 30 13:03:32 volumio volumio[956]: info: Loading plugin "my_music"...
Mar 30 13:03:32 volumio volumio[956]: info: Loading plugin "mpd"...
Mar 30 13:03:33 volumio volumio-remote-updater[617]: [2024-03-30 13:03:33] [connect] Successful connection
Mar 30 13:03:35 volumio sudo[1093]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Mar 30 13:03:35 volumio sudo[1093]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 30 13:03:35 volumio sudo[1093]: pam_unix(sudo:session): session closed for user root
Mar 30 13:03:35 volumio volumio[956]: info: Loading plugin "upnp_browser"...
Mar 30 13:03:35 volumio sudo[1096]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Mar 30 13:03:35 volumio sudo[1096]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 30 13:03:35 volumio systemd[1]: Stopping Music Player Daemon...
Mar 30 13:03:37 volumio dhcpcd[528]: timed out
Mar 30 13:03:37 volumio dhcpcd[528]: exited
Mar 30 13:03:37 volumio ifup[496]: dhcpcd[528]: timed out
Mar 30 13:03:37 volumio ifup[496]: dhcpcd[528]: exited
Mar 30 13:03:37 volumio ifup[496]: Failed to bring up eth0.
Mar 30 13:03:37 volumio systemd[1]: Starting Music Player Daemon...
Mar 30 13:03:38 volumio systemd[1]: Started Music Player Daemon.
Mar 30 13:03:38 volumio sudo[1096]: pam_unix(sudo:session): session closed for user root
Mar 30 13:03:39 volumio volumio[956]: info: Loading plugin "networkfs"...
Mar 30 13:03:40 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Mar 30 13:03:40 volumio volumio[956]: info: Loading plugin "alarm-clock"...
Mar 30 13:03:42 volumio volumio[956]: info: Loading plugin "airplay_emulation"...
Mar 30 13:03:42 volumio volumio[956]: info: Starting Shairport Sync
Mar 30 13:03:42 volumio volumio[956]: info: Loading plugin "last_100"...
Mar 30 13:03:42 volumio volumio[956]: info: Loading plugin "webradio"...
Mar 30 13:03:42 volumio volumio[956]: info: Loading plugin "i2s_dacs"...
Mar 30 13:03:42 volumio volumio[956]: info: I2S DAC not set, start Auto-detection
Mar 30 13:03:42 volumio volumio[956]: info: Loading plugin "volumiodiscovery"...
Mar 30 13:03:42 volumio volumio[956]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Mar 30 13:03:42 volumio node[956]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Mar 30 13:03:42 volumio node[956]: *** WARNING *** Please fix your application to use the native API of Avahi!
Mar 30 13:03:42 volumio node[956]: *** WARNING *** For more information see
Mar 30 13:03:42 volumio node[956]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Mar 30 13:03:42 volumio node[956]: *** WARNING *** Please fix your application to use the native API of Avahi!
Mar 30 13:03:42 volumio node[956]: *** WARNING *** For more information see
Mar 30 13:03:42 volumio volumio[956]: *** WARNING *** Please fix your application to use the native API of Avahi!
Mar 30 13:03:42 volumio volumio[956]: *** WARNING *** For more information see
Mar 30 13:03:42 volumio volumio[956]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Mar 30 13:03:42 volumio volumio[956]: *** WARNING *** Please fix your application to use the native API of Avahi!
Mar 30 13:03:42 volumio volumio[956]: *** WARNING *** For more information see
Mar 30 13:03:42 volumio volumio[956]: info: Applying required configuration parameters for plugin volumiodiscovery
Mar 30 13:03:42 volumio volumio[956]: Discovery: StartAdv! undefined
Mar 30 13:03:42 volumio volumio[956]: Discovery: Started advertising... Volumio - undefined
Mar 30 13:03:42 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Mar 30 13:03:42 volumio volumio[956]: info: Loading plugin "outputs"...
Mar 30 13:03:42 volumio volumio[956]: info: Loading plugin "albumart"...
Mar 30 13:03:43 volumio volumio[956]: info: Plugin example_plugin is not enabled
Mar 30 13:03:43 volumio volumio[956]: info: Loading plugin "inputs"...
Mar 30 13:03:43 volumio volumio[956]: info: Loading plugin "updater_comm"...
Mar 30 13:03:43 volumio volumio[956]: Forking 1 albumart workers
Mar 30 13:03:44 volumio volumio[956]: info: Plugin mpdemulation is not enabled
Mar 30 13:03:44 volumio volumio[956]: info: Loading plugin "rest_api"...
Mar 30 13:03:44 volumio volumio[956]: info: Loading plugin "websocket"...
Mar 30 13:03:44 volumio volumio[956]: info: ___________ START PLUGINS ___________
Mar 30 13:03:44 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Mar 30 13:03:44 volumio volumio[956]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Mar 30 13:03:44 volumio volumio[956]: info: [1711803824525] CoreMusicLibrary::Adding element Media Servers
Mar 30 13:03:44 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 30 13:03:44 volumio volumio[956]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Mar 30 13:03:44 volumio volumio[956]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Mar 30 13:03:44 volumio volumio[956]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Mar 30 13:03:44 volumio volumio[956]: info: [1711803824726] CoreMusicLibrary::Adding element Last_100
Mar 30 13:03:44 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 30 13:03:44 volumio volumio[956]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Mar 30 13:03:44 volumio volumio[956]: info: [1711803824736] CoreMusicLibrary::Adding element Webradio
Mar 30 13:03:44 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 30 13:03:44 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Mar 30 13:03:44 volumio volumio[956]: info: -------------------------------------------
Mar 30 13:03:44 volumio volumio[956]: info: ----- MyVolumio plugins startup ----
Mar 30 13:03:44 volumio volumio[956]: info: -------------------------------------------
Mar 30 13:03:44 volumio volumio[956]: info: [MyVolumio PluginManager] Fetching plans data....
Mar 30 13:03:44 volumio volumio[956]: info: Loading i18n strings for locale ru
Mar 30 13:03:44 volumio volumio[956]: Updating browse sources language
Mar 30 13:03:44 volumio volumio[956]: Cannot find translation for sourceMedia Servers
Mar 30 13:03:44 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 30 13:03:44 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Mar 30 13:03:44 volumio volumio[956]: info: CoreCommandRouter::initPlayerControls
Mar 30 13:03:45 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 30 13:03:45 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards
Mar 30 13:03:45 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 30 13:03:45 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 30 13:03:45 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 30 13:03:45 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 30 13:03:45 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 30 13:03:45 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Mar 30 13:03:45 volumio volumio[956]: info: BOOT COMPLETED
Mar 30 13:03:45 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 30 13:03:45 volumio volumio[956]: Starting albumart workers
Mar 30 13:03:48 volumio volumio-remote-updater[617]: [2024-03-30 13:03:48] [connect] Successful connection
Mar 30 13:03:52 volumio volumio[956]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo
Mar 30 13:03:52 volumio volumio[956]: underrun!!! (at least 333.810 ms long)
Mar 30 13:03:52 volumio volumio[956]: underrun!!! (at least 316.466 ms long)
Mar 30 13:03:52 volumio volumio[956]: underrun!!! (at least 113.924 ms long)
Mar 30 13:03:52 volumio volumio[956]: info: CoreCommandRouter::Close All Modals sent
Mar 30 13:03:52 volumio volumio[956]: info: CoreCommandRouter::Close All Modals sent
Mar 30 13:03:52 volumio volumio[956]: Express server listening on port 3000
Mar 30 13:03:52 volumio volumio[956]: info: Setting Device type: x86
Mar 30 13:03:52 volumio volumio[956]: Volumio Calling Home
Mar 30 13:03:52 volumio volumio[956]: info: CoreStateMachine::resetVolumioState
Mar 30 13:03:52 volumio volumio[956]: info: CoreStateMachine::getcurrentVolume
Mar 30 13:03:52 volumio volumio[956]: info: CoreCommandRouter::volumioRetrievevolume
Mar 30 13:03:52 volumio sudo[1191]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Mar 30 13:03:52 volumio sudo[1191]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 30 13:03:52 volumio sudo[1191]: pam_unix(sudo:session): session closed for user root
Mar 30 13:03:52 volumio volumio[956]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt'
Mar 30 13:03:52 volumio volumio[956]: info: MPD Permissions set
Mar 30 13:03:52 volumio sudo[1195]: pam_unix(sudo:auth): conversation failed
Mar 30 13:03:52 volumio sudo[1195]: pam_unix(sudo:auth): auth could not identify password for [volumio]
Mar 30 13:03:52 volumio volumio-remote-updater[617]: [2024-03-30 13:03:52] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1711803828 101
Mar 30 13:03:52 volumio volumio[956]: info: VolumeController:: Volume=100 Mute =false
Mar 30 13:03:52 volumio volumio[956]: info: CoreStateMachine::pushState
Mar 30 13:03:52 volumio volumio[956]: info: CoreStateMachine::getState
Mar 30 13:03:52 volumio volumio[956]: info: CorePlayQueue::getTrack 0
Mar 30 13:03:52 volumio volumio[956]: info: CoreCommandRouter::volumioPushState
Mar 30 13:03:52 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 30 13:03:52 volumio volumio[956]: info: CoreStateMachine::updateTrackBlock
Mar 30 13:03:52 volumio volumio[956]: info: CorePlayQueue::getTrackBlock
Mar 30 13:03:52 volumio volumio[956]: info: CoreCommandRouter::volumioRetrievevolume
Mar 30 13:03:53 volumio volumio[956]: info: Cannot read I2C interface or I2C interface not presentError: Command failed: /usr/bin/sudo /usr/sbin/i2cdetect -y 1
Mar 30 13:03:53 volumio volumio[956]: We trust you have received the usual lecture from the local System
Mar 30 13:03:53 volumio volumio[956]: Administrator. It usually boils down to these three things:
Mar 30 13:03:53 volumio volumio[956]: #1) Respect the privacy of others.
Mar 30 13:03:53 volumio volumio[956]: #2) Think before you type.
Mar 30 13:03:53 volumio volumio[956]: #3) With great power comes great responsibility.
Mar 30 13:03:53 volumio volumio[956]: sudo: no tty present and no askpass program specified
Mar 30 13:03:53 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 30 13:03:53 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 30 13:03:53 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 30 13:03:53 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 30 13:03:53 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 30 13:03:53 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 30 13:03:53 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 30 13:03:53 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 30 13:03:53 volumio volumio[956]: info:
Mar 30 13:03:53 volumio volumio[956]: info: ControllerMpd::sendMpdCommand update
Mar 30 13:03:53 volumio volumio[956]: info: sending command...
Mar 30 13:03:53 volumio volumio[956]: info: MPD running with PID1101 ,establishing connection
Mar 30 13:03:53 volumio volumio[956]: info: ControllerMpd::sendMpdCommand status
Mar 30 13:03:53 volumio volumio[956]: info:
Mar 30 13:03:53 volumio volumio[956]: ---------------------------- MPD announces state update: update
Mar 30 13:03:53 volumio volumio[956]: info: parsing response...
Mar 30 13:03:53 volumio volumio[956]: info: ControllerMpd::getState
Mar 30 13:03:53 volumio volumio[956]: info: ControllerMpd::sendMpdCommand status
Mar 30 13:03:53 volumio volumio[956]: info: VolumeController:: Volume=100 Mute =false
Mar 30 13:03:53 volumio volumio[956]: info: CoreStateMachine::pushState
Mar 30 13:03:53 volumio volumio[956]: info: CoreStateMachine::getState
Mar 30 13:03:53 volumio volumio[956]: info: CorePlayQueue::getTrack 0
Mar 30 13:03:53 volumio volumio[956]: info: CoreCommandRouter::volumioPushState
Mar 30 13:03:53 volumio volumio[956]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 30 13:03:53 volumio volumio[956]: info: Reloading queue from file
Mar 30 13:03:53 volumio volumio[956]: info: MPD Database updated - AlbumList cache refreshed
Mar 30 13:03:53 volumio volumio[956]: info:
Mar 30 13:03:53 volumio volumio[956]: ---------------------------- MPD announces state update: database
Mar 30 13:03:53 volumio volumio[956]: info: ControllerMpd::sendMpdCommand status
Mar 30 13:03:53 volumio volumio[956]: info:
Mar 30 13:03:53 volumio volumio[956]: ---------------------------- MPD announces state update: update
Mar 30 13:03:53 volumio volumio[956]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 30 13:03:53 volumio volumio[956]: { AssertionError [ERR_ASSERTION]: false == true
Mar 30 13:03:53 volumio volumio[956]: at MpdClient.sendCommand (/volumio/app/plugins/music_service/mpd/lib/mpd.js:92:9)
Mar 30 13:03:53 volumio volumio[956]: at /volumio/app/plugins/music_service/mpd/index.js:3118:28
Mar 30 13:03:53 volumio volumio[956]: at _combinedTickCallback (internal/process/next_tick.js:131:7)
Mar 30 13:03:53 volumio volumio[956]: at process._tickCallback (internal/process/next_tick.js:180:9)
Mar 30 13:03:53 volumio volumio[956]: generatedMessage: true,
Mar 30 13:03:53 volumio volumio[956]: name: 'AssertionError [ERR_ASSERTION]',
Mar 30 13:03:53 volumio volumio[956]: code: 'ERR_ASSERTION',
Mar 30 13:03:53 volumio volumio[956]: actual: false,
Mar 30 13:03:53 volumio volumio[956]: expected: true,
Mar 30 13:03:53 volumio volumio[956]: operator: '==' }
Mar 30 13:03:53 volumio volumio[956]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 30 13:03:54 volumio sudo[1220]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-03-30 13:02
Mar 30 13:03:54 volumio sudo[1220]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 8 (jessie)"
NAME="Debian GNU/Linux"
VERSION_ID="8"
VERSION="8 (jessie)"
ID=debian
HOME_URL="http://www.debian.org/"
SUPPORT_URL="http://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="80e3a7415791a01dac7cd7cc2cc0a3d3fc65ba9d"
VOLUMIO_FE_VERSION=""
VOLUMIO_BE_VERSION="a5d5fb6aa4e4c71be85580a005adf6b2009366a5"
VOLUMIO_ARCH="x86"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu Jan 16 20:39:24 CET 2020"
VOLUMIO_VERSION="2.698"
VOLUMIO_HARDWARE="x86"
VOLUMIO_HASH="248eba14dbaa0e62252bbd3ba3c90535"