-- Logs begin at Wed 2021-10-06 10:20:30 UTC, end at Fri 2024-09-06 11:32:36 UTC. --
Sep 06 11:31:02 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Sep 06 11:31:13 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Sep 06 11:31:13 volumio volumio[1043]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Sep 06 11:31:13 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Sep 06 11:31:13 volumio volumio[1043]: info: Error : CoreCommandRouter::executeOnPlugin: No method [retreiveBackendEventStates] in plugin my_volumio
Sep 06 11:31:13 volumio volumio[1043]: info: Received Get System Version
Sep 06 11:31:13 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 06 11:32:00 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 06 11:32:00 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 06 11:32:00 volumio volumio[1043]: info: Discovery: Getting this device information
Sep 06 11:32:00 volumio volumio[1043]: info: CoreCommandRouter::volumioGetState
Sep 06 11:32:00 volumio volumio[1043]: info: CorePlayQueue::getTrack 0
Sep 06 11:32:00 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses
Sep 06 11:32:00 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , getConf
Sep 06 11:32:00 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , getConf
Sep 06 11:32:04 volumio volumio[1043]: info: CoreCommandRouter::volumioGetState
Sep 06 11:32:04 volumio volumio[1043]: info: CorePlayQueue::getTrack 0
Sep 06 11:32:04 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Sep 06 11:32:04 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Sep 06 11:32:07 volumio sudo[1702]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Sep 06 11:32:07 volumio sudo[1702]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 11:32:07 volumio sudo[1704]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Sep 06 11:32:07 volumio sudo[1702]: pam_unix(sudo:session): session closed for user root
Sep 06 11:32:07 volumio sudo[1704]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 06 11:32:07 volumio sudo[1704]: pam_unix(sudo:session): session closed for user root
Sep 06 11:32:07 volumio volumio[1043]: info: CoreCommandRouter::volumioGetState
Sep 06 11:32:07 volumio volumio[1043]: info: CorePlayQueue::getTrack 0
Sep 06 11:32:07 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Sep 06 11:32:07 volumio volumio[1043]: info: Listing playlists
Sep 06 11:32:07 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Sep 06 11:32:07 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Sep 06 11:32:07 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Sep 06 11:32:07 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Sep 06 11:32:09 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Sep 06 11:32:09 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Sep 06 11:32:11 volumio volumio[1043]: info: CoreCommandRouter::volumioPlay
Sep 06 11:32:11 volumio volumio[1043]: verbose: UNSET VOLATILE
Sep 06 11:32:11 volumio volumio[1043]: info: CoreStateMachine::play index undefined
Sep 06 11:32:11 volumio volumio[1043]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 06 11:32:11 volumio volumio[1043]: info: CorePlayQueue::getTrack 0
Sep 06 11:32:11 volumio volumio[1043]: info: CoreStateMachine::startPlaybackTimer
Sep 06 11:32:11 volumio volumio[1043]: info: CorePlayQueue::getTrack 0
Sep 06 11:32:11 volumio volumio[1043]: verbose: ControllerMpd::sendMpdCommand stop
Sep 06 11:32:11 volumio volumio[1043]: info: sendMpdCommand stop took 13 milliseconds
Sep 06 11:32:11 volumio volumio[1043]: verbose: ControllerMpd::sendMpdCommand clear
Sep 06 11:32:11 volumio volumio[1043]: info:
Sep 06 11:32:11 volumio volumio[1043]: ---------------------------- MPD announces system playlist update
Sep 06 11:32:11 volumio volumio[1043]: info: Ignoring MPD Status Update
Sep 06 11:32:11 volumio volumio[1043]: info: sendMpdCommand clear took 6 milliseconds
Sep 06 11:32:11 volumio volumio[1043]: verbose: ControllerMpd::sendMpdCommand add "https://1fm.gscdn.kbs.co.kr/1fm_192_2.m3u8?Expires=1715035484&Policy=eyJTdGF0ZW1lbnQiOlt7IlJlc291cmNlIjoiaHR0cHM6Ly8xZm0uZ3NjZG4ua2JzLmNvLmtyLzFmbV8xOTJfMi5tM3U4IiwiQ29uZGl0aW9uIjp7IkRhdGVMZXNzVGhhbiI6eyJBV1M6RXBvY2hUaW1lIjoxNzE1MDM1NDg0fX19XX0_&Signature=kPE93CWGO4l30OOMM5Y0d5lwMqqZUY~dpVihltuGhzLn85ZpBLh5vIGNnsovAPdrA~1SQTvldftnlvINk-Hap7Uxd8IiJVS9tIV7nnvBbSfI2vyF~H~dTMEiXDOBhFTCv~hdTygw6ggYHFUMhbOoiIZcUAnWrhalZeC1FwkqeAYyiGKklPr8IwxuQWZBjU6~hgq798JBY~RVOXh787goNsAjeTPJYOthA3QarjoQoZVv5Ia-VP0ObHpeG2LQs29QcBblx62O4K0jN9UomI0QTOabdZllkuLNfPrphEi03es9U-kRb3HZZkHQrbSKqW3VZLLPP8NGRj8FRUIwsmByIA__&Key-Pair-Id=APKAICDSGT3Y7IXGJ3TA"
Sep 06 11:32:11 volumio volumio[1043]: error: updateQueue error: null
Sep 06 11:32:11 volumio volumio[1043]: info:
Sep 06 11:32:11 volumio volumio[1043]: ---------------------------- MPD announces system playlist update
Sep 06 11:32:11 volumio volumio[1043]: info: Ignoring MPD Status Update
Sep 06 11:32:11 volumio volumio[1043]: info: ------------------------------ 12ms
Sep 06 11:32:11 volumio volumio[1043]: info: sendMpdCommand add "https://1fm.gscdn.kbs.co.kr/1fm_192_2.m3u8?Expires=1715035484&Policy=eyJTdGF0ZW1lbnQiOlt7IlJlc291cmNlIjoiaHR0cHM6Ly8xZm0uZ3NjZG4ua2JzLmNvLmtyLzFmbV8xOTJfMi5tM3U4IiwiQ29uZGl0aW9uIjp7IkRhdGVMZXNzVGhhbiI6eyJBV1M6RXBvY2hUaW1lIjoxNzE1MDM1NDg0fX19XX0_&Signature=kPE93CWGO4l30OOMM5Y0d5lwMqqZUY~dpVihltuGhzLn85ZpBLh5vIGNnsovAPdrA~1SQTvldftnlvINk-Hap7Uxd8IiJVS9tIV7nnvBbSfI2vyF~H~dTMEiXDOBhFTCv~hdTygw6ggYHFUMhbOoiIZcUAnWrhalZeC1FwkqeAYyiGKklPr8IwxuQWZBjU6~hgq798JBY~RVOXh787goNsAjeTPJYOthA3QarjoQoZVv5Ia-VP0ObHpeG2LQs29QcBblx62O4K0jN9UomI0QTOabdZllkuLNfPrphEi03es9U-kRb3HZZkHQrbSKqW3VZLLPP8NGRj8FRUIwsmByIA__&Key-Pair-Id=APKAICDSGT3Y7IXGJ3TA" took 7 milliseconds
Sep 06 11:32:11 volumio volumio[1043]: verbose: ControllerMpd::sendMpdCommand play
Sep 06 11:32:11 volumio volumio[1043]: info: ------------------------------ 19ms
Sep 06 11:32:11 volumio volumio[1043]: info: sendMpdCommand play took 9 milliseconds
Sep 06 11:32:11 volumio volumio[1043]: info: ControllerMpd::getState
Sep 06 11:32:11 volumio volumio[1043]: verbose: ControllerMpd::sendMpdCommand status
Sep 06 11:32:11 volumio volumio[1043]: info: sendMpdCommand status took 3 milliseconds
Sep 06 11:32:11 volumio volumio[1043]: verbose: ControllerMpd::parseState
Sep 06 11:32:11 volumio volumio[1043]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 06 11:32:11 volumio volumio[1043]: info: sendMpdCommand playlistinfo took 3 milliseconds
Sep 06 11:32:11 volumio volumio[1043]: verbose: ControllerMpd::parseTrackInfo
Sep 06 11:32:11 volumio volumio[1043]: info: CorePlayQueue::getTrack 0
Sep 06 11:32:11 volumio volumio[1043]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1fm_192_2.m3u8?Expires=1715035484&Policy=eyJTdGF0ZW1lbnQiOlt7IlJlc291cmNlIjoiaHR0cHM6Ly8xZm0uZ3NjZG4ua2JzLmNvLmtyLzFmbV8xOTJfMi5tM3U4IiwiQ29uZGl0aW9uIjp7IkRhdGVMZXNzVGhhbiI6eyJBV1M6RXBvY2hUaW1lIjoxNzE1MDM1NDg0fX19XX0_&Signature=kPE93CWGO4l30OOMM5Y0d5lwMqqZUY~dpVihltuGhzLn85ZpBLh5vIGNnsovAPdrA~1SQTvldftnlvINk-Hap7Uxd8IiJVS9tIV7nnvBbSfI2vyF~H~dTMEiXDOBhFTCv~hdTygw6ggYHFUMhbOoiIZcUAnWrhalZeC1FwkqeAYyiGKklPr8IwxuQWZBjU6~hgq798JBY~RVOXh787goNsAjeTPJYOthA3QarjoQoZVv5Ia-VP0ObHpeG2LQs29QcBblx62O4K0jN9UomI0QTOabdZllkuLNfPrphEi03es9U-kRb3HZZkHQrbSKqW3VZLLPP8NGRj8FRUIwsmByIA__&Key-Pair-Id=APKAICDSGT3Y7IXGJ3TA","artist":null,"album":null,"uri":"https://1fm.gscdn.kbs.co.kr/1fm_192_2.m3u8?Expires=1715035484&Policy=eyJTdGF0ZW1lbnQiOlt7IlJlc291cmNlIjoiaHR0cHM6Ly8xZm0uZ3NjZG4ua2JzLmNvLmtyLzFmbV8xOTJfMi5tM3U4IiwiQ29uZGl0aW9uIjp7IkRhdGVMZXNzVGhhbiI6eyJBV1M6RXBvY2hUaW1lIjoxNzE1MDM1NDg0fX19XX0_&Signature=kPE93CWGO4l30OOMM5Y0d5lwMqqZUY~dpVihltuGhzLn85ZpBLh5vIGNnsovAPdrA~1SQTvldftnlvINk-Hap7Uxd8IiJVS9tIV7nnvBbSfI2vyF~H~dTMEiXDOBhFTCv~hdTygw6ggYHFUMhbOoiIZcUAnWrhalZeC1FwkqeAYyiGKklPr8IwxuQWZBjU6~hgq798JBY~RVOXh787goNsAjeTPJYOthA3QarjoQoZVv5Ia-VP0ObHpeG2LQs29QcBblx62O4K0jN9UomI0QTOabdZllkuLNfPrphEi03es9U-kRb3HZZkHQrbSKqW3VZLLPP8NGRj8FRUIwsmByIA__&Key-Pair-Id=APKAICDSGT3Y7IXGJ3TA","trackType":""}
Sep 06 11:32:11 volumio volumio[1043]: verbose: CURRENT POSITION 0
Sep 06 11:32:11 volumio volumio[1043]: info: CoreStateMachine::syncState stateService play
Sep 06 11:32:11 volumio volumio[1043]: info: CoreStateMachine::syncState currentStatus stop
Sep 06 11:32:11 volumio volumio[1043]: info: CoreStateMachine::pushState
Sep 06 11:32:11 volumio volumio[1043]: info: CorePlayQueue::getTrack 0
Sep 06 11:32:11 volumio volumio[1043]: info: CoreCommandRouter::volumioPushState
Sep 06 11:32:11 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 06 11:32:11 volumio volumio[1043]: info:
Sep 06 11:32:11 volumio volumio[1043]: ---------------------------- MPD announces state update: player
Sep 06 11:32:11 volumio volumio[1043]: info: ControllerMpd::getState
Sep 06 11:32:11 volumio volumio[1043]: verbose: ControllerMpd::sendMpdCommand status
Sep 06 11:32:11 volumio volumio[1043]: verbose: ControllerMpd::sendMpdCommand clearerror
Sep 06 11:32:11 volumio volumio[1043]: info: sendMpdCommand status took 14 milliseconds
Sep 06 11:32:11 volumio volumio[1043]: verbose: ControllerMpd::parseState
Sep 06 11:32:11 volumio volumio[1043]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 06 11:32:11 volumio volumio[1043]: info: sendMpdCommand clearerror took 5 milliseconds
Sep 06 11:32:11 volumio volumio[1043]: info: sendMpdCommand playlistinfo took 3 milliseconds
Sep 06 11:32:11 volumio volumio[1043]: verbose: ControllerMpd::parseTrackInfo
Sep 06 11:32:11 volumio volumio[1043]: info: ControllerMpd::pushState
Sep 06 11:32:11 volumio volumio[1043]: info: CoreCommandRouter::servicePushState
Sep 06 11:32:11 volumio volumio[1043]: info: CoreStateMachine::pushState
Sep 06 11:32:11 volumio volumio[1043]: info: CorePlayQueue::getTrack 0
Sep 06 11:32:11 volumio volumio[1043]: info: CoreCommandRouter::volumioPushState
Sep 06 11:32:11 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 06 11:32:11 volumio volumio[1043]: info: CorePlayQueue::getTrack 0
Sep 06 11:32:11 volumio volumio[1043]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current personal_radio Received mpd
Sep 06 11:32:11 volumio volumio[1043]: info: ------------------------------ 45ms
Sep 06 11:32:12 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Sep 06 11:32:12 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Sep 06 11:32:13 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Sep 06 11:32:14 volumio volumio[1043]: info: CoreCommandRouter::volumioGetQueue
Sep 06 11:32:14 volumio volumio[1043]: info: CoreStateMachine::getQueue
Sep 06 11:32:14 volumio volumio[1043]: info: CorePlayQueue::getQueue
Sep 06 11:32:15 volumio volumio[1043]: info: CoreCommandRouter::volumioPlay
Sep 06 11:32:15 volumio volumio[1043]: verbose: UNSET VOLATILE
Sep 06 11:32:15 volumio volumio[1043]: info: CoreStateMachine::play index 0
Sep 06 11:32:15 volumio volumio[1043]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 06 11:32:15 volumio volumio[1043]: info: CoreStateMachine::stop
Sep 06 11:32:15 volumio volumio[1043]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 06 11:32:15 volumio volumio[1043]: verbose: UNSET VOLATILE
Sep 06 11:32:15 volumio volumio[1043]: info: CoreStateMachine::stPlaybackTimer
Sep 06 11:32:15 volumio volumio[1043]: info: CoreStateMachine::updateTrackBlock
Sep 06 11:32:15 volumio volumio[1043]: info: CorePlayQueue::getTrackBlock
Sep 06 11:32:15 volumio volumio[1043]: info: CoreStateMachine::pushState
Sep 06 11:32:15 volumio volumio[1043]: info: CorePlayQueue::getTrack 0
Sep 06 11:32:15 volumio volumio[1043]: info: CoreCommandRouter::volumioPushState
Sep 06 11:32:15 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 06 11:32:15 volumio volumio[1043]: info: CoreStateMachine::serviceStop
Sep 06 11:32:15 volumio volumio[1043]: info: CorePlayQueue::getTrack 0
Sep 06 11:32:15 volumio volumio[1043]: info: CoreCommandRouter::serviceStop
Sep 06 11:32:15 volumio volumio[1043]: info: ControllerMpd::stop
Sep 06 11:32:15 volumio volumio[1043]: verbose: ControllerMpd::sendMpdCommand stop
Sep 06 11:32:15 volumio volumio[1043]: info: sendMpdCommand stop took 14 milliseconds
Sep 06 11:32:15 volumio volumio[1043]: info: ControllerMpd::getState
Sep 06 11:32:15 volumio volumio[1043]: verbose: ControllerMpd::sendMpdCommand status
Sep 06 11:32:15 volumio volumio[1043]: info: sendMpdCommand status took 8 milliseconds
Sep 06 11:32:15 volumio volumio[1043]: verbose: ControllerMpd::parseState
Sep 06 11:32:15 volumio volumio[1043]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 06 11:32:15 volumio volumio[1043]: info: sendMpdCommand playlistinfo took 3 milliseconds
Sep 06 11:32:15 volumio volumio[1043]: verbose: ControllerMpd::parseTrackInfo
Sep 06 11:32:15 volumio volumio[1043]: info: CoreStateMachine::pushState
Sep 06 11:32:15 volumio volumio[1043]: info: CorePlayQueue::getTrack 0
Sep 06 11:32:15 volumio volumio[1043]: info: CoreCommandRouter::volumioPushState
Sep 06 11:32:15 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 06 11:32:15 volumio volumio[1043]: info: CorePlayQueue::getTrack 0
Sep 06 11:32:15 volumio volumio[1043]: 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":"1fm_192_2.m3u8?Expires=1715035484&Policy=eyJTdGF0ZW1lbnQiOlt7IlJlc291cmNlIjoiaHR0cHM6Ly8xZm0uZ3NjZG4ua2JzLmNvLmtyLzFmbV8xOTJfMi5tM3U4IiwiQ29uZGl0aW9uIjp7IkRhdGVMZXNzVGhhbiI6eyJBV1M6RXBvY2hUaW1lIjoxNzE1MDM1NDg0fX19XX0_&Signature=kPE93CWGO4l30OOMM5Y0d5lwMqqZUY~dpVihltuGhzLn85ZpBLh5vIGNnsovAPdrA~1SQTvldftnlvINk-Hap7Uxd8IiJVS9tIV7nnvBbSfI2vyF~H~dTMEiXDOBhFTCv~hdTygw6ggYHFUMhbOoiIZcUAnWrhalZeC1FwkqeAYyiGKklPr8IwxuQWZBjU6~hgq798JBY~RVOXh787goNsAjeTPJYOthA3QarjoQoZVv5Ia-VP0ObHpeG2LQs29QcBblx62O4K0jN9UomI0QTOabdZllkuLNfPrphEi03es9U-kRb3HZZkHQrbSKqW3VZLLPP8NGRj8FRUIwsmByIA__&Key-Pair-Id=APKAICDSGT3Y7IXGJ3TA","artist":null,"album":null,"uri":"https://1fm.gscdn.kbs.co.kr/1fm_192_2.m3u8?Expires=1715035484&Policy=eyJTdGF0ZW1lbnQiOlt7IlJlc291cmNlIjoiaHR0cHM6Ly8xZm0uZ3NjZG4ua2JzLmNvLmtyLzFmbV8xOTJfMi5tM3U4IiwiQ29uZGl0aW9uIjp7IkRhdGVMZXNzVGhhbiI6eyJBV1M6RXBvY2hUaW1lIjoxNzE1MDM1NDg0fX19XX0_&Signature=kPE93CWGO4l30OOMM5Y0d5lwMqqZUY~dpVihltuGhzLn85ZpBLh5vIGNnsovAPdrA~1SQTvldftnlvINk-Hap7Uxd8IiJVS9tIV7nnvBbSfI2vyF~H~dTMEiXDOBhFTCv~hdTygw6ggYHFUMhbOoiIZcUAnWrhalZeC1FwkqeAYyiGKklPr8IwxuQWZBjU6~hgq798JBY~RVOXh787goNsAjeTPJYOthA3QarjoQoZVv5Ia-VP0ObHpeG2LQs29QcBblx62O4K0jN9UomI0QTOabdZllkuLNfPrphEi03es9U-kRb3HZZkHQrbSKqW3VZLLPP8NGRj8FRUIwsmByIA__&Key-Pair-Id=APKAICDSGT3Y7IXGJ3TA","trackType":""}
Sep 06 11:32:15 volumio volumio[1043]: verbose: CURRENT POSITION 0
Sep 06 11:32:15 volumio volumio[1043]: info: CoreStateMachine::syncState stateService stop
Sep 06 11:32:15 volumio volumio[1043]: info: CoreStateMachine::syncState currentStatus stop
Sep 06 11:32:15 volumio volumio[1043]: info: CoreStateMachine::pushState
Sep 06 11:32:15 volumio volumio[1043]: info: CorePlayQueue::getTrack 0
Sep 06 11:32:15 volumio volumio[1043]: info: CoreCommandRouter::volumioPushState
Sep 06 11:32:15 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 06 11:32:15 volumio volumio[1043]: info: No code
Sep 06 11:32:15 volumio volumio[1043]: info: CoreStateMachine::pushState
Sep 06 11:32:15 volumio volumio[1043]: info: CorePlayQueue::getTrack 0
Sep 06 11:32:15 volumio volumio[1043]: info: CoreCommandRouter::volumioPushState
Sep 06 11:32:15 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 06 11:32:15 volumio volumio[1043]: info: CoreStateMachine::play index undefined
Sep 06 11:32:15 volumio volumio[1043]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 06 11:32:15 volumio volumio[1043]: info: CorePlayQueue::getTrack 0
Sep 06 11:32:15 volumio volumio[1043]: info: CoreStateMachine::startPlaybackTimer
Sep 06 11:32:15 volumio volumio[1043]: info: CorePlayQueue::getTrack 0
Sep 06 11:32:15 volumio volumio[1043]: verbose: ControllerMpd::sendMpdCommand stop
Sep 06 11:32:15 volumio volumio[1043]: info: sendMpdCommand stop took 7 milliseconds
Sep 06 11:32:15 volumio volumio[1043]: verbose: ControllerMpd::sendMpdCommand clear
Sep 06 11:32:15 volumio volumio[1043]: info:
Sep 06 11:32:15 volumio volumio[1043]: ---------------------------- MPD announces system playlist update
Sep 06 11:32:15 volumio volumio[1043]: info: Ignoring MPD Status Update
Sep 06 11:32:16 volumio volumio[1043]: info: sendMpdCommand clear took 24 milliseconds
Sep 06 11:32:16 volumio volumio[1043]: verbose: ControllerMpd::sendMpdCommand add "https://1fm.gscdn.kbs.co.kr/1fm_192_2.m3u8?Expires=1715035484&Policy=eyJTdGF0ZW1lbnQiOlt7IlJlc291cmNlIjoiaHR0cHM6Ly8xZm0uZ3NjZG4ua2JzLmNvLmtyLzFmbV8xOTJfMi5tM3U4IiwiQ29uZGl0aW9uIjp7IkRhdGVMZXNzVGhhbiI6eyJBV1M6RXBvY2hUaW1lIjoxNzE1MDM1NDg0fX19XX0_&Signature=kPE93CWGO4l30OOMM5Y0d5lwMqqZUY~dpVihltuGhzLn85ZpBLh5vIGNnsovAPdrA~1SQTvldftnlvINk-Hap7Uxd8IiJVS9tIV7nnvBbSfI2vyF~H~dTMEiXDOBhFTCv~hdTygw6ggYHFUMhbOoiIZcUAnWrhalZeC1FwkqeAYyiGKklPr8IwxuQWZBjU6~hgq798JBY~RVOXh787goNsAjeTPJYOthA3QarjoQoZVv5Ia-VP0ObHpeG2LQs29QcBblx62O4K0jN9UomI0QTOabdZllkuLNfPrphEi03es9U-kRb3HZZkHQrbSKqW3VZLLPP8NGRj8FRUIwsmByIA__&Key-Pair-Id=APKAICDSGT3Y7IXGJ3TA"
Sep 06 11:32:16 volumio volumio[1043]: error: updateQueue error: null
Sep 06 11:32:16 volumio volumio[1043]: info:
Sep 06 11:32:16 volumio volumio[1043]: ---------------------------- MPD announces system playlist update
Sep 06 11:32:16 volumio volumio[1043]: info: Ignoring MPD Status Update
Sep 06 11:32:16 volumio volumio[1043]: info: ------------------------------ 29ms
Sep 06 11:32:16 volumio volumio[1043]: info: sendMpdCommand add "https://1fm.gscdn.kbs.co.kr/1fm_192_2.m3u8?Expires=1715035484&Policy=eyJTdGF0ZW1lbnQiOlt7IlJlc291cmNlIjoiaHR0cHM6Ly8xZm0uZ3NjZG4ua2JzLmNvLmtyLzFmbV8xOTJfMi5tM3U4IiwiQ29uZGl0aW9uIjp7IkRhdGVMZXNzVGhhbiI6eyJBV1M6RXBvY2hUaW1lIjoxNzE1MDM1NDg0fX19XX0_&Signature=kPE93CWGO4l30OOMM5Y0d5lwMqqZUY~dpVihltuGhzLn85ZpBLh5vIGNnsovAPdrA~1SQTvldftnlvINk-Hap7Uxd8IiJVS9tIV7nnvBbSfI2vyF~H~dTMEiXDOBhFTCv~hdTygw6ggYHFUMhbOoiIZcUAnWrhalZeC1FwkqeAYyiGKklPr8IwxuQWZBjU6~hgq798JBY~RVOXh787goNsAjeTPJYOthA3QarjoQoZVv5Ia-VP0ObHpeG2LQs29QcBblx62O4K0jN9UomI0QTOabdZllkuLNfPrphEi03es9U-kRb3HZZkHQrbSKqW3VZLLPP8NGRj8FRUIwsmByIA__&Key-Pair-Id=APKAICDSGT3Y7IXGJ3TA" took 20 milliseconds
Sep 06 11:32:16 volumio volumio[1043]: verbose: ControllerMpd::sendMpdCommand play
Sep 06 11:32:16 volumio volumio[1043]: info: ------------------------------ 20ms
Sep 06 11:32:16 volumio volumio[1043]: info: sendMpdCommand play took 15 milliseconds
Sep 06 11:32:16 volumio volumio[1043]: info: ControllerMpd::getState
Sep 06 11:32:16 volumio volumio[1043]: verbose: ControllerMpd::sendMpdCommand status
Sep 06 11:32:16 volumio volumio[1043]: info: sendMpdCommand status took 34 milliseconds
Sep 06 11:32:16 volumio volumio[1043]: verbose: ControllerMpd::parseState
Sep 06 11:32:16 volumio volumio[1043]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 06 11:32:16 volumio volumio[1043]: info: sendMpdCommand playlistinfo took 9 milliseconds
Sep 06 11:32:16 volumio volumio[1043]: verbose: ControllerMpd::parseTrackInfo
Sep 06 11:32:16 volumio volumio[1043]: info: CorePlayQueue::getTrack 0
Sep 06 11:32:16 volumio volumio[1043]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1fm_192_2.m3u8?Expires=1715035484&Policy=eyJTdGF0ZW1lbnQiOlt7IlJlc291cmNlIjoiaHR0cHM6Ly8xZm0uZ3NjZG4ua2JzLmNvLmtyLzFmbV8xOTJfMi5tM3U4IiwiQ29uZGl0aW9uIjp7IkRhdGVMZXNzVGhhbiI6eyJBV1M6RXBvY2hUaW1lIjoxNzE1MDM1NDg0fX19XX0_&Signature=kPE93CWGO4l30OOMM5Y0d5lwMqqZUY~dpVihltuGhzLn85ZpBLh5vIGNnsovAPdrA~1SQTvldftnlvINk-Hap7Uxd8IiJVS9tIV7nnvBbSfI2vyF~H~dTMEiXDOBhFTCv~hdTygw6ggYHFUMhbOoiIZcUAnWrhalZeC1FwkqeAYyiGKklPr8IwxuQWZBjU6~hgq798JBY~RVOXh787goNsAjeTPJYOthA3QarjoQoZVv5Ia-VP0ObHpeG2LQs29QcBblx62O4K0jN9UomI0QTOabdZllkuLNfPrphEi03es9U-kRb3HZZkHQrbSKqW3VZLLPP8NGRj8FRUIwsmByIA__&Key-Pair-Id=APKAICDSGT3Y7IXGJ3TA","artist":null,"album":null,"uri":"https://1fm.gscdn.kbs.co.kr/1fm_192_2.m3u8?Expires=1715035484&Policy=eyJTdGF0ZW1lbnQiOlt7IlJlc291cmNlIjoiaHR0cHM6Ly8xZm0uZ3NjZG4ua2JzLmNvLmtyLzFmbV8xOTJfMi5tM3U4IiwiQ29uZGl0aW9uIjp7IkRhdGVMZXNzVGhhbiI6eyJBV1M6RXBvY2hUaW1lIjoxNzE1MDM1NDg0fX19XX0_&Signature=kPE93CWGO4l30OOMM5Y0d5lwMqqZUY~dpVihltuGhzLn85ZpBLh5vIGNnsovAPdrA~1SQTvldftnlvINk-Hap7Uxd8IiJVS9tIV7nnvBbSfI2vyF~H~dTMEiXDOBhFTCv~hdTygw6ggYHFUMhbOoiIZcUAnWrhalZeC1FwkqeAYyiGKklPr8IwxuQWZBjU6~hgq798JBY~RVOXh787goNsAjeTPJYOthA3QarjoQoZVv5Ia-VP0ObHpeG2LQs29QcBblx62O4K0jN9UomI0QTOabdZllkuLNfPrphEi03es9U-kRb3HZZkHQrbSKqW3VZLLPP8NGRj8FRUIwsmByIA__&Key-Pair-Id=APKAICDSGT3Y7IXGJ3TA","trackType":""}
Sep 06 11:32:16 volumio volumio[1043]: verbose: CURRENT POSITION 0
Sep 06 11:32:16 volumio volumio[1043]: info: CoreStateMachine::syncState stateService play
Sep 06 11:32:16 volumio volumio[1043]: info: CoreStateMachine::syncState currentStatus stop
Sep 06 11:32:16 volumio volumio[1043]: info: CoreStateMachine::pushState
Sep 06 11:32:16 volumio volumio[1043]: info: CorePlayQueue::getTrack 0
Sep 06 11:32:16 volumio volumio[1043]: info: CoreCommandRouter::volumioPushState
Sep 06 11:32:16 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 06 11:32:16 volumio volumio[1043]: info: touch_display: Setting screensaver timeout to 120 seconds.
Sep 06 11:32:16 volumio volumio[1043]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0
Sep 06 11:32:16 volumio volumio[1043]: info: touch_display: Setting screensaver timeout to 120 seconds.
Sep 06 11:32:16 volumio volumio[1043]: info:
Sep 06 11:32:16 volumio volumio[1043]: ---------------------------- MPD announces state update: player
Sep 06 11:32:16 volumio volumio[1043]: info: ControllerMpd::getState
Sep 06 11:32:16 volumio volumio[1043]: verbose: ControllerMpd::sendMpdCommand status
Sep 06 11:32:16 volumio volumio[1043]: verbose: ControllerMpd::sendMpdCommand clearerror
Sep 06 11:32:16 volumio volumio[1043]: info: sendMpdCommand status took 10 milliseconds
Sep 06 11:32:16 volumio volumio[1043]: verbose: ControllerMpd::parseState
Sep 06 11:32:16 volumio volumio[1043]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 06 11:32:16 volumio volumio[1043]: info: sendMpdCommand clearerror took 5 milliseconds
Sep 06 11:32:16 volumio volumio[1043]: info: sendMpdCommand playlistinfo took 3 milliseconds
Sep 06 11:32:16 volumio volumio[1043]: verbose: ControllerMpd::parseTrackInfo
Sep 06 11:32:16 volumio volumio[1043]: info: ControllerMpd::pushState
Sep 06 11:32:16 volumio volumio[1043]: info: CoreCommandRouter::servicePushState
Sep 06 11:32:16 volumio volumio[1043]: info: CoreStateMachine::pushState
Sep 06 11:32:16 volumio volumio[1043]: info: CorePlayQueue::getTrack 0
Sep 06 11:32:16 volumio volumio[1043]: info: CoreCommandRouter::volumioPushState
Sep 06 11:32:16 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 06 11:32:16 volumio volumio[1043]: info: CorePlayQueue::getTrack 0
Sep 06 11:32:16 volumio volumio[1043]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current personal_radio Received mpd
Sep 06 11:32:16 volumio volumio[1043]: info: ------------------------------ 43ms
Sep 06 11:32:17 volumio volumio[1043]: info: CoreCommandRouter::volumioPlay
Sep 06 11:32:17 volumio volumio[1043]: verbose: UNSET VOLATILE
Sep 06 11:32:17 volumio volumio[1043]: info: CoreStateMachine::play index 0
Sep 06 11:32:17 volumio volumio[1043]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 06 11:32:17 volumio volumio[1043]: info: CoreStateMachine::stop
Sep 06 11:32:17 volumio volumio[1043]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 06 11:32:17 volumio volumio[1043]: verbose: UNSET VOLATILE
Sep 06 11:32:17 volumio volumio[1043]: info: CoreStateMachine::stPlaybackTimer
Sep 06 11:32:17 volumio volumio[1043]: info: CoreStateMachine::updateTrackBlock
Sep 06 11:32:17 volumio volumio[1043]: info: CorePlayQueue::getTrackBlock
Sep 06 11:32:17 volumio volumio[1043]: info: CoreStateMachine::pushState
Sep 06 11:32:17 volumio volumio[1043]: info: CorePlayQueue::getTrack 0
Sep 06 11:32:17 volumio volumio[1043]: info: CoreCommandRouter::volumioPushState
Sep 06 11:32:17 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 06 11:32:17 volumio volumio[1043]: info: CoreStateMachine::serviceStop
Sep 06 11:32:17 volumio volumio[1043]: info: CorePlayQueue::getTrack 0
Sep 06 11:32:17 volumio volumio[1043]: info: CoreCommandRouter::serviceStop
Sep 06 11:32:17 volumio volumio[1043]: info: ControllerMpd::stop
Sep 06 11:32:17 volumio volumio[1043]: verbose: ControllerMpd::sendMpdCommand stop
Sep 06 11:32:17 volumio volumio[1043]: info: sendMpdCommand stop took 15 milliseconds
Sep 06 11:32:17 volumio volumio[1043]: info: ControllerMpd::getState
Sep 06 11:32:17 volumio volumio[1043]: verbose: ControllerMpd::sendMpdCommand status
Sep 06 11:32:17 volumio volumio[1043]: info: sendMpdCommand status took 12 milliseconds
Sep 06 11:32:17 volumio volumio[1043]: verbose: ControllerMpd::parseState
Sep 06 11:32:17 volumio volumio[1043]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 06 11:32:17 volumio volumio[1043]: info: sendMpdCommand playlistinfo took 6 milliseconds
Sep 06 11:32:17 volumio volumio[1043]: verbose: ControllerMpd::parseTrackInfo
Sep 06 11:32:17 volumio volumio[1043]: info: CoreStateMachine::pushState
Sep 06 11:32:17 volumio volumio[1043]: info: CorePlayQueue::getTrack 0
Sep 06 11:32:17 volumio volumio[1043]: info: CoreCommandRouter::volumioPushState
Sep 06 11:32:17 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 06 11:32:17 volumio volumio[1043]: info: CorePlayQueue::getTrack 0
Sep 06 11:32:17 volumio volumio[1043]: 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":"1fm_192_2.m3u8?Expires=1715035484&Policy=eyJTdGF0ZW1lbnQiOlt7IlJlc291cmNlIjoiaHR0cHM6Ly8xZm0uZ3NjZG4ua2JzLmNvLmtyLzFmbV8xOTJfMi5tM3U4IiwiQ29uZGl0aW9uIjp7IkRhdGVMZXNzVGhhbiI6eyJBV1M6RXBvY2hUaW1lIjoxNzE1MDM1NDg0fX19XX0_&Signature=kPE93CWGO4l30OOMM5Y0d5lwMqqZUY~dpVihltuGhzLn85ZpBLh5vIGNnsovAPdrA~1SQTvldftnlvINk-Hap7Uxd8IiJVS9tIV7nnvBbSfI2vyF~H~dTMEiXDOBhFTCv~hdTygw6ggYHFUMhbOoiIZcUAnWrhalZeC1FwkqeAYyiGKklPr8IwxuQWZBjU6~hgq798JBY~RVOXh787goNsAjeTPJYOthA3QarjoQoZVv5Ia-VP0ObHpeG2LQs29QcBblx62O4K0jN9UomI0QTOabdZllkuLNfPrphEi03es9U-kRb3HZZkHQrbSKqW3VZLLPP8NGRj8FRUIwsmByIA__&Key-Pair-Id=APKAICDSGT3Y7IXGJ3TA","artist":null,"album":null,"uri":"https://1fm.gscdn.kbs.co.kr/1fm_192_2.m3u8?Expires=1715035484&Policy=eyJTdGF0ZW1lbnQiOlt7IlJlc291cmNlIjoiaHR0cHM6Ly8xZm0uZ3NjZG4ua2JzLmNvLmtyLzFmbV8xOTJfMi5tM3U4IiwiQ29uZGl0aW9uIjp7IkRhdGVMZXNzVGhhbiI6eyJBV1M6RXBvY2hUaW1lIjoxNzE1MDM1NDg0fX19XX0_&Signature=kPE93CWGO4l30OOMM5Y0d5lwMqqZUY~dpVihltuGhzLn85ZpBLh5vIGNnsovAPdrA~1SQTvldftnlvINk-Hap7Uxd8IiJVS9tIV7nnvBbSfI2vyF~H~dTMEiXDOBhFTCv~hdTygw6ggYHFUMhbOoiIZcUAnWrhalZeC1FwkqeAYyiGKklPr8IwxuQWZBjU6~hgq798JBY~RVOXh787goNsAjeTPJYOthA3QarjoQoZVv5Ia-VP0ObHpeG2LQs29QcBblx62O4K0jN9UomI0QTOabdZllkuLNfPrphEi03es9U-kRb3HZZkHQrbSKqW3VZLLPP8NGRj8FRUIwsmByIA__&Key-Pair-Id=APKAICDSGT3Y7IXGJ3TA","trackType":""}
Sep 06 11:32:17 volumio volumio[1043]: verbose: CURRENT POSITION 0
Sep 06 11:32:17 volumio volumio[1043]: info: CoreStateMachine::syncState stateService stop
Sep 06 11:32:17 volumio volumio[1043]: info: CoreStateMachine::syncState currentStatus stop
Sep 06 11:32:17 volumio volumio[1043]: info: CoreStateMachine::pushState
Sep 06 11:32:17 volumio volumio[1043]: info: CorePlayQueue::getTrack 0
Sep 06 11:32:17 volumio volumio[1043]: info: CoreCommandRouter::volumioPushState
Sep 06 11:32:17 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 06 11:32:17 volumio volumio[1043]: info: No code
Sep 06 11:32:17 volumio volumio[1043]: info: CoreStateMachine::pushState
Sep 06 11:32:17 volumio volumio[1043]: info: CorePlayQueue::getTrack 0
Sep 06 11:32:17 volumio volumio[1043]: info: CoreCommandRouter::volumioPushState
Sep 06 11:32:17 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 06 11:32:17 volumio volumio[1043]: info: CoreStateMachine::play index undefined
Sep 06 11:32:17 volumio volumio[1043]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 06 11:32:17 volumio volumio[1043]: info: CorePlayQueue::getTrack 0
Sep 06 11:32:17 volumio volumio[1043]: info: CoreStateMachine::startPlaybackTimer
Sep 06 11:32:17 volumio volumio[1043]: info: CorePlayQueue::getTrack 0
Sep 06 11:32:17 volumio volumio[1043]: verbose: ControllerMpd::sendMpdCommand stop
Sep 06 11:32:17 volumio volumio[1043]: info: sendMpdCommand stop took 7 milliseconds
Sep 06 11:32:17 volumio volumio[1043]: verbose: ControllerMpd::sendMpdCommand clear
Sep 06 11:32:17 volumio volumio[1043]: info:
Sep 06 11:32:17 volumio volumio[1043]: ---------------------------- MPD announces system playlist update
Sep 06 11:32:17 volumio volumio[1043]: info: Ignoring MPD Status Update
Sep 06 11:32:17 volumio volumio[1043]: info: sendMpdCommand clear took 29 milliseconds
Sep 06 11:32:17 volumio volumio[1043]: verbose: ControllerMpd::sendMpdCommand add "https://1fm.gscdn.kbs.co.kr/1fm_192_2.m3u8?Expires=1715035484&Policy=eyJTdGF0ZW1lbnQiOlt7IlJlc291cmNlIjoiaHR0cHM6Ly8xZm0uZ3NjZG4ua2JzLmNvLmtyLzFmbV8xOTJfMi5tM3U4IiwiQ29uZGl0aW9uIjp7IkRhdGVMZXNzVGhhbiI6eyJBV1M6RXBvY2hUaW1lIjoxNzE1MDM1NDg0fX19XX0_&Signature=kPE93CWGO4l30OOMM5Y0d5lwMqqZUY~dpVihltuGhzLn85ZpBLh5vIGNnsovAPdrA~1SQTvldftnlvINk-Hap7Uxd8IiJVS9tIV7nnvBbSfI2vyF~H~dTMEiXDOBhFTCv~hdTygw6ggYHFUMhbOoiIZcUAnWrhalZeC1FwkqeAYyiGKklPr8IwxuQWZBjU6~hgq798JBY~RVOXh787goNsAjeTPJYOthA3QarjoQoZVv5Ia-VP0ObHpeG2LQs29QcBblx62O4K0jN9UomI0QTOabdZllkuLNfPrphEi03es9U-kRb3HZZkHQrbSKqW3VZLLPP8NGRj8FRUIwsmByIA__&Key-Pair-Id=APKAICDSGT3Y7IXGJ3TA"
Sep 06 11:32:17 volumio volumio[1043]: error: updateQueue error: null
Sep 06 11:32:17 volumio volumio[1043]: info:
Sep 06 11:32:17 volumio volumio[1043]: ---------------------------- MPD announces system playlist update
Sep 06 11:32:17 volumio volumio[1043]: info: Ignoring MPD Status Update
Sep 06 11:32:17 volumio volumio[1043]: info: ------------------------------ 33ms
Sep 06 11:32:17 volumio volumio[1043]: info: sendMpdCommand add "https://1fm.gscdn.kbs.co.kr/1fm_192_2.m3u8?Expires=1715035484&Policy=eyJTdGF0ZW1lbnQiOlt7IlJlc291cmNlIjoiaHR0cHM6Ly8xZm0uZ3NjZG4ua2JzLmNvLmtyLzFmbV8xOTJfMi5tM3U4IiwiQ29uZGl0aW9uIjp7IkRhdGVMZXNzVGhhbiI6eyJBV1M6RXBvY2hUaW1lIjoxNzE1MDM1NDg0fX19XX0_&Signature=kPE93CWGO4l30OOMM5Y0d5lwMqqZUY~dpVihltuGhzLn85ZpBLh5vIGNnsovAPdrA~1SQTvldftnlvINk-Hap7Uxd8IiJVS9tIV7nnvBbSfI2vyF~H~dTMEiXDOBhFTCv~hdTygw6ggYHFUMhbOoiIZcUAnWrhalZeC1FwkqeAYyiGKklPr8IwxuQWZBjU6~hgq798JBY~RVOXh787goNsAjeTPJYOthA3QarjoQoZVv5Ia-VP0ObHpeG2LQs29QcBblx62O4K0jN9UomI0QTOabdZllkuLNfPrphEi03es9U-kRb3HZZkHQrbSKqW3VZLLPP8NGRj8FRUIwsmByIA__&Key-Pair-Id=APKAICDSGT3Y7IXGJ3TA" took 31 milliseconds
Sep 06 11:32:18 volumio volumio[1043]: verbose: ControllerMpd::sendMpdCommand play
Sep 06 11:32:18 volumio volumio[1043]: info: ------------------------------ 30ms
Sep 06 11:32:18 volumio volumio[1043]: info: sendMpdCommand play took 23 milliseconds
Sep 06 11:32:18 volumio volumio[1043]: info: ControllerMpd::getState
Sep 06 11:32:18 volumio volumio[1043]: verbose: ControllerMpd::sendMpdCommand status
Sep 06 11:32:18 volumio volumio[1043]: info: touch_display: Setting screensaver timeout to 120 seconds.
Sep 06 11:32:18 volumio volumio[1043]: info: sendMpdCommand status took 7 milliseconds
Sep 06 11:32:18 volumio volumio[1043]: verbose: ControllerMpd::parseState
Sep 06 11:32:18 volumio volumio[1043]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 06 11:32:18 volumio volumio[1043]: info: sendMpdCommand playlistinfo took 23 milliseconds
Sep 06 11:32:18 volumio volumio[1043]: verbose: ControllerMpd::parseTrackInfo
Sep 06 11:32:18 volumio volumio[1043]: info: CorePlayQueue::getTrack 0
Sep 06 11:32:18 volumio volumio[1043]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1fm_192_2.m3u8?Expires=1715035484&Policy=eyJTdGF0ZW1lbnQiOlt7IlJlc291cmNlIjoiaHR0cHM6Ly8xZm0uZ3NjZG4ua2JzLmNvLmtyLzFmbV8xOTJfMi5tM3U4IiwiQ29uZGl0aW9uIjp7IkRhdGVMZXNzVGhhbiI6eyJBV1M6RXBvY2hUaW1lIjoxNzE1MDM1NDg0fX19XX0_&Signature=kPE93CWGO4l30OOMM5Y0d5lwMqqZUY~dpVihltuGhzLn85ZpBLh5vIGNnsovAPdrA~1SQTvldftnlvINk-Hap7Uxd8IiJVS9tIV7nnvBbSfI2vyF~H~dTMEiXDOBhFTCv~hdTygw6ggYHFUMhbOoiIZcUAnWrhalZeC1FwkqeAYyiGKklPr8IwxuQWZBjU6~hgq798JBY~RVOXh787goNsAjeTPJYOthA3QarjoQoZVv5Ia-VP0ObHpeG2LQs29QcBblx62O4K0jN9UomI0QTOabdZllkuLNfPrphEi03es9U-kRb3HZZkHQrbSKqW3VZLLPP8NGRj8FRUIwsmByIA__&Key-Pair-Id=APKAICDSGT3Y7IXGJ3TA","artist":null,"album":null,"uri":"https://1fm.gscdn.kbs.co.kr/1fm_192_2.m3u8?Expires=1715035484&Policy=eyJTdGF0ZW1lbnQiOlt7IlJlc291cmNlIjoiaHR0cHM6Ly8xZm0uZ3NjZG4ua2JzLmNvLmtyLzFmbV8xOTJfMi5tM3U4IiwiQ29uZGl0aW9uIjp7IkRhdGVMZXNzVGhhbiI6eyJBV1M6RXBvY2hUaW1lIjoxNzE1MDM1NDg0fX19XX0_&Signature=kPE93CWGO4l30OOMM5Y0d5lwMqqZUY~dpVihltuGhzLn85ZpBLh5vIGNnsovAPdrA~1SQTvldftnlvINk-Hap7Uxd8IiJVS9tIV7nnvBbSfI2vyF~H~dTMEiXDOBhFTCv~hdTygw6ggYHFUMhbOoiIZcUAnWrhalZeC1FwkqeAYyiGKklPr8IwxuQWZBjU6~hgq798JBY~RVOXh787goNsAjeTPJYOthA3QarjoQoZVv5Ia-VP0ObHpeG2LQs29QcBblx62O4K0jN9UomI0QTOabdZllkuLNfPrphEi03es9U-kRb3HZZkHQrbSKqW3VZLLPP8NGRj8FRUIwsmByIA__&Key-Pair-Id=APKAICDSGT3Y7IXGJ3TA","trackType":""}
Sep 06 11:32:18 volumio volumio[1043]: verbose: CURRENT POSITION 0
Sep 06 11:32:18 volumio volumio[1043]: info: CoreStateMachine::syncState stateService play
Sep 06 11:32:18 volumio volumio[1043]: info: CoreStateMachine::syncState currentStatus stop
Sep 06 11:32:18 volumio volumio[1043]: info: CoreStateMachine::pushState
Sep 06 11:32:18 volumio volumio[1043]: info: CorePlayQueue::getTrack 0
Sep 06 11:32:18 volumio volumio[1043]: info: CoreCommandRouter::volumioPushState
Sep 06 11:32:18 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 06 11:32:18 volumio volumio[1043]: info:
Sep 06 11:32:18 volumio volumio[1043]: ---------------------------- MPD announces state update: player
Sep 06 11:32:18 volumio volumio[1043]: info: ControllerMpd::getState
Sep 06 11:32:18 volumio volumio[1043]: verbose: ControllerMpd::sendMpdCommand status
Sep 06 11:32:18 volumio volumio[1043]: verbose: ControllerMpd::sendMpdCommand clearerror
Sep 06 11:32:18 volumio volumio[1043]: info: sendMpdCommand status took 13 milliseconds
Sep 06 11:32:18 volumio volumio[1043]: verbose: ControllerMpd::parseState
Sep 06 11:32:18 volumio volumio[1043]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 06 11:32:18 volumio volumio[1043]: info: sendMpdCommand clearerror took 8 milliseconds
Sep 06 11:32:18 volumio volumio[1043]: info: sendMpdCommand playlistinfo took 7 milliseconds
Sep 06 11:32:18 volumio volumio[1043]: verbose: ControllerMpd::parseTrackInfo
Sep 06 11:32:18 volumio volumio[1043]: info: ControllerMpd::pushState
Sep 06 11:32:18 volumio volumio[1043]: info: CoreCommandRouter::servicePushState
Sep 06 11:32:18 volumio volumio[1043]: info: CoreStateMachine::pushState
Sep 06 11:32:18 volumio volumio[1043]: info: CorePlayQueue::getTrack 0
Sep 06 11:32:18 volumio volumio[1043]: info: CoreCommandRouter::volumioPushState
Sep 06 11:32:18 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 06 11:32:18 volumio volumio[1043]: info: CorePlayQueue::getTrack 0
Sep 06 11:32:18 volumio volumio[1043]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current personal_radio Received mpd
Sep 06 11:32:18 volumio volumio[1043]: info: ------------------------------ 53ms
Sep 06 11:32:19 volumio volumio[1043]: info: CoreCommandRouter::volumioRemoveQueueItem
Sep 06 11:32:19 volumio volumio[1043]: info: CoreStateMachine::removeQueueItem
Sep 06 11:32:19 volumio volumio[1043]: info: CoreStateMachine::stop
Sep 06 11:32:19 volumio volumio[1043]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 06 11:32:19 volumio volumio[1043]: verbose: UNSET VOLATILE
Sep 06 11:32:19 volumio volumio[1043]: info: CoreStateMachine::stPlaybackTimer
Sep 06 11:32:19 volumio volumio[1043]: info: CoreStateMachine::updateTrackBlock
Sep 06 11:32:19 volumio volumio[1043]: info: CorePlayQueue::getTrackBlock
Sep 06 11:32:19 volumio volumio[1043]: info: CoreStateMachine::pushState
Sep 06 11:32:19 volumio volumio[1043]: info: CorePlayQueue::getTrack 0
Sep 06 11:32:19 volumio volumio[1043]: info: CoreCommandRouter::volumioPushState
Sep 06 11:32:19 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 06 11:32:19 volumio volumio[1043]: info: CoreStateMachine::serviceStop
Sep 06 11:32:19 volumio volumio[1043]: info: CorePlayQueue::getTrack 0
Sep 06 11:32:19 volumio volumio[1043]: info: CoreCommandRouter::serviceStop
Sep 06 11:32:19 volumio volumio[1043]: info: ControllerMpd::stop
Sep 06 11:32:19 volumio volumio[1043]: verbose: ControllerMpd::sendMpdCommand stop
Sep 06 11:32:19 volumio volumio[1043]: info: CorePlayQueue::removeQueueItem 0
Sep 06 11:32:19 volumio volumio[1043]: info: CorePlayQueue::saveQueue
Sep 06 11:32:19 volumio volumio[1043]: info: CoreCommandRouter::volumioPushQueue
Sep 06 11:32:19 volumio volumio[1043]: info: sendMpdCommand stop took 23 milliseconds
Sep 06 11:32:19 volumio volumio[1043]: info: ControllerMpd::getState
Sep 06 11:32:19 volumio volumio[1043]: verbose: ControllerMpd::sendMpdCommand status
Sep 06 11:32:19 volumio volumio[1043]: info: sendMpdCommand status took 14 milliseconds
Sep 06 11:32:19 volumio volumio[1043]: verbose: ControllerMpd::parseState
Sep 06 11:32:19 volumio volumio[1043]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Sep 06 11:32:19 volumio volumio[1043]: info: sendMpdCommand playlistinfo took 2 milliseconds
Sep 06 11:32:19 volumio volumio[1043]: verbose: ControllerMpd::parseTrackInfo
Sep 06 11:32:19 volumio volumio[1043]: info: CoreStateMachine::pushState
Sep 06 11:32:19 volumio volumio[1043]: info: CorePlayQueue::getTrack 0
Sep 06 11:32:19 volumio volumio[1043]: info: CoreCommandRouter::volumioPushState
Sep 06 11:32:19 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 06 11:32:19 volumio volumio[1043]: info: CorePlayQueue::getTrack 0
Sep 06 11:32:19 volumio volumio[1043]: 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":"1fm_192_2.m3u8?Expires=1715035484&Policy=eyJTdGF0ZW1lbnQiOlt7IlJlc291cmNlIjoiaHR0cHM6Ly8xZm0uZ3NjZG4ua2JzLmNvLmtyLzFmbV8xOTJfMi5tM3U4IiwiQ29uZGl0aW9uIjp7IkRhdGVMZXNzVGhhbiI6eyJBV1M6RXBvY2hUaW1lIjoxNzE1MDM1NDg0fX19XX0_&Signature=kPE93CWGO4l30OOMM5Y0d5lwMqqZUY~dpVihltuGhzLn85ZpBLh5vIGNnsovAPdrA~1SQTvldftnlvINk-Hap7Uxd8IiJVS9tIV7nnvBbSfI2vyF~H~dTMEiXDOBhFTCv~hdTygw6ggYHFUMhbOoiIZcUAnWrhalZeC1FwkqeAYyiGKklPr8IwxuQWZBjU6~hgq798JBY~RVOXh787goNsAjeTPJYOthA3QarjoQoZVv5Ia-VP0ObHpeG2LQs29QcBblx62O4K0jN9UomI0QTOabdZllkuLNfPrphEi03es9U-kRb3HZZkHQrbSKqW3VZLLPP8NGRj8FRUIwsmByIA__&Key-Pair-Id=APKAICDSGT3Y7IXGJ3TA","artist":null,"album":null,"uri":"https://1fm.gscdn.kbs.co.kr/1fm_192_2.m3u8?Expires=1715035484&Policy=eyJTdGF0ZW1lbnQiOlt7IlJlc291cmNlIjoiaHR0cHM6Ly8xZm0uZ3NjZG4ua2JzLmNvLmtyLzFmbV8xOTJfMi5tM3U4IiwiQ29uZGl0aW9uIjp7IkRhdGVMZXNzVGhhbiI6eyJBV1M6RXBvY2hUaW1lIjoxNzE1MDM1NDg0fX19XX0_&Signature=kPE93CWGO4l30OOMM5Y0d5lwMqqZUY~dpVihltuGhzLn85ZpBLh5vIGNnsovAPdrA~1SQTvldftnlvINk-Hap7Uxd8IiJVS9tIV7nnvBbSfI2vyF~H~dTMEiXDOBhFTCv~hdTygw6ggYHFUMhbOoiIZcUAnWrhalZeC1FwkqeAYyiGKklPr8IwxuQWZBjU6~hgq798JBY~RVOXh787goNsAjeTPJYOthA3QarjoQoZVv5Ia-VP0ObHpeG2LQs29QcBblx62O4K0jN9UomI0QTOabdZllkuLNfPrphEi03es9U-kRb3HZZkHQrbSKqW3VZLLPP8NGRj8FRUIwsmByIA__&Key-Pair-Id=APKAICDSGT3Y7IXGJ3TA","trackType":""}
Sep 06 11:32:19 volumio volumio[1043]: verbose: CURRENT POSITION 0
Sep 06 11:32:19 volumio volumio[1043]: info: CoreStateMachine::syncState stateService stop
Sep 06 11:32:19 volumio volumio[1043]: info: CoreStateMachine::syncState currentStatus stop
Sep 06 11:32:19 volumio volumio[1043]: info: CoreStateMachine::pushState
Sep 06 11:32:19 volumio volumio[1043]: info: CorePlayQueue::getTrack 0
Sep 06 11:32:19 volumio volumio[1043]: info: CoreCommandRouter::volumioPushState
Sep 06 11:32:19 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 06 11:32:19 volumio volumio[1043]: info: No code
Sep 06 11:32:19 volumio volumio[1043]: info: CoreStateMachine::pushState
Sep 06 11:32:19 volumio volumio[1043]: info: CorePlayQueue::getTrack 0
Sep 06 11:32:19 volumio volumio[1043]: info: CoreCommandRouter::volumioPushState
Sep 06 11:32:19 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 06 11:32:19 volumio volumio[1043]: info: touch_display: Setting screensaver timeout to 120 seconds.
Sep 06 11:32:22 volumio volumio[1043]: info: CoreCommandRouter::volumioGetVisibleSources
Sep 06 11:32:22 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 06 11:32:26 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Sep 06 11:32:26 volumio volumio[1043]: info: CURURI: music-library
Sep 06 11:32:26 volumio volumio[1043]: error: Failed LSINFO: null
Sep 06 11:32:28 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Sep 06 11:32:28 volumio volumio[1043]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Sep 06 11:32:28 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Sep 06 11:32:28 volumio volumio[1043]: info: Error : CoreCommandRouter::executeOnPlugin: No method [retreiveBackendEventStates] in plugin my_volumio
Sep 06 11:32:28 volumio volumio[1043]: info: Received Get System Version
Sep 06 11:32:28 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 06 11:32:31 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri
Sep 06 11:32:32 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri
Sep 06 11:32:34 volumio volumio[1043]: info: CoreCommandRouter::volumioReplaceandPlayItems
Sep 06 11:32:34 volumio volumio[1043]: info: CoreStateMachine::ClearQueue
Sep 06 11:32:34 volumio volumio[1043]: info: CoreStateMachine::stop
Sep 06 11:32:34 volumio volumio[1043]: info: CoreStateMachine::setConsumeUpdateService undefined
Sep 06 11:32:34 volumio volumio[1043]: verbose: UNSET VOLATILE
Sep 06 11:32:34 volumio volumio[1043]: info: CorePlayQueue::clearPlayQueue
Sep 06 11:32:34 volumio volumio[1043]: info: CorePlayQueue::saveQueue
Sep 06 11:32:34 volumio volumio[1043]: info: CoreCommandRouter::volumioPushState
Sep 06 11:32:34 volumio volumio[1043]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 06 11:32:34 volumio volumio[1043]: info: CoreCommandRouter::volumioPushQueue
Sep 06 11:32:34 volumio volumio[1043]: info: CoreStateMachine::addQueueItems
Sep 06 11:32:34 volumio volumio[1043]: info: CorePlayQueue::addQueueItems
Sep 06 11:32:34 volumio volumio[1043]: info: Adding Item to queue: webkbs/0
Sep 06 11:32:34 volumio volumio[1043]: info: Exploding uri webkbs/0 in service personal_radio
Sep 06 11:32:35 volumio volumio[1043]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 06 11:32:35 volumio volumio[1043]: ReferenceError: self is not defined
Sep 06 11:32:35 volumio volumio[1043]: at ControllerPersonalRadio.errorToast (/data/plugins/music_service/personal_radio/index.js:575:22)
Sep 06 11:32:35 volumio volumio[1043]: at /data/plugins/music_service/personal_radio/index.js:487:12
Sep 06 11:32:35 volumio volumio[1043]: at Request.handleRequestResponse [as _callback] (/data/plugins/music_service/personal_radio/node_modules/unirest/index.js:355:15)
Sep 06 11:32:35 volumio volumio[1043]: at self.callback (/data/plugins/music_service/personal_radio/node_modules/request/request.js:187:22)
Sep 06 11:32:35 volumio volumio[1043]: at emitOne (events.js:116:13)
Sep 06 11:32:35 volumio volumio[1043]: at Request.emit (events.js:211:7)
Sep 06 11:32:35 volumio volumio[1043]: at Request.onRequestError (/data/plugins/music_service/personal_radio/node_modules/request/request.js:813:8)
Sep 06 11:32:35 volumio volumio[1043]: at emitOne (events.js:116:13)
Sep 06 11:32:35 volumio volumio[1043]: at ClientRequest.emit (events.js:211:7)
Sep 06 11:32:35 volumio volumio[1043]: at Socket.socketErrorListener (_http_client.js:387:9)
Sep 06 11:32:35 volumio volumio[1043]: at emitOne (events.js:116:13)
Sep 06 11:32:35 volumio volumio[1043]: at Socket.emit (events.js:211:7)
Sep 06 11:32:35 volumio volumio[1043]: at emitErrorNT (internal/streams/destroy.js:64:8)
Sep 06 11:32:35 volumio volumio[1043]: at _combinedTickCallback (internal/process/next_tick.js:138:11)
Sep 06 11:32:35 volumio volumio[1043]: at process._tickCallback (internal/process/next_tick.js:180:9)
Sep 06 11:32:35 volumio volumio[1043]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 06 11:32:36 volumio sudo[1829]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-06 11:31
Sep 06 11:32:36 volumio sudo[1829]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)"
NAME="Raspbian GNU/Linux"
VERSION_ID="8"
VERSION="8 (jessie)"
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="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03"
VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae"
VOLUMIO_BE_VERSION="307f91893fca011201acba9973e1c41bd3a0ad5d"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu Sep 30 22:42:09 CEST 2021"
VOLUMIO_VERSION="2.915"
VOLUMIO_HARDWARE="pi"
VOLUMIO_HASH="02ee61bb422c79b6e5c0b6d1847a78d9"