-- Logs begin at Thu 2019-02-14 10:12:01 UTC, end at Fri 2023-01-20 18:09:00 UTC. -- Jan 20 18:08:01 hudba volumio-remote-updater[445]: [2023-01-20 18:08:01] [connect] Successful connection Jan 20 18:08:03 hudba volumio[729]: info: Loading plugin "ytcr"... Jan 20 18:08:04 hudba dhcpcd[761]: eth0: probing for an IPv4LL address Jan 20 18:08:09 hudba volumio[729]: info: Loading plugin "ytmusic"... Jan 20 18:08:09 hudba dhcpcd[761]: eth0: using IPv4LL address 169.254.173.196 Jan 20 18:08:09 hudba dhcpcd[761]: eth0: adding route to 169.254.0.0/16 Jan 20 18:08:09 hudba dhcpcd[761]: eth0: adding default route Jan 20 18:08:09 hudba avahi-daemon[444]: Joining mDNS multicast group on interface eth0.IPv4 with address 169.254.173.196. Jan 20 18:08:09 hudba avahi-daemon[444]: New relevant interface eth0.IPv4 for mDNS. Jan 20 18:08:09 hudba avahi-daemon[444]: Registering new address record for 169.254.173.196 on eth0.IPv4. Jan 20 18:08:11 hudba ntpd[640]: Listen normally on 4 eth0 169.254.173.196:123 Jan 20 18:08:11 hudba ntpd[640]: new interface(s) found: waking up resolver Jan 20 18:08:11 hudba dhcpcd[761]: eth0: offered 192.168.1.11 from 192.168.1.1 Jan 20 18:08:11 hudba dhcpcd[761]: eth0: probing address 192.168.1.11/24 Jan 20 18:08:16 hudba dhcpcd[761]: eth0: leased 192.168.1.11 for 86400 seconds Jan 20 18:08:16 hudba dhcpcd[761]: eth0: adding route to 192.168.1.0/24 Jan 20 18:08:16 hudba dhcpcd[761]: eth0: changing default route via 192.168.1.1 Jan 20 18:08:16 hudba avahi-daemon[444]: Registering new address record for 192.168.1.11 on eth0.IPv4. Jan 20 18:08:16 hudba avahi-daemon[444]: Withdrawing address record for 169.254.173.196 on eth0. Jan 20 18:08:16 hudba avahi-daemon[444]: Leaving mDNS multicast group on interface eth0.IPv4 with address 169.254.173.196. Jan 20 18:08:16 hudba dhcpcd[761]: eth0: deleting route to 169.254.0.0/16 Jan 20 18:08:16 hudba avahi-daemon[444]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.11. Jan 20 18:08:16 hudba dhcpcd[761]: eth0: pid 761 deleted default route via 192.168.1.1 Jan 20 18:08:16 hudba volumio[729]: info: Loading plugin "outputs"... Jan 20 18:08:16 hudba volumio[729]: info: Loading plugin "albumart"... Jan 20 18:08:16 hudba volumio[729]: info: Plugin example_plugin is not enabled Jan 20 18:08:16 hudba volumio[729]: info: Loading plugin "inputs"... Jan 20 18:08:16 hudba volumio[729]: info: Loading plugin "updater_comm"... Jan 20 18:08:16 hudba volumio[729]: info: Plugin mpdemulation is not enabled Jan 20 18:08:16 hudba volumio[729]: info: Loading plugin "rest_api"... Jan 20 18:08:16 hudba volumio[729]: info: Loading plugin "websocket"... Jan 20 18:08:16 hudba volumio[729]: info: Loading plugin "motherearthradio"... Jan 20 18:08:16 hudba volumio-remote-updater[445]: [2023-01-20 18:08:16] [connect] Successful connection Jan 20 18:08:16 hudba volumio[729]: Forking 3 albumart workers Jan 20 18:08:17 hudba volumio[729]: Starting albumart workers Jan 20 18:08:17 hudba volumio[729]: Starting albumart workers Jan 20 18:08:17 hudba volumio[729]: Starting albumart workers Jan 20 18:08:18 hudba ntpd[640]: Listen normally on 5 eth0 192.168.1.11:123 Jan 20 18:08:18 hudba ntpd[640]: Deleting interface #4 eth0, 169.254.173.196#123, interface stats: received=0, sent=0, dropped=0, active_time=7 secs Jan 20 18:08:18 hudba ntpd[640]: new interface(s) found: waking up resolver Jan 20 18:08:18 hudba volumio[729]: info: Applying required configuration parameters for plugin motherearthradio Jan 20 18:08:18 hudba volumio[729]: info: [1674238098192] [MotherEarth] API delay: 5 Jan 20 18:08:18 hudba volumio[729]: info: Loading plugin "radio_paradise"... Jan 20 18:08:19 hudba volumio[729]: info: Applying required configuration parameters for plugin radio_paradise Jan 20 18:08:19 hudba volumio[729]: info: [1674238099266] [RadioParadise] API delay: 5 Jan 20 18:08:19 hudba volumio[729]: info: Loading plugin "Systeminfo"... Jan 20 18:08:20 hudba volumio[729]: info: Loading plugin "lastfm"... Jan 20 18:08:22 hudba volumio[729]: info: Loading i18n strings for locale sk Jan 20 18:08:22 hudba volumio[729]: Updating browse sources language Jan 20 18:08:22 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 18:08:23 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 20 18:08:23 hudba volumio[729]: info: CoreCommandRouter::initPlayerControls Jan 20 18:08:23 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 18:08:23 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 18:08:23 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 18:08:23 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 18:08:23 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 18:08:23 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 18:08:23 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 18:08:23 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 18:08:23 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 20 18:08:23 hudba volumio[729]: Express server listening on port 3000 Jan 20 18:08:23 hudba volumio[729]: [Metrics] WebUI: 58s 763.91ms Jan 20 18:08:23 hudba volumio[729]: info: CoreStateMachine::resetVolumioState Jan 20 18:08:23 hudba volumio[729]: info: CoreStateMachine::getcurrentVolume Jan 20 18:08:23 hudba volumio[729]: info: CoreCommandRouter::volumioRetrievevolume Jan 20 18:08:23 hudba volumio[729]: info: CoreStateMachine::pushState Jan 20 18:08:23 hudba volumio[729]: info: CorePlayQueue::getTrack 0 Jan 20 18:08:23 hudba volumio[729]: info: CoreCommandRouter::volumioPushState Jan 20 18:08:23 hudba sudo[966]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 20 18:08:23 hudba sudo[966]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 18:08:23 hudba sudo[966]: pam_unix(sudo:session): session closed for user root Jan 20 18:08:23 hudba sudo[969]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 20 18:08:23 hudba sudo[969]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 18:08:23 hudba sudo[969]: pam_unix(sudo:session): session closed for user root Jan 20 18:08:23 hudba volumio[729]: info: MPD Permissions set Jan 20 18:08:23 hudba volumio[729]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 1 Jan 20 18:08:23 hudba volumio[729]: info: MPD running with PID819 Jan 20 18:08:23 hudba volumio[729]: ,establishing connection Jan 20 18:08:23 hudba volumio[729]: info: Reloading queue from file Jan 20 18:08:23 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 18:08:23 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 18:08:23 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 18:08:23 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 18:08:23 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 18:08:23 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 18:08:23 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 18:08:23 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 18:08:23 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 18:08:23 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 18:08:23 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 18:08:23 hudba volumio[729]: error: updateQueue error: null Jan 20 18:08:23 hudba volumio[729]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Jan 20 18:08:23 hudba volumio[729]: info: Setting Device type: Raspberry PI Jan 20 18:08:23 hudba volumio[729]: info: CoreStateMachine::setRepeat false single undefined Jan 20 18:08:23 hudba volumio[729]: info: CoreStateMachine::pushState Jan 20 18:08:23 hudba volumio[729]: info: CorePlayQueue::getTrack 0 Jan 20 18:08:23 hudba volumio[729]: info: CoreCommandRouter::volumioPushState Jan 20 18:08:23 hudba volumio[729]: info: CoreStateMachine::setRandom true Jan 20 18:08:23 hudba volumio[729]: info: CoreStateMachine::pushState Jan 20 18:08:23 hudba volumio[729]: info: CorePlayQueue::getTrack 0 Jan 20 18:08:23 hudba volumio[729]: info: CoreCommandRouter::volumioPushState Jan 20 18:08:23 hudba volumio[729]: info: Completed loading Core Plugins Jan 20 18:08:23 hudba volumio[729]: info: Preparing to generate the ALSA configuration file Jan 20 18:08:23 hudba volumio[729]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jan 20 18:08:23 hudba volumio[729]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jan 20 18:08:23 hudba volumio[729]: info: Reading ALSA contributions from plugins. Jan 20 18:08:23 hudba volumio[729]: error: updateQueue error: null Jan 20 18:08:23 hudba sudo[983]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jan 20 18:08:23 hudba sudo[983]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 18:08:23 hudba volumio[729]: info: Discovery: A device disappeared from network Jan 20 18:08:23 hudba systemd[1]: Started UPnP Renderer front-end to MPD. Jan 20 18:08:23 hudba sudo[983]: pam_unix(sudo:session): session closed for user root Jan 20 18:08:23 hudba volumio[729]: info: Upmpdcli Daemon Started Jan 20 18:08:24 hudba volumio[729]: info: Asound.conf file unchanged, so no further update is needed Jan 20 18:08:24 hudba volumio[729]: info: Output device has changed, restarting MPD Jan 20 18:08:24 hudba sudo[989]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 20 18:08:24 hudba sudo[989]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 18:08:24 hudba volumio[729]: info: Output device has changed, restarting Shairport Sync Jan 20 18:08:24 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 18:08:24 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 18:08:24 hudba sudo[989]: pam_unix(sudo:session): session closed for user root Jan 20 18:08:24 hudba sudo[992]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 20 18:08:24 hudba sudo[992]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 18:08:24 hudba systemd[1]: Stopping Music Player Daemon... Jan 20 18:08:24 hudba volumio[729]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 20 18:08:24 hudba volumio[729]: info: ___________ START PLUGINS ___________ Jan 20 18:08:24 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 20 18:08:24 hudba volumio[729]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 18:08:24 hudba volumio[729]: info: [1674238104131] CoreMusicLibrary::Adding element Media Servers Jan 20 18:08:24 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 18:08:24 hudba volumio[729]: Cannot find translation for sourceMedia Servers Jan 20 18:08:24 hudba systemd[1]: mpd.service: Succeeded. Jan 20 18:08:24 hudba systemd[1]: Stopped Music Player Daemon. Jan 20 18:08:24 hudba systemd[1]: Starting Music Player Daemon... Jan 20 18:08:24 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 18:08:24 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 18:08:24 hudba volumio[729]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 20 18:08:24 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 18:08:24 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 18:08:24 hudba volumio[729]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 20 18:08:24 hudba volumio[729]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 18:08:24 hudba volumio[729]: info: [1674238104291] CoreMusicLibrary::Adding element Last_100 Jan 20 18:08:24 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 18:08:24 hudba volumio[729]: Cannot find translation for sourceMedia Servers Jan 20 18:08:24 hudba volumio[729]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 18:08:24 hudba volumio[729]: info: [1674238104294] CoreMusicLibrary::Adding element Webradio Jan 20 18:08:24 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 18:08:24 hudba volumio[729]: Cannot find translation for sourceMedia Servers Jan 20 18:08:24 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 20 18:08:24 hudba volumio[729]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 18:08:24 hudba volumio[729]: info: [1674238104315] CoreMusicLibrary::Adding element Bandcamp Discover Jan 20 18:08:24 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 18:08:24 hudba volumio[729]: Cannot find translation for sourceMedia Servers Jan 20 18:08:24 hudba volumio[729]: Cannot find translation for sourceBandcamp Discover Jan 20 18:08:24 hudba volumio[729]: info: Adding Calm Radio to Browse Sources Jan 20 18:08:24 hudba volumio[729]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 18:08:24 hudba volumio[729]: info: [1674238104320] CoreMusicLibrary::Adding element Calm Radio Jan 20 18:08:24 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 18:08:24 hudba volumio[729]: Cannot find translation for sourceMedia Servers Jan 20 18:08:24 hudba volumio[729]: Cannot find translation for sourceBandcamp Discover Jan 20 18:08:24 hudba volumio[729]: Cannot find translation for sourceCalm Radio Jan 20 18:08:24 hudba volumio[729]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 18:08:24 hudba volumio[729]: info: [1674238104332] CoreMusicLibrary::Adding element Mixcloud Jan 20 18:08:24 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 18:08:24 hudba volumio[729]: Cannot find translation for sourceMedia Servers Jan 20 18:08:24 hudba volumio[729]: Cannot find translation for sourceBandcamp Discover Jan 20 18:08:24 hudba volumio[729]: Cannot find translation for sourceCalm Radio Jan 20 18:08:24 hudba volumio[729]: Cannot find translation for sourceMixcloud Jan 20 18:08:24 hudba volumio[729]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 18:08:24 hudba volumio[729]: info: [1674238104390] CoreMusicLibrary::Adding element SoundCloud Jan 20 18:08:24 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 18:08:24 hudba volumio[729]: Cannot find translation for sourceMedia Servers Jan 20 18:08:24 hudba volumio[729]: Cannot find translation for sourceBandcamp Discover Jan 20 18:08:24 hudba volumio[729]: Cannot find translation for sourceCalm Radio Jan 20 18:08:24 hudba volumio[729]: Cannot find translation for sourceMixcloud Jan 20 18:08:24 hudba volumio[729]: Cannot find translation for sourceSoundCloud Jan 20 18:08:24 hudba volumio[729]: info: Checking for old spotify connect plugin installed Jan 20 18:08:24 hudba volumio[729]: info: [youtube2-auth] Starting auth flow... Jan 20 18:08:24 hudba volumio[729]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 18:08:24 hudba volumio[729]: info: [1674238104486] CoreMusicLibrary::Adding element YouTube2 Jan 20 18:08:24 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 18:08:24 hudba volumio[729]: Cannot find translation for sourceMedia Servers Jan 20 18:08:24 hudba volumio[729]: Cannot find translation for sourceBandcamp Discover Jan 20 18:08:24 hudba volumio[729]: Cannot find translation for sourceCalm Radio Jan 20 18:08:24 hudba volumio[729]: Cannot find translation for sourceMixcloud Jan 20 18:08:24 hudba volumio[729]: Cannot find translation for sourceSoundCloud Jan 20 18:08:24 hudba volumio[729]: Cannot find translation for sourceYouTube2 Jan 20 18:08:24 hudba volumio[729]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 18:08:24 hudba volumio[729]: info: [1674238104606] CoreMusicLibrary::Adding element Mother Earth Radio Jan 20 18:08:24 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 18:08:24 hudba volumio[729]: Cannot find translation for sourceMedia Servers Jan 20 18:08:24 hudba volumio[729]: Cannot find translation for sourceBandcamp Discover Jan 20 18:08:24 hudba volumio[729]: Cannot find translation for sourceCalm Radio Jan 20 18:08:24 hudba volumio[729]: Cannot find translation for sourceMixcloud Jan 20 18:08:24 hudba volumio[729]: Cannot find translation for sourceSoundCloud Jan 20 18:08:24 hudba volumio[729]: Cannot find translation for sourceYouTube2 Jan 20 18:08:24 hudba volumio[729]: Cannot find translation for sourceMother Earth Radio Jan 20 18:08:24 hudba volumio[729]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 18:08:24 hudba volumio[729]: info: [1674238104616] CoreMusicLibrary::Adding element Radio Paradise Jan 20 18:08:24 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 18:08:24 hudba volumio[729]: Cannot find translation for sourceMedia Servers Jan 20 18:08:24 hudba volumio[729]: Cannot find translation for sourceBandcamp Discover Jan 20 18:08:24 hudba volumio[729]: Cannot find translation for sourceCalm Radio Jan 20 18:08:24 hudba volumio[729]: Cannot find translation for sourceMixcloud Jan 20 18:08:24 hudba volumio[729]: Cannot find translation for sourceSoundCloud Jan 20 18:08:24 hudba volumio[729]: Cannot find translation for sourceYouTube2 Jan 20 18:08:24 hudba volumio[729]: Cannot find translation for sourceMother Earth Radio Jan 20 18:08:24 hudba volumio[729]: Cannot find translation for sourceRadio Paradise Jan 20 18:08:24 hudba volumio[729]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 18:08:24 hudba volumio[729]: info: [1674238104621] CoreMusicLibrary::Adding element LastFM Jan 20 18:08:24 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 18:08:24 hudba volumio[729]: Cannot find translation for sourceMedia Servers Jan 20 18:08:24 hudba volumio[729]: Cannot find translation for sourceBandcamp Discover Jan 20 18:08:24 hudba volumio[729]: Cannot find translation for sourceCalm Radio Jan 20 18:08:24 hudba volumio[729]: Cannot find translation for sourceMixcloud Jan 20 18:08:24 hudba volumio[729]: Cannot find translation for sourceSoundCloud Jan 20 18:08:24 hudba volumio[729]: Cannot find translation for sourceYouTube2 Jan 20 18:08:24 hudba volumio[729]: Cannot find translation for sourceMother Earth Radio Jan 20 18:08:24 hudba volumio[729]: Cannot find translation for sourceRadio Paradise Jan 20 18:08:24 hudba volumio[729]: Cannot find translation for sourceLastFM Jan 20 18:08:24 hudba volumio[729]: info: [LastFM] scrobbler initiated! Jan 20 18:08:24 hudba volumio[729]: info: [LastFM] extended logging: false Jan 20 18:08:24 hudba volumio[729]: info: [LastFM] try scrobble stream/radio plays: true Jan 20 18:08:24 hudba volumio[729]: info: [LastFM] Left init routine Jan 20 18:08:24 hudba volumio[729]: info: [LastFM] Socket already connected: true Jan 20 18:08:24 hudba volumio[729]: info: Volumio Calling Home Jan 20 18:08:24 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 20 18:08:24 hudba volumio[729]: [SpotifyConnect] Creating VLS config file Jan 20 18:08:24 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 18:08:24 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 18:08:24 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 18:08:24 hudba volumio[729]: [SpotifyConnect] Starting metadata listener Jan 20 18:08:24 hudba sudo[1010]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect.service Jan 20 18:08:24 hudba sudo[1010]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 18:08:24 hudba systemd[1]: Started Volspotconnect2 Daemon. Jan 20 18:08:24 hudba sudo[1010]: pam_unix(sudo:session): session closed for user root Jan 20 18:08:24 hudba volumio[729]: info: MPD Permissions set Jan 20 18:08:24 hudba volumio[729]: [SpotifyConnect] Vollibrespot Daemon service started! Jan 20 18:08:24 hudba volumio[729]: [Metrics] SpotifyConnect: 0s 134.93ms Jan 20 18:08:24 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 18:08:24 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 18:08:24 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 18:08:24 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 18:08:24 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 18:08:24 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 18:08:24 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 18:08:24 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 18:08:24 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 18:08:24 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 18:08:24 hudba volumio[729]: info: Starting Shairport Sync Jan 20 18:08:24 hudba volumio[729]: info: Starting Shairport Sync Jan 20 18:08:24 hudba sudo[1019]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 20 18:08:24 hudba sudo[1019]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 18:08:24 hudba volumio[729]: info: Starting Shairport Sync Jan 20 18:08:25 hudba sudo[1022]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 20 18:08:25 hudba sudo[1022]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 18:08:25 hudba systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 20 18:08:25 hudba systemd[1]: shairport-sync.service: Succeeded. Jan 20 18:08:25 hudba systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 20 18:08:25 hudba sudo[1025]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 20 18:08:25 hudba sudo[1025]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 18:08:25 hudba systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 20 18:08:25 hudba sudo[1019]: pam_unix(sudo:session): session closed for user root Jan 20 18:08:25 hudba sudo[1022]: pam_unix(sudo:session): session closed for user root Jan 20 18:08:25 hudba volumio[729]: info: Shairport-Sync Started Jan 20 18:08:25 hudba volumio[729]: Error adding Membership: Error: addMembership EINVAL Jan 20 18:08:25 hudba volumio[729]: info: Shairport-Sync Started Jan 20 18:08:25 hudba systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 20 18:08:25 hudba systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Jan 20 18:08:25 hudba systemd[1]: shairport-sync.service: Succeeded. Jan 20 18:08:25 hudba systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 20 18:08:25 hudba systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 20 18:08:25 hudba sudo[1025]: pam_unix(sudo:session): session closed for user root Jan 20 18:08:25 hudba volumio[729]: info: Shairport-Sync Started Jan 20 18:08:25 hudba mpd[1005]: Jan 20 18:08 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 20 18:08:25 hudba mpd[1005]: Jan 20 18:08 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Jan 20 18:08:25 hudba mpd[1005]: Jan 20 18:08 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Jan 20 18:08:25 hudba systemd[1]: Started Music Player Daemon. Jan 20 18:08:25 hudba sudo[992]: pam_unix(sudo:session): session closed for user root Jan 20 18:08:25 hudba volumio[729]: error: updateQueue error: null Jan 20 18:08:25 hudba volumio[1012]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 Jan 20 18:08:25 hudba volumio[1012]: Reading Config from "/tmp/volspotify.toml" Jan 20 18:08:26 hudba volumio[1012]: [Vollibrespot] : Using Alsa backend with device: volumio Jan 20 18:08:26 hudba volumio[985]: Generating RSA private key, 4096 bit long modulus (2 primes) Jan 20 18:08:26 hudba volumio[1012]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Jan 20 18:08:28 hudba volumio[729]: info: Checking Spotify Web API Jan 20 18:08:30 hudba ntpd[640]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Jan 20 18:08:31 hudba volumio-remote-updater[445]: [2023-01-20 18:08:31] [connect] Successful connection Jan 20 18:08:31 hudba volumio-remote-updater[445]: [2023-01-20 18:08:31] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1674238111 101 Jan 20 18:08:31 hudba volumio[729]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 2 Jan 20 18:08:36 hudba volumio[985]: .....................................................................................++++ Jan 20 18:08:37 hudba volumio[985]: .......++++ Jan 20 18:08:37 hudba volumio[985]: e is 65537 (0x010001) Jan 20 18:08:37 hudba volumio[985]: writing RSA key Jan 20 18:08:44 hudba volumio[1012]: [Vollibrespot] : Failed to resolve Access Point: HTTP error Jan 20 18:08:44 hudba volumio[1012]: [Vollibrespot] : Using fallback "ap.spotify.com:443" Jan 20 18:08:44 hudba volumio[1012]: [Vollibrespot] : Connecting to AP "ap.spotify.com:443" Jan 20 18:08:45 hudba nmbd[614]: [2023/01/20 18:08:45.787871, 0] ../source3/libsmb/nmblib.c:917(send_udp) Jan 20 18:08:45 hudba nmbd[614]: Packet send failed to 169.254.255.255(138) ERRNO=Network is unreachable Jan 20 18:08:48 hudba ntpd[640]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Jan 20 18:08:52 hudba volumio[729]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=3.396&uuid=241a6769010397b422f4a84088a72cf1" http://updates.volumio.org/downloader-v1/track-device Jan 20 18:08:52 hudba volumio[729]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 20 18:08:52 hudba volumio[729]: Dload Upload Total Spent Left Speed Jan 20 18:08:52 hudba volumio[729]: [1.5K blob data] Jan 20 18:08:52 hudba volumio[729]: retrying in 5 seconds, trial 0 Jan 20 18:08:52 hudba volumio[729]: info: Volumio Calling Home Jan 20 18:08:54 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 20 18:08:54 hudba volumio[729]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 18:08:54 hudba volumio[729]: error: Plugin music_service ytcr failed to complete 'onStart' in a timely fashion Jan 20 18:08:54 hudba volumio[729]: error: Plugin music_service ytmusic failed to complete 'onStart' in a timely fashion Jan 20 18:08:54 hudba volumio[729]: info: ------------------------------------------- Jan 20 18:08:54 hudba volumio[729]: info: ----- MyVolumio plugins startup ---- Jan 20 18:08:54 hudba volumio[729]: info: ------------------------------------------- Jan 20 18:08:54 hudba volumio[729]: info: [MyVolumio PluginManager] Fetching plans data.... Jan 20 18:08:59 hudba volumio[729]: info: Discovery: adding 708d7b9c-e43e-4d24-bd64-1a4e995ae0fd Jan 20 18:08:59 hudba volumio[729]: info: Discovery: Found device Hudba Jan 20 18:08:59 hudba volumio[729]: info: CoreCommandRouter::volumioGetState Jan 20 18:08:59 hudba volumio[729]: info: CorePlayQueue::getTrack 0 Jan 20 18:08:59 hudba volumio[729]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 3 Jan 20 18:09:00 hudba volumio[729]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 4 Jan 20 18:09:00 hudba volumio[729]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 20 18:09:00 hudba volumio[729]: ReferenceError: deferred is not defined Jan 20 18:09:00 hudba volumio[729]: at ClientRequest. (/data/plugins/music_service/youtube2/lib/core/gapi/auth.js:155:13) Jan 20 18:09:00 hudba volumio[729]: at ClientRequest.emit (events.js:315:20) Jan 20 18:09:00 hudba volumio[729]: at TLSSocket.socketErrorListener (_http_client.js:469:9) Jan 20 18:09:00 hudba volumio[729]: at TLSSocket.emit (events.js:315:20) Jan 20 18:09:00 hudba volumio[729]: at emitErrorNT (internal/streams/destroy.js:106:8) Jan 20 18:09:00 hudba volumio[729]: at emitErrorCloseNT (internal/streams/destroy.js:74:3) Jan 20 18:09:00 hudba volumio[729]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Jan 20 18:09:00 hudba volumio[729]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 20 18:09:00 hudba ntpd[640]: Soliciting pool server 212.55.254.189 Jan 20 18:09:00 hudba ntpd[640]: Soliciting pool server 213.81.129.99 Jan 20 18:09:00 hudba sudo[1080]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2023-01-20 18:08 Jan 20 18:09:00 hudba sudo[1080]: 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="91e88ea6c5c4ec4f00aff63f7c3a2944b14ec939" VOLUMIO_FE_VERSION="c433755e569617abac52264d17ad61be303ef463" VOLUMIO_FE3_VERSION="2419ddd8e895c5bdc456962163c9dc7c0f187aa7" VOLUMIO_BE_VERSION="8e6823482d6af342172ec9fdc1c15b0dd02653d2" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sun 04 Dec 2022 08:41:29 PM CET" VOLUMIO_VERSION="3.396" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d460c75d04818d0f55c67627fa362668"