-- Logs begin at Wed 2024-11-20 22:07:11 CET, end at Wed 2024-11-20 22:14:02 CET. -- Nov 20 22:13:04 volumio go-librespot[1761]: time="2024-11-20T22:13:04+01:00" level=debug msg="fetched chunk 5/17, size: 524288" uri="spotify:track:5OC347cwcGpiwnHt0YmToq" Nov 20 22:13:09 volumio volumio[1089]: info: CoreCommandRouter::volumioPause Nov 20 22:13:09 volumio volumio[1089]: info: CoreStateMachine::pause Nov 20 22:13:09 volumio volumio[1089]: info: CoreStateMachine::stPlaybackTimer Nov 20 22:13:09 volumio volumio[1089]: info: CoreStateMachine::servicePause Nov 20 22:13:09 volumio volumio[1089]: info: CorePlayQueue::getTrack 0 Nov 20 22:13:09 volumio volumio[1089]: info: CoreCommandRouter::servicePause Nov 20 22:13:09 volumio volumio[1089]: info: Spotify Received pause Nov 20 22:13:09 volumio volumio[1089]: SPOTIFY: SPOTIFY PAUSE Nov 20 22:13:09 volumio volumio[1089]: SPOTIFY: {"status":"play","position":0,"title":"było, minęło","artist":"sanah","album":"Kaprysy","albumart":"https://i.scdn.co/image/ab67616d0000b27335468b346904b80c89409ea6","uri":"spotify:track:5OC347cwcGpiwnHt0YmToq","trackType":"spotify","codec":"ogg","seek":0,"duration":207,"samplerate":"320 kbps","bitdepth":"16 bit","channels":2,"random":null,"repeat":null,"repeatSingle":false,"consume":false,"volume":100,"dbVolume":null,"disableVolumeControl":false,"mute":false,"stream":"spotify","volatile":false,"service":"spop"} Nov 20 22:13:09 volumio volumio[1089]: info: Sending Spotify command to local API: /player/pause Nov 20 22:13:09 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 20 22:13:09 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 20 22:13:09 volumio volumio[1089]: info: Discovery: Getting this device information Nov 20 22:13:09 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState Nov 20 22:13:09 volumio volumio[1089]: info: CorePlayQueue::getTrack 0 Nov 20 22:13:09 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 20 22:13:09 volumio go-librespot[1761]: time="2024-11-20T22:13:09+01:00" level=debug msg="pause track at 27216ms" Nov 20 22:13:09 volumio go-librespot[1761]: time="2024-11-20T22:13:09+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Nov 20 22:13:09 volumio go-librespot[1761]: time="2024-11-20T22:13:09+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Nov 20 22:13:09 volumio go-librespot[1761]: time="2024-11-20T22:13:09+01:00" level=trace msg="emitting websocket event: paused" Nov 20 22:13:09 volumio volumio[1089]: SPOTIFY: received: {"type":"paused","data":{"uri":"spotify:track:5OC347cwcGpiwnHt0YmToq","play_origin":"go-librespot"}} Nov 20 22:13:09 volumio volumio[1089]: SPOTIFY: PUSH STATE SPOTIFY Nov 20 22:13:09 volumio volumio[1089]: SPOTIFY: {"status":"pause","service":"spop","title":"było, minęło","artist":"sanah","album":"Kaprysy","albumart":"https://i.scdn.co/image/ab67616d00001e0235468b346904b80c89409ea6","uri":"spotify:track:5OC347cwcGpiwnHt0YmToq","trackType":"spotify","seek":27000,"duration":207,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Nov 20 22:13:09 volumio volumio[1089]: info: CoreCommandRouter::servicePushState Nov 20 22:13:09 volumio volumio[1089]: info: CorePlayQueue::getTrack 0 Nov 20 22:13:09 volumio volumio[1089]: verbose: STATE SERVICE {"status":"pause","service":"spop","title":"było, minęło","artist":"sanah","album":"Kaprysy","albumart":"https://i.scdn.co/image/ab67616d00001e0235468b346904b80c89409ea6","uri":"spotify:track:5OC347cwcGpiwnHt0YmToq","trackType":"spotify","seek":27000,"duration":207,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Nov 20 22:13:09 volumio volumio[1089]: verbose: CURRENT POSITION 0 Nov 20 22:13:09 volumio volumio[1089]: info: CoreStateMachine::syncState stateService pause Nov 20 22:13:09 volumio volumio[1089]: info: CoreStateMachine::syncState currentStatus pause Nov 20 22:13:09 volumio volumio[1089]: info: CoreStateMachine::pushState Nov 20 22:13:09 volumio volumio[1089]: info: CorePlayQueue::getTrack 0 Nov 20 22:13:09 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 20 22:13:09 volumio volumio[1089]: info: CoreCommandRouter::volumioPushState Nov 20 22:13:09 volumio volumio[1089]: info: CoreStateMachine::stPlaybackTimer Nov 20 22:13:09 volumio volumio[1089]: info: [ASDebug] CurState: pause PrevState: play Nov 20 22:13:09 volumio volumio[1089]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Nov 20 22:13:09 volumio volumio[1089]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 20 22:13:09 volumio volumio[1089]: info: touch_display: Setting screensaver timeout to 120 seconds. Nov 20 22:13:09 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 20 22:13:09 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 20 22:13:09 volumio volumio[1089]: info: Discovery: Getting this device information Nov 20 22:13:09 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState Nov 20 22:13:09 volumio volumio[1089]: info: CorePlayQueue::getTrack 0 Nov 20 22:13:09 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 20 22:13:09 volumio volumio[1089]: info: peppy_screensaver: Start PeppyMeter Nov 20 22:13:09 volumio volumio[1089]: info: [ASDebug] Pulsing GPIO for 500ms Nov 20 22:13:09 volumio volumio[1089]: info: [ASDebug] Togle GPIO: ON Nov 20 22:13:10 volumio volumio[1089]: info: [ASDebug] Togle GPIO: OFF Nov 20 22:13:17 volumio volumio[1089]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 20 22:13:18 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 20 22:13:18 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 20 22:13:18 volumio volumio[1089]: info: Discovery: Getting this device information Nov 20 22:13:18 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState Nov 20 22:13:18 volumio volumio[1089]: info: CorePlayQueue::getTrack 0 Nov 20 22:13:18 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 20 22:13:21 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 20 22:13:21 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 20 22:13:21 volumio volumio[1089]: info: Discovery: Getting this device information Nov 20 22:13:21 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState Nov 20 22:13:21 volumio volumio[1089]: info: CorePlayQueue::getTrack 0 Nov 20 22:13:21 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 20 22:13:28 volumio volumio[1089]: verbose: New Socket.io Connection to 192.168.0.31:3000 from 192.168.0.27 UA: Mozilla/5.0 (Linux; Android 14; CPH2629 Build/UKQ1.231108.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/130.0.6723.107 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 13 Nov 20 22:13:28 volumio volumio[1089]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Nov 20 22:13:28 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Nov 20 22:13:28 volumio volumio[1089]: error: [now-playing] API endpoint weather/fetchInfo returned error: Error: Could not access weather service: missing geographic coordinates. Nov 20 22:13:28 volumio volumio[1089]: at WeatherAPI.fetchInfo (/data/plugins/user_interface/now_playing/dist/lib/api/WeatherAPI.js:106:19) Nov 20 22:13:28 volumio volumio[1089]: at Object.api (/data/plugins/user_interface/now_playing/dist/app/Handler.js:115:37) Nov 20 22:13:28 volumio volumio[1089]: at /data/plugins/user_interface/now_playing/dist/app/Router.js:47:13 Nov 20 22:13:28 volumio volumio[1089]: at Layer.handle [as handle_request] (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/layer.js:95:5) Nov 20 22:13:28 volumio volumio[1089]: at next (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/route.js:149:13) Nov 20 22:13:28 volumio volumio[1089]: at Route.dispatch (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/route.js:119:3) Nov 20 22:13:28 volumio volumio[1089]: at Layer.handle [as handle_request] (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/layer.js:95:5) Nov 20 22:13:28 volumio volumio[1089]: at /data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:284:15 Nov 20 22:13:28 volumio volumio[1089]: at param (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:365:14) Nov 20 22:13:28 volumio volumio[1089]: at param (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:376:14) Nov 20 22:13:28 volumio volumio[1089]: at Function.process_params (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:421:3) Nov 20 22:13:28 volumio volumio[1089]: at next (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:280:10) Nov 20 22:13:28 volumio volumio[1089]: at Function.handle (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:175:3) Nov 20 22:13:28 volumio volumio[1089]: at router (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:47:12) Nov 20 22:13:28 volumio volumio[1089]: at Layer.handle [as handle_request] (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/layer.js:95:5) Nov 20 22:13:28 volumio volumio[1089]: verbose: New Socket.io Connection to 192.168.0.31:3000 from 192.168.0.27 UA: Mozilla/5.0 (Linux; Android 14; CPH2629 Build/UKQ1.231108.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/130.0.6723.107 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 14 Nov 20 22:13:28 volumio volumio[1089]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Nov 20 22:13:28 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Nov 20 22:13:28 volumio volumio[1089]: info: Listing playlists Nov 20 22:13:28 volumio volumio[1089]: info: CoreCommandRouter::volumioGetQueue Nov 20 22:13:28 volumio volumio[1089]: info: CoreStateMachine::getQueue Nov 20 22:13:28 volumio volumio[1089]: info: CorePlayQueue::getQueue Nov 20 22:13:28 volumio volumio[1089]: info: CoreCommandRouter::volumioGetVisibleSources Nov 20 22:13:28 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 20 22:13:28 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState Nov 20 22:13:28 volumio volumio[1089]: info: CorePlayQueue::getTrack 0 Nov 20 22:13:28 volumio sudo[3538]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 20 22:13:28 volumio sudo[3538]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 22:13:29 volumio sudo[3538]: pam_unix(sudo:session): session closed for user root Nov 20 22:13:29 volumio sudo[3541]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 20 22:13:29 volumio sudo[3541]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 22:13:29 volumio sudo[3541]: pam_unix(sudo:session): session closed for user root Nov 20 22:13:29 volumio volumio[1089]: verbose: New Socket.io Connection to 192.168.0.31 from 192.168.0.27 UA: Mozilla/5.0 (Linux; Android 14; CPH2629 Build/UKQ1.231108.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/130.0.6723.107 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 15 Nov 20 22:13:29 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 20 22:13:29 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 20 22:13:29 volumio volumio[1089]: info: Discovery: Getting this device information Nov 20 22:13:29 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState Nov 20 22:13:29 volumio volumio[1089]: info: CorePlayQueue::getTrack 0 Nov 20 22:13:29 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 20 22:13:29 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 20 22:13:29 volumio sudo[3544]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 20 22:13:29 volumio sudo[3544]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 22:13:29 volumio sudo[3544]: pam_unix(sudo:session): session closed for user root Nov 20 22:13:29 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Nov 20 22:13:29 volumio sudo[3547]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 20 22:13:29 volumio sudo[3547]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 22:13:29 volumio sudo[3547]: pam_unix(sudo:session): session closed for user root Nov 20 22:13:29 volumio volumio[1089]: verbose: New Socket.io Connection to 192.168.0.31 from 192.168.0.27 UA: Mozilla/5.0 (Linux; Android 14; CPH2629 Build/UKQ1.231108.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/130.0.6723.107 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 16 Nov 20 22:13:29 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 20 22:13:29 volumio volumio[1089]: info: CoreCommandRouter::volumioGetVisibleSources Nov 20 22:13:29 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 20 22:13:29 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState Nov 20 22:13:29 volumio volumio[1089]: info: CorePlayQueue::getTrack 0 Nov 20 22:13:29 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 20 22:13:29 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 20 22:13:29 volumio volumio[1089]: info: Received Get System Info Nov 20 22:13:29 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 20 22:13:29 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 20 22:13:29 volumio volumio[1089]: info: Discovery: Getting this device information Nov 20 22:13:29 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState Nov 20 22:13:29 volumio volumio[1089]: info: CorePlayQueue::getTrack 0 Nov 20 22:13:29 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 20 22:13:29 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState Nov 20 22:13:29 volumio volumio[1089]: info: CorePlayQueue::getTrack 0 Nov 20 22:13:29 volumio volumio[1089]: info: Listing playlists Nov 20 22:13:29 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Nov 20 22:13:29 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 20 22:13:29 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Nov 20 22:13:32 volumio volumio[1089]: info: CoreCommandRouter::volumioPlay Nov 20 22:13:32 volumio volumio[1089]: info: CoreStateMachine::play index undefined Nov 20 22:13:32 volumio volumio[1089]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 20 22:13:32 volumio volumio[1089]: info: CorePlayQueue::getTrack 0 Nov 20 22:13:32 volumio volumio[1089]: info: CoreStateMachine::startPlaybackTimer Nov 20 22:13:32 volumio volumio[1089]: info: CorePlayQueue::getTrack 0 Nov 20 22:13:32 volumio volumio[1089]: info: Spotify Resume Nov 20 22:13:32 volumio volumio[1089]: info: Sending Spotify command to local API: /player/resume Nov 20 22:13:32 volumio go-librespot[1761]: time="2024-11-20T22:13:32+01:00" level=trace msg="seek to 27216ms (diff: 81ms, samples: 1200225, bytes: 1230022)" uri="spotify:track:5OC347cwcGpiwnHt0YmToq" Nov 20 22:13:32 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Nov 20 22:13:32 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 20 22:13:32 volumio volumio[1089]: info: Received Get System Info Nov 20 22:13:32 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 20 22:13:32 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 20 22:13:32 volumio volumio[1089]: info: Discovery: Getting this device information Nov 20 22:13:32 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState Nov 20 22:13:32 volumio volumio[1089]: info: CorePlayQueue::getTrack 0 Nov 20 22:13:32 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 20 22:13:32 volumio go-librespot[1761]: time="2024-11-20T22:13:32+01:00" level=debug msg="alsa driver configured, rate = 44100 bps, period time = 5102 us, period size = 225 frames, buffer time = 500000 us, buffer size = 22050 frames, periods per buffer = 98 frames" Nov 20 22:13:32 volumio go-librespot[1761]: time="2024-11-20T22:13:32+01:00" level=debug msg="resume track at 27039ms" Nov 20 22:13:32 volumio go-librespot[1761]: time="2024-11-20T22:13:32+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Nov 20 22:13:32 volumio go-librespot[1761]: time="2024-11-20T22:13:32+01:00" level=trace msg="scheduling prefetch in 150s" Nov 20 22:13:32 volumio go-librespot[1761]: time="2024-11-20T22:13:32+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Nov 20 22:13:32 volumio go-librespot[1761]: time="2024-11-20T22:13:32+01:00" level=trace msg="emitting websocket event: playing" Nov 20 22:13:32 volumio volumio[1089]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:5OC347cwcGpiwnHt0YmToq","play_origin":"go-librespot"}} Nov 20 22:13:32 volumio volumio[1089]: SPOTIFY: PUSH STATE SPOTIFY Nov 20 22:13:32 volumio volumio[1089]: SPOTIFY: {"status":"play","service":"spop","title":"było, minęło","artist":"sanah","album":"Kaprysy","albumart":"https://i.scdn.co/image/ab67616d00001e0235468b346904b80c89409ea6","uri":"spotify:track:5OC347cwcGpiwnHt0YmToq","trackType":"spotify","seek":27000,"duration":207,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Nov 20 22:13:32 volumio volumio[1089]: info: CoreCommandRouter::servicePushState Nov 20 22:13:32 volumio volumio[1089]: info: CorePlayQueue::getTrack 0 Nov 20 22:13:32 volumio volumio[1089]: verbose: STATE SERVICE {"status":"play","service":"spop","title":"było, minęło","artist":"sanah","album":"Kaprysy","albumart":"https://i.scdn.co/image/ab67616d00001e0235468b346904b80c89409ea6","uri":"spotify:track:5OC347cwcGpiwnHt0YmToq","trackType":"spotify","seek":27000,"duration":207,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Nov 20 22:13:32 volumio volumio[1089]: verbose: CURRENT POSITION 0 Nov 20 22:13:32 volumio volumio[1089]: info: CoreStateMachine::syncState stateService play Nov 20 22:13:32 volumio volumio[1089]: info: CoreStateMachine::syncState currentStatus pause Nov 20 22:13:32 volumio volumio[1089]: info: CoreStateMachine::pushState Nov 20 22:13:32 volumio volumio[1089]: info: CorePlayQueue::getTrack 0 Nov 20 22:13:32 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 20 22:13:32 volumio volumio[1089]: info: CoreCommandRouter::volumioPushState Nov 20 22:13:32 volumio volumio[1089]: info: [ASDebug] CurState: play PrevState: pause Nov 20 22:13:32 volumio volumio[1089]: info: [ASDebug] Pulsing GPIO for 500ms Nov 20 22:13:32 volumio volumio[1089]: info: [ASDebug] Togle GPIO: ON Nov 20 22:13:32 volumio volumio[1089]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 20 22:13:32 volumio volumio[1089]: info: touch_display: Setting screensaver timeout to 0 seconds. Nov 20 22:13:32 volumio volumio[1089]: SPOTIFY: PUSH STATE SPOTIFY Nov 20 22:13:32 volumio volumio[1089]: SPOTIFY: {"status":"play","service":"spop","title":"było, minęło","artist":"sanah","album":"Kaprysy","albumart":"https://i.scdn.co/image/ab67616d00001e0235468b346904b80c89409ea6","uri":"spotify:track:5OC347cwcGpiwnHt0YmToq","trackType":"spotify","seek":27000,"duration":207,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Nov 20 22:13:32 volumio volumio[1089]: info: CoreCommandRouter::servicePushState Nov 20 22:13:32 volumio volumio[1089]: info: CorePlayQueue::getTrack 0 Nov 20 22:13:32 volumio volumio[1089]: verbose: STATE SERVICE {"status":"play","service":"spop","title":"było, minęło","artist":"sanah","album":"Kaprysy","albumart":"https://i.scdn.co/image/ab67616d00001e0235468b346904b80c89409ea6","uri":"spotify:track:5OC347cwcGpiwnHt0YmToq","trackType":"spotify","seek":27000,"duration":207,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Nov 20 22:13:32 volumio volumio[1089]: verbose: CURRENT POSITION 0 Nov 20 22:13:32 volumio volumio[1089]: info: CoreStateMachine::syncState stateService play Nov 20 22:13:32 volumio volumio[1089]: info: CoreStateMachine::syncState currentStatus play Nov 20 22:13:32 volumio volumio[1089]: info: Received an update from plugin. extracting info from payload Nov 20 22:13:32 volumio volumio[1089]: info: CoreStateMachine::pushState Nov 20 22:13:32 volumio volumio[1089]: info: CorePlayQueue::getTrack 0 Nov 20 22:13:32 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 20 22:13:32 volumio volumio[1089]: info: CoreCommandRouter::volumioPushState Nov 20 22:13:32 volumio volumio[1089]: info: CoreStateMachine::pushState Nov 20 22:13:32 volumio volumio[1089]: info: CorePlayQueue::getTrack 0 Nov 20 22:13:32 volumio volumio[1089]: info: CoreCommandRouter::volumioPushState Nov 20 22:13:32 volumio volumio[1089]: info: [ASDebug] CurState: play PrevState: play Nov 20 22:13:32 volumio volumio[1089]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 20 22:13:32 volumio volumio[1089]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 20 22:13:32 volumio volumio[1089]: info: [ASDebug] Togle GPIO: OFF Nov 20 22:13:33 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 20 22:13:33 volumio volumio[1089]: info: Received Get System Info Nov 20 22:13:33 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 20 22:13:33 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 20 22:13:33 volumio volumio[1089]: info: Discovery: Getting this device information Nov 20 22:13:33 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState Nov 20 22:13:33 volumio volumio[1089]: info: CorePlayQueue::getTrack 0 Nov 20 22:13:33 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 20 22:13:38 volumio volumio[1089]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 17 Nov 20 22:13:38 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState Nov 20 22:13:38 volumio volumio[1089]: info: CorePlayQueue::getTrack 0 Nov 20 22:13:38 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 20 22:13:38 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 20 22:13:38 volumio volumio[1089]: info: Discovery: Getting this device information Nov 20 22:13:38 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState Nov 20 22:13:38 volumio volumio[1089]: info: CorePlayQueue::getTrack 0 Nov 20 22:13:38 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 20 22:13:39 volumio go-librespot[1761]: time="2024-11-20T22:13:39+01:00" level=debug msg="fetched chunk 6/17, size: 524288" uri="spotify:track:5OC347cwcGpiwnHt0YmToq" Nov 20 22:13:39 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 20 22:13:39 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 20 22:13:39 volumio volumio[1089]: info: Discovery: Getting this device information Nov 20 22:13:39 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState Nov 20 22:13:39 volumio volumio[1089]: info: CorePlayQueue::getTrack 0 Nov 20 22:13:39 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 20 22:13:39 volumio volumio[1089]: info: CoreCommandRouter::volumioPause Nov 20 22:13:39 volumio volumio[1089]: info: CoreStateMachine::pause Nov 20 22:13:39 volumio volumio[1089]: info: CoreStateMachine::stPlaybackTimer Nov 20 22:13:39 volumio volumio[1089]: info: CoreStateMachine::servicePause Nov 20 22:13:39 volumio volumio[1089]: info: CorePlayQueue::getTrack 0 Nov 20 22:13:39 volumio volumio[1089]: info: CoreCommandRouter::servicePause Nov 20 22:13:39 volumio volumio[1089]: info: Spotify Received pause Nov 20 22:13:39 volumio volumio[1089]: SPOTIFY: SPOTIFY PAUSE Nov 20 22:13:39 volumio volumio[1089]: SPOTIFY: {"status":"play","position":0,"title":"było, minęło","artist":"sanah","album":"Kaprysy","albumart":"https://i.scdn.co/image/ab67616d0000b27335468b346904b80c89409ea6","uri":"spotify:track:5OC347cwcGpiwnHt0YmToq","trackType":"spotify","codec":"ogg","seek":27000,"duration":207,"samplerate":"320 kbps","bitdepth":"16 bit","channels":2,"random":null,"repeat":null,"repeatSingle":false,"consume":false,"volume":100,"dbVolume":null,"disableVolumeControl":false,"mute":false,"stream":"spotify","volatile":false,"service":"spop"} Nov 20 22:13:39 volumio volumio[1089]: info: Sending Spotify command to local API: /player/pause Nov 20 22:13:39 volumio go-librespot[1761]: time="2024-11-20T22:13:39+01:00" level=debug msg="pause track at 34484ms" Nov 20 22:13:39 volumio go-librespot[1761]: time="2024-11-20T22:13:39+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Nov 20 22:13:39 volumio go-librespot[1761]: time="2024-11-20T22:13:39+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Nov 20 22:13:39 volumio go-librespot[1761]: time="2024-11-20T22:13:39+01:00" level=trace msg="emitting websocket event: paused" Nov 20 22:13:39 volumio volumio[1089]: SPOTIFY: received: {"type":"paused","data":{"uri":"spotify:track:5OC347cwcGpiwnHt0YmToq","play_origin":"go-librespot"}} Nov 20 22:13:39 volumio volumio[1089]: SPOTIFY: PUSH STATE SPOTIFY Nov 20 22:13:39 volumio volumio[1089]: SPOTIFY: {"status":"pause","service":"spop","title":"było, minęło","artist":"sanah","album":"Kaprysy","albumart":"https://i.scdn.co/image/ab67616d00001e0235468b346904b80c89409ea6","uri":"spotify:track:5OC347cwcGpiwnHt0YmToq","trackType":"spotify","seek":34000,"duration":207,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Nov 20 22:13:39 volumio volumio[1089]: info: CoreCommandRouter::servicePushState Nov 20 22:13:39 volumio volumio[1089]: info: CorePlayQueue::getTrack 0 Nov 20 22:13:39 volumio volumio[1089]: verbose: STATE SERVICE {"status":"pause","service":"spop","title":"było, minęło","artist":"sanah","album":"Kaprysy","albumart":"https://i.scdn.co/image/ab67616d00001e0235468b346904b80c89409ea6","uri":"spotify:track:5OC347cwcGpiwnHt0YmToq","trackType":"spotify","seek":34000,"duration":207,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Nov 20 22:13:39 volumio volumio[1089]: verbose: CURRENT POSITION 0 Nov 20 22:13:39 volumio volumio[1089]: info: CoreStateMachine::syncState stateService pause Nov 20 22:13:39 volumio volumio[1089]: info: CoreStateMachine::syncState currentStatus pause Nov 20 22:13:39 volumio volumio[1089]: info: CoreStateMachine::pushState Nov 20 22:13:39 volumio volumio[1089]: info: CorePlayQueue::getTrack 0 Nov 20 22:13:39 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 20 22:13:39 volumio volumio[1089]: info: CoreCommandRouter::volumioPushState Nov 20 22:13:39 volumio volumio[1089]: info: CoreStateMachine::stPlaybackTimer Nov 20 22:13:39 volumio volumio[1089]: info: [ASDebug] CurState: pause PrevState: play Nov 20 22:13:39 volumio volumio[1089]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Nov 20 22:13:39 volumio volumio[1089]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 20 22:13:39 volumio volumio[1089]: info: touch_display: Setting screensaver timeout to 120 seconds. Nov 20 22:13:40 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 20 22:13:40 volumio volumio[1089]: info: [ASDebug] Pulsing GPIO for 500ms Nov 20 22:13:40 volumio volumio[1089]: info: [ASDebug] Togle GPIO: ON Nov 20 22:13:40 volumio volumio[1089]: info: peppy_screensaver: Start PeppyMeter Nov 20 22:13:40 volumio volumio[1089]: info: [ASDebug] Togle GPIO: OFF Nov 20 22:13:45 volumio sudo[3615]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 20 22:13:45 volumio sudo[3615]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 22:13:45 volumio sudo[3615]: pam_unix(sudo:session): session closed for user root Nov 20 22:13:45 volumio sudo[3618]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 20 22:13:45 volumio sudo[3618]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 22:13:45 volumio sudo[3618]: pam_unix(sudo:session): session closed for user root Nov 20 22:13:46 volumio volumio[1089]: verbose: New Socket.io Connection to 192.168.0.31 from 192.168.0.27 UA: Mozilla/5.0 (Linux; Android 14; CPH2629 Build/UKQ1.231108.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/130.0.6723.107 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 17 Nov 20 22:13:46 volumio sudo[3621]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 20 22:13:46 volumio sudo[3621]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 22:13:46 volumio sudo[3621]: pam_unix(sudo:session): session closed for user root Nov 20 22:13:46 volumio sudo[3624]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 20 22:13:46 volumio sudo[3624]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 22:13:46 volumio sudo[3624]: pam_unix(sudo:session): session closed for user root Nov 20 22:13:46 volumio volumio[1089]: verbose: New Socket.io Connection to 192.168.0.31 from 192.168.0.27 UA: Mozilla/5.0 (Linux; Android 14; CPH2629 Build/UKQ1.231108.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/130.0.6723.107 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 18 Nov 20 22:13:46 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 20 22:13:46 volumio volumio[1089]: info: CoreCommandRouter::volumioGetVisibleSources Nov 20 22:13:46 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 20 22:13:46 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState Nov 20 22:13:46 volumio volumio[1089]: info: CorePlayQueue::getTrack 0 Nov 20 22:13:46 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 20 22:13:46 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 20 22:13:46 volumio volumio[1089]: info: Received Get System Info Nov 20 22:13:46 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 20 22:13:46 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 20 22:13:46 volumio volumio[1089]: info: Discovery: Getting this device information Nov 20 22:13:46 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState Nov 20 22:13:46 volumio volumio[1089]: info: CorePlayQueue::getTrack 0 Nov 20 22:13:46 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 20 22:13:46 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState Nov 20 22:13:46 volumio volumio[1089]: info: CorePlayQueue::getTrack 0 Nov 20 22:13:46 volumio volumio[1089]: info: Listing playlists Nov 20 22:13:46 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Nov 20 22:13:46 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 20 22:13:47 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Nov 20 22:13:48 volumio volumio[1089]: info: CoreCommandRouter::volumioGetQueue Nov 20 22:13:48 volumio volumio[1089]: info: CoreStateMachine::getQueue Nov 20 22:13:48 volumio volumio[1089]: info: CorePlayQueue::getQueue Nov 20 22:13:48 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 20 22:13:48 volumio volumio[1089]: info: Received Get System Info Nov 20 22:13:48 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 20 22:13:48 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 20 22:13:48 volumio volumio[1089]: info: Discovery: Getting this device information Nov 20 22:13:48 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState Nov 20 22:13:48 volumio volumio[1089]: info: CorePlayQueue::getTrack 0 Nov 20 22:13:48 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 20 22:13:48 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Nov 20 22:13:49 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 20 22:13:49 volumio volumio[1089]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Nov 20 22:13:49 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Nov 20 22:13:49 volumio volumio[1089]: info: Received Get System Version Nov 20 22:13:49 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 20 22:13:49 volumio volumio[1089]: info: Received Get System Info Nov 20 22:13:49 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 20 22:13:49 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 20 22:13:49 volumio volumio[1089]: info: Discovery: Getting this device information Nov 20 22:13:49 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState Nov 20 22:13:49 volumio volumio[1089]: info: CorePlayQueue::getTrack 0 Nov 20 22:13:49 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 20 22:13:49 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 20 22:13:49 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 20 22:13:49 volumio volumio[1089]: info: Discovery: Getting this device information Nov 20 22:13:49 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState Nov 20 22:13:49 volumio volumio[1089]: info: CorePlayQueue::getTrack 0 Nov 20 22:13:49 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 20 22:13:49 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 20 22:13:49 volumio volumio[1089]: info: Received Get System Info Nov 20 22:13:49 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 20 22:13:49 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 20 22:13:49 volumio volumio[1089]: info: Discovery: Getting this device information Nov 20 22:13:49 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState Nov 20 22:13:49 volumio volumio[1089]: info: CorePlayQueue::getTrack 0 Nov 20 22:13:49 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 20 22:13:51 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 20 22:13:51 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 20 22:13:51 volumio volumio[1089]: info: Discovery: Getting this device information Nov 20 22:13:51 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState Nov 20 22:13:51 volumio volumio[1089]: info: CorePlayQueue::getTrack 0 Nov 20 22:13:51 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 20 22:13:52 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 20 22:13:52 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Nov 20 22:13:56 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 20 22:13:58 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 20 22:13:58 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 20 22:13:58 volumio volumio[1089]: info: Discovery: Getting this device information Nov 20 22:13:58 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState Nov 20 22:13:58 volumio volumio[1089]: info: CorePlayQueue::getTrack 0 Nov 20 22:13:58 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 20 22:14:01 volumio volumio[1089]: info: [ASDebug] Port: 24 Nov 20 22:14:01 volumio volumio[1089]: info: [ASDebug] Inverted: false Nov 20 22:14:01 volumio volumio[1089]: info: [ASDebug] Delay: 720 Nov 20 22:14:02 volumio volumio[1089]: info: [ASDebug] Port: 24 Nov 20 22:14:02 volumio volumio[1089]: info: [ASDebug] Inverted: false Nov 20 22:14:02 volumio volumio[1089]: info: [ASDebug] Delay: 720 Nov 20 22:14:02 volumio volumio[1089]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 20 22:14:02 volumio volumio[1089]: Error: EBADF: bad file descriptor, close Nov 20 22:14:02 volumio volumio[1089]: at Object.closeSync (fs.js:439:3) Nov 20 22:14:02 volumio volumio[1089]: at Object.closeSync (/volumio/node_modules/graceful-fs/graceful-fs.js:74:20) Nov 20 22:14:02 volumio volumio[1089]: at Object.closeSync (/data/plugins/system_controller/ampswitch/node_modules/graceful-fs/graceful-fs.js:51:27) Nov 20 22:14:02 volumio volumio[1089]: at Gpio.unexport (/data/plugins/system_controller/ampswitch/node_modules/onoff/onoff.js:307:8) Nov 20 22:14:02 volumio volumio[1089]: at AmpSwitchController.freeGPIO (/data/plugins/system_controller/ampswitch/index.js:242:19) Nov 20 22:14:02 volumio volumio[1089]: at AmpSwitchController.onStop (/data/plugins/system_controller/ampswitch/index.js:90:10) Nov 20 22:14:02 volumio volumio[1089]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Nov 20 22:14:02 volumio volumio[1089]: at PluginManager.disableAndStopPlugin (/volumio/app/pluginmanager.js:1883:8) Nov 20 22:14:02 volumio volumio[1089]: at CoreCommandRouter.disableAndStopPlugin (/volumio/app/index.js:1551:29) Nov 20 22:14:02 volumio volumio[1089]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1395:47) Nov 20 22:14:02 volumio volumio[1089]: at Socket.emit (events.js:315:20) Nov 20 22:14:02 volumio volumio[1089]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Nov 20 22:14:02 volumio volumio[1089]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Nov 20 22:14:02 volumio volumio[1089]: errno: -9, Nov 20 22:14:02 volumio volumio[1089]: syscall: 'close', Nov 20 22:14:02 volumio volumio[1089]: code: 'EBADF' Nov 20 22:14:02 volumio volumio[1089]: } Nov 20 22:14:02 volumio volumio[1089]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 20 22:14:02 volumio sudo[3667]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-20 22:13 Nov 20 22:14:02 volumio sudo[3667]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 06:51:56 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="b9009e0280f50389e80a537357ff3961"