-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Sat 2025-07-19 16:15:26 CEST. --
Jul 19 16:14:05 volumio sshd[8201]: pam_unix(sshd:auth): authentication failure; logname= uid=0 euid=0 tty=ssh ruser= rhost=210.16.168.181 user=root
Jul 19 16:14:06 volumio go-librespot[1368]: time="2025-07-19T16:14:06+02:00" level=debug msg="update volume to 61602/65535"
Jul 19 16:14:06 volumio go-librespot[1368]: time="2025-07-19T16:14:06+02:00" level=debug msg="update volume to 38665/65535"
Jul 19 16:14:06 volumio go-librespot[1368]: time="2025-07-19T16:14:06+02:00" level=debug msg="update volume to 33422/65535"
Jul 19 16:14:07 volumio go-librespot[1368]: time="2025-07-19T16:14:07+02:00" level=debug msg="put connect state because VOLUME_CHANGED"
Jul 19 16:14:07 volumio go-librespot[1368]: time="2025-07-19T16:14:07+02:00" level=trace msg="emitting websocket event: volume"
Jul 19 16:14:07 volumio volumio[1056]: SPOTIFY: received: {"type":"volume","data":{"value":51,"max":100}}
Jul 19 16:14:07 volumio volumio[1056]: SPOTIFY: RECEIVED SPOTIFY VOLUME 51
Jul 19 16:14:07 volumio volumio[1056]: info: Setting Volumio Volume from Spotify: 51
Jul 19 16:14:07 volumio volumio[1056]: info: VolumeController::SetAlsaVolume51
Jul 19 16:14:07 volumio volumio[1056]: info: CoreStateMachine::pushState
Jul 19 16:14:07 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 19 16:14:07 volumio volumio[1056]: info: CoreCommandRouter::volumioPushState
Jul 19 16:14:07 volumio volumio[1056]: info: [GPIO_Control] Status changed: play
Jul 19 16:14:07 volumio volumio[1056]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jul 19 16:14:07 volumio sshd[8201]: Failed password for root from 210.16.168.181 port 56336 ssh2
Jul 19 16:14:08 volumio sshd[8201]: Connection closed by authenticating user root 210.16.168.181 port 56336 [preauth]
Jul 19 16:14:09 volumio go-librespot[1368]: time="2025-07-19T16:14:09+02:00" level=trace msg="sent dealer ping"
Jul 19 16:14:09 volumio go-librespot[1368]: time="2025-07-19T16:14:09+02:00" level=trace msg="received dealer pong"
Jul 19 16:14:10 volumio go-librespot[1368]: time="2025-07-19T16:14:10+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update
Jul 19 16:14:10 volumio go-librespot[1368]: time="2025-07-19T16:14:10+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 2026"
Jul 19 16:14:10 volumio go-librespot[1368]: time="2025-07-19T16:14:10+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update
Jul 19 16:14:10 volumio go-librespot[1368]: time="2025-07-19T16:14:10+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 2008"
Jul 19 16:14:10 volumio go-librespot[1368]: time="2025-07-19T16:14:10+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update
Jul 19 16:14:10 volumio go-librespot[1368]: time="2025-07-19T16:14:10+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1448"
Jul 19 16:14:13 volumio sshd[8272]: Invalid user hadoop from 210.16.168.181 port 58038
Jul 19 16:14:13 volumio sshd[8272]: pam_unix(sshd:auth): check pass; user unknown
Jul 19 16:14:13 volumio sshd[8272]: pam_unix(sshd:auth): authentication failure; logname= uid=0 euid=0 tty=ssh ruser= rhost=210.16.168.181
Jul 19 16:14:15 volumio sshd[8272]: Failed password for invalid user hadoop from 210.16.168.181 port 58038 ssh2
Jul 19 16:14:17 volumio sshd[8272]: Connection closed by invalid user hadoop 210.16.168.181 port 58038 [preauth]
Jul 19 16:14:19 volumio go-librespot[1368]: time="2025-07-19T16:14:19+02:00" level=debug msg="handling play player command from d8b3c2ed10e59dbc4287b0a5641dd3bfde94b65b"
Jul 19 16:14:19 volumio go-librespot[1368]: time="2025-07-19T16:14:19+02:00" level=debug msg="resolved context of track" uri="spotify:playlist:5M8QIvH7m3VY4YeqHil2YB"
Jul 19 16:14:19 volumio go-librespot[1368]: time="2025-07-19T16:14:19+02:00" level=trace msg="fetched new page 0 with 436 items (list: 436)" uri="spotify:playlist:5M8QIvH7m3VY4YeqHil2YB"
Jul 19 16:14:19 volumio go-librespot[1368]: time="2025-07-19T16:14:19+02:00" level=debug msg="shuffled context with seed 8306071030375241092 (len: 436, keep: -1)" uri="spotify:playlist:5M8QIvH7m3VY4YeqHil2YB"
Jul 19 16:14:19 volumio go-librespot[1368]: time="2025-07-19T16:14:19+02:00" level=debug msg="loading track (paused: false, position: 1ms)" uri="spotify:track:7pcANiSH8mEKLUIPAxiSDr"
Jul 19 16:14:20 volumio go-librespot[1368]: time="2025-07-19T16:14:20+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
Jul 19 16:14:20 volumio go-librespot[1368]: time="2025-07-19T16:14:20+02:00" level=trace msg="emitting websocket event: will_play"
Jul 19 16:14:20 volumio volumio[1056]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:7pcANiSH8mEKLUIPAxiSDr","play_origin":"playlist/ondemand"}}
Jul 19 16:14:20 volumio go-librespot[1368]: time="2025-07-19T16:14:20+02:00" level=debug msg="selected format OGG_VORBIS_320 (ac55463289c396629058e42013241e8b83a5a7ae)" uri="spotify:track:7pcANiSH8mEKLUIPAxiSDr"
Jul 19 16:14:20 volumio go-librespot[1368]: time="2025-07-19T16:14:20+02:00" level=debug msg="requested aes key for file ac55463289c396629058e42013241e8b83a5a7ae, gid: 7pcANiSH8mEKLUIPAxiSDr"
Jul 19 16:14:20 volumio go-librespot[1368]: time="2025-07-19T16:14:20+02:00" level=debug msg="fetched first chunk of 16, total size is 8118400 bytes" uri="spotify:track:7pcANiSH8mEKLUIPAxiSDr"
Jul 19 16:14:20 volumio go-librespot[1368]: time="2025-07-19T16:14:20+02:00" level=trace msg="seek to 1ms (diff: 1ms, samples: 44, bytes: 0)" uri="spotify:track:7pcANiSH8mEKLUIPAxiSDr"
Jul 19 16:14:20 volumio go-librespot[1368]: time="2025-07-19T16:14:20+02:00" level=info msg="loaded track \"CAN YOU HEAR THE MOON\" (paused: false, position: 1ms, duration: 182534ms, prefetched: false)" uri="spotify:track:7pcANiSH8mEKLUIPAxiSDr"
Jul 19 16:14:20 volumio go-librespot[1368]: time="2025-07-19T16:14:20+02:00" level=debug msg="fetched chunk 1/15, size: 524288" uri="spotify:track:7pcANiSH8mEKLUIPAxiSDr"
Jul 19 16:14:20 volumio go-librespot[1368]: time="2025-07-19T16:14:20+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
Jul 19 16:14:20 volumio go-librespot[1368]: time="2025-07-19T16:14:20+02:00" level=trace msg="scheduling prefetch in 152s"
Jul 19 16:14:20 volumio go-librespot[1368]: time="2025-07-19T16:14:20+02:00" level=trace msg="emitting websocket event: metadata"
Jul 19 16:14:20 volumio go-librespot[1368]: time="2025-07-19T16:14:20+02:00" level=debug msg="sending successful reply for dealer request"
Jul 19 16:14:20 volumio volumio[1056]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:7pcANiSH8mEKLUIPAxiSDr","name":"CAN YOU HEAR THE MOON","artist_names":["Grady"],"album_name":"The in Between","album_cover_url":"https://i.scdn.co/image/ab67616d00001e02d1d516b06b99d10643e6ff98","position":1,"duration":182534,"release_date":"year:2019 month:10 day:25","track_number":1,"disc_number":1}}
Jul 19 16:14:20 volumio go-librespot[1368]: time="2025-07-19T16:14:20+02:00" level=debug msg="fetched chunk 2/15, size: 524288" uri="spotify:track:7pcANiSH8mEKLUIPAxiSDr"
Jul 19 16:14:20 volumio go-librespot[1368]: time="2025-07-19T16:14:20+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
Jul 19 16:14:20 volumio go-librespot[1368]: time="2025-07-19T16:14:20+02:00" level=trace msg="emitting websocket event: playing"
Jul 19 16:14:20 volumio volumio[1056]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:7pcANiSH8mEKLUIPAxiSDr","play_origin":"playlist/ondemand"}}
Jul 19 16:14:20 volumio volumio[1056]: SPOTIFY: PUSH STATE SPOTIFY
Jul 19 16:14:20 volumio volumio[1056]: SPOTIFY: {"status":"play","service":"spop","title":"CAN YOU HEAR THE MOON","artist":"Grady","album":"The in Between","albumart":"https://i.scdn.co/image/ab67616d00001e02d1d516b06b99d10643e6ff98","uri":"spotify:track:7pcANiSH8mEKLUIPAxiSDr","trackType":"spotify","seek":1,"duration":182,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"}
Jul 19 16:14:20 volumio volumio[1056]: info: CoreCommandRouter::servicePushState
Jul 19 16:14:20 volumio volumio[1056]: info: CoreStateMachine::pushState
Jul 19 16:14:20 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 19 16:14:20 volumio volumio[1056]: info: CoreCommandRouter::volumioPushState
Jul 19 16:14:20 volumio volumio[1056]: info: [GPIO_Control] Status changed: play
Jul 19 16:14:20 volumio volumio[1056]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jul 19 16:14:20 volumio go-librespot[1368]: time="2025-07-19T16:14:20+02:00" level=debug msg="fetched chunk 3/15, size: 524288" uri="spotify:track:7pcANiSH8mEKLUIPAxiSDr"
Jul 19 16:14:20 volumio volumio[1056]: SPOTIFY: PUSH STATE SPOTIFY
Jul 19 16:14:20 volumio volumio[1056]: SPOTIFY: {"status":"play","service":"spop","title":"CAN YOU HEAR THE MOON","artist":"Grady","album":"The in Between","albumart":"https://i.scdn.co/image/ab67616d00001e02d1d516b06b99d10643e6ff98","uri":"spotify:track:7pcANiSH8mEKLUIPAxiSDr","trackType":"spotify","seek":1,"duration":182,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"}
Jul 19 16:14:20 volumio volumio[1056]: info: CoreCommandRouter::servicePushState
Jul 19 16:14:20 volumio volumio[1056]: info: CoreStateMachine::pushState
Jul 19 16:14:20 volumio volumio[1056]: info: CoreCommandRouter::volumioPushState
Jul 19 16:14:20 volumio volumio[1056]: info: [GPIO_Control] Status changed: play
Jul 19 16:14:20 volumio volumio[1056]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jul 19 16:14:25 volumio sshd[8289]: Invalid user tools from 210.16.168.181 port 59748
Jul 19 16:14:26 volumio sshd[8289]: pam_unix(sshd:auth): check pass; user unknown
Jul 19 16:14:26 volumio sshd[8289]: pam_unix(sshd:auth): authentication failure; logname= uid=0 euid=0 tty=ssh ruser= rhost=210.16.168.181
Jul 19 16:14:27 volumio sshd[8289]: Failed password for invalid user tools from 210.16.168.181 port 59748 ssh2
Jul 19 16:14:30 volumio sshd[8289]: Connection closed by invalid user tools 210.16.168.181 port 59748 [preauth]
Jul 19 16:14:32 volumio go-librespot[1368]: time="2025-07-19T16:14:32+02:00" level=debug msg="fetched chunk 4/15, size: 524288" uri="spotify:track:7pcANiSH8mEKLUIPAxiSDr"
Jul 19 16:14:33 volumio sshd[8308]: Invalid user admin from 210.16.168.181 port 33222
Jul 19 16:14:35 volumio sshd[8308]: pam_unix(sshd:auth): check pass; user unknown
Jul 19 16:14:35 volumio sshd[8308]: pam_unix(sshd:auth): authentication failure; logname= uid=0 euid=0 tty=ssh ruser= rhost=210.16.168.181
Jul 19 16:14:37 volumio sshd[8308]: Failed password for invalid user admin from 210.16.168.181 port 33222 ssh2
Jul 19 16:14:38 volumio go-librespot[1368]: time="2025-07-19T16:14:38+02:00" level=trace msg="received accesspoint ping"
Jul 19 16:14:38 volumio go-librespot[1368]: time="2025-07-19T16:14:38+02:00" level=trace msg="received accesspoint pong ack"
Jul 19 16:14:39 volumio go-librespot[1368]: time="2025-07-19T16:14:39+02:00" level=trace msg="sent dealer ping"
Jul 19 16:14:39 volumio go-librespot[1368]: time="2025-07-19T16:14:39+02:00" level=trace msg="received dealer pong"
Jul 19 16:14:39 volumio sshd[8308]: Connection closed by invalid user admin 210.16.168.181 port 33222 [preauth]
Jul 19 16:14:40 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jul 19 16:14:40 volumio volumio[1056]: info: CURURI: artists://
Jul 19 16:14:40 volumio volumio[1056]: info: Preload queue cleared
Jul 19 16:14:41 volumio sshd[8325]: Invalid user www from 210.16.168.181 port 34928
Jul 19 16:14:42 volumio sshd[8325]: pam_unix(sshd:auth): check pass; user unknown
Jul 19 16:14:42 volumio sshd[8325]: pam_unix(sshd:auth): authentication failure; logname= uid=0 euid=0 tty=ssh ruser= rhost=210.16.168.181
Jul 19 16:14:43 volumio go-librespot[1368]: time="2025-07-19T16:14:43+02:00" level=debug msg="fetched chunk 5/15, size: 524288" uri="spotify:track:7pcANiSH8mEKLUIPAxiSDr"
Jul 19 16:14:43 volumio sshd[8325]: Failed password for invalid user www from 210.16.168.181 port 34928 ssh2
Jul 19 16:14:43 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jul 19 16:14:43 volumio volumio[1056]: info: CURURI: genres://
Jul 19 16:14:43 volumio volumio[1056]: info: Preload queue cleared
Jul 19 16:14:44 volumio sshd[8325]: Connection closed by invalid user www 210.16.168.181 port 34928 [preauth]
Jul 19 16:14:46 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Jul 19 16:14:46 volumio volumio[1056]: info: Preload queue cleared
Jul 19 16:14:50 volumio sshd[8344]: pam_unix(sshd:auth): authentication failure; logname= uid=0 euid=0 tty=ssh ruser= rhost=210.16.168.181 user=root
Jul 19 16:14:51 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Jul 19 16:14:51 volumio volumio[1056]: info: Preload queue cleared
Jul 19 16:14:52 volumio sshd[8344]: Failed password for root from 210.16.168.181 port 36632 ssh2
Jul 19 16:14:53 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Jul 19 16:14:54 volumio sshd[8344]: Connection closed by authenticating user root 210.16.168.181 port 36632 [preauth]
Jul 19 16:14:54 volumio go-librespot[1368]: time="2025-07-19T16:14:54+02:00" level=debug msg="fetched chunk 6/15, size: 524288" uri="spotify:track:7pcANiSH8mEKLUIPAxiSDr"
Jul 19 16:14:56 volumio volumio[1056]: info: Preload queue cleared
Jul 19 16:14:59 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Jul 19 16:14:59 volumio volumio[1056]: info: Preload queue cleared
Jul 19 16:15:04 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Jul 19 16:15:04 volumio volumio[1056]: info: Preload queue cleared
Jul 19 16:15:04 volumio volumio[1056]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/none.svg'
Jul 19 16:15:05 volumio sshd[8361]: pam_unix(sshd:auth): authentication failure; logname= uid=0 euid=0 tty=ssh ruser= rhost=210.16.168.181 user=root
Jul 19 16:15:05 volumio go-librespot[1368]: time="2025-07-19T16:15:05+02:00" level=debug msg="fetched chunk 7/15, size: 524288" uri="spotify:track:7pcANiSH8mEKLUIPAxiSDr"
Jul 19 16:15:07 volumio sshd[8361]: Failed password for root from 210.16.168.181 port 38338 ssh2
Jul 19 16:15:07 volumio volumio[1056]: info: Preload queue cleared
Jul 19 16:15:07 volumio volumio[1056]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jul 19 16:15:07 volumio volumio[1056]: info: CoreStateMachine::ClearQueue
Jul 19 16:15:07 volumio volumio[1056]: info: CoreStateMachine::stop
Jul 19 16:15:07 volumio volumio[1056]: info: CoreStateMachine::serviceStop
Jul 19 16:15:07 volumio volumio[1056]: info: CoreCommandRouter::serviceStop
Jul 19 16:15:07 volumio volumio[1056]: info: Spotify Stop
Jul 19 16:15:07 volumio volumio[1056]: SPOTIFY: SPOTIFY STOP
Jul 19 16:15:07 volumio volumio[1056]: SPOTIFY: {"status":"play","title":"CAN YOU HEAR THE MOON","artist":"Grady","album":"The in Between","albumart":"https://i.scdn.co/image/ab67616d00001e02d1d516b06b99d10643e6ff98","uri":"spotify:track:7pcANiSH8mEKLUIPAxiSDr","trackType":"spotify","codec":"ogg","seek":1,"duration":182,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"random":null,"repeat":null,"repeatSingle":null,"consume":false,"volume":51,"dbVolume":null,"mute":false,"disableVolumeControl":false,"stream":false,"updatedb":false,"volatile":true,"service":"spop"}
Jul 19 16:15:07 volumio volumio[1056]: info: Sending Spotify command to local API: /player/pause
Jul 19 16:15:07 volumio volumio[1056]: info: CorePlayQueue::clearPlayQueue
Jul 19 16:15:07 volumio volumio[1056]: info: CorePlayQueue::saveQueue
Jul 19 16:15:07 volumio volumio[1056]: info: CoreCommandRouter::volumioPushQueue
Jul 19 16:15:07 volumio volumio[1056]: info: CoreStateMachine::addQueueItems
Jul 19 16:15:07 volumio volumio[1056]: info: CorePlayQueue::addQueueItems
Jul 19 16:15:07 volumio volumio[1056]: info: Preload queue cleared
Jul 19 16:15:07 volumio volumio[1056]: info: Adding Item to queue: upnp/folder/http://192.168.178.1:49000/MediaServer/ContentDirectory/Control@4:cont2:553:Pop0:0:
Jul 19 16:15:07 volumio volumio[1056]: info: Exploding uri upnp/folder/http://192.168.178.1:49000/MediaServer/ContentDirectory/Control@4:cont2:553:Pop0:0: in service upnp_browser
Jul 19 16:15:07 volumio go-librespot[1368]: time="2025-07-19T16:15:07+02:00" level=debug msg="pause track at 47177ms"
Jul 19 16:15:07 volumio volumio[1056]: info: CoreCommandRouter::volumioPushQueue
Jul 19 16:15:07 volumio volumio[1056]: info: CorePlayQueue::saveQueue
Jul 19 16:15:07 volumio volumio[1056]: info: CoreStateMachine::updateTrackBlock
Jul 19 16:15:07 volumio volumio[1056]: info: CorePlayQueue::getTrackBlock
Jul 19 16:15:07 volumio volumio[1056]: info: CoreCommandRouter::volumioPlay
Jul 19 16:15:07 volumio volumio[1056]: info: CoreStateMachine::play index 0
Jul 19 16:15:07 volumio volumio[1056]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 19 16:15:07 volumio volumio[1056]: info: CoreStateMachine::stop
Jul 19 16:15:07 volumio volumio[1056]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 19 16:15:07 volumio volumio[1056]: info: CoreStateMachine::stPlaybackTimer
Jul 19 16:15:07 volumio volumio[1056]: info: CoreStateMachine::updateTrackBlock
Jul 19 16:15:07 volumio volumio[1056]: info: CorePlayQueue::getTrackBlock
Jul 19 16:15:07 volumio volumio[1056]: info: CoreStateMachine::pushState
Jul 19 16:15:07 volumio volumio[1056]: info: CorePlayQueue::getTrack 0
Jul 19 16:15:07 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 19 16:15:07 volumio volumio[1056]: info: CoreCommandRouter::volumioPushState
Jul 19 16:15:07 volumio volumio[1056]: info: CoreStateMachine::serviceStop
Jul 19 16:15:07 volumio volumio[1056]: info: CorePlayQueue::getTrack 0
Jul 19 16:15:07 volumio volumio[1056]: info: ControllerMpd::stop
Jul 19 16:15:07 volumio volumio[1056]: verbose: ControllerMpd::sendMpdCommand stop
Jul 19 16:15:07 volumio volumio[1056]: info: [GPIO_Control] Status changed: stop
Jul 19 16:15:07 volumio volumio[1056]: info: [GPIO_Control] Handling event: musicStop
Jul 19 16:15:07 volumio volumio[1056]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jul 19 16:15:07 volumio volumio[1056]: info: sendMpdCommand stop took 9 milliseconds
Jul 19 16:15:07 volumio volumio[1056]: info: CoreStateMachine::play index undefined
Jul 19 16:15:07 volumio volumio[1056]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 19 16:15:07 volumio volumio[1056]: info: CorePlayQueue::getTrack 0
Jul 19 16:15:07 volumio go-librespot[1368]: time="2025-07-19T16:15:07+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
Jul 19 16:15:07 volumio go-librespot[1368]: time="2025-07-19T16:15:07+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
Jul 19 16:15:07 volumio go-librespot[1368]: time="2025-07-19T16:15:07+02:00" level=trace msg="emitting websocket event: paused"
Jul 19 16:15:07 volumio volumio[1056]: SPOTIFY: received: {"type":"paused","data":{"uri":"spotify:track:7pcANiSH8mEKLUIPAxiSDr","play_origin":"playlist/ondemand"}}
Jul 19 16:15:07 volumio volumio[1056]: info: Spotify is playing in volatile mode
Jul 19 16:15:07 volumio volumio[1056]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 19 16:15:07 volumio volumio[1056]: SPOTIFY: UNSET VOLATILE
Jul 19 16:15:07 volumio volumio[1056]: SPOTIFY: {"status":"stop","position":0,"title":"","artist":"","album":"","albumart":"/albumart","duration":0,"uri":"","seek":0,"samplerate":"","channels":"","bitdepth":"","Streaming":false,"service":"mpd","volume":51,"dbVolume":null,"mute":false,"disableVolumeControl":false,"random":null,"repeat":null,"repeatSingle":false,"updatedb":false,"consume":false}
Jul 19 16:15:07 volumio volumio[1056]: SPOTIFY: PUSH STATE SPOTIFY
Jul 19 16:15:07 volumio volumio[1056]: SPOTIFY: {"status":"pause","service":"spop","title":"CAN YOU HEAR THE MOON","artist":"Grady","album":"The in Between","albumart":"https://i.scdn.co/image/ab67616d00001e02d1d516b06b99d10643e6ff98","uri":"spotify:track:7pcANiSH8mEKLUIPAxiSDr","trackType":"spotify","seek":47001,"duration":182,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"}
Jul 19 16:15:07 volumio volumio[1056]: info: CoreCommandRouter::servicePushState
Jul 19 16:15:07 volumio volumio[1056]: info: CoreStateMachine::pushState
Jul 19 16:15:07 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 19 16:15:07 volumio volumio[1056]: info: CoreCommandRouter::volumioPushState
Jul 19 16:15:07 volumio volumio[1056]: info: [GPIO_Control] Status changed: pause
Jul 19 16:15:07 volumio volumio[1056]: info: [GPIO_Control] Handling event: musicPause
Jul 19 16:15:07 volumio volumio[1056]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jul 19 16:15:08 volumio sshd[8361]: Connection closed by authenticating user root 210.16.168.181 port 38338 [preauth]
Jul 19 16:15:09 volumio go-librespot[1368]: time="2025-07-19T16:15:09+02:00" level=trace msg="sent dealer ping"
Jul 19 16:15:09 volumio go-librespot[1368]: time="2025-07-19T16:15:09+02:00" level=trace msg="received dealer pong"
Jul 19 16:15:12 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Jul 19 16:15:12 volumio volumio[1056]: info: Preload queue cleared
Jul 19 16:15:13 volumio sshd[8430]: Invalid user es from 210.16.168.181 port 40034
Jul 19 16:15:13 volumio volumio[1056]: info: Preload queue cleared
Jul 19 16:15:13 volumio volumio[1056]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jul 19 16:15:13 volumio volumio[1056]: info: CoreStateMachine::ClearQueue
Jul 19 16:15:13 volumio volumio[1056]: info: CoreStateMachine::stop
Jul 19 16:15:13 volumio volumio[1056]: info: CoreStateMachine::serviceStop
Jul 19 16:15:13 volumio volumio[1056]: info: CoreCommandRouter::serviceStop
Jul 19 16:15:13 volumio volumio[1056]: info: Spotify Stop
Jul 19 16:15:13 volumio volumio[1056]: SPOTIFY: SPOTIFY STOP
Jul 19 16:15:13 volumio volumio[1056]: SPOTIFY: {"status":"pause","title":"CAN YOU HEAR THE MOON","artist":"Grady","album":"The in Between","albumart":"https://i.scdn.co/image/ab67616d00001e02d1d516b06b99d10643e6ff98","uri":"spotify:track:7pcANiSH8mEKLUIPAxiSDr","trackType":"spotify","codec":"ogg","seek":47001,"duration":182,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"random":null,"repeat":null,"repeatSingle":null,"consume":false,"volume":51,"dbVolume":null,"mute":false,"disableVolumeControl":false,"stream":false,"updatedb":false,"volatile":true,"service":"spop"}
Jul 19 16:15:13 volumio volumio[1056]: info: Sending Spotify command to local API: /player/pause
Jul 19 16:15:13 volumio volumio[1056]: info: CorePlayQueue::clearPlayQueue
Jul 19 16:15:13 volumio volumio[1056]: info: CorePlayQueue::saveQueue
Jul 19 16:15:13 volumio volumio[1056]: info: CoreCommandRouter::volumioPushQueue
Jul 19 16:15:13 volumio volumio[1056]: info: CoreStateMachine::addQueueItems
Jul 19 16:15:13 volumio volumio[1056]: info: CorePlayQueue::addQueueItems
Jul 19 16:15:13 volumio volumio[1056]: info: Preload queue cleared
Jul 19 16:15:13 volumio volumio[1056]: info: Adding Item to queue: upnp/folder/http://192.168.178.1:49000/MediaServer/ContentDirectory/Control@4:cont2:516:FRITZ!0:0:
Jul 19 16:15:13 volumio volumio[1056]: info: Exploding uri upnp/folder/http://192.168.178.1:49000/MediaServer/ContentDirectory/Control@4:cont2:516:FRITZ!0:0: in service upnp_browser
Jul 19 16:15:13 volumio go-librespot[1368]: time="2025-07-19T16:15:13+02:00" level=debug msg="pause track at 47547ms"
Jul 19 16:15:13 volumio volumio[1056]: info: CoreCommandRouter::volumioPushQueue
Jul 19 16:15:13 volumio volumio[1056]: info: CorePlayQueue::saveQueue
Jul 19 16:15:13 volumio volumio[1056]: info: CoreStateMachine::updateTrackBlock
Jul 19 16:15:13 volumio volumio[1056]: info: CorePlayQueue::getTrackBlock
Jul 19 16:15:13 volumio volumio[1056]: info: CoreCommandRouter::volumioPlay
Jul 19 16:15:13 volumio volumio[1056]: info: CoreStateMachine::play index 0
Jul 19 16:15:13 volumio volumio[1056]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 19 16:15:13 volumio volumio[1056]: info: CoreStateMachine::stop
Jul 19 16:15:13 volumio volumio[1056]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 19 16:15:13 volumio volumio[1056]: info: CoreStateMachine::updateTrackBlock
Jul 19 16:15:13 volumio volumio[1056]: info: CorePlayQueue::getTrackBlock
Jul 19 16:15:13 volumio volumio[1056]: info: CoreStateMachine::stPlaybackTimer
Jul 19 16:15:13 volumio volumio[1056]: info: CoreStateMachine::pushState
Jul 19 16:15:13 volumio volumio[1056]: info: CorePlayQueue::getTrack 0
Jul 19 16:15:13 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 19 16:15:13 volumio volumio[1056]: info: CoreCommandRouter::volumioPushState
Jul 19 16:15:13 volumio volumio[1056]: info: CoreStateMachine::serviceStop
Jul 19 16:15:13 volumio volumio[1056]: info: CorePlayQueue::getTrack 0
Jul 19 16:15:13 volumio volumio[1056]: info: CoreCommandRouter::serviceStop
Jul 19 16:15:13 volumio volumio[1056]: info: [1752934513668] ControllerUPNPBrowser::stop
Jul 19 16:15:13 volumio volumio[1056]: verbose: ControllerMpd::sendMpdCommand stop
Jul 19 16:15:13 volumio volumio[1056]: info: [GPIO_Control] Status changed: stop
Jul 19 16:15:13 volumio volumio[1056]: info: [GPIO_Control] Handling event: musicStop
Jul 19 16:15:13 volumio volumio[1056]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jul 19 16:15:13 volumio volumio[1056]: info: sendMpdCommand stop took 12 milliseconds
Jul 19 16:15:13 volumio volumio[1056]: info: CoreStateMachine::play index undefined
Jul 19 16:15:13 volumio volumio[1056]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 19 16:15:13 volumio volumio[1056]: info: CorePlayQueue::getTrack 0
Jul 19 16:15:13 volumio volumio[1056]: info: CoreStateMachine::startPlaybackTimer
Jul 19 16:15:13 volumio volumio[1056]: info: CorePlayQueue::getTrack 0
Jul 19 16:15:13 volumio go-librespot[1368]: time="2025-07-19T16:15:13+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
Jul 19 16:15:13 volumio volumio[1056]: info: [1752934513683] ControllerUPNPBrowser::clearAddPlayTrack
Jul 19 16:15:13 volumio volumio[1056]: verbose: ControllerMpd::sendMpdCommand stop
Jul 19 16:15:13 volumio volumio[1056]: info: sendMpdCommand stop took 1 milliseconds
Jul 19 16:15:13 volumio volumio[1056]: verbose: ControllerMpd::sendMpdCommand clear
Jul 19 16:15:13 volumio volumio[1056]: info:
Jul 19 16:15:13 volumio volumio[1056]: ---------------------------- MPD announces system playlist update
Jul 19 16:15:13 volumio volumio[1056]: info: Ignoring MPD Status Update
Jul 19 16:15:13 volumio volumio[1056]: info: sendMpdCommand clear took 3 milliseconds
Jul 19 16:15:13 volumio volumio[1056]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.178.1:49200/AUDIO/DLNA-1-0/Musik/FRITZ-Song.mp3"
Jul 19 16:15:13 volumio volumio[1056]: info:
Jul 19 16:15:13 volumio volumio[1056]: ---------------------------- MPD announces system playlist update
Jul 19 16:15:13 volumio volumio[1056]: info: Ignoring MPD Status Update
Jul 19 16:15:13 volumio volumio[1056]: info:
Jul 19 16:15:13 volumio volumio[1056]: ---------------------------- MPD announces system playlist update
Jul 19 16:15:13 volumio volumio[1056]: info: Ignoring MPD Status Update
Jul 19 16:15:13 volumio volumio[1056]: error: updateQueue error: null
Jul 19 16:15:13 volumio volumio[1056]: info: ------------------------------ 7ms
Jul 19 16:15:13 volumio volumio[1056]: error: Upnp client error: Error: This socket has been ended by the other party
Jul 19 16:15:13 volumio go-librespot[1368]: time="2025-07-19T16:15:13+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
Jul 19 16:15:13 volumio go-librespot[1368]: time="2025-07-19T16:15:13+02:00" level=trace msg="emitting websocket event: paused"
Jul 19 16:15:13 volumio volumio[1056]: SPOTIFY: received: {"type":"paused","data":{"uri":"spotify:track:7pcANiSH8mEKLUIPAxiSDr","play_origin":"playlist/ondemand"}}
Jul 19 16:15:13 volumio volumio[1056]: info: Spotify is playing in volatile mode
Jul 19 16:15:13 volumio volumio[1056]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 19 16:15:13 volumio volumio[1056]: SPOTIFY: UNSET VOLATILE
Jul 19 16:15:13 volumio volumio[1056]: SPOTIFY: {"status":"stop","position":0,"title":"Fly FRITZ! Fly","artist":"AVM GmbH","album":"FRITZ!","albumart":"/albumart?cacheid=121&web=AVM%20GmbH/FRITZ!/extralarge&path=&metadata=false","uri":"http://192.168.178.1:49200/AUDIO/DLNA-1-0/Musik/FRITZ-Song.mp3","seek":0,"duration":0,"random":null,"repeat":null,"repeatSingle":false,"consume":false,"volume":51,"dbVolume":null,"disableVolumeControl":false,"mute":false,"updatedb":false,"volatile":false,"service":"upnp_browser"}
Jul 19 16:15:13 volumio volumio[1056]: SPOTIFY: PUSH STATE SPOTIFY
Jul 19 16:15:13 volumio volumio[1056]: SPOTIFY: {"status":"pause","service":"spop","title":"CAN YOU HEAR THE MOON","artist":"Grady","album":"The in Between","albumart":"https://i.scdn.co/image/ab67616d00001e02d1d516b06b99d10643e6ff98","uri":"spotify:track:7pcANiSH8mEKLUIPAxiSDr","trackType":"spotify","seek":47001,"duration":182,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"}
Jul 19 16:15:13 volumio volumio[1056]: info: CoreCommandRouter::servicePushState
Jul 19 16:15:13 volumio volumio[1056]: info: CoreStateMachine::pushState
Jul 19 16:15:13 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 19 16:15:13 volumio volumio[1056]: info: CoreCommandRouter::volumioPushState
Jul 19 16:15:13 volumio volumio[1056]: info: [GPIO_Control] Status changed: pause
Jul 19 16:15:13 volumio volumio[1056]: info: [GPIO_Control] Handling event: musicPause
Jul 19 16:15:13 volumio volumio[1056]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jul 19 16:15:13 volumio volumio[1056]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.178.1:49200/AUDIO/DLNA-1-0/Musik/FRITZ-Song.mp3"
Jul 19 16:15:13 volumio volumio[1056]: error: updateQueue error: null
Jul 19 16:15:13 volumio volumio[1056]: error: updateQueue error: null
Jul 19 16:15:13 volumio volumio[1056]: info:
Jul 19 16:15:13 volumio volumio[1056]: ---------------------------- MPD announces system playlist update
Jul 19 16:15:13 volumio volumio[1056]: info: Ignoring MPD Status Update
Jul 19 16:15:13 volumio volumio[1056]: info: ------------------------------ 213ms
Jul 19 16:15:13 volumio volumio[1056]: info: ------------------------------ 212ms
Jul 19 16:15:13 volumio volumio[1056]: info: sendMpdCommand add "http://192.168.178.1:49200/AUDIO/DLNA-1-0/Musik/FRITZ-Song.mp3" took 2 milliseconds
Jul 19 16:15:13 volumio volumio[1056]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 19 16:15:13 volumio volumio[1056]: verbose: ControllerMpd::sendMpdCommand play
Jul 19 16:15:13 volumio volumio[1056]: info:
Jul 19 16:15:13 volumio volumio[1056]: ---------------------------- MPD announces system playlist update
Jul 19 16:15:13 volumio volumio[1056]: info: Ignoring MPD Status Update
Jul 19 16:15:13 volumio volumio[1056]: info:
Jul 19 16:15:13 volumio volumio[1056]: ---------------------------- MPD announces system playlist update
Jul 19 16:15:13 volumio volumio[1056]: info: Ignoring MPD Status Update
Jul 19 16:15:13 volumio volumio[1056]: info: ------------------------------ 8ms
Jul 19 16:15:13 volumio volumio[1056]: info: sendMpdCommand play took 6 milliseconds
Jul 19 16:15:13 volumio volumio[1056]: info: ------------------------------ 6ms
Jul 19 16:15:13 volumio volumio[1056]: info: ------------------------------ 4ms
Jul 19 16:15:14 volumio volumio[1056]: info:
Jul 19 16:15:14 volumio volumio[1056]: ---------------------------- MPD announces state update: player
Jul 19 16:15:14 volumio volumio[1056]: info: ControllerMpd::getState
Jul 19 16:15:14 volumio volumio[1056]: verbose: ControllerMpd::sendMpdCommand status
Jul 19 16:15:14 volumio volumio[1056]: info:
Jul 19 16:15:14 volumio volumio[1056]: ---------------------------- MPD announces state update: player
Jul 19 16:15:14 volumio volumio[1056]: info: ControllerMpd::getState
Jul 19 16:15:14 volumio volumio[1056]: verbose: ControllerMpd::sendMpdCommand status
Jul 19 16:15:14 volumio volumio[1056]: info:
Jul 19 16:15:14 volumio volumio[1056]: ---------------------------- MPD announces state update: player
Jul 19 16:15:14 volumio volumio[1056]: info: ControllerMpd::getState
Jul 19 16:15:14 volumio volumio[1056]: verbose: ControllerMpd::sendMpdCommand status
Jul 19 16:15:14 volumio volumio[1056]: info:
Jul 19 16:15:14 volumio volumio[1056]: ---------------------------- MPD announces state update: player
Jul 19 16:15:14 volumio volumio[1056]: info: sendMpdCommand status took 3 milliseconds
Jul 19 16:15:14 volumio volumio[1056]: info: ControllerMpd::getState
Jul 19 16:15:14 volumio volumio[1056]: verbose: ControllerMpd::sendMpdCommand status
Jul 19 16:15:14 volumio volumio[1056]: info: sendMpdCommand status took 3 milliseconds
Jul 19 16:15:14 volumio volumio[1056]: info: sendMpdCommand status took 2 milliseconds
Jul 19 16:15:14 volumio volumio[1056]: verbose: ControllerMpd::parseState
Jul 19 16:15:14 volumio volumio[1056]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 19 16:15:14 volumio volumio[1056]: verbose: ControllerMpd::parseState
Jul 19 16:15:14 volumio volumio[1056]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 19 16:15:14 volumio volumio[1056]: verbose: ControllerMpd::parseState
Jul 19 16:15:14 volumio volumio[1056]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 19 16:15:14 volumio volumio[1056]: info:
Jul 19 16:15:14 volumio volumio[1056]: ---------------------------- MPD announces state update: player
Jul 19 16:15:14 volumio volumio[1056]: info: ControllerMpd::getState
Jul 19 16:15:14 volumio volumio[1056]: verbose: ControllerMpd::sendMpdCommand status
Jul 19 16:15:14 volumio volumio[1056]: info:
Jul 19 16:15:14 volumio volumio[1056]: ---------------------------- MPD announces state update: player
Jul 19 16:15:14 volumio volumio[1056]: info: ControllerMpd::getState
Jul 19 16:15:14 volumio volumio[1056]: verbose: ControllerMpd::sendMpdCommand status
Jul 19 16:15:14 volumio volumio[1056]: info:
Jul 19 16:15:14 volumio volumio[1056]: ---------------------------- MPD announces system playlist update
Jul 19 16:15:14 volumio volumio[1056]: info: Ignoring MPD Status Update
Jul 19 16:15:14 volumio volumio[1056]: info:
Jul 19 16:15:14 volumio volumio[1056]: ---------------------------- MPD announces state update: player
Jul 19 16:15:14 volumio volumio[1056]: info: sendMpdCommand status took 11 milliseconds
Jul 19 16:15:14 volumio volumio[1056]: info: sendMpdCommand playlistinfo took 10 milliseconds
Jul 19 16:15:14 volumio volumio[1056]: info: sendMpdCommand playlistinfo took 9 milliseconds
Jul 19 16:15:14 volumio volumio[1056]: info: ControllerMpd::getState
Jul 19 16:15:14 volumio volumio[1056]: verbose: ControllerMpd::sendMpdCommand status
Jul 19 16:15:14 volumio volumio[1056]: info: sendMpdCommand status took 8 milliseconds
Jul 19 16:15:14 volumio volumio[1056]: info: sendMpdCommand status took 7 milliseconds
Jul 19 16:15:14 volumio volumio[1056]: verbose: ControllerMpd::parseState
Jul 19 16:15:14 volumio volumio[1056]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 19 16:15:14 volumio volumio[1056]: verbose: ControllerMpd::parseTrackInfo
Jul 19 16:15:14 volumio volumio[1056]: verbose: ControllerMpd::parseTrackInfo
Jul 19 16:15:14 volumio volumio[1056]: verbose: ControllerMpd::parseTrackInfo
Jul 19 16:15:14 volumio volumio[1056]: verbose: ControllerMpd::parseState
Jul 19 16:15:14 volumio volumio[1056]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 19 16:15:14 volumio volumio[1056]: verbose: ControllerMpd::parseState
Jul 19 16:15:14 volumio volumio[1056]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 19 16:15:14 volumio volumio[1056]: info: ControllerMpd::pushState
Jul 19 16:15:14 volumio volumio[1056]: info: CoreCommandRouter::servicePushState
Jul 19 16:15:14 volumio volumio[1056]: info: CoreStateMachine::pushState
Jul 19 16:15:14 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 19 16:15:14 volumio volumio[1056]: info: CoreCommandRouter::volumioPushState
Jul 19 16:15:14 volumio volumio[1056]: info: ControllerMpd::pushState
Jul 19 16:15:14 volumio volumio[1056]: info: CoreCommandRouter::servicePushState
Jul 19 16:15:14 volumio volumio[1056]: info: CoreStateMachine::pushState
Jul 19 16:15:14 volumio volumio[1056]: info: CoreCommandRouter::volumioPushState
Jul 19 16:15:14 volumio volumio[1056]: info: ControllerMpd::pushState
Jul 19 16:15:14 volumio volumio[1056]: info: CoreCommandRouter::servicePushState
Jul 19 16:15:14 volumio volumio[1056]: info: CoreStateMachine::pushState
Jul 19 16:15:14 volumio volumio[1056]: info: CoreCommandRouter::volumioPushState
Jul 19 16:15:14 volumio volumio[1056]: info: ------------------------------ 46ms
Jul 19 16:15:14 volumio volumio[1056]: info: ------------------------------ 46ms
Jul 19 16:15:14 volumio volumio[1056]: info: ------------------------------ 45ms
Jul 19 16:15:14 volumio volumio[1056]: info:
Jul 19 16:15:14 volumio volumio[1056]: ---------------------------- MPD announces system playlist update
Jul 19 16:15:14 volumio volumio[1056]: info: Ignoring MPD Status Update
Jul 19 16:15:14 volumio volumio[1056]: info:
Jul 19 16:15:14 volumio volumio[1056]: ---------------------------- MPD announces state update: player
Jul 19 16:15:14 volumio volumio[1056]: info: ControllerMpd::getState
Jul 19 16:15:14 volumio volumio[1056]: verbose: ControllerMpd::sendMpdCommand status
Jul 19 16:15:14 volumio volumio[1056]: info:
Jul 19 16:15:14 volumio volumio[1056]: ---------------------------- MPD announces system playlist update
Jul 19 16:15:14 volumio volumio[1056]: info: Ignoring MPD Status Update
Jul 19 16:15:14 volumio volumio[1056]: info:
Jul 19 16:15:14 volumio volumio[1056]: ---------------------------- MPD announces state update: player
Jul 19 16:15:14 volumio volumio[1056]: info: ControllerMpd::getState
Jul 19 16:15:14 volumio volumio[1056]: verbose: ControllerMpd::sendMpdCommand status
Jul 19 16:15:14 volumio volumio[1056]: info: ------------------------------ 36ms
Jul 19 16:15:14 volumio volumio[1056]: info: sendMpdCommand status took 34 milliseconds
Jul 19 16:15:14 volumio volumio[1056]: info: sendMpdCommand playlistinfo took 33 milliseconds
Jul 19 16:15:14 volumio volumio[1056]: info: sendMpdCommand playlistinfo took 32 milliseconds
Jul 19 16:15:14 volumio volumio[1056]: info: sendMpdCommand playlistinfo took 31 milliseconds
Jul 19 16:15:14 volumio volumio[1056]: info: ------------------------------ 5ms
Jul 19 16:15:14 volumio volumio[1056]: info: sendMpdCommand status took 4 milliseconds
Jul 19 16:15:14 volumio volumio[1056]: info: ------------------------------ 4ms
Jul 19 16:15:14 volumio volumio[1056]: info: sendMpdCommand status took 4 milliseconds
Jul 19 16:15:14 volumio volumio[1056]: verbose: ControllerMpd::parseState
Jul 19 16:15:14 volumio volumio[1056]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 19 16:15:14 volumio volumio[1056]: verbose: ControllerMpd::parseTrackInfo
Jul 19 16:15:14 volumio volumio[1056]: verbose: ControllerMpd::parseTrackInfo
Jul 19 16:15:14 volumio volumio[1056]: verbose: ControllerMpd::parseTrackInfo
Jul 19 16:15:14 volumio volumio[1056]: verbose: ControllerMpd::parseState
Jul 19 16:15:14 volumio volumio[1056]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 19 16:15:14 volumio volumio[1056]: verbose: ControllerMpd::parseState
Jul 19 16:15:14 volumio volumio[1056]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 19 16:15:14 volumio volumio[1056]: info: ControllerMpd::pushState
Jul 19 16:15:14 volumio volumio[1056]: info: CoreCommandRouter::servicePushState
Jul 19 16:15:14 volumio volumio[1056]: info: CoreStateMachine::pushState
Jul 19 16:15:14 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 19 16:15:14 volumio volumio[1056]: info: CoreCommandRouter::volumioPushState
Jul 19 16:15:14 volumio volumio[1056]: info: ControllerMpd::pushState
Jul 19 16:15:14 volumio volumio[1056]: info: CoreCommandRouter::servicePushState
Jul 19 16:15:14 volumio volumio[1056]: info: CoreStateMachine::pushState
Jul 19 16:15:14 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 19 16:15:14 volumio volumio[1056]: info: CoreCommandRouter::volumioPushState
Jul 19 16:15:14 volumio volumio[1056]: info: ControllerMpd::pushState
Jul 19 16:15:14 volumio volumio[1056]: info: CoreCommandRouter::servicePushState
Jul 19 16:15:14 volumio volumio[1056]: info: CoreStateMachine::pushState
Jul 19 16:15:14 volumio volumio[1056]: info: CoreCommandRouter::volumioPushState
Jul 19 16:15:14 volumio volumio[1056]: info: ------------------------------ 76ms
Jul 19 16:15:14 volumio volumio[1056]: info: ------------------------------ 71ms
Jul 19 16:15:14 volumio volumio[1056]: info: ------------------------------ 69ms
Jul 19 16:15:14 volumio volumio[1056]: info: [GPIO_Control] Status changed: play
Jul 19 16:15:14 volumio volumio[1056]: info: [GPIO_Control] Handling event: musicPlay
Jul 19 16:15:14 volumio volumio[1056]: info: [GPIO_Control] Status changed: play
Jul 19 16:15:14 volumio volumio[1056]: info: [GPIO_Control] Status changed: play
Jul 19 16:15:14 volumio volumio[1056]: info: [GPIO_Control] Status changed: play
Jul 19 16:15:14 volumio volumio[1056]: info: [GPIO_Control] Status changed: play
Jul 19 16:15:14 volumio volumio[1056]: info: [GPIO_Control] Status changed: play
Jul 19 16:15:14 volumio volumio[1056]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jul 19 16:15:14 volumio volumio[1056]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jul 19 16:15:14 volumio volumio[1056]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jul 19 16:15:14 volumio volumio[1056]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jul 19 16:15:14 volumio volumio[1056]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jul 19 16:15:14 volumio volumio[1056]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jul 19 16:15:14 volumio volumio[1056]: info: sendMpdCommand playlistinfo took 48 milliseconds
Jul 19 16:15:14 volumio volumio[1056]: info: sendMpdCommand playlistinfo took 47 milliseconds
Jul 19 16:15:14 volumio volumio[1056]: info: sendMpdCommand playlistinfo took 48 milliseconds
Jul 19 16:15:14 volumio volumio[1056]: verbose: ControllerMpd::parseTrackInfo
Jul 19 16:15:14 volumio volumio[1056]: verbose: ControllerMpd::parseTrackInfo
Jul 19 16:15:14 volumio volumio[1056]: verbose: ControllerMpd::parseTrackInfo
Jul 19 16:15:14 volumio volumio[1056]: info: ControllerMpd::pushState
Jul 19 16:15:14 volumio volumio[1056]: info: CoreCommandRouter::servicePushState
Jul 19 16:15:14 volumio volumio[1056]: info: CoreStateMachine::pushState
Jul 19 16:15:14 volumio volumio[1056]: info: CoreCommandRouter::volumioPushState
Jul 19 16:15:14 volumio volumio[1056]: info: ControllerMpd::pushState
Jul 19 16:15:14 volumio volumio[1056]: info: CoreCommandRouter::servicePushState
Jul 19 16:15:14 volumio volumio[1056]: info: CoreStateMachine::pushState
Jul 19 16:15:14 volumio volumio[1056]: info: CoreCommandRouter::volumioPushState
Jul 19 16:15:14 volumio volumio[1056]: info: ControllerMpd::pushState
Jul 19 16:15:14 volumio volumio[1056]: info: CoreCommandRouter::servicePushState
Jul 19 16:15:14 volumio volumio[1056]: info: CoreStateMachine::pushState
Jul 19 16:15:14 volumio volumio[1056]: info: CoreCommandRouter::volumioPushState
Jul 19 16:15:14 volumio volumio[1056]: info: ------------------------------ 113ms
Jul 19 16:15:14 volumio volumio[1056]: info: ------------------------------ 82ms
Jul 19 16:15:14 volumio volumio[1056]: info: ------------------------------ 80ms
Jul 19 16:15:14 volumio volumio[1056]: info: [GPIO_Control] Status changed: play
Jul 19 16:15:14 volumio volumio[1056]: info: [GPIO_Control] Status changed: play
Jul 19 16:15:14 volumio volumio[1056]: info: [GPIO_Control] Status changed: play
Jul 19 16:15:14 volumio volumio[1056]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jul 19 16:15:14 volumio volumio[1056]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jul 19 16:15:14 volumio volumio[1056]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jul 19 16:15:14 volumio sshd[8430]: pam_unix(sshd:auth): check pass; user unknown
Jul 19 16:15:14 volumio sshd[8430]: pam_unix(sshd:auth): authentication failure; logname= uid=0 euid=0 tty=ssh ruser= rhost=210.16.168.181
Jul 19 16:15:16 volumio sshd[8430]: Failed password for invalid user es from 210.16.168.181 port 40034 ssh2
Jul 19 16:15:16 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Jul 19 16:15:16 volumio volumio[1056]: info: Preload queue cleared
Jul 19 16:15:18 volumio sshd[8430]: Connection closed by invalid user es 210.16.168.181 port 40034 [preauth]
Jul 19 16:15:20 volumio volumio[1056]: info: Preload queue cleared
Jul 19 16:15:20 volumio volumio[1056]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jul 19 16:15:20 volumio volumio[1056]: info: CoreStateMachine::ClearQueue
Jul 19 16:15:20 volumio volumio[1056]: info: CoreStateMachine::stop
Jul 19 16:15:20 volumio volumio[1056]: info: CoreStateMachine::serviceStop
Jul 19 16:15:20 volumio volumio[1056]: info: CoreCommandRouter::serviceStop
Jul 19 16:15:20 volumio volumio[1056]: info: ControllerMpd::stop
Jul 19 16:15:20 volumio volumio[1056]: verbose: ControllerMpd::sendMpdCommand stop
Jul 19 16:15:20 volumio volumio[1056]: info: CorePlayQueue::clearPlayQueue
Jul 19 16:15:20 volumio volumio[1056]: info: CorePlayQueue::saveQueue
Jul 19 16:15:20 volumio volumio[1056]: info: CoreCommandRouter::volumioPushQueue
Jul 19 16:15:20 volumio volumio[1056]: info: CoreStateMachine::addQueueItems
Jul 19 16:15:20 volumio volumio[1056]: info: CorePlayQueue::addQueueItems
Jul 19 16:15:20 volumio volumio[1056]: info: Preload queue cleared
Jul 19 16:15:20 volumio volumio[1056]: info: Adding Item to queue: upnp/folder/http://192.168.178.1:49000/MediaServer/ContentDirectory/Control@4:cont2:528:AVM GmbH0:0:
Jul 19 16:15:20 volumio volumio[1056]: info: Exploding uri upnp/folder/http://192.168.178.1:49000/MediaServer/ContentDirectory/Control@4:cont2:528:AVM GmbH0:0: in service upnp_browser
Jul 19 16:15:20 volumio volumio[1056]: info:
Jul 19 16:15:20 volumio volumio[1056]: ---------------------------- MPD announces state update: player
Jul 19 16:15:20 volumio volumio[1056]: info: sendMpdCommand stop took 11 milliseconds
Jul 19 16:15:20 volumio volumio[1056]: info: ControllerMpd::getState
Jul 19 16:15:20 volumio volumio[1056]: verbose: ControllerMpd::sendMpdCommand status
Jul 19 16:15:20 volumio volumio[1056]: info: sendMpdCommand status took 1 milliseconds
Jul 19 16:15:20 volumio volumio[1056]: verbose: ControllerMpd::parseState
Jul 19 16:15:20 volumio volumio[1056]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 19 16:15:20 volumio volumio[1056]: info:
Jul 19 16:15:20 volumio volumio[1056]: ---------------------------- MPD announces state update: player
Jul 19 16:15:20 volumio volumio[1056]: info: ControllerMpd::getState
Jul 19 16:15:20 volumio volumio[1056]: verbose: ControllerMpd::sendMpdCommand status
Jul 19 16:15:20 volumio volumio[1056]: info:
Jul 19 16:15:20 volumio volumio[1056]: ---------------------------- MPD announces state update: player
Jul 19 16:15:20 volumio volumio[1056]: info: ControllerMpd::getState
Jul 19 16:15:20 volumio volumio[1056]: verbose: ControllerMpd::sendMpdCommand status
Jul 19 16:15:20 volumio volumio[1056]: info: sendMpdCommand playlistinfo took 3 milliseconds
Jul 19 16:15:20 volumio volumio[1056]: info: sendMpdCommand status took 2 milliseconds
Jul 19 16:15:20 volumio volumio[1056]: info: sendMpdCommand status took 1 milliseconds
Jul 19 16:15:20 volumio volumio[1056]: verbose: ControllerMpd::parseTrackInfo
Jul 19 16:15:20 volumio volumio[1056]: verbose: ControllerMpd::parseState
Jul 19 16:15:20 volumio volumio[1056]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 19 16:15:20 volumio volumio[1056]: verbose: ControllerMpd::parseState
Jul 19 16:15:20 volumio volumio[1056]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 19 16:15:20 volumio volumio[1056]: info: ControllerMpd::pushState
Jul 19 16:15:20 volumio volumio[1056]: info: CoreCommandRouter::servicePushState
Jul 19 16:15:20 volumio volumio[1056]: info: CoreStateMachine::pushState
Jul 19 16:15:20 volumio volumio[1056]: info: CoreCommandRouter::volumioPushState
Jul 19 16:15:20 volumio volumio[1056]: info: CorePlayQueue::getTrack 0
Jul 19 16:15:20 volumio volumio[1056]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Fly FRITZ! Fly","artist":"AVM GmbH","album":"FRITZ!","uri":"http://192.168.178.1:49200/AUDIO/DLNA-1-0/Musik/FRITZ-Song.mp3","trackType":"mp3"}
Jul 19 16:15:20 volumio volumio[1056]: verbose: CURRENT POSITION 0
Jul 19 16:15:20 volumio volumio[1056]: info: CoreStateMachine::syncState stateService stop
Jul 19 16:15:20 volumio volumio[1056]: info: CoreStateMachine::syncState currentStatus play
Jul 19 16:15:20 volumio volumio[1056]: info: CoreCommandRouter::volumioPushState
Jul 19 16:15:20 volumio volumio[1056]: info: CoreStateMachine::stPlaybackTimer
Jul 19 16:15:20 volumio volumio[1056]: info: ------------------------------ 24ms
Jul 19 16:15:20 volumio volumio[1056]: info: sendMpdCommand playlistinfo took 18 milliseconds
Jul 19 16:15:20 volumio volumio[1056]: info: sendMpdCommand playlistinfo took 19 milliseconds
Jul 19 16:15:20 volumio volumio[1056]: verbose: ControllerMpd::parseTrackInfo
Jul 19 16:15:20 volumio volumio[1056]: verbose: ControllerMpd::parseTrackInfo
Jul 19 16:15:20 volumio volumio[1056]: info: ControllerMpd::pushState
Jul 19 16:15:20 volumio volumio[1056]: info: CoreCommandRouter::servicePushState
Jul 19 16:15:20 volumio volumio[1056]: info: CoreStateMachine::pushState
Jul 19 16:15:20 volumio volumio[1056]: info: CoreCommandRouter::volumioPushState
Jul 19 16:15:20 volumio volumio[1056]: info: CorePlayQueue::getTrack 0
Jul 19 16:15:20 volumio volumio[1056]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Fly FRITZ! Fly","artist":"AVM GmbH","album":"FRITZ!","uri":"http://192.168.178.1:49200/AUDIO/DLNA-1-0/Musik/FRITZ-Song.mp3","trackType":"mp3"}
Jul 19 16:15:20 volumio volumio[1056]: verbose: CURRENT POSITION 0
Jul 19 16:15:20 volumio volumio[1056]: info: CoreStateMachine::syncState stateService stop
Jul 19 16:15:20 volumio volumio[1056]: info: CoreStateMachine::syncState currentStatus stop
Jul 19 16:15:20 volumio volumio[1056]: info: CoreStateMachine::pushState
Jul 19 16:15:20 volumio volumio[1056]: info: CoreCommandRouter::volumioPushState
Jul 19 16:15:20 volumio volumio[1056]: info: No code
Jul 19 16:15:20 volumio volumio[1056]: info: CoreStateMachine::pushState
Jul 19 16:15:20 volumio volumio[1056]: info: CoreCommandRouter::volumioPushState
Jul 19 16:15:20 volumio volumio[1056]: info: ControllerMpd::pushState
Jul 19 16:15:20 volumio volumio[1056]: info: CoreCommandRouter::servicePushState
Jul 19 16:15:20 volumio volumio[1056]: info: CoreStateMachine::pushState
Jul 19 16:15:20 volumio volumio[1056]: info: CoreCommandRouter::volumioPushState
Jul 19 16:15:20 volumio volumio[1056]: info: CorePlayQueue::getTrack 0
Jul 19 16:15:20 volumio volumio[1056]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Fly FRITZ! Fly","artist":"AVM GmbH","album":"FRITZ!","uri":"http://192.168.178.1:49200/AUDIO/DLNA-1-0/Musik/FRITZ-Song.mp3","trackType":"mp3"}
Jul 19 16:15:20 volumio volumio[1056]: verbose: CURRENT POSITION 0
Jul 19 16:15:20 volumio volumio[1056]: info: CoreStateMachine::syncState stateService stop
Jul 19 16:15:20 volumio volumio[1056]: info: CoreStateMachine::syncState currentStatus stop
Jul 19 16:15:20 volumio volumio[1056]: info: CoreStateMachine::pushState
Jul 19 16:15:20 volumio volumio[1056]: info: CoreCommandRouter::volumioPushState
Jul 19 16:15:20 volumio volumio[1056]: info: No code
Jul 19 16:15:20 volumio volumio[1056]: info: CoreStateMachine::pushState
Jul 19 16:15:20 volumio volumio[1056]: info: CoreCommandRouter::volumioPushState
Jul 19 16:15:20 volumio volumio[1056]: info: ------------------------------ 58ms
Jul 19 16:15:20 volumio volumio[1056]: info: ------------------------------ 58ms
Jul 19 16:15:20 volumio volumio[1056]: info: [GPIO_Control] Status changed: play
Jul 19 16:15:20 volumio volumio[1056]: info: [GPIO_Control] Status changed: stop
Jul 19 16:15:20 volumio volumio[1056]: info: [GPIO_Control] Handling event: musicStop
Jul 19 16:15:20 volumio volumio[1056]: info: [GPIO_Control] Status changed: play
Jul 19 16:15:20 volumio volumio[1056]: info: [GPIO_Control] Handling event: musicPlay
Jul 19 16:15:20 volumio volumio[1056]: info: [GPIO_Control] Status changed: play
Jul 19 16:15:20 volumio volumio[1056]: info: [GPIO_Control] Status changed: play
Jul 19 16:15:20 volumio volumio[1056]: info: [GPIO_Control] Status changed: play
Jul 19 16:15:20 volumio volumio[1056]: info: [GPIO_Control] Status changed: play
Jul 19 16:15:20 volumio volumio[1056]: info: [GPIO_Control] Status changed: play
Jul 19 16:15:20 volumio volumio[1056]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jul 19 16:15:20 volumio volumio[1056]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jul 19 16:15:20 volumio volumio[1056]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jul 19 16:15:20 volumio volumio[1056]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jul 19 16:15:20 volumio volumio[1056]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jul 19 16:15:20 volumio volumio[1056]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jul 19 16:15:20 volumio volumio[1056]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jul 19 16:15:20 volumio volumio[1056]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51
Jul 19 16:15:20 volumio volumio[1056]: info: CoreCommandRouter::volumioPushQueue
Jul 19 16:15:20 volumio volumio[1056]: info: CorePlayQueue::saveQueue
Jul 19 16:15:20 volumio volumio[1056]: info: CoreStateMachine::updateTrackBlock
Jul 19 16:15:20 volumio volumio[1056]: info: CorePlayQueue::getTrackBlock
Jul 19 16:15:20 volumio volumio[1056]: info: CoreCommandRouter::volumioPlay
Jul 19 16:15:20 volumio volumio[1056]: info: CoreStateMachine::play index 0
Jul 19 16:15:20 volumio volumio[1056]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 19 16:15:20 volumio volumio[1056]: info: CoreStateMachine::stop
Jul 19 16:15:20 volumio volumio[1056]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 19 16:15:20 volumio volumio[1056]: info: CoreStateMachine::play index undefined
Jul 19 16:15:20 volumio volumio[1056]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 19 16:15:20 volumio volumio[1056]: info: CorePlayQueue::getTrack 0
Jul 19 16:15:24 volumio sshd[8463]: pam_unix(sshd:auth): authentication failure; logname= uid=0 euid=0 tty=ssh ruser= rhost=210.16.168.181 user=root
Jul 19 16:15:26 volumio volumio[1056]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Jul 19 16:15:26 volumio sshd[8463]: Failed password for root from 210.16.168.181 port 41752 ssh2
Jul 19 16:15:26 volumio volumio[1056]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 19 16:15:26 volumio volumio[1056]: TypeError: Cannot read property 'length' of undefined
Jul 19 16:15:26 volumio volumio[1056]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25
Jul 19 16:15:26 volumio volumio[1056]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13
Jul 19 16:15:26 volumio volumio[1056]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18)
Jul 19 16:15:26 volumio volumio[1056]: at Parser.emit (events.js:315:20)
Jul 19 16:15:26 volumio volumio[1056]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26)
Jul 19 16:15:26 volumio volumio[1056]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35)
Jul 19 16:15:26 volumio volumio[1056]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5)
Jul 19 16:15:26 volumio volumio[1056]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7)
Jul 19 16:15:26 volumio volumio[1056]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13)
Jul 19 16:15:26 volumio volumio[1056]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31)
Jul 19 16:15:26 volumio volumio[1056]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59)
Jul 19 16:15:26 volumio volumio[1056]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19)
Jul 19 16:15:26 volumio volumio[1056]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15)
Jul 19 16:15:26 volumio volumio[1056]: at IncomingMessage.emit (events.js:327:22)
Jul 19 16:15:26 volumio volumio[1056]: at endReadableNT (internal/streams/readable.js:1327:12)
Jul 19 16:15:26 volumio volumio[1056]: at processTicksAndRejections (internal/process/task_queues.js:80:21)
Jul 19 16:15:26 volumio volumio[1056]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 19 16:15:26 volumio sudo[8481]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-19 16:14
Jul 19 16:15:26 volumio sudo[8481]: 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="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="811ff8312d42f9da0260be1d353081a805678820"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed 02 Jul 2025 04:07:25 PM CEST"
VOLUMIO_VERSION="3.819"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="3b9115b1943141a9d7186aa434f8f3c2"