-- Logs begin at Sat 2024-11-23 10:44:46 UTC, end at Sat 2024-11-23 12:03:35 UTC. -- Nov 23 12:02:06 volumio systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE Nov 23 12:02:06 volumio volumio-remote-updater[607]: [2024-11-23 12:02:06] [info] asio async_read_at_least error: system:104 (Connection reset by peer) Nov 23 12:02:06 volumio volumio-remote-updater[607]: [2024-11-23 12:02:06] [error] handle_read_frame error: websocketpp.transport:2 (Underlying Transport Error) Nov 23 12:02:06 volumio volumio-remote-updater[607]: [2024-11-23 12:02:06] [disconnect] Disconnect close local:[1006,Underlying Transport Error] remote:[1006] Nov 23 12:02:06 volumio systemd[1]: Unit volumio.service entered failed state. Nov 23 12:02:06 volumio systemd[1]: Starting dynamicswap service... Nov 23 12:02:06 volumio systemd[1]: Started dynamicswap service. Nov 23 12:02:06 volumio systemd[1]: volumio.service holdoff time over, scheduling restart. Nov 23 12:02:06 volumio systemd[1]: Starting dynamicswap service... Nov 23 12:02:06 volumio systemd[1]: Started dynamicswap service. Nov 23 12:02:06 volumio systemd[1]: Stopping Volumio Backend Module... Nov 23 12:02:06 volumio systemd[1]: Starting Volumio Backend Module... Nov 23 12:02:06 volumio systemd[1]: Started Volumio Backend Module. Nov 23 12:02:07 volumio dhcpcd[1014]: eth0: adding route to 192.168.3.0/24 Nov 23 12:02:07 volumio dhcpcd[1014]: eth0: adding default route via 192.168.3.101 Nov 23 12:02:07 volumio dhcpcd[1014]: eth0: ipv4_addroute: File exists Nov 23 12:02:07 volumio dhcpcd[1014]: eth0: removing route to 192.168.3.0/24 Nov 23 12:02:07 volumio volumio[16961]: info: ------------------------------------------- Nov 23 12:02:07 volumio volumio[16961]: info: ----- Volumio2 ---- Nov 23 12:02:07 volumio volumio[16961]: info: ------------------------------------------- Nov 23 12:02:07 volumio volumio[16961]: info: ----- System startup ---- Nov 23 12:02:07 volumio volumio[16961]: info: ------------------------------------------- Nov 23 12:02:08 volumio volumio[16961]: info: MYVOLUMIO Environment detected Nov 23 12:02:08 volumio volumio[16961]: info: Plugin folders cleanup Nov 23 12:02:08 volumio volumio[16961]: info: Scanning into folder /volumio/app/plugins/ Nov 23 12:02:08 volumio volumio[16961]: info: Scanning category audio_interface Nov 23 12:02:08 volumio volumio[16961]: info: Scanning category miscellanea Nov 23 12:02:08 volumio volumio[16961]: info: Scanning category music_service Nov 23 12:02:08 volumio volumio[16961]: info: Scanning category plugins.json Nov 23 12:02:08 volumio volumio[16961]: info: Scanning category system_controller Nov 23 12:02:08 volumio volumio[16961]: info: Scanning category user_interface Nov 23 12:02:08 volumio volumio[16961]: info: Scanning into folder /data/plugins/ Nov 23 12:02:08 volumio volumio[16961]: info: Scanning category music_service Nov 23 12:02:08 volumio volumio[16961]: info: Plugin folders cleanup completed Nov 23 12:02:08 volumio volumio[16961]: info: ------------------------------------------- Nov 23 12:02:08 volumio volumio[16961]: info: ----- Core plugins startup ---- Nov 23 12:02:08 volumio volumio[16961]: info: ------------------------------------------- Nov 23 12:02:08 volumio volumio[16961]: info: Loading plugins from folder /volumio/app/plugins/ Nov 23 12:02:08 volumio volumio[16961]: info: Adding plugin upnp to MyMusic Plugins Nov 23 12:02:08 volumio volumio[16961]: info: Adding plugin airplay_emulation to MyMusic Plugins Nov 23 12:02:08 volumio volumio[16961]: info: Adding plugin upnp_browser to MyMusic Plugins Nov 23 12:02:08 volumio volumio[16961]: info: Loading plugins from folder /data/plugins/ Nov 23 12:02:08 volumio volumio[16961]: info: Loading plugin "system"... Nov 23 12:02:08 volumio volumio[16961]: info: Loading plugin "appearance"... Nov 23 12:02:09 volumio volumio[16961]: info: Loading plugin "network"... Nov 23 12:02:09 volumio volumio[16961]: info: Refreshing Cached IP Addresses Nov 23 12:02:09 volumio sudo[17004]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 23 12:02:09 volumio sudo[17004]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 23 12:02:09 volumio sudo[17004]: pam_unix(sudo:session): session closed for user root Nov 23 12:02:09 volumio volumio[16961]: info: Loading plugin "services"... Nov 23 12:02:09 volumio volumio[16961]: info: Loading plugin "alsa_controller"... Nov 23 12:02:09 volumio sudo[17007]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 23 12:02:09 volumio sudo[17007]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 23 12:02:09 volumio sudo[17007]: pam_unix(sudo:session): session closed for user root Nov 23 12:02:09 volumio volumio[16961]: info: Loading plugin "wizard"... Nov 23 12:02:09 volumio volumio[16961]: info: Loading plugin "volumio_command_line_client"... Nov 23 12:02:09 volumio volumio[16961]: info: Loading plugin "upnp"... Nov 23 12:02:09 volumio volumio[16961]: info: [1732363329536] Starting Upmpd Daemon Nov 23 12:02:09 volumio volumio[16961]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 23 12:02:09 volumio volumio[16961]: info: Loading plugin "my_music"... Nov 23 12:02:09 volumio volumio[16961]: info: Loading plugin "mpd"... Nov 23 12:02:09 volumio volumio[16961]: info: Loading plugin "upnp_browser"... Nov 23 12:02:10 volumio volumio[16961]: info: Loading plugin "networkfs"... Nov 23 12:02:10 volumio volumio[16961]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 23 12:02:10 volumio volumio[16961]: info: Loading plugin "alarm-clock"... Nov 23 12:02:10 volumio volumio[16961]: info: Plugin airplay_emulation is not enabled Nov 23 12:02:10 volumio volumio[16961]: info: Loading plugin "last_100"... Nov 23 12:02:10 volumio volumio[16961]: info: Loading plugin "webradio"... Nov 23 12:02:10 volumio volumio[16961]: info: Loading plugin "i2s_dacs"... Nov 23 12:02:10 volumio volumio[16961]: info: I2S DAC not set, start Auto-detection Nov 23 12:02:10 volumio volumio[16961]: info: Loading plugin "volumiodiscovery"... Nov 23 12:02:10 volumio volumio[16961]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 23 12:02:10 volumio node[16961]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 23 12:02:10 volumio node[16961]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 23 12:02:10 volumio node[16961]: *** WARNING *** For more information see Nov 23 12:02:10 volumio node[16961]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 23 12:02:10 volumio node[16961]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 23 12:02:10 volumio node[16961]: *** WARNING *** For more information see Nov 23 12:02:10 volumio volumio[16961]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 23 12:02:10 volumio volumio[16961]: *** WARNING *** For more information see Nov 23 12:02:10 volumio volumio[16961]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 23 12:02:10 volumio volumio[16961]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 23 12:02:10 volumio volumio[16961]: *** WARNING *** For more information see Nov 23 12:02:10 volumio volumio[16961]: info: Applying required configuration parameters for plugin volumiodiscovery Nov 23 12:02:10 volumio volumio[16961]: Discovery: StartAdv! undefined Nov 23 12:02:10 volumio volumio[16961]: Discovery: Started advertising... Volumio - undefined Nov 23 12:02:10 volumio volumio[16961]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 23 12:02:10 volumio volumio[16961]: info: Loading plugin "outputs"... Nov 23 12:02:10 volumio volumio[16961]: info: Loading plugin "albumart"... Nov 23 12:02:10 volumio volumio[16961]: info: Plugin example_plugin is not enabled Nov 23 12:02:10 volumio volumio[16961]: info: Loading plugin "inputs"... Nov 23 12:02:10 volumio volumio[16961]: info: Loading plugin "updater_comm"... Nov 23 12:02:10 volumio volumio[16961]: info: Plugin mpdemulation is not enabled Nov 23 12:02:10 volumio volumio[16961]: info: Loading plugin "rest_api"... Nov 23 12:02:10 volumio volumio[16961]: info: Loading plugin "websocket"... Nov 23 12:02:10 volumio volumio[16961]: info: Loading plugin "spop"... Nov 23 12:02:10 volumio volumio[16961]: Forking 1 albumart workers Nov 23 12:02:11 volumio volumio-remote-updater[607]: [2024-11-23 12:02:11] [connect] Successful connection Nov 23 12:02:11 volumio volumio[16961]: info: ___________ START PLUGINS ___________ Nov 23 12:02:11 volumio volumio[16961]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 23 12:02:11 volumio volumio[16961]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 23 12:02:11 volumio volumio[16961]: info: [1732363331505] CoreMusicLibrary::Adding element Media Servers Nov 23 12:02:11 volumio volumio[16961]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 23 12:02:11 volumio volumio[16961]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 23 12:02:11 volumio volumio[16961]: info: [1732363331528] CoreMusicLibrary::Adding element Last_100 Nov 23 12:02:11 volumio volumio[16961]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 23 12:02:11 volumio volumio[16961]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 23 12:02:11 volumio volumio[16961]: info: [1732363331531] CoreMusicLibrary::Adding element Webradio Nov 23 12:02:11 volumio volumio[16961]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 23 12:02:11 volumio volumio[16961]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 23 12:02:11 volumio volumio[16961]: info: ------------------------------------------- Nov 23 12:02:11 volumio volumio[16961]: info: ----- MyVolumio plugins startup ---- Nov 23 12:02:11 volumio volumio[16961]: info: ------------------------------------------- Nov 23 12:02:11 volumio volumio[16961]: info: [MyVolumio PluginManager] Fetching plans data.... Nov 23 12:02:11 volumio volumio[16961]: info: Loading i18n strings for locale zh Nov 23 12:02:11 volumio volumio[16961]: Updating browse sources language Nov 23 12:02:11 volumio volumio[16961]: Cannot find translation for sourceMedia Servers Nov 23 12:02:11 volumio volumio[16961]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 23 12:02:11 volumio sudo[17034]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start spop.service Nov 23 12:02:11 volumio sudo[17034]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 23 12:02:11 volumio volumio[16961]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 23 12:02:11 volumio volumio[16961]: info: CoreCommandRouter::initPlayerControls Nov 23 12:02:11 volumio volumio[16961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 12:02:11 volumio volumio[16961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Nov 23 12:02:11 volumio systemd[1]: Starting Spotify Daemon... Nov 23 12:02:11 volumio systemd[1]: Started Spotify Daemon. Nov 23 12:02:11 volumio sudo[17034]: pam_unix(sudo:session): session closed for user root Nov 23 12:02:11 volumio volumio[17038]: 2024-11-23 12:02:11 [SPTF] 12:02:11.633 I [offline_authorizer.cpp:297] Unable to login offline: no such user Nov 23 12:02:11 volumio volumio[16961]: Starting albumart workers Nov 23 12:02:11 volumio volumio[17038]: 2024-11-23 12:02:11 [SPTF] 12:02:11.641 I [ap:1752] Connecting to AP ap.spotify.com:4070 Nov 23 12:02:11 volumio volumio[16961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 12:02:11 volumio volumio[16961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 12:02:11 volumio volumio[16961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 12:02:11 volumio volumio[16961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 12:02:11 volumio volumio[16961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 23 12:02:11 volumio volumio[16961]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 23 12:02:11 volumio volumio[16961]: info: BOOT COMPLETED Nov 23 12:02:11 volumio volumio[16961]: [Metrics] CommandRouter: 3s 831.13ms Nov 23 12:02:11 volumio volumio[16961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 23 12:02:11 volumio volumio[16961]: aplay: main:722: audio open error: Device or resource busy Nov 23 12:02:11 volumio volumio[16961]: Cannot play startup sound Nov 23 12:02:11 volumio volumio[16961]: info: CoreCommandRouter::Close All Modals sent Nov 23 12:02:11 volumio volumio[16961]: info: CoreCommandRouter::Close All Modals sent Nov 23 12:02:11 volumio volumio[16961]: Express server listening on port 3000 Nov 23 12:02:11 volumio volumio[16961]: [Metrics] WebUI: 4s 251.02ms Nov 23 12:02:11 volumio volumio[16961]: info: Setting Device type: x86 Nov 23 12:02:11 volumio volumio[16961]: Volumio Calling Home Nov 23 12:02:11 volumio volumio[16961]: info: CoreStateMachine::resetVolumioState Nov 23 12:02:11 volumio volumio[16961]: info: CoreStateMachine::getcurrentVolume Nov 23 12:02:11 volumio volumio[16961]: info: CoreCommandRouter::volumioRetrievevolume Nov 23 12:02:11 volumio volumio[16961]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Nov 23 12:02:12 volumio volumio[16961]: info: SpopD Daemon Started Nov 23 12:02:12 volumio volumio[16961]: info: MPD running with PID658 Nov 23 12:02:12 volumio volumio[16961]: ,establishing connection Nov 23 12:02:12 volumio sudo[17050]: pam_unix(sudo:auth): conversation failed Nov 23 12:02:12 volumio sudo[17050]: pam_unix(sudo:auth): auth could not identify password for [volumio] Nov 23 12:02:12 volumio volumio-remote-updater[607]: [2024-11-23 12:02:12] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1732363331 101 Nov 23 12:02:12 volumio volumio[16961]: info: Cannot read I2C interface or I2C interface not presentError: Command failed: /usr/bin/sudo /usr/sbin/i2cdetect -y 1 Nov 23 12:02:12 volumio volumio[16961]: sudo: no tty present and no askpass program specified Nov 23 12:02:12 volumio volumio[16961]: info: VolumeController:: Volume=100 Mute =false Nov 23 12:02:12 volumio volumio[16961]: info: CoreStateMachine::pushState Nov 23 12:02:12 volumio volumio[16961]: info: CorePlayQueue::getTrack 0 Nov 23 12:02:12 volumio volumio[16961]: info: CoreCommandRouter::volumioPushState Nov 23 12:02:12 volumio volumio[16961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 23 12:02:12 volumio volumio[16961]: info: CoreStateMachine::updateTrackBlock Nov 23 12:02:12 volumio volumio[16961]: info: CorePlayQueue::getTrackBlock Nov 23 12:02:12 volumio volumio[16961]: info: CoreCommandRouter::volumioRetrievevolume Nov 23 12:02:12 volumio volumio[16961]: error: Failed LSINFO: Error: [50@0] {} No such directory Nov 23 12:02:12 volumio volumio[16961]: info: CoreStateMachine::setRepeat false single undefined Nov 23 12:02:12 volumio volumio[16961]: info: CoreStateMachine::pushState Nov 23 12:02:12 volumio volumio[16961]: info: CorePlayQueue::getTrack 0 Nov 23 12:02:12 volumio volumio[16961]: info: CoreCommandRouter::volumioPushState Nov 23 12:02:12 volumio volumio[16961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 23 12:02:12 volumio volumio[16961]: info: CoreStateMachine::setRandom false Nov 23 12:02:12 volumio volumio[16961]: info: CoreStateMachine::pushState Nov 23 12:02:12 volumio volumio[16961]: info: CorePlayQueue::getTrack 0 Nov 23 12:02:12 volumio volumio[16961]: info: CoreCommandRouter::volumioPushState Nov 23 12:02:12 volumio volumio[16961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 23 12:02:12 volumio volumio[16961]: info: VolumeController:: Volume=100 Mute =false Nov 23 12:02:12 volumio volumio[16961]: info: CoreStateMachine::pushState Nov 23 12:02:12 volumio volumio[16961]: info: CorePlayQueue::getTrack 0 Nov 23 12:02:12 volumio volumio[16961]: info: CoreCommandRouter::volumioPushState Nov 23 12:02:12 volumio volumio[16961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 23 12:02:12 volumio volumio[16961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Nov 23 12:02:12 volumio volumio[16961]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 23 12:02:12 volumio volumio[16961]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Nov 23 12:02:13 volumio volumio[16961]: info: CoreCommandRouter::volumioGetState Nov 23 12:02:13 volumio volumio[16961]: info: CorePlayQueue::getTrack 0 Nov 23 12:02:13 volumio volumio[16961]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 23 12:02:13 volumio volumio[16961]: info: CoreCommandRouter::volumioGetVisibleSources Nov 23 12:02:13 volumio volumio[16961]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 23 12:02:13 volumio volumio[16961]: info: Listing playlists Nov 23 12:02:14 volumio volumio[16961]: info: Nov 23 12:02:14 volumio volumio[16961]: ---------------------------- Client requests Volume 100 Nov 23 12:02:14 volumio volumio[16961]: info: VolumeController::SetAlsaVolume100 Nov 23 12:02:14 volumio volumio[16961]: info: CoreStateMachine::pushState Nov 23 12:02:14 volumio volumio[16961]: info: CorePlayQueue::getTrack 0 Nov 23 12:02:14 volumio volumio[16961]: info: CoreCommandRouter::volumioPushState Nov 23 12:02:14 volumio volumio[16961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 23 12:02:14 volumio volumio[16961]: info: Setting volume on startup at 100 Nov 23 12:02:14 volumio volumio[16961]: info: CoreCommandRouter::volumioGetState Nov 23 12:02:14 volumio volumio[16961]: info: CorePlayQueue::getTrack 0 Nov 23 12:02:15 volumio volumio[16961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 23 12:02:16 volumio volumio[17038]: 2024-11-23 12:02:16 [SPTF] 12:02:16.646 E [ap:1694] AP Socket Error: Timeout reached (20000) Nov 23 12:02:16 volumio volumio[17038]: 2024-11-23 12:02:16 [SPTF] 12:02:16.647 E [ap:3915] Connection error: 117 Nov 23 12:02:16 volumio volumio[17038]: 2024-11-23 12:02:16 [SPTF] 12:02:16.647 I [ap:1752] Connecting to AP ap.spotify.com:443 Nov 23 12:02:17 volumio volumio[16961]: info: Connecting to daemon Nov 23 12:02:17 volumio volumio[16961]: info: FIRST BRANCH Nov 23 12:02:17 volumio volumio[16961]: Discovery: adding 7b9516d9-eb41-486b-b491-71a91f98d613 Nov 23 12:02:17 volumio volumio[16961]: info: mDNS: Found device Volumio Nov 23 12:02:17 volumio volumio[16961]: info: CoreCommandRouter::volumioGetState Nov 23 12:02:17 volumio volumio[16961]: info: CorePlayQueue::getTrack 0 Nov 23 12:02:19 volumio sudo[17103]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 23 12:02:19 volumio sudo[17103]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 23 12:02:19 volumio sudo[17103]: pam_unix(sudo:session): session closed for user root Nov 23 12:02:19 volumio sudo[17106]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 23 12:02:19 volumio sudo[17106]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 23 12:02:19 volumio sudo[17106]: pam_unix(sudo:session): session closed for user root Nov 23 12:02:19 volumio sudo[17109]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Nov 23 12:02:19 volumio sudo[17109]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 23 12:02:19 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Nov 23 12:02:19 volumio sudo[17109]: pam_unix(sudo:session): session closed for user root Nov 23 12:02:19 volumio volumio[16961]: info: Upmpdcli Daemon Started Nov 23 12:02:21 volumio volumio[17038]: 2024-11-23 12:02:21 [SPTF] 12:02:21.652 E [ap:1694] AP Socket Error: Timeout reached (20000) Nov 23 12:02:21 volumio volumio[17038]: 2024-11-23 12:02:21 [SPTF] 12:02:21.653 E [ap:3915] Connection error: 117 Nov 23 12:02:21 volumio volumio[17038]: 2024-11-23 12:02:21 [SPTF] 12:02:21.653 I [ap:1752] Connecting to AP ap.spotify.com:80 Nov 23 12:02:26 volumio volumio[16961]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Nov 23 12:02:26 volumio volumio[16961]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Nov 23 12:02:26 volumio volumio[16961]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Nov 23 12:02:26 volumio volumio[16961]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Nov 23 12:02:26 volumio volumio[16961]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Nov 23 12:02:26 volumio volumio[16961]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Nov 23 12:02:26 volumio volumio[16961]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Nov 23 12:02:26 volumio volumio[16961]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Nov 23 12:02:26 volumio volumio[16961]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Nov 23 12:02:26 volumio volumio[16961]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Nov 23 12:02:26 volumio volumio[16961]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Nov 23 12:02:26 volumio volumio[16961]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Nov 23 12:02:26 volumio volumio[16961]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Nov 23 12:02:26 volumio volumio[16961]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Nov 23 12:02:26 volumio volumio[16961]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Nov 23 12:02:26 volumio volumio[16961]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Nov 23 12:02:26 volumio volumio[16961]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Nov 23 12:02:26 volumio volumio[16961]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Nov 23 12:02:26 volumio volumio[16961]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Nov 23 12:02:26 volumio volumio[16961]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Nov 23 12:02:26 volumio volumio[16961]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Nov 23 12:02:26 volumio volumio[16961]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Nov 23 12:02:26 volumio volumio[16961]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Nov 23 12:02:26 volumio volumio[16961]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Nov 23 12:02:26 volumio volumio[16961]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Nov 23 12:02:26 volumio volumio[16961]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Nov 23 12:02:26 volumio volumio[16961]: info: Adding plugin bluetooth to MyMusic Plugins Nov 23 12:02:26 volumio volumio[16961]: info: Adding plugin cd_controller to MyMusic Plugins Nov 23 12:02:26 volumio volumio[16961]: info: Adding plugin smart_inputs to MyMusic Plugins Nov 23 12:02:26 volumio volumio[16961]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Nov 23 12:02:26 volumio volumio[17038]: 2024-11-23 12:02:26 [SPTF] 12:02:26.657 E [ap:1694] AP Socket Error: Timeout reached (20000) Nov 23 12:02:26 volumio volumio[17038]: 2024-11-23 12:02:26 [SPTF] 12:02:26.657 E [ap:3915] Connection error: 117 Nov 23 12:02:26 volumio volumio[17038]: 2024-11-23 12:02:26 [SPTF] 12:02:26.657 I [ap:1752] Connecting to AP ap.spotify.com:4070 Nov 23 12:02:27 volumio volumio[16961]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Nov 23 12:02:28 volumio volumio[16961]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Nov 23 12:02:28 volumio volumio[16961]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Nov 23 12:02:28 volumio volumio[16961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 23 12:02:28 volumio volumio[16961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 23 12:02:28 volumio volumio[16961]: info: Starting MyVolumio Remote Streaming Endpoints Nov 23 12:02:28 volumio volumio[16961]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Nov 23 12:02:28 volumio volumio[16961]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Nov 23 12:02:28 volumio volumio[16961]: info: Streaming services startup Nov 23 12:02:28 volumio volumio[16961]: info: Starting Streaming Daemon Nov 23 12:02:28 volumio sudo[17131]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Nov 23 12:02:28 volumio sudo[17131]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 23 12:02:28 volumio systemd[1]: Stopping Volumio Streaming Daemon... Nov 23 12:02:28 volumio volumio[16961]: info: MyVolumio not started Nov 23 12:02:28 volumio volumio[16961]: info: Initializing device activation check Nov 23 12:02:28 volumio systemd[1]: Starting Volumio Streaming Daemon... Nov 23 12:02:28 volumio systemd[1]: Started Volumio Streaming Daemon. Nov 23 12:02:28 volumio sudo[17131]: pam_unix(sudo:session): session closed for user root Nov 23 12:02:28 volumio volumio[16961]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Nov 23 12:02:28 volumio volumio-streaming-daemon[17138]: ############################ Nov 23 12:02:28 volumio volumio-streaming-daemon[17138]: # Volumio Streaming Daemon # Nov 23 12:02:28 volumio volumio-streaming-daemon[17138]: # Running on port 7777 # Nov 23 12:02:28 volumio volumio-streaming-daemon[17138]: ############################ Nov 23 12:02:28 volumio volumio-streaming-daemon[17138]: Environment: production Nov 23 12:02:28 volumio volumio[16961]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=x86&variante=volumio&version=2.861&uuid=ae75cddd0d7d3a4accb1f42004ae15c8" http://updates.volumio.org:7070/downloader-v1/track-device Nov 23 12:02:28 volumio volumio[16961]: % Total % Received % Xferd Average Speed Time Time Time Current Nov 23 12:02:28 volumio volumio[16961]: Dload Upload Total Spent Left Speed Nov 23 12:02:28 volumio volumio[16961]: [551B blob data] Nov 23 12:02:28 volumio volumio[16961]: retrying in 5 seconds, trial 0 Nov 23 12:02:28 volumio volumio[16961]: Volumio Calling Home Nov 23 12:02:30 volumio volumio-streaming-daemon[17138]: Environment: production Nov 23 12:02:30 volumio volumio[16961]: info: Fetching Streaming Services browse cache Nov 23 12:02:31 volumio volumio[17038]: 2024-11-23 12:02:31 [SPTF] 12:02:31.663 E [ap:1694] AP Socket Error: Timeout reached (20000) Nov 23 12:02:31 volumio volumio[17038]: 2024-11-23 12:02:31 [SPTF] 12:02:31.663 E [ap:3915] Connection error: 117 Nov 23 12:02:31 volumio volumio[17038]: 2024-11-23 12:02:31 [SPTF] 12:02:31.663 I [ap:1752] Connecting to AP ap.spotify.com:443 Nov 23 12:02:36 volumio volumio[17038]: 2024-11-23 12:02:36 [SPTF] 12:02:36.669 E [ap:1694] AP Socket Error: Timeout reached (20000) Nov 23 12:02:36 volumio volumio[17038]: 2024-11-23 12:02:36 [SPTF] 12:02:36.669 E [ap:3915] Connection error: 117 Nov 23 12:02:36 volumio volumio[17038]: 2024-11-23 12:02:36 [SPTF] 12:02:36.669 I [ap:1752] Connecting to AP ap.spotify.com:80 Nov 23 12:02:37 volumio dhcpcd[1014]: eth0: adding route to 192.168.3.0/24 Nov 23 12:02:37 volumio dhcpcd[1014]: eth0: adding default route via 192.168.3.101 Nov 23 12:02:37 volumio dhcpcd[1014]: eth0: ipv4_addroute: File exists Nov 23 12:02:37 volumio dhcpcd[1014]: eth0: removing route to 192.168.3.0/24 Nov 23 12:02:41 volumio volumio[16961]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 23 12:02:41 volumio volumio[16961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 23 12:02:41 volumio volumio[17038]: 2024-11-23 12:02:41 [SPTF] 12:02:41.674 E [ap:1694] AP Socket Error: Timeout reached (20000) Nov 23 12:02:41 volumio volumio[17038]: 2024-11-23 12:02:41 [SPTF] 12:02:41.674 E [ap:3915] Connection error: 117 Nov 23 12:02:41 volumio volumio[17038]: 2024-11-23 12:02:41 [WARN] Login failed: Can not connect to Spotify Nov 23 12:02:41 volumio volumio[17038]: 2024-11-23 12:02:41 [ERR ] Could not get the playlist container. Nov 23 12:02:41 volumio systemd[1]: spop.service: main process exited, code=killed, status=5/TRAP Nov 23 12:02:41 volumio systemd[1]: Unit spop.service entered failed state. Nov 23 12:02:44 volumio volumio[16961]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=x86&variante=volumio&version=2.861&uuid=ae75cddd0d7d3a4accb1f42004ae15c8" http://updates.volumio.org:7070/downloader-v1/track-device Nov 23 12:02:44 volumio volumio[16961]: % Total % Received % Xferd Average Speed Time Time Time Current Nov 23 12:02:44 volumio volumio[16961]: Dload Upload Total Spent Left Speed Nov 23 12:02:44 volumio volumio[16961]: [630B blob data] Nov 23 12:02:44 volumio volumio[16961]: retrying in 5 seconds, trial 1 Nov 23 12:02:44 volumio volumio[16961]: Volumio Calling Home Nov 23 12:03:00 volumio volumio[16961]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=x86&variante=volumio&version=2.861&uuid=ae75cddd0d7d3a4accb1f42004ae15c8" http://updates.volumio.org:7070/downloader-v1/track-device Nov 23 12:03:00 volumio volumio[16961]: % Total % Received % Xferd Average Speed Time Time Time Current Nov 23 12:03:00 volumio volumio[16961]: Dload Upload Total Spent Left Speed Nov 23 12:03:00 volumio volumio[16961]: [630B blob data] Nov 23 12:03:00 volumio volumio[16961]: retrying in 5 seconds, trial 2 Nov 23 12:03:00 volumio volumio[16961]: Volumio Calling Home Nov 23 12:03:07 volumio dhcpcd[1014]: eth0: adding route to 192.168.3.0/24 Nov 23 12:03:07 volumio dhcpcd[1014]: eth0: adding default route via 192.168.3.101 Nov 23 12:03:07 volumio dhcpcd[1014]: eth0: ipv4_addroute: File exists Nov 23 12:03:07 volumio dhcpcd[1014]: eth0: removing route to 192.168.3.0/24 Nov 23 12:03:16 volumio volumio[16961]: info: Nov 23 12:03:16 volumio volumio[16961]: ---------------------------- MPD announces state update: player Nov 23 12:03:16 volumio volumio[16961]: info: ControllerMpd::getState Nov 23 12:03:16 volumio volumio[16961]: verbose: ControllerMpd::sendMpdCommand status Nov 23 12:03:16 volumio volumio[16961]: verbose: ControllerMpd::parseState Nov 23 12:03:16 volumio volumio[16961]: info: ControllerMpd::pushState Nov 23 12:03:16 volumio volumio[16961]: info: CoreCommandRouter::servicePushState Nov 23 12:03:16 volumio volumio[16961]: info: CoreStateMachine::pushState Nov 23 12:03:16 volumio volumio[16961]: info: CorePlayQueue::getTrack 0 Nov 23 12:03:16 volumio volumio[16961]: info: CoreCommandRouter::volumioPushState Nov 23 12:03:16 volumio volumio[16961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 23 12:03:16 volumio volumio[16961]: info: CorePlayQueue::getTrack 0 Nov 23 12:03:16 volumio volumio[16961]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Nov 23 12:03:16 volumio volumio[16961]: verbose: CURRENT POSITION 0 Nov 23 12:03:16 volumio volumio[16961]: info: CoreStateMachine::syncState stateService stop Nov 23 12:03:16 volumio volumio[16961]: info: CoreStateMachine::syncState currentStatus stop Nov 23 12:03:16 volumio volumio[16961]: info: CoreStateMachine::pushState Nov 23 12:03:16 volumio volumio[16961]: info: CorePlayQueue::getTrack 0 Nov 23 12:03:16 volumio volumio[16961]: info: CoreCommandRouter::volumioPushState Nov 23 12:03:16 volumio volumio[16961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 23 12:03:16 volumio volumio[16961]: info: No code Nov 23 12:03:16 volumio volumio[16961]: info: CoreStateMachine::pushState Nov 23 12:03:16 volumio volumio[16961]: info: CorePlayQueue::getTrack 0 Nov 23 12:03:16 volumio volumio[16961]: info: CoreCommandRouter::volumioPushState Nov 23 12:03:16 volumio volumio[16961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 23 12:03:16 volumio volumio[16961]: info: ------------------------------ 24ms Nov 23 12:03:16 volumio volumio[16961]: info: Clearing queue after UPNP request Nov 23 12:03:17 volumio volumio[16961]: info: CoreStateMachine::ClearQueue Nov 23 12:03:17 volumio volumio[16961]: info: CoreStateMachine::stop Nov 23 12:03:17 volumio volumio[16961]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 23 12:03:17 volumio volumio[16961]: UNSET VOLATILE Nov 23 12:03:17 volumio volumio[16961]: info: CorePlayQueue::clearPlayQueue Nov 23 12:03:17 volumio volumio[16961]: info: CorePlayQueue::saveQueue Nov 23 12:03:17 volumio volumio[16961]: info: CoreCommandRouter::volumioPushState Nov 23 12:03:17 volumio volumio[16961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 23 12:03:17 volumio volumio[16961]: info: CoreCommandRouter::volumioPushQueue Nov 23 12:03:17 volumio volumio[16961]: info: Nov 23 12:03:17 volumio volumio[16961]: ---------------------------- MPD announces system playlist update Nov 23 12:03:17 volumio volumio[16961]: info: Ignoring MPD Status Update Nov 23 12:03:17 volumio volumio[16961]: error: updateQueue error: null Nov 23 12:03:17 volumio volumio[16961]: info: ------------------------------ 2ms Nov 23 12:03:17 volumio volumio[16961]: info: Starting UPNP Playback Nov 23 12:03:17 volumio volumio[16961]: info: Preparing playback through UPNP Nov 23 12:03:17 volumio volumio[16961]: info: CoreCommandRouter::volumioGetState Nov 23 12:03:17 volumio volumio[16961]: info: CorePlayQueue::getTrack 0 Nov 23 12:03:17 volumio volumio[16961]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 23 12:03:17 volumio volumio[16961]: info: Nov 23 12:03:17 volumio volumio[16961]: ---------------------------- MPD announces system playlist update Nov 23 12:03:17 volumio volumio[16961]: info: Ignoring MPD Status Update Nov 23 12:03:17 volumio volumio[16961]: info: Nov 23 12:03:17 volumio volumio[16961]: ---------------------------- MPD announces system playlist update Nov 23 12:03:17 volumio volumio[16961]: info: Ignoring MPD Status Update Nov 23 12:03:17 volumio volumio[16961]: info: ------------------------------ 2ms Nov 23 12:03:17 volumio volumio[16961]: info: ------------------------------ 2ms Nov 23 12:03:17 volumio volumio[16961]: info: Nov 23 12:03:17 volumio volumio[16961]: ---------------------------- MPD announces system playlist update Nov 23 12:03:17 volumio volumio[16961]: info: Ignoring MPD Status Update Nov 23 12:03:17 volumio volumio[16961]: info: Nov 23 12:03:17 volumio volumio[16961]: ---------------------------- MPD announces system playlist update Nov 23 12:03:17 volumio volumio[16961]: info: Ignoring MPD Status Update Nov 23 12:03:17 volumio volumio[16961]: info: ------------------------------ 2ms Nov 23 12:03:17 volumio volumio[16961]: info: ------------------------------ 1ms Nov 23 12:03:17 volumio volumio[16961]: info: Nov 23 12:03:17 volumio volumio[16961]: ---------------------------- MPD announces system playlist update Nov 23 12:03:17 volumio volumio[16961]: info: Ignoring MPD Status Update Nov 23 12:03:17 volumio volumio[16961]: info: Nov 23 12:03:17 volumio volumio[16961]: ---------------------------- MPD announces system playlist update Nov 23 12:03:17 volumio volumio[16961]: info: Ignoring MPD Status Update Nov 23 12:03:17 volumio volumio[16961]: info: ------------------------------ 2ms Nov 23 12:03:17 volumio volumio[16961]: info: ------------------------------ 2ms Nov 23 12:03:23 volumio volumio[16961]: info: Nov 23 12:03:23 volumio volumio[16961]: ---------------------------- MPD announces state update: player Nov 23 12:03:23 volumio volumio[16961]: info: ControllerMpd::getState Nov 23 12:03:23 volumio volumio[16961]: verbose: ControllerMpd::sendMpdCommand status Nov 23 12:03:23 volumio volumio[16961]: verbose: ControllerMpd::parseState Nov 23 12:03:23 volumio volumio[16961]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 23 12:03:23 volumio volumio[16961]: info: Nov 23 12:03:23 volumio volumio[16961]: ---------------------------- MPD announces state update: player Nov 23 12:03:23 volumio volumio[16961]: info: ControllerMpd::getState Nov 23 12:03:23 volumio volumio[16961]: verbose: ControllerMpd::sendMpdCommand status Nov 23 12:03:23 volumio volumio[16961]: verbose: ControllerMpd::parseTrackInfo Nov 23 12:03:23 volumio volumio[16961]: verbose: ControllerMpd::parseState Nov 23 12:03:23 volumio volumio[16961]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 23 12:03:23 volumio volumio[16961]: info: ControllerMpd::pushState Nov 23 12:03:23 volumio volumio[16961]: info: CoreCommandRouter::servicePushState Nov 23 12:03:23 volumio volumio[16961]: In UPNP mode Nov 23 12:03:23 volumio volumio[16961]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":302,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"My Simple Thing","artist":"Peter Sandberg","album":"A Scandinavian Thing","uri":"http://aqqmusic.tc.qq.com/F000003kgMMO1YnHkL.flac?guid=0000000004cb49d2000001871e73f5cf&vkey=1C04BA0E04DF11C699B04839715C0BB41DF31595E03FA292E8AA3AC1BA6D66CC29DB0E778A95D6A10D34383EBDDD2B7820EB728F69CD0196&uin=1259438298&src=F000000s1fqK2rsMN2.flac&redirect=1&fromtag=111114","trackType":""} Nov 23 12:03:23 volumio volumio[16961]: verbose: CURRENT POSITION 0 Nov 23 12:03:23 volumio volumio[16961]: info: CoreStateMachine::syncState stateService play Nov 23 12:03:23 volumio volumio[16961]: info: CoreStateMachine::syncState currentStatus stop Nov 23 12:03:23 volumio volumio[16961]: info: CoreStateMachine::pushState Nov 23 12:03:23 volumio volumio[16961]: info: CoreCommandRouter::volumioPushState Nov 23 12:03:23 volumio volumio[16961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 23 12:03:23 volumio volumio[16961]: info: ------------------------------ 43ms Nov 23 12:03:23 volumio volumio[16961]: verbose: ControllerMpd::parseTrackInfo Nov 23 12:03:23 volumio volumio[16961]: info: ControllerMpd::pushState Nov 23 12:03:23 volumio volumio[16961]: info: CoreCommandRouter::servicePushState Nov 23 12:03:23 volumio volumio[16961]: In UPNP mode Nov 23 12:03:23 volumio volumio[16961]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":302,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"My Simple Thing","artist":"Peter Sandberg","album":"A Scandinavian Thing","uri":"http://aqqmusic.tc.qq.com/F000003kgMMO1YnHkL.flac?guid=0000000004cb49d2000001871e73f5cf&vkey=1C04BA0E04DF11C699B04839715C0BB41DF31595E03FA292E8AA3AC1BA6D66CC29DB0E778A95D6A10D34383EBDDD2B7820EB728F69CD0196&uin=1259438298&src=F000000s1fqK2rsMN2.flac&redirect=1&fromtag=111114","trackType":""} Nov 23 12:03:23 volumio volumio[16961]: verbose: CURRENT POSITION 0 Nov 23 12:03:23 volumio volumio[16961]: info: CoreStateMachine::syncState stateService play Nov 23 12:03:23 volumio volumio[16961]: info: CoreStateMachine::syncState currentStatus play Nov 23 12:03:23 volumio volumio[16961]: info: Received an update from plugin. extracting info from payload Nov 23 12:03:23 volumio volumio[16961]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Nov 23 12:03:23 volumio volumio[16961]: info: CoreStateMachine::pushState Nov 23 12:03:23 volumio volumio[16961]: info: CoreCommandRouter::volumioPushState Nov 23 12:03:23 volumio volumio[16961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 23 12:03:23 volumio volumio[16961]: info: CoreStateMachine::pushState Nov 23 12:03:23 volumio volumio[16961]: info: CoreCommandRouter::volumioPushState Nov 23 12:03:23 volumio volumio[16961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 23 12:03:23 volumio volumio[16961]: info: ------------------------------ 57ms Nov 23 12:03:23 volumio volumio[16961]: info: CoreCommandRouter::volumioGetQueue Nov 23 12:03:23 volumio volumio[16961]: info: CoreStateMachine::getQueue Nov 23 12:03:23 volumio volumio[16961]: info: CorePlayQueue::getQueue Nov 23 12:03:23 volumio volumio[16961]: info: CoreCommandRouter::volumioGetQueue Nov 23 12:03:23 volumio volumio[16961]: info: CoreStateMachine::getQueue Nov 23 12:03:23 volumio volumio[16961]: info: CorePlayQueue::getQueue Nov 23 12:03:34 volumio volumio[16961]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 23 12:03:34 volumio volumio[16961]: { Error: connect ECONNREFUSED 54.89.135.129:443 Nov 23 12:03:34 volumio volumio[16961]: at Object._errnoException (util.js:1022:11) Nov 23 12:03:34 volumio volumio[16961]: at _exceptionWithHostPort (util.js:1044:20) Nov 23 12:03:34 volumio volumio[16961]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Nov 23 12:03:34 volumio volumio[16961]: code: 'ECONNREFUSED', Nov 23 12:03:34 volumio volumio[16961]: errno: 'ECONNREFUSED', Nov 23 12:03:34 volumio volumio[16961]: syscall: 'connect', Nov 23 12:03:34 volumio volumio[16961]: address: '54.89.135.129', Nov 23 12:03:34 volumio volumio[16961]: port: 443 } Nov 23 12:03:34 volumio volumio[16961]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 23 12:03:35 volumio sudo[17404]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-23 12:02 Nov 23 12:03:35 volumio sudo[17404]: 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="168ba7444df98cd868db72f24faec0b6346489cc" VOLUMIO_FE_VERSION="847a48ecf32d35cc502a0053d585d1a69236e391" VOLUMIO_BE_VERSION="03f7bbd984817e093cac62b7ff876f3c2cfabc1d" VOLUMIO_ARCH="x86" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Dec 22 15:00:46 CET 2020" VOLUMIO_VERSION="2.861" VOLUMIO_HARDWARE="x86" VOLUMIO_HASH="b3401e25b8d19b16b1038c2843d2deaf"