-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Sat 2024-04-06 19:48:09 CEST. -- Apr 06 19:47:00 volumio volumio[13533]: info: Loading plugin "autostart"... Apr 06 19:47:00 volumio volumio[13533]: info: Applying required configuration parameters for plugin autostart Apr 06 19:47:00 volumio volumio[13533]: info: AutoStart - onVolumioStart - read config.json Apr 06 19:47:00 volumio volumio[13533]: info: Loading plugin "gpio-buttons"... Apr 06 19:47:01 volumio volumio[13533]: info: GPIO-Buttons initialized Apr 06 19:47:01 volumio volumio[13533]: info: Loading plugin "now_playing"... Apr 06 19:47:03 volumio volumio-remote-updater[532]: [2024-04-06 19:47:03] [connect] Successful connection Apr 06 19:47:03 volumio volumio[13533]: info: Loading plugin "outputs"... Apr 06 19:47:03 volumio volumio[13533]: info: Loading plugin "albumart"... Apr 06 19:47:03 volumio volumio[13533]: info: Plugin example_plugin is not enabled Apr 06 19:47:03 volumio volumio[13533]: info: Loading plugin "inputs"... Apr 06 19:47:03 volumio volumio[13533]: info: Loading plugin "updater_comm"... Apr 06 19:47:03 volumio volumio[13533]: info: Plugin mpdemulation is not enabled Apr 06 19:47:03 volumio volumio[13533]: info: Loading plugin "rest_api"... Apr 06 19:47:03 volumio volumio[13533]: info: Loading plugin "websocket"... Apr 06 19:47:03 volumio volumio[13533]: info: Loading plugin "fusiondsp"... Apr 06 19:47:03 volumio volumio[13533]: Forking 3 albumart workers Apr 06 19:47:04 volumio volumio[13533]: info: Applying required configuration parameters for plugin fusiondsp Apr 06 19:47:04 volumio volumio[13533]: info: Loading plugin "80s80s"... Apr 06 19:47:05 volumio volumio[13533]: Starting albumart workers Apr 06 19:47:05 volumio volumio[13533]: Starting albumart workers Apr 06 19:47:05 volumio volumio[13533]: Starting albumart workers Apr 06 19:47:05 volumio volumio[13533]: info: Applying required configuration parameters for plugin 80s80s Apr 06 19:47:05 volumio volumio[13533]: info: [1712425625887] [80s80s] API delay: 30 Apr 06 19:47:05 volumio volumio[13533]: info: Loading plugin "RoonBridge"... Apr 06 19:47:06 volumio volumio[13533]: info: Applying required configuration parameters for plugin RoonBridge Apr 06 19:47:06 volumio volumio[13533]: info: Loading plugin "dmd2_music"... Apr 06 19:47:08 volumio volumio[13533]: info: Loading plugin "minidlna"... Apr 06 19:47:09 volumio volumio[13533]: info: Applying required configuration parameters for plugin minidlna Apr 06 19:47:09 volumio volumio[13533]: info: Loading plugin "motherearthradio"... Apr 06 19:47:09 volumio volumio[13533]: info: Applying required configuration parameters for plugin motherearthradio Apr 06 19:47:09 volumio volumio[13533]: info: [1712425629716] [MotherEarth] API delay: 5 Apr 06 19:47:09 volumio volumio[13533]: info: Loading plugin "podcast"... Apr 06 19:47:10 volumio volumio[13533]: info: ControllerPodcast::constructor Apr 06 19:47:10 volumio volumio[13533]: info: Loading plugin "rad357pl"... Apr 06 19:47:10 volumio volumio[13533]: info: Applying required configuration parameters for plugin rad357pl Apr 06 19:47:10 volumio volumio[13533]: info: [1712425630670] [rad357pl] API delay: 5 Apr 06 19:47:10 volumio volumio[13533]: info: Loading plugin "radio_paradise"... Apr 06 19:47:11 volumio volumio[13533]: info: Applying required configuration parameters for plugin radio_paradise Apr 06 19:47:11 volumio volumio[13533]: info: [1712425631040] [RadioParadise] API delay: 5 Apr 06 19:47:11 volumio volumio[13533]: info: Loading plugin "swarmstation"... Apr 06 19:47:11 volumio volumio[13533]: info: Applying required configuration parameters for plugin swarmstation Apr 06 19:47:11 volumio volumio[13533]: info: [1712425631439] [Swarmstation] API delay: 5 Apr 06 19:47:11 volumio volumio[13533]: info: Loading plugin "volusonic"... Apr 06 19:47:18 volumio volumio-remote-updater[532]: [2024-04-06 19:47:18] [connect] Successful connection Apr 06 19:47:36 volumio volumio-remote-updater[532]: [2024-04-06 19:47:33] [connect] Successful connection Apr 06 19:47:37 volumio go-librespot[10775]: time="2024-04-06T19:47:37+02:00" level=error msg="did not receive last pong from dealer, 37s passed" Apr 06 19:47:37 volumio go-librespot[10775]: time="2024-04-06T19:47:37+02:00" level=error msg="did not receive last pong ack from accesspoint, 127s passed" Apr 06 19:47:37 volumio go-librespot[10775]: time="2024-04-06T19:47:37+02:00" level=error msg="failed receiving packet" error="failed reading packet header: read tcp 192.168.1.139:51704->34.158.0.131:4070: use of closed network connection" Apr 06 19:47:37 volumio go-librespot[10775]: time="2024-04-06T19:47:37+02:00" level=error msg="failed receiving dealer message" error="failed to get reader: received close frame: status = StatusServiceRestart and reason = \"\"" Apr 06 19:47:38 volumio go-librespot[10775]: time="2024-04-06T19:47:38+02:00" level=debug msg="completed keyexchange" Apr 06 19:47:38 volumio go-librespot[10775]: time="2024-04-06T19:47:38+02:00" level=debug msg="re-established dealer connection" Apr 06 19:47:38 volumio go-librespot[10775]: time="2024-04-06T19:47:38+02:00" level=debug msg="received connection id: OGM0N2U3ZmYtNTM0NC00ZmVmLWFiZmEtZmE4OTMzY2NkYjBlK2RlYWxlcit0Y3A6Ly9ndWUxLWRlYWxlci1hLWw4aHcuZ3VlMS5zcG90aWZ5Lm5ldDo1NzAwK0RBRUZDMDFDQUY0RTZFNTZGNUY4NUU0QkUxMzYxMTlGN0U1MjhCMzkwNkM3QTg0MTJDMEFEQTU4QzQ5QjQ2MkU=" Apr 06 19:47:38 volumio go-librespot[10775]: time="2024-04-06T19:47:38+02:00" level=debug msg="put connect state because NEW_DEVICE" Apr 06 19:47:38 volumio volumio[13533]: info: Applying required configuration parameters for plugin volusonic Apr 06 19:47:38 volumio volumio[13533]: info: Loading plugin "audiophonicsonoff"... Apr 06 19:47:38 volumio go-librespot[10775]: time="2024-04-06T19:47:38+02:00" level=debug msg="completed challenge" Apr 06 19:47:38 volumio go-librespot[10775]: time="2024-04-06T19:47:38+02:00" level=debug msg="authenticated as 31lrcanxtz3lqfx2cagcxmilikzy" Apr 06 19:47:38 volumio go-librespot[10775]: time="2024-04-06T19:47:38+02:00" level=debug msg="re-established accesspoint connection" Apr 06 19:47:38 volumio go-librespot[10775]: time="2024-04-06T19:47:38+02:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Apr 06 19:47:38 volumio go-librespot[10775]: time="2024-04-06T19:47:38+02:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Apr 06 19:47:38 volumio go-librespot[10775]: time="2024-04-06T19:47:38+02:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Apr 06 19:47:38 volumio go-librespot[10775]: time="2024-04-06T19:47:38+02:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Apr 06 19:47:38 volumio go-librespot[10775]: time="2024-04-06T19:47:38+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 513" Apr 06 19:47:38 volumio volumio[13533]: info: Applying required configuration parameters for plugin audiophonicsonoff Apr 06 19:47:38 volumio volumio[13533]: info: Audiophonics on/off initiated Apr 06 19:47:38 volumio volumio[13533]: info: Loading plugin "backup_restore"... Apr 06 19:47:39 volumio volumio[13533]: info: Applying required configuration parameters for plugin backup_restore Apr 06 19:47:39 volumio volumio[13533]: info: Loading plugin "audiophonics_evo_sabre"... Apr 06 19:47:39 volumio volumio[13533]: info: Applying required configuration parameters for plugin audiophonics_evo_sabre Apr 06 19:47:39 volumio volumio[13533]: info: Loading plugin "gpio_control"... Apr 06 19:47:40 volumio volumio[13533]: info: Applying required configuration parameters for plugin gpio_control Apr 06 19:47:40 volumio volumio[13533]: info: [GPIO_Control] Detected Raspberry Pi Zero 2 W Rev 1.0 Apr 06 19:47:40 volumio volumio[13533]: info: [GPIO_Control] 40 GPIOs: true Apr 06 19:47:40 volumio volumio[13533]: info: [GPIO_Control] Initialized Apr 06 19:47:40 volumio volumio[13533]: info: Loading plugin "ir_controller"... Apr 06 19:47:40 volumio volumio[13533]: info: Applying required configuration parameters for plugin ir_controller Apr 06 19:47:40 volumio volumio[13533]: info: Loading plugin "mpd_oled"... Apr 06 19:47:41 volumio volumio[13533]: info: Applying required configuration parameters for plugin mpd_oled Apr 06 19:47:41 volumio volumio[13533]: info: [MPD_OLED Plugin] Reading configuration file at: /data/configuration/system_hardware/mpd_oled/config.json Apr 06 19:47:41 volumio volumio[13533]: info: Loading plugin "music_services_shield"... Apr 06 19:47:41 volumio volumio[13533]: info: Applying required configuration parameters for plugin music_services_shield Apr 06 19:47:41 volumio volumio[13533]: info: Loading plugin "onkyo_control"... Apr 06 19:47:42 volumio volumio[13533]: info: Applying required configuration parameters for plugin onkyo_control Apr 06 19:47:42 volumio volumio[13533]: info: Loading plugin "pirateaudio"... Apr 06 19:47:42 volumio volumio[13533]: info: Applying required configuration parameters for plugin pirateaudio Apr 06 19:47:42 volumio volumio[13533]: info: Loading plugin "remotepi"... Apr 06 19:47:43 volumio volumio[13533]: info: Applying required configuration parameters for plugin remotepi Apr 06 19:47:43 volumio volumio[13533]: info: Loading plugin "rotaryencoder2"... Apr 06 19:47:43 volumio volumio[13533]: info: Loading plugin "Systeminfo"... Apr 06 19:47:44 volumio volumio[13533]: info: Loading plugin "lastfm"... Apr 06 19:47:45 volumio volumio[13533]: info: Loading plugin "randomizer"... Apr 06 19:47:45 volumio volumio[13533]: info: Applying required configuration parameters for plugin randomizer Apr 06 19:47:45 volumio volumio[13533]: info: Plugin touch_display is not enabled Apr 06 19:47:45 volumio volumio[13533]: info: Loading i18n strings for locale en Apr 06 19:47:45 volumio volumio[13533]: info: Plugin volusonic has duplicated i18n key SAVE. It is ignored. Apr 06 19:47:45 volumio volumio[13533]: info: Plugin audiophonics_evo_sabre has duplicated i18n key PLUGIN_CONFIGURATION. It is ignored. Apr 06 19:47:45 volumio volumio[13533]: info: Plugin audiophonics_evo_sabre has duplicated i18n key SAVE. It is ignored. Apr 06 19:47:46 volumio volumio[13533]: Updating browse sources language Apr 06 19:47:46 volumio volumio[13533]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 06 19:47:46 volumio volumio[13533]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 06 19:47:46 volumio volumio[13533]: info: CoreCommandRouter::initPlayerControls Apr 06 19:47:46 volumio volumio[13533]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 19:47:46 volumio volumio[13533]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 19:47:46 volumio volumio[13533]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 19:47:46 volumio volumio[13533]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 19:47:46 volumio volumio[13533]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 06 19:47:46 volumio volumio[13533]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 06 19:47:46 volumio volumio[13533]: Express server listening on port 3000 Apr 06 19:47:46 volumio volumio[13533]: [Metrics] WebUI: 72s 946.09ms Apr 06 19:47:46 volumio volumio[13533]: info: CoreStateMachine::resetVolumioState Apr 06 19:47:46 volumio volumio[13533]: info: CoreStateMachine::getcurrentVolume Apr 06 19:47:46 volumio volumio[13533]: info: CoreCommandRouter::volumioRetrievevolume Apr 06 19:47:46 volumio volumio[13533]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Apr 06 19:47:46 volumio volumio[13533]: info: CoreStateMachine::getcurrentVolume Apr 06 19:47:46 volumio volumio[13533]: info: CoreCommandRouter::volumioRetrievevolume Apr 06 19:47:46 volumio sudo[13762]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 06 19:47:46 volumio sudo[13764]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 06 19:47:46 volumio volumio[13533]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Apr 06 19:47:46 volumio sudo[13762]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 06 19:47:46 volumio sudo[13764]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 06 19:47:46 volumio sudo[13764]: pam_unix(sudo:session): session closed for user root Apr 06 19:47:46 volumio volumio[13533]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Apr 06 19:47:47 volumio sudo[13762]: pam_unix(sudo:session): session closed for user root Apr 06 19:47:47 volumio volumio[13533]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.31.0 Total Clients: 1 Apr 06 19:47:47 volumio volumio[13533]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 2 Apr 06 19:47:47 volumio volumio[13533]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.218 UA: okhttp/4.9.2 Total Clients: 3 Apr 06 19:47:47 volumio volumio[13533]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.218 UA: okhttp/4.9.2 Total Clients: 4 Apr 06 19:47:47 volumio volumio[13533]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.218 UA: okhttp/4.9.2 Total Clients: 5 Apr 06 19:47:47 volumio volumio[13533]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.218 UA: okhttp/4.9.2 Total Clients: 6 Apr 06 19:47:47 volumio volumio[13533]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.218 UA: okhttp/4.9.2 Total Clients: 7 Apr 06 19:47:47 volumio volumio[13533]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.218 UA: okhttp/4.9.2 Total Clients: 8 Apr 06 19:47:47 volumio volumio[13533]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.218 UA: okhttp/4.9.2 Total Clients: 9 Apr 06 19:47:47 volumio volumio[13533]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.218 UA: okhttp/4.9.2 Total Clients: 10 Apr 06 19:47:47 volumio volumio[13533]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.218 UA: okhttp/4.9.2 Total Clients: 11 Apr 06 19:47:47 volumio volumio[13533]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.218 UA: okhttp/4.9.2 Total Clients: 12 Apr 06 19:47:47 volumio volumio[13533]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.218 UA: okhttp/4.9.2 Total Clients: 13 Apr 06 19:47:47 volumio volumio[13533]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.218 UA: okhttp/4.9.2 Total Clients: 14 Apr 06 19:47:47 volumio volumio[13533]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.218 UA: okhttp/4.9.2 Total Clients: 15 Apr 06 19:47:47 volumio volumio[13533]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.218 UA: okhttp/4.9.2 Total Clients: 16 Apr 06 19:47:47 volumio volumio[13533]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.218 UA: okhttp/4.9.2 Total Clients: 17 Apr 06 19:47:47 volumio volumio[13533]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.218 UA: okhttp/4.9.2 Total Clients: 18 Apr 06 19:47:47 volumio volumio[13533]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.218 UA: okhttp/4.9.2 Total Clients: 19 Apr 06 19:47:47 volumio volumio[13533]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.218 UA: okhttp/4.9.2 Total Clients: 20 Apr 06 19:47:47 volumio volumio[13533]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.218 UA: okhttp/4.9.2 Total Clients: 21 Apr 06 19:47:47 volumio volumio[13533]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 22 Apr 06 19:47:47 volumio volumio[13533]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.218 UA: okhttp/4.9.2 Total Clients: 23 Apr 06 19:47:47 volumio volumio[13533]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.218 UA: okhttp/4.9.2 Total Clients: 24 Apr 06 19:47:47 volumio volumio[13533]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.218 UA: okhttp/4.9.2 Total Clients: 25 Apr 06 19:47:47 volumio volumio[13533]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.218 UA: okhttp/4.9.2 Total Clients: 26 Apr 06 19:47:47 volumio volumio[13533]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.218 UA: okhttp/4.9.2 Total Clients: 27 Apr 06 19:47:47 volumio volumio[13533]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.218 UA: okhttp/4.9.2 Total Clients: 28 Apr 06 19:47:47 volumio volumio[13533]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.218 UA: okhttp/4.9.2 Total Clients: 29 Apr 06 19:47:47 volumio volumio[13533]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.218 UA: okhttp/4.9.2 Total Clients: 30 Apr 06 19:47:47 volumio volumio[13533]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.218 UA: okhttp/4.9.2 Total Clients: 31 Apr 06 19:47:47 volumio volumio[13533]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.218 UA: okhttp/4.9.2 Total Clients: 32 Apr 06 19:47:47 volumio volumio[13533]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.218 UA: okhttp/4.9.2 Total Clients: 33 Apr 06 19:47:47 volumio volumio[13533]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.218 UA: okhttp/4.9.2 Total Clients: 34 Apr 06 19:47:47 volumio volumio[13533]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 35 Apr 06 19:47:47 volumio volumio[13533]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.218 UA: okhttp/4.9.2 Total Clients: 36 Apr 06 19:47:47 volumio volumio[13533]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.218 UA: okhttp/4.9.2 Total Clients: 37 Apr 06 19:47:47 volumio volumio[13533]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.218 UA: okhttp/4.9.2 Total Clients: 38 Apr 06 19:47:47 volumio volumio[13533]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.218 UA: okhttp/4.9.2 Total Clients: 39 Apr 06 19:47:47 volumio volumio[13533]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.218 UA: okhttp/4.9.2 Total Clients: 40 Apr 06 19:47:47 volumio volumio[13533]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.218 UA: okhttp/4.9.2 Total Clients: 41 Apr 06 19:47:47 volumio volumio[13533]: info: VolumeController:: Volume=undefined Mute =false Apr 06 19:47:47 volumio volumio[13533]: info: CoreStateMachine::pushState Apr 06 19:47:47 volumio volumio[13533]: info: CorePlayQueue::getTrack 0 Apr 06 19:47:47 volumio volumio[13533]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 06 19:47:47 volumio volumio[13533]: info: CoreCommandRouter::volumioPushState Apr 06 19:47:47 volumio volumio[13533]: info: CoreStateMachine::updateTrackBlock Apr 06 19:47:47 volumio volumio[13533]: info: CorePlayQueue::getTrackBlock Apr 06 19:47:47 volumio volumio[13533]: info: CoreCommandRouter::volumioRetrievevolume Apr 06 19:47:47 volumio volumio[13533]: info: VolumeController:: Volume=undefined Mute =false Apr 06 19:47:47 volumio volumio[13533]: info: CoreStateMachine::pushState Apr 06 19:47:47 volumio volumio[13533]: info: CorePlayQueue::getTrack 0 Apr 06 19:47:47 volumio volumio[13533]: info: CoreCommandRouter::volumioPushState Apr 06 19:47:47 volumio volumio[13533]: info: CoreStateMachine::updateTrackBlock Apr 06 19:47:47 volumio volumio[13533]: info: CorePlayQueue::getTrackBlock Apr 06 19:47:47 volumio volumio[13533]: info: CoreCommandRouter::volumioRetrievevolume Apr 06 19:47:48 volumio volumio[13533]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 06 19:47:48 volumio volumio[13533]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 06 19:47:48 volumio volumio[13533]: info: Discovery: Getting this device information Apr 06 19:47:48 volumio volumio[13533]: info: CoreCommandRouter::volumioGetState Apr 06 19:47:48 volumio volumio[13533]: info: CorePlayQueue::getTrack 0 Apr 06 19:47:48 volumio volumio[13533]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 06 19:47:48 volumio volumio[13533]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 42 Apr 06 19:47:48 volumio volumio[13533]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 43 Apr 06 19:47:48 volumio volumio[13533]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 44 Apr 06 19:47:48 volumio volumio[13533]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Apr 06 19:47:48 volumio volumio[13533]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Apr 06 19:47:48 volumio volumio[13533]: info: Reloading queue from file Apr 06 19:47:48 volumio volumio[13533]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 06 19:47:48 volumio volumio-remote-updater[532]: [2024-04-06 19:47:48] [connect] Successful connection Apr 06 19:47:48 volumio volumio[13533]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.218 UA: okhttp/4.9.2 Total Clients: 45 Apr 06 19:47:48 volumio volumio[13533]: info: VolumeController:: Volume=undefined Mute =false Apr 06 19:47:48 volumio volumio[13533]: info: CoreStateMachine::pushState Apr 06 19:47:48 volumio volumio[13533]: info: CorePlayQueue::getTrack 0 Apr 06 19:47:48 volumio volumio[13533]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 06 19:47:48 volumio volumio[13533]: info: CoreCommandRouter::volumioPushState Apr 06 19:47:48 volumio volumio[13533]: info: VolumeController:: Volume=undefined Mute =false Apr 06 19:47:48 volumio volumio[13533]: info: CoreStateMachine::pushState Apr 06 19:47:48 volumio volumio[13533]: info: CorePlayQueue::getTrack 0 Apr 06 19:47:48 volumio volumio[13533]: info: CoreCommandRouter::volumioPushState Apr 06 19:47:48 volumio volumio[13533]: info: CoreStateMachine::setRepeat null single undefined Apr 06 19:47:48 volumio volumio[13533]: info: CoreStateMachine::pushState Apr 06 19:47:48 volumio volumio[13533]: info: CorePlayQueue::getTrack 0 Apr 06 19:47:48 volumio volumio[13533]: info: CoreCommandRouter::volumioPushState Apr 06 19:47:48 volumio volumio[13533]: info: CoreStateMachine::setRandom null Apr 06 19:47:48 volumio volumio[13533]: info: CoreStateMachine::pushState Apr 06 19:47:48 volumio volumio[13533]: info: CorePlayQueue::getTrack 0 Apr 06 19:47:48 volumio volumio[13533]: info: CoreCommandRouter::volumioPushState Apr 06 19:47:48 volumio volumio[13533]: info: Setting Device type: Raspberry PI Apr 06 19:47:48 volumio volumio[13533]: info: CoreCommandRouter::volumioGetState Apr 06 19:47:48 volumio volumio[13533]: info: CorePlayQueue::getTrack 0 Apr 06 19:47:48 volumio volumio[13533]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 06 19:47:48 volumio volumio[13533]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 06 19:47:48 volumio volumio[13533]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 46 Apr 06 19:47:48 volumio volumio[13533]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 47 Apr 06 19:47:48 volumio volumio-remote-updater[532]: [2024-04-06 19:47:48] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1712425668 101 Apr 06 19:47:48 volumio volumio[12228]: register 5 Apr 06 19:47:48 volumio volumio[12228]: success Apr 06 19:47:48 volumio volumio[12228]: register 6 Apr 06 19:47:48 volumio volumio[12228]: success Apr 06 19:47:48 volumio volumio[12228]: register 16 Apr 06 19:47:48 volumio volumio[12228]: success Apr 06 19:47:48 volumio volumio[12228]: register 20 Apr 06 19:47:48 volumio volumio[12228]: success Apr 06 19:47:48 volumio sudo[13782]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 06 19:47:48 volumio sudo[13782]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 06 19:47:49 volumio volumio[12228]: Traceback (most recent call last): Apr 06 19:47:49 volumio volumio[12228]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 721, in Apr 06 19:47:49 volumio volumio[12228]: main() Apr 06 19:47:49 volumio volumio[12228]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 697, in main Apr 06 19:47:49 volumio volumio[12228]: SOCKETIO.wait() Apr 06 19:47:49 volumio volumio[12228]: File "/usr/local/lib/python3.7/dist-packages/socketIO_client/__init__.py", line 251, in wait Apr 06 19:47:49 volumio volumio[12228]: self._process_packets() Apr 06 19:47:49 volumio volumio[12228]: File "/usr/local/lib/python3.7/dist-packages/socketIO_client/__init__.py", line 278, in _process_packets Apr 06 19:47:49 volumio volumio[12228]: self._process_packet(engineIO_packet) Apr 06 19:47:49 volumio volumio[12228]: File "/usr/local/lib/python3.7/dist-packages/socketIO_client/__init__.py", line 491, in _process_packet Apr 06 19:47:49 volumio volumio[12228]: delegate(parse_socketIO_packet_data(socketIO_packet_data), namespace) Apr 06 19:47:49 volumio volumio[12228]: File "/usr/local/lib/python3.7/dist-packages/socketIO_client/__init__.py", line 513, in _on_event Apr 06 19:47:49 volumio volumio[12228]: namespace._find_packet_callback(event)(*args) Apr 06 19:47:49 volumio volumio[12228]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 497, in on_push_state Apr 06 19:47:49 volumio volumio[12228]: VOLUMIO_DICT['VOLUME'] = int(args[0]['volume']) Apr 06 19:47:49 volumio volumio[12228]: ValueError: invalid literal for int() with base 10: '' Apr 06 19:47:49 volumio volumio[13533]: info: Discovery: adding ec69fa60-2a90-4c04-a616-c756b596d002 Apr 06 19:47:49 volumio volumio[13533]: info: Discovery: Found device Volumio Apr 06 19:47:49 volumio volumio[13533]: info: CoreCommandRouter::volumioGetState Apr 06 19:47:49 volumio volumio[13533]: info: CorePlayQueue::getTrack 0 Apr 06 19:47:49 volumio volumio[13533]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.218 UA: okhttp/4.9.2 Total Clients: 48 Apr 06 19:47:49 volumio volumio[13533]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 06 19:47:49 volumio volumio[13533]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 06 19:47:49 volumio volumio[13533]: info: CoreCommandRouter::volumioGetVisibleSources Apr 06 19:47:49 volumio volumio[13533]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 06 19:47:49 volumio volumio[13533]: info: CoreCommandRouter::volumioGetState Apr 06 19:47:49 volumio volumio[13533]: info: CorePlayQueue::getTrack 0 Apr 06 19:47:49 volumio volumio[13533]: info: CoreCommandRouter::volumioGetState Apr 06 19:47:49 volumio volumio[13533]: info: CorePlayQueue::getTrack 0 Apr 06 19:47:49 volumio volumio[13533]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 06 19:47:49 volumio volumio[13533]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 06 19:47:49 volumio volumio[13533]: info: Received Get System Info Apr 06 19:47:49 volumio volumio[13533]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 06 19:47:49 volumio volumio[13533]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 06 19:47:49 volumio volumio[13533]: info: Discovery: Getting this device information Apr 06 19:47:49 volumio volumio[13533]: info: CoreCommandRouter::volumioGetState Apr 06 19:47:49 volumio volumio[13533]: info: CorePlayQueue::getTrack 0 Apr 06 19:47:49 volumio volumio[13533]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 06 19:47:49 volumio volumio[13533]: info: CoreCommandRouter::volumioGetState Apr 06 19:47:49 volumio volumio[13533]: info: CorePlayQueue::getTrack 0 Apr 06 19:47:49 volumio sudo[13782]: pam_unix(sudo:session): session closed for user root Apr 06 19:47:49 volumio volumio[13533]: info: Listing playlists Apr 06 19:47:49 volumio volumio[13533]: info: CoreCommandRouter::volumioGetQueue Apr 06 19:47:49 volumio volumio[13533]: info: CoreStateMachine::getQueue Apr 06 19:47:49 volumio volumio[13533]: info: CorePlayQueue::getQueue Apr 06 19:47:49 volumio volumio[13533]: info: Upmpdcli Daemon Started Apr 06 19:47:49 volumio volumio[13533]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 06 19:47:49 volumio volumio[13533]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 06 19:47:49 volumio volumio[13533]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 06 19:47:49 volumio volumio[13533]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 06 19:47:50 volumio systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Apr 06 19:47:50 volumio systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Apr 06 19:47:51 volumio systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Apr 06 19:47:51 volumio systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 153. Apr 06 19:47:51 volumio systemd[1]: Stopped Service for using pirate audio display in volumio. Apr 06 19:47:51 volumio systemd[1]: Started Service for using pirate audio display in volumio. Apr 06 19:47:54 volumio volumio[13533]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.31.0 Total Clients: 48 Apr 06 19:47:55 volumio volumio[13533]: info: CoreCommandRouter::volumioGetState Apr 06 19:47:55 volumio volumio[13533]: info: CorePlayQueue::getTrack 0 Apr 06 19:47:55 volumio volumio[13533]: info: CoreCommandRouter::volumioGetQueue Apr 06 19:47:55 volumio volumio[13533]: info: CoreStateMachine::getQueue Apr 06 19:47:55 volumio volumio[13533]: info: CorePlayQueue::getQueue Apr 06 19:47:55 volumio volumio[13788]: register 5 Apr 06 19:47:55 volumio volumio[13788]: success Apr 06 19:47:55 volumio volumio[13788]: register 6 Apr 06 19:47:55 volumio volumio[13788]: success Apr 06 19:47:55 volumio volumio[13788]: register 16 Apr 06 19:47:55 volumio volumio[13788]: success Apr 06 19:47:55 volumio volumio[13788]: register 20 Apr 06 19:47:55 volumio volumio[13788]: success Apr 06 19:47:55 volumio volumio[13788]: Traceback (most recent call last): Apr 06 19:47:55 volumio volumio[13788]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 721, in Apr 06 19:47:55 volumio volumio[13788]: main() Apr 06 19:47:55 volumio volumio[13788]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 697, in main Apr 06 19:47:55 volumio volumio[13788]: SOCKETIO.wait() Apr 06 19:47:55 volumio volumio[13788]: File "/usr/local/lib/python3.7/dist-packages/socketIO_client/__init__.py", line 251, in wait Apr 06 19:47:55 volumio volumio[13788]: self._process_packets() Apr 06 19:47:55 volumio volumio[13788]: File "/usr/local/lib/python3.7/dist-packages/socketIO_client/__init__.py", line 278, in _process_packets Apr 06 19:47:55 volumio volumio[13788]: self._process_packet(engineIO_packet) Apr 06 19:47:55 volumio volumio[13788]: File "/usr/local/lib/python3.7/dist-packages/socketIO_client/__init__.py", line 491, in _process_packet Apr 06 19:47:55 volumio volumio[13788]: delegate(parse_socketIO_packet_data(socketIO_packet_data), namespace) Apr 06 19:47:55 volumio volumio[13788]: File "/usr/local/lib/python3.7/dist-packages/socketIO_client/__init__.py", line 513, in _on_event Apr 06 19:47:55 volumio volumio[13788]: namespace._find_packet_callback(event)(*args) Apr 06 19:47:55 volumio volumio[13788]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 497, in on_push_state Apr 06 19:47:55 volumio volumio[13788]: VOLUMIO_DICT['VOLUME'] = int(args[0]['volume']) Apr 06 19:47:55 volumio volumio[13788]: ValueError: invalid literal for int() with base 10: '' Apr 06 19:47:55 volumio systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Apr 06 19:47:55 volumio systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Apr 06 19:47:55 volumio systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Apr 06 19:47:55 volumio systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 154. Apr 06 19:47:55 volumio systemd[1]: Stopped Service for using pirate audio display in volumio. Apr 06 19:47:55 volumio systemd[1]: Started Service for using pirate audio display in volumio. Apr 06 19:47:57 volumio volumio[13835]: Traceback (most recent call last): Apr 06 19:47:57 volumio volumio[13835]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 309, in Apr 06 19:47:57 volumio volumio[13835]: display_stuff(IMAGE_DICT['BG_DEFAULT'], OBJ_TRANS['DISPLAY']['WAIT'], 0, 0, 'info') Apr 06 19:47:57 volumio volumio[13835]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 304, in display_stuff Apr 06 19:47:57 volumio volumio[13835]: sendtodisplay(IMAGE_DICT['IMG3']) Apr 06 19:47:57 volumio volumio[13835]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 210, in sendtodisplay Apr 06 19:47:57 volumio volumio[13835]: DISP.display(img4) Apr 06 19:47:57 volumio volumio[13835]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 343, in display Apr 06 19:47:57 volumio volumio[13835]: self.data(pixelbytes[i:i + 4096]) Apr 06 19:47:57 volumio volumio[13835]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 191, in data Apr 06 19:47:57 volumio volumio[13835]: self.send(data, True) Apr 06 19:47:57 volumio volumio[13835]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 170, in send Apr 06 19:47:57 volumio volumio[13835]: self._spi.xfer(data[start:end]) Apr 06 19:47:57 volumio volumio[13835]: TimeoutError: [Errno 110] Connection timed out Apr 06 19:47:57 volumio kernel: spidev spi0.1: SPI transfer timed out Apr 06 19:47:57 volumio kernel: spi_master spi0: failed to transfer one message from queue Apr 06 19:47:57 volumio kernel: spi_master spi0: noqueue transfer failed Apr 06 19:47:57 volumio systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Apr 06 19:47:57 volumio systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Apr 06 19:47:57 volumio volumio[13533]: info: CoreCommandRouter::volumioGetState Apr 06 19:47:57 volumio volumio[13533]: info: CorePlayQueue::getTrack 0 Apr 06 19:47:58 volumio systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Apr 06 19:47:58 volumio systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 155. Apr 06 19:47:58 volumio systemd[1]: Stopped Service for using pirate audio display in volumio. Apr 06 19:47:58 volumio systemd[1]: Started Service for using pirate audio display in volumio. Apr 06 19:47:59 volumio volumio[13533]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.31.0 Total Clients: 48 Apr 06 19:48:00 volumio volumio[13533]: info: CoreCommandRouter::volumioGetState Apr 06 19:48:00 volumio volumio[13533]: info: CorePlayQueue::getTrack 0 Apr 06 19:48:00 volumio volumio[13533]: info: CoreCommandRouter::volumioGetQueue Apr 06 19:48:00 volumio volumio[13533]: info: CoreStateMachine::getQueue Apr 06 19:48:00 volumio volumio[13533]: info: CorePlayQueue::getQueue Apr 06 19:48:00 volumio volumio[13836]: register 5 Apr 06 19:48:00 volumio volumio[13836]: success Apr 06 19:48:00 volumio volumio[13836]: register 6 Apr 06 19:48:00 volumio volumio[13836]: success Apr 06 19:48:00 volumio volumio[13836]: register 16 Apr 06 19:48:00 volumio volumio[13836]: success Apr 06 19:48:00 volumio volumio[13836]: register 20 Apr 06 19:48:00 volumio volumio[13836]: success Apr 06 19:48:00 volumio volumio[13836]: Traceback (most recent call last): Apr 06 19:48:00 volumio volumio[13836]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 721, in Apr 06 19:48:00 volumio volumio[13836]: main() Apr 06 19:48:00 volumio volumio[13836]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 697, in main Apr 06 19:48:00 volumio volumio[13836]: SOCKETIO.wait() Apr 06 19:48:00 volumio volumio[13836]: File "/usr/local/lib/python3.7/dist-packages/socketIO_client/__init__.py", line 251, in wait Apr 06 19:48:00 volumio volumio[13836]: self._process_packets() Apr 06 19:48:00 volumio volumio[13836]: File "/usr/local/lib/python3.7/dist-packages/socketIO_client/__init__.py", line 278, in _process_packets Apr 06 19:48:00 volumio volumio[13836]: self._process_packet(engineIO_packet) Apr 06 19:48:00 volumio volumio[13836]: File "/usr/local/lib/python3.7/dist-packages/socketIO_client/__init__.py", line 491, in _process_packet Apr 06 19:48:00 volumio volumio[13836]: delegate(parse_socketIO_packet_data(socketIO_packet_data), namespace) Apr 06 19:48:00 volumio volumio[13836]: File "/usr/local/lib/python3.7/dist-packages/socketIO_client/__init__.py", line 513, in _on_event Apr 06 19:48:00 volumio volumio[13836]: namespace._find_packet_callback(event)(*args) Apr 06 19:48:00 volumio volumio[13836]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 497, in on_push_state Apr 06 19:48:00 volumio volumio[13836]: VOLUMIO_DICT['VOLUME'] = int(args[0]['volume']) Apr 06 19:48:00 volumio volumio[13836]: ValueError: invalid literal for int() with base 10: '' Apr 06 19:48:00 volumio systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Apr 06 19:48:00 volumio systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Apr 06 19:48:01 volumio systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Apr 06 19:48:01 volumio systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 156. Apr 06 19:48:01 volumio systemd[1]: Stopped Service for using pirate audio display in volumio. Apr 06 19:48:01 volumio systemd[1]: Started Service for using pirate audio display in volumio. Apr 06 19:48:02 volumio volumio[13533]: info: VolumeController::SetAlsaVolume0 Apr 06 19:48:02 volumio volumio[13533]: info: CoreStateMachine::pushState Apr 06 19:48:02 volumio volumio[13533]: info: CorePlayQueue::getTrack 0 Apr 06 19:48:02 volumio volumio[13533]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 06 19:48:02 volumio volumio[13533]: info: CoreCommandRouter::volumioPushState Apr 06 19:48:02 volumio volumio[13533]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Apr 06 19:48:03 volumio volumio[13883]: Traceback (most recent call last): Apr 06 19:48:03 volumio volumio[13883]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 309, in Apr 06 19:48:03 volumio volumio[13883]: display_stuff(IMAGE_DICT['BG_DEFAULT'], OBJ_TRANS['DISPLAY']['WAIT'], 0, 0, 'info') Apr 06 19:48:03 volumio volumio[13883]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 304, in display_stuff Apr 06 19:48:03 volumio volumio[13883]: sendtodisplay(IMAGE_DICT['IMG3']) Apr 06 19:48:03 volumio volumio[13883]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 210, in sendtodisplay Apr 06 19:48:03 volumio volumio[13883]: DISP.display(img4) Apr 06 19:48:03 volumio volumio[13883]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 343, in display Apr 06 19:48:03 volumio volumio[13883]: self.data(pixelbytes[i:i + 4096]) Apr 06 19:48:03 volumio volumio[13883]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 191, in data Apr 06 19:48:03 volumio volumio[13883]: self.send(data, True) Apr 06 19:48:03 volumio volumio[13883]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 170, in send Apr 06 19:48:03 volumio volumio[13883]: self._spi.xfer(data[start:end]) Apr 06 19:48:03 volumio volumio[13883]: TimeoutError: [Errno 110] Connection timed out Apr 06 19:48:03 volumio kernel: spidev spi0.1: SPI transfer timed out Apr 06 19:48:03 volumio kernel: spi_master spi0: failed to transfer one message from queue Apr 06 19:48:03 volumio kernel: spi_master spi0: noqueue transfer failed Apr 06 19:48:03 volumio systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Apr 06 19:48:03 volumio systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Apr 06 19:48:03 volumio systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Apr 06 19:48:03 volumio systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 157. Apr 06 19:48:03 volumio systemd[1]: Stopped Service for using pirate audio display in volumio. Apr 06 19:48:03 volumio systemd[1]: Started Service for using pirate audio display in volumio. Apr 06 19:48:05 volumio volumio[13885]: Traceback (most recent call last): Apr 06 19:48:05 volumio volumio[13885]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 309, in Apr 06 19:48:05 volumio volumio[13885]: display_stuff(IMAGE_DICT['BG_DEFAULT'], OBJ_TRANS['DISPLAY']['WAIT'], 0, 0, 'info') Apr 06 19:48:05 volumio volumio[13885]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 304, in display_stuff Apr 06 19:48:05 volumio volumio[13885]: sendtodisplay(IMAGE_DICT['IMG3']) Apr 06 19:48:05 volumio volumio[13885]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 210, in sendtodisplay Apr 06 19:48:05 volumio volumio[13885]: DISP.display(img4) Apr 06 19:48:05 volumio volumio[13885]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 343, in display Apr 06 19:48:05 volumio volumio[13885]: self.data(pixelbytes[i:i + 4096]) Apr 06 19:48:05 volumio volumio[13885]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 191, in data Apr 06 19:48:05 volumio volumio[13885]: self.send(data, True) Apr 06 19:48:05 volumio volumio[13885]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 170, in send Apr 06 19:48:05 volumio volumio[13885]: self._spi.xfer(data[start:end]) Apr 06 19:48:05 volumio volumio[13885]: TimeoutError: [Errno 110] Connection timed out Apr 06 19:48:05 volumio kernel: spidev spi0.1: SPI transfer timed out Apr 06 19:48:05 volumio kernel: spi_master spi0: failed to transfer one message from queue Apr 06 19:48:05 volumio kernel: spi_master spi0: noqueue transfer failed Apr 06 19:48:06 volumio systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Apr 06 19:48:06 volumio systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Apr 06 19:48:06 volumio systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Apr 06 19:48:06 volumio systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 158. Apr 06 19:48:06 volumio systemd[1]: Stopped Service for using pirate audio display in volumio. Apr 06 19:48:06 volumio systemd[1]: Started Service for using pirate audio display in volumio. Apr 06 19:48:07 volumio volumio[13533]: info: Preload queue cleared Apr 06 19:48:07 volumio volumio[13533]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 06 19:48:07 volumio volumio[13533]: info: CoreStateMachine::ClearQueue Apr 06 19:48:07 volumio volumio[13533]: info: CoreStateMachine::stop Apr 06 19:48:07 volumio volumio[13533]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 06 19:48:07 volumio volumio[13533]: info: CorePlayQueue::clearPlayQueue Apr 06 19:48:07 volumio volumio[13533]: info: CorePlayQueue::saveQueue Apr 06 19:48:07 volumio volumio[13533]: info: CoreCommandRouter::volumioPushQueue Apr 06 19:48:07 volumio volumio[13533]: info: CoreStateMachine::addQueueItems Apr 06 19:48:07 volumio volumio[13533]: info: CorePlayQueue::addQueueItems Apr 06 19:48:07 volumio volumio[13533]: info: Preload queue cleared Apr 06 19:48:07 volumio volumio[13533]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s308766&filter=s:popular Apr 06 19:48:07 volumio volumio[13533]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 06 19:48:07 volumio volumio[13533]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 06 19:48:07 volumio volumio[13533]: TypeError: Cannot read property 'tune_radio' of undefined Apr 06 19:48:07 volumio volumio[13533]: at ControllerWebradio.explodeUri (/volumio/app/plugins/music_service/webradio/index.js:539:33) Apr 06 19:48:07 volumio volumio[13533]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1077:32) Apr 06 19:48:07 volumio volumio[13533]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:179:33) Apr 06 19:48:07 volumio volumio[13533]: at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:223:30) Apr 06 19:48:07 volumio volumio[13533]: at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:247:25) Apr 06 19:48:07 volumio volumio[13533]: at CoreCommandRouter.replaceAndPlay (/volumio/app/index.js:507:23) Apr 06 19:48:07 volumio volumio[13533]: at CoreCommandRouter.playItemsList (/volumio/app/index.js:477:17) Apr 06 19:48:07 volumio volumio[13533]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:118:33) Apr 06 19:48:07 volumio volumio[13533]: at Socket.emit (events.js:315:20) Apr 06 19:48:07 volumio volumio[13533]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Apr 06 19:48:07 volumio volumio[13533]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Apr 06 19:48:07 volumio volumio[13533]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 06 19:48:08 volumio volumio[13887]: Traceback (most recent call last): Apr 06 19:48:08 volumio volumio[13887]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 309, in Apr 06 19:48:08 volumio volumio[13887]: display_stuff(IMAGE_DICT['BG_DEFAULT'], OBJ_TRANS['DISPLAY']['WAIT'], 0, 0, 'info') Apr 06 19:48:08 volumio volumio[13887]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 304, in display_stuff Apr 06 19:48:08 volumio volumio[13887]: sendtodisplay(IMAGE_DICT['IMG3']) Apr 06 19:48:08 volumio volumio[13887]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 210, in sendtodisplay Apr 06 19:48:08 volumio volumio[13887]: DISP.display(img4) Apr 06 19:48:08 volumio volumio[13887]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 343, in display Apr 06 19:48:08 volumio volumio[13887]: self.data(pixelbytes[i:i + 4096]) Apr 06 19:48:08 volumio volumio[13887]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 191, in data Apr 06 19:48:08 volumio volumio[13887]: self.send(data, True) Apr 06 19:48:08 volumio volumio[13887]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 170, in send Apr 06 19:48:08 volumio volumio[13887]: self._spi.xfer(data[start:end]) Apr 06 19:48:08 volumio volumio[13887]: TimeoutError: [Errno 110] Connection timed out Apr 06 19:48:08 volumio kernel: spidev spi0.1: SPI transfer timed out Apr 06 19:48:08 volumio kernel: spi_master spi0: failed to transfer one message from queue Apr 06 19:48:08 volumio kernel: spi_master spi0: noqueue transfer failed Apr 06 19:48:08 volumio systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Apr 06 19:48:08 volumio systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Apr 06 19:48:08 volumio systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Apr 06 19:48:08 volumio systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 159. Apr 06 19:48:08 volumio systemd[1]: Stopped Service for using pirate audio display in volumio. Apr 06 19:48:08 volumio systemd[1]: Started Service for using pirate audio display in volumio. Apr 06 19:48:09 volumio sudo[13898]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-06 19:47 Apr 06 19:48:09 volumio sudo[13898]: 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"