-- Logs begin at Sun 2024-12-01 13:15:32 -03, end at Sun 2024-12-01 16:06:20 -03. -- Dec 01 16:05:08 volumio go-librespot[1011]: time="2024-12-01T16:05:08-03:00" level=debug msg="fetched chunk 12/13, size: 524288" uri="spotify:track:0QE84LDZvfTNSGxQcadbeV" Dec 01 16:05:21 volumio go-librespot[1011]: time="2024-12-01T16:05:21-03:00" level=debug msg="fetched chunk 13/13, size: 195320" uri="spotify:track:0QE84LDZvfTNSGxQcadbeV" Dec 01 16:05:29 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 01 16:05:29 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 01 16:05:29 volumio volumio[741]: info: Discovery: Getting this device information Dec 01 16:05:29 volumio volumio[741]: info: CoreCommandRouter::volumioGetState Dec 01 16:05:29 volumio volumio[741]: info: CorePlayQueue::getTrack 2 Dec 01 16:05:29 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 01 16:05:59 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 01 16:05:59 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 01 16:05:59 volumio volumio[741]: info: Discovery: Getting this device information Dec 01 16:05:59 volumio volumio[741]: info: CoreCommandRouter::volumioGetState Dec 01 16:05:59 volumio volumio[741]: info: CorePlayQueue::getTrack 2 Dec 01 16:05:59 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 01 16:06:03 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 01 16:06:03 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 01 16:06:03 volumio volumio[741]: info: Discovery: Getting this device information Dec 01 16:06:03 volumio volumio[741]: info: CoreCommandRouter::volumioGetState Dec 01 16:06:03 volumio volumio[741]: info: CorePlayQueue::getTrack 2 Dec 01 16:06:03 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 01 16:06:04 volumio volumio[741]: info: CorePlayQueue::getTrack 2 Dec 01 16:06:04 volumio volumio[741]: info: CorePlayQueue::getTrack 16 Dec 01 16:06:04 volumio volumio[741]: info: Prefetching next song Dec 01 16:06:04 volumio volumio[741]: info: [1733079964061] ControllerSpotify::prefetch Dec 01 16:06:04 volumio volumio[741]: info: Sending Spotify command with payload to local API: /player/add_to_queue Dec 01 16:06:04 volumio go-librespot[1011]: time="2024-12-01T16:06:04-03:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Dec 01 16:06:04 volumio go-librespot[1011]: time="2024-12-01T16:06:04-03:00" level=debug msg="prefetching next track" uri="spotify:track:4cw5UEJFMcjqQjiorPEiJe" Dec 01 16:06:04 volumio go-librespot[1011]: time="2024-12-01T16:06:04-03:00" level=debug msg="selected format OGG_VORBIS_320 (9547e034be1c5905f73a96a7a2924475feec3cc4)" uri="spotify:track:4cw5UEJFMcjqQjiorPEiJe" Dec 01 16:06:04 volumio go-librespot[1011]: time="2024-12-01T16:06:04-03:00" level=debug msg="requested aes key for file 9547e034be1c5905f73a96a7a2924475feec3cc4, gid: 4cw5UEJFMcjqQjiorPEiJe" Dec 01 16:06:05 volumio go-librespot[1011]: time="2024-12-01T16:06:05-03:00" level=debug msg="fetched first chunk of 17, total size is 8416128 bytes" uri="spotify:track:4cw5UEJFMcjqQjiorPEiJe" Dec 01 16:06:05 volumio go-librespot[1011]: time="2024-12-01T16:06:05-03:00" level=trace msg="seek to 0ms (diff: 0ms, samples: 0, bytes: 0)" uri="spotify:track:4cw5UEJFMcjqQjiorPEiJe" Dec 01 16:06:05 volumio go-librespot[1011]: time="2024-12-01T16:06:05-03:00" level=info msg="prefetched track \"The Cello Song (Live)\" (duration: 203453ms)" uri="spotify:track:4cw5UEJFMcjqQjiorPEiJe" Dec 01 16:06:05 volumio go-librespot[1011]: time="2024-12-01T16:06:05-03:00" level=debug msg="fetched chunk 1/16, size: 524288" uri="spotify:track:4cw5UEJFMcjqQjiorPEiJe" Dec 01 16:06:05 volumio go-librespot[1011]: time="2024-12-01T16:06:05-03:00" level=debug msg="fetched chunk 3/16, size: 524288" uri="spotify:track:4cw5UEJFMcjqQjiorPEiJe" Dec 01 16:06:05 volumio go-librespot[1011]: time="2024-12-01T16:06:05-03:00" level=debug msg="fetched chunk 2/16, size: 524288" uri="spotify:track:4cw5UEJFMcjqQjiorPEiJe" Dec 01 16:06:05 volumio go-librespot[1011]: time="2024-12-01T16:06:05-03:00" level=trace msg="emitting websocket event: not_playing" Dec 01 16:06:05 volumio go-librespot[1011]: time="2024-12-01T16:06:05-03:00" level=debug msg="loading track (paused: false, position: 0ms)" uri="spotify:track:4cw5UEJFMcjqQjiorPEiJe" Dec 01 16:06:05 volumio volumio[741]: SPOTIFY: received: {"type":"not_playing","data":{"uri":"spotify:track:0QE84LDZvfTNSGxQcadbeV","play_origin":"go-librespot"}} Dec 01 16:06:05 volumio volumio[741]: error: Failed to decode event: not_playing Dec 01 16:06:05 volumio go-librespot[1011]: time="2024-12-01T16:06:05-03:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Dec 01 16:06:05 volumio go-librespot[1011]: time="2024-12-01T16:06:05-03:00" level=trace msg="emitting websocket event: will_play" Dec 01 16:06:05 volumio volumio[741]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:4cw5UEJFMcjqQjiorPEiJe","play_origin":"go-librespot"}} Dec 01 16:06:05 volumio go-librespot[1011]: time="2024-12-01T16:06:05-03:00" level=info msg="loaded track \"The Cello Song (Live)\" (paused: false, position: 0ms, duration: 203453ms, prefetched: true)" uri="spotify:track:4cw5UEJFMcjqQjiorPEiJe" Dec 01 16:06:05 volumio go-librespot[1011]: time="2024-12-01T16:06:05-03:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Dec 01 16:06:06 volumio go-librespot[1011]: time="2024-12-01T16:06:06-03:00" level=trace msg="scheduling prefetch in 173s" Dec 01 16:06:06 volumio go-librespot[1011]: time="2024-12-01T16:06:06-03:00" level=trace msg="emitting websocket event: metadata" Dec 01 16:06:06 volumio volumio[741]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:4cw5UEJFMcjqQjiorPEiJe","name":"The Cello Song (Live)","artist_names":["The Piano Guys"],"album_name":"Live!","album_cover_url":"https://i.scdn.co/image/ab67616d00001e02be343f1898c3aaa61103a353","position":0,"duration":203453,"release_date":"year:2015 month:11 day:13","track_number":13,"disc_number":1}} Dec 01 16:06:06 volumio go-librespot[1011]: time="2024-12-01T16:06:06-03:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Dec 01 16:06:06 volumio go-librespot[1011]: time="2024-12-01T16:06:06-03:00" level=trace msg="emitting websocket event: playing" Dec 01 16:06:06 volumio volumio[741]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:4cw5UEJFMcjqQjiorPEiJe","play_origin":"go-librespot"}} Dec 01 16:06:06 volumio volumio[741]: SPOTIFY: PUSH STATE SPOTIFY Dec 01 16:06:06 volumio volumio[741]: SPOTIFY: {"status":"play","service":"spop","title":"The Cello Song (Live)","artist":"The Piano Guys","album":"Live!","albumart":"https://i.scdn.co/image/ab67616d00001e02be343f1898c3aaa61103a353","uri":"spotify:track:4cw5UEJFMcjqQjiorPEiJe","trackType":"spotify","seek":0,"duration":203,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Dec 01 16:06:06 volumio volumio[741]: info: CoreCommandRouter::servicePushState Dec 01 16:06:06 volumio volumio[741]: info: CorePlayQueue::getTrack 2 Dec 01 16:06:06 volumio volumio[741]: verbose: STATE SERVICE {"status":"play","service":"spop","title":"The Cello Song (Live)","artist":"The Piano Guys","album":"Live!","albumart":"https://i.scdn.co/image/ab67616d00001e02be343f1898c3aaa61103a353","uri":"spotify:track:4cw5UEJFMcjqQjiorPEiJe","trackType":"spotify","seek":0,"duration":203,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Dec 01 16:06:06 volumio volumio[741]: verbose: CURRENT POSITION 2 Dec 01 16:06:06 volumio volumio[741]: info: CoreStateMachine::syncState stateService play Dec 01 16:06:06 volumio volumio[741]: info: CoreStateMachine::syncState currentStatus play Dec 01 16:06:06 volumio volumio[741]: info: Received an update from plugin. extracting info from payload Dec 01 16:06:06 volumio volumio[741]: info: CoreStateMachine::pushState Dec 01 16:06:06 volumio volumio[741]: info: CorePlayQueue::getTrack 2 Dec 01 16:06:06 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 16:06:06 volumio volumio[741]: info: CoreCommandRouter::volumioPushState Dec 01 16:06:06 volumio volumio[741]: info: CoreStateMachine::pushState Dec 01 16:06:06 volumio volumio[741]: info: CorePlayQueue::getTrack 2 Dec 01 16:06:06 volumio volumio[741]: info: CoreCommandRouter::volumioPushState Dec 01 16:06:06 volumio volumio[741]: SPOTIFY: PUSH STATE SPOTIFY Dec 01 16:06:06 volumio volumio[741]: SPOTIFY: {"status":"play","service":"spop","title":"The Cello Song (Live)","artist":"The Piano Guys","album":"Live!","albumart":"https://i.scdn.co/image/ab67616d00001e02be343f1898c3aaa61103a353","uri":"spotify:track:4cw5UEJFMcjqQjiorPEiJe","trackType":"spotify","seek":1000,"duration":203,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Dec 01 16:06:06 volumio volumio[741]: info: CoreCommandRouter::servicePushState Dec 01 16:06:06 volumio volumio[741]: info: CorePlayQueue::getTrack 2 Dec 01 16:06:06 volumio volumio[741]: verbose: STATE SERVICE {"status":"play","service":"spop","title":"The Cello Song (Live)","artist":"The Piano Guys","album":"Live!","albumart":"https://i.scdn.co/image/ab67616d00001e02be343f1898c3aaa61103a353","uri":"spotify:track:4cw5UEJFMcjqQjiorPEiJe","trackType":"spotify","seek":1000,"duration":203,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Dec 01 16:06:06 volumio volumio[741]: verbose: CURRENT POSITION 2 Dec 01 16:06:06 volumio volumio[741]: info: CoreStateMachine::syncState stateService play Dec 01 16:06:06 volumio volumio[741]: info: CoreStateMachine::syncState currentStatus play Dec 01 16:06:06 volumio volumio[741]: info: Received an update from plugin. extracting info from payload Dec 01 16:06:06 volumio volumio[741]: info: CoreStateMachine::pushState Dec 01 16:06:06 volumio volumio[741]: info: CorePlayQueue::getTrack 2 Dec 01 16:06:06 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 16:06:06 volumio volumio[741]: info: CoreCommandRouter::volumioPushState Dec 01 16:06:06 volumio volumio[741]: info: CoreStateMachine::pushState Dec 01 16:06:06 volumio volumio[741]: info: CorePlayQueue::getTrack 2 Dec 01 16:06:06 volumio volumio[741]: info: CoreCommandRouter::volumioPushState Dec 01 16:06:08 volumio volumio[741]: info: CoreStateMachine::startPlaybackTimer Dec 01 16:06:08 volumio volumio[741]: info: CorePlayQueue::getTrack 16 Dec 01 16:06:09 volumio volumio[741]: info: CoreStateMachine::pushState Dec 01 16:06:09 volumio volumio[741]: info: CorePlayQueue::getTrack 16 Dec 01 16:06:09 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 16:06:09 volumio volumio[741]: info: CoreCommandRouter::volumioPushState Dec 01 16:06:09 volumio sudo[25238]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 01 16:06:09 volumio sudo[25238]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 16:06:09 volumio sudo[25238]: pam_unix(sudo:session): session closed for user root Dec 01 16:06:09 volumio sudo[25240]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 01 16:06:09 volumio sudo[25240]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 16:06:09 volumio sudo[25240]: pam_unix(sudo:session): session closed for user root Dec 01 16:06:09 volumio volumio[741]: verbose: New Socket.io Connection to 192.168.70.241 from 192.168.70.217 UA: Mozilla/5.0 (Linux; Android 14; SM-A556E Build/UP1A.231005.007; 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: 6 Dec 01 16:06:10 volumio volumio[741]: info: CoreCommandRouter::volumioGetVisibleSources Dec 01 16:06:10 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 01 16:06:10 volumio volumio[741]: info: CoreCommandRouter::volumioGetState Dec 01 16:06:10 volumio volumio[741]: info: CorePlayQueue::getTrack 16 Dec 01 16:06:10 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 01 16:06:10 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 01 16:06:10 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 01 16:06:10 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 01 16:06:10 volumio sudo[25246]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 01 16:06:10 volumio sudo[25246]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 16:06:10 volumio sudo[25246]: pam_unix(sudo:session): session closed for user root Dec 01 16:06:10 volumio sudo[25248]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 01 16:06:10 volumio sudo[25248]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 16:06:10 volumio sudo[25248]: pam_unix(sudo:session): session closed for user root Dec 01 16:06:10 volumio volumio[741]: verbose: New Socket.io Connection to 192.168.70.241 from 192.168.70.217 UA: Mozilla/5.0 (Linux; Android 14; SM-A556E Build/UP1A.231005.007; 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: 7 Dec 01 16:06:10 volumio volumio[741]: info: CoreCommandRouter::volumioGetState Dec 01 16:06:10 volumio volumio[741]: info: CorePlayQueue::getTrack 16 Dec 01 16:06:10 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 01 16:06:10 volumio volumio[741]: info: Listing playlists Dec 01 16:06:10 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 01 16:06:10 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 01 16:06:10 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 01 16:06:10 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 01 16:06:12 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 01 16:06:12 volumio volumio[741]: info: Received Get System Info Dec 01 16:06:12 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 01 16:06:12 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 01 16:06:12 volumio volumio[741]: info: Discovery: Getting this device information Dec 01 16:06:12 volumio volumio[741]: info: CoreCommandRouter::volumioGetState Dec 01 16:06:12 volumio volumio[741]: info: CorePlayQueue::getTrack 16 Dec 01 16:06:12 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 01 16:06:12 volumio volumio[741]: info: CoreCommandRouter::volumioPause Dec 01 16:06:12 volumio volumio[741]: info: CoreStateMachine::pause Dec 01 16:06:12 volumio volumio[741]: info: CoreStateMachine::stPlaybackTimer Dec 01 16:06:12 volumio volumio[741]: info: CoreStateMachine::servicePause Dec 01 16:06:12 volumio volumio[741]: info: CorePlayQueue::getTrack 16 Dec 01 16:06:12 volumio volumio[741]: info: CoreCommandRouter::servicePause Dec 01 16:06:12 volumio volumio[741]: info: Spotify Received pause Dec 01 16:06:12 volumio volumio[741]: SPOTIFY: SPOTIFY PAUSE Dec 01 16:06:12 volumio volumio[741]: SPOTIFY: {"status":"play","position":16,"title":"The Cello Song (Live)","artist":"The Piano Guys","album":"Live!","albumart":"https://i.scdn.co/image/ab67616d0000b273be343f1898c3aaa61103a353","uri":"spotify:track:4cw5UEJFMcjqQjiorPEiJe","trackType":"spotify","codec":"ogg","seek":250,"duration":203,"samplerate":"320 kbps","bitdepth":"16 bit","random":true,"repeat":true,"repeatSingle":false,"consume":false,"volume":100,"dbVolume":null,"disableVolumeControl":true,"mute":false,"stream":"spotify","volatile":false,"service":"spop"} Dec 01 16:06:12 volumio volumio[741]: info: Sending Spotify command to local API: /player/pause Dec 01 16:06:12 volumio go-librespot[1011]: time="2024-12-01T16:06:12-03:00" level=debug msg="pause track at 7205ms" Dec 01 16:06:12 volumio go-librespot[1011]: time="2024-12-01T16:06:12-03:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Dec 01 16:06:13 volumio go-librespot[1011]: time="2024-12-01T16:06:13-03:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Dec 01 16:06:13 volumio go-librespot[1011]: time="2024-12-01T16:06:13-03:00" level=trace msg="emitting websocket event: paused" Dec 01 16:06:13 volumio volumio[741]: SPOTIFY: received: {"type":"paused","data":{"uri":"spotify:track:4cw5UEJFMcjqQjiorPEiJe","play_origin":"go-librespot"}} Dec 01 16:06:13 volumio volumio[741]: SPOTIFY: PUSH STATE SPOTIFY Dec 01 16:06:13 volumio volumio[741]: SPOTIFY: {"status":"pause","service":"spop","title":"The Cello Song (Live)","artist":"The Piano Guys","album":"Live!","albumart":"https://i.scdn.co/image/ab67616d00001e02be343f1898c3aaa61103a353","uri":"spotify:track:4cw5UEJFMcjqQjiorPEiJe","trackType":"spotify","seek":7000,"duration":203,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Dec 01 16:06:13 volumio volumio[741]: info: CoreCommandRouter::servicePushState Dec 01 16:06:13 volumio volumio[741]: info: CorePlayQueue::getTrack 16 Dec 01 16:06:13 volumio volumio[741]: verbose: STATE SERVICE {"status":"pause","service":"spop","title":"The Cello Song (Live)","artist":"The Piano Guys","album":"Live!","albumart":"https://i.scdn.co/image/ab67616d00001e02be343f1898c3aaa61103a353","uri":"spotify:track:4cw5UEJFMcjqQjiorPEiJe","trackType":"spotify","seek":7000,"duration":203,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Dec 01 16:06:13 volumio volumio[741]: verbose: CURRENT POSITION 16 Dec 01 16:06:13 volumio volumio[741]: info: CoreStateMachine::syncState stateService pause Dec 01 16:06:13 volumio volumio[741]: info: CoreStateMachine::syncState currentStatus pause Dec 01 16:06:13 volumio volumio[741]: info: CoreStateMachine::pushState Dec 01 16:06:13 volumio volumio[741]: info: CorePlayQueue::getTrack 16 Dec 01 16:06:13 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 16:06:13 volumio volumio[741]: info: CoreCommandRouter::volumioPushState Dec 01 16:06:13 volumio volumio[741]: info: CoreStateMachine::stPlaybackTimer Dec 01 16:06:13 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 01 16:06:13 volumio volumio[741]: info: Received Get System Info Dec 01 16:06:13 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 01 16:06:13 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 01 16:06:13 volumio volumio[741]: info: Discovery: Getting this device information Dec 01 16:06:13 volumio volumio[741]: info: CoreCommandRouter::volumioGetState Dec 01 16:06:13 volumio volumio[741]: info: CorePlayQueue::getTrack 16 Dec 01 16:06:13 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 01 16:06:18 volumio volumio[741]: info: ___________ PLUGINS: Run Shutdown Tasks ___________ Dec 01 16:06:18 volumio volumio[741]: info: PLUGIN onShutdown : networkfs Dec 01 16:06:18 volumio volumio[741]: info: PLUGIN onShutdown : audiophonicsonoff Dec 01 16:06:18 volumio volumio[741]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 01 16:06:18 volumio volumio[741]: TypeError: Cannot read property 'writeSync' of undefined Dec 01 16:06:18 volumio volumio[741]: at ControllerAudiophonicsOnOff.onVolumioShutdown (/data/plugins/system_controller/audiophonicsonoff/index.js:43:25) Dec 01 16:06:18 volumio volumio[741]: at PluginManager.onVolumioShutdownPlugin (/volumio/app/pluginmanager.js:638:30) Dec 01 16:06:18 volumio volumio[741]: at HashMap. (/volumio/app/pluginmanager.js:621:31) Dec 01 16:06:18 volumio volumio[741]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Dec 01 16:06:18 volumio volumio[741]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Dec 01 16:06:18 volumio volumio[741]: at PluginManager.onVolumioShutdown (/volumio/app/pluginmanager.js:619:20) Dec 01 16:06:18 volumio volumio[741]: at CoreCommandRouter.shutdown (/volumio/app/index.js:1333:24) Dec 01 16:06:18 volumio volumio[741]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:859:33) Dec 01 16:06:18 volumio volumio[741]: at Socket.emit (events.js:315:20) Dec 01 16:06:18 volumio volumio[741]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Dec 01 16:06:18 volumio volumio[741]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 01 16:06:20 volumio sudo[25280]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-12-01 16:05 Dec 01 16:06:20 volumio sudo[25280]: 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"