Jul 10 14:16:07 volumio volumio[1078]: info: CoreCommandRouter::volumioSeek
Jul 10 14:16:07 volumio volumio[1078]: info: CoreStateMachine::seek
Jul 10 14:16:07 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:07 volumio volumio[1078]: info: TRACKBLOCK {"service":"youtube2","uri":"youtube2/video@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22K2e4MEFVvs0%22%2C%22playlistId%22%3A%22RDK2e4MEFVvs0%22%2C%22params%22%3A%22OAHAAQGqAxjjgrnjg47jg7zjg5bjg6njgqTjg7Pjg4m6AwsIpsyW1M3f1a-pAboDCgjVyai62OypxSu6AwoIrqvfyebm07NzugMPEg1SRHFWOVdfTnFGcGlZugMLCNC6nbGD3piBkwG6AwsI9IOHpJ7Fvdb5AboDCgiepLOB3YCe4Ce6AwoIwqr53OyTu-cGugMLCOv2ko_KzaOb6gG6AwoIrtHylPb0p_xDugMLCPmYpIfJx8GR6AG6AwsIkYTj4Kfq65rmAboDCgjg9NHx4raF1FS6AwoIwbPNiJKe1tNKugMLCL-vqbSFvcaT3gG6AwoI3Y7njfaD8IB9ugMLCO7pzYmpidq98QG6AwsIt6Ha0daGsbTlAboDCgjp1qqhlvSx8D3yAwUNQW_bPbgFAQ%253D%253D%22%7D%7D@explodeTrackData:o=%7B%22title%22%3A%22%E5%B9%B3%E6%B2%A2%E9%80%B2%20Susumu%20Hirasawa%20-%20Snow%20Blind%20(Hybrid%20Phonon)%22%2C%22artist%22%3A%22hrsw_vt%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2FK2e4MEFVvs0%2Fhqdefault.jpg%3Fsqp%3D-oaymwEjCOADEI4CSFryq4qpAxUIARUAAAAAGAElAADIQj0AgKJDeAE%3D%26rs%3DAOn4CLD7SYZSiCVZgmke0PE51Hzuujk1nw%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22K2e4MEFVvs0%22%2C%22playlistId%22%3A%22RDK2e4MEFVvs0%22%2C%22params%22%3A%22OAHAAQGqAxjjgrnjg47jg7zjg5bjg6njgqTjg7Pjg4m6AwsIpsyW1M3f1a-pAboDCgjVyai62OypxSu6AwoIrqvfyebm07NzugMPEg1SRHFWOVdfTnFGcGlZugMLCNC6nbGD3piBkwG6AwsI9IOHpJ7Fvdb5AboDCgiepLOB3YCe4Ce6AwoIwqr53OyTu-cGugMLCOv2ko_KzaOb6gG6AwoIrtHylPb0p_xDugMLCPmYpIfJx8GR6AG6AwsIkYTj4Kfq65rmAboDCgjg9NHx4raF1FS6AwoIwbPNiJKe1tNKugMLCL-vqbSFvcaT3gG6AwoI3Y7njfaD8IB9ugMLCO7pzYmpidq98QG6AwsIt6Ha0daGsbTlAboDCgjp1qqhlvSx8D3yAwUNQW_bPbgFAQ%253D%253D%22%7D%7D%7D","albumart":"https://i.ytimg.com/vi/K2e4MEFVvs0/hqdefault.jpg","artist":"hrsw_vt","album":"YouTube","name":"平沢進 Susumu Hirasawa - Snow Blind (Hybrid Phonon)","title":"平沢進 Susumu Hirasawa - Snow Blind (Hybrid Phonon)","duration":401,"samplerate":"160 kbps"}
Jul 10 14:16:07 volumio volumio[1078]: info: CoreStateMachine::startPlaybackTimer
Jul 10 14:16:07 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:07 volumio volumio[1078]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 10 14:16:07 volumio volumio[1078]: info: ControllerMpd::seek
Jul 10 14:16:07 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:07 volumio volumio[1078]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 10 14:16:07 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:07 volumio mpd[1322]: ffmpeg/matroska,webm: File ended prematurely
Jul 10 14:16:08 volumio volumio[1078]: error: null
Jul 10 14:16:08 volumio volumio[1078]: info:
Jul 10 14:16:08 volumio volumio[1078]: ---------------------------- MPD announces state update: player
Jul 10 14:16:08 volumio volumio[1078]: info: ControllerMpd::getState
Jul 10 14:16:08 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand status
Jul 10 14:16:08 volumio volumio[1078]: info:
Jul 10 14:16:08 volumio volumio[1078]: ---------------------------- MPD announces state update: player
Jul 10 14:16:08 volumio volumio[1078]: info: ControllerMpd::getState
Jul 10 14:16:08 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand status
Jul 10 14:16:08 volumio volumio[1078]: info:
Jul 10 14:16:08 volumio volumio[1078]: ---------------------------- MPD announces state update: player
Jul 10 14:16:08 volumio volumio[1078]: info: ControllerMpd::getState
Jul 10 14:16:08 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand status
Jul 10 14:16:08 volumio volumio[1078]: info: sendMpdCommand status took 18 milliseconds
Jul 10 14:16:08 volumio volumio[1078]: info: sendMpdCommand status took 15 milliseconds
Jul 10 14:16:08 volumio volumio[1078]: info: sendMpdCommand status took 4 milliseconds
Jul 10 14:16:08 volumio volumio[1078]: verbose: ControllerMpd::parseState
Jul 10 14:16:08 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 10 14:16:08 volumio volumio[1078]: verbose: ControllerMpd::parseState
Jul 10 14:16:08 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 10 14:16:08 volumio volumio[1078]: verbose: ControllerMpd::parseState
Jul 10 14:16:08 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 10 14:16:08 volumio volumio[1078]: info: sendMpdCommand playlistinfo took 34 milliseconds
Jul 10 14:16:08 volumio volumio[1078]: info: sendMpdCommand playlistinfo took 11 milliseconds
Jul 10 14:16:08 volumio volumio[1078]: info: sendMpdCommand playlistinfo took 11 milliseconds
Jul 10 14:16:08 volumio volumio[1078]: verbose: ControllerMpd::parseTrackInfo
Jul 10 14:16:08 volumio volumio[1078]: verbose: ControllerMpd::parseTrackInfo
Jul 10 14:16:08 volumio volumio[1078]: verbose: ControllerMpd::parseTrackInfo
Jul 10 14:16:08 volumio volumio[1078]: info: ControllerMpd::pushState
Jul 10 14:16:08 volumio volumio[1078]: info: CoreCommandRouter::servicePushState
Jul 10 14:16:08 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:08 volumio volumio[1078]: verbose: STATE SERVICE {"status":"play","position":0,"seek":63000,"duration":401,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"平沢進 Susumu Hirasawa - Snow Blind (Hybrid Phonon)","artist":"hrsw_vt","album":"YouTube","uri":"https://rr4---sn-ogul7n7s.googlevideo.com/videoplayback?expire=1752146157&ei=jUxvaNT2DNWx-dIPk7PF0Qw&ip=133.32.225.246&id=o-APvHs7AAzpWT4no2bUW5J8u3mOr4Yeqy4OvMt27f6RLz&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1752124557%2C&mh=JF&mm=31%2C29&mn=sn-ogul7n7s%2Csn-oguelnzy&ms=au%2Crdu&mv=m&mvi=4&pl=19&rms=au%2Cau&initcwndbps=2780000&bui=AY1jyLOVzst9wJFIi4oEPwkGK97-1vvhXFwKTEtDRYy22bVM8JYyyQgu-bXtZlaMMONSGqS9qnqo0Gbt&spc=l3OVKSyDnO1ASDbpB6BLLoZWB2VgejezTz7--SFyacqLnz5WnirgQg&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=ob6LAJPPb5UkUpJX36Rz95EQ&rqh=1&gir=yes&clen=6531091&dur=401.261&lmt=1669426681939773&mt=1752124147&fvip=3&keepalive=yes&fexp=51476174&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=6218224&n=nfu42lxoWwhwEQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgYRfO64gmFMgoLbeEXPT70TjdAbb0Z2XhlBT5Dewti5YCIBwDXA0hp9Hy3Sk4jVVk_u9rdqm_b153FVsrFeHMSoox&sig=AJfQdSswRQIhAOxXs8aWGlHyQ_bU7C0V5Ri0P6ajEEYmW5uRPRuGwjnBAiA3tneU0ULS3ZRorjRNrQ_sG7_oW6mNeHey4YS6m9dtAw%3D%3D&pot=Mni_eQLHpKeg2L9FnoEqmXRQzgwNJHHDZYKQZPt6-3GhlJT6DKJaMI2l52mCaWI-6K4Ftq4g4acJUzNCLJcUTfhd2Ile65OK-Xn67aojdzXItmrXvcTQlpNzhWsHT3g3FjS5_FZK-Da0tAWCvR9LTFB7Uooqvqy7_xY%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"}
Jul 10 14:16:08 volumio volumio[1078]: verbose: CURRENT POSITION 0
Jul 10 14:16:08 volumio volumio[1078]: info: CoreStateMachine::syncState stateService play
Jul 10 14:16:08 volumio volumio[1078]: info: CoreStateMachine::syncState currentStatus play
Jul 10 14:16:08 volumio volumio[1078]: info: Received an update from plugin. extracting info from payload
Jul 10 14:16:08 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:08 volumio volumio[1078]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 10 14:16:08 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:08 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:08 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:08 volumio volumio[1078]: info: ControllerMpd::pushState
Jul 10 14:16:08 volumio volumio[1078]: info: CoreCommandRouter::servicePushState
Jul 10 14:16:08 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:08 volumio volumio[1078]: verbose: STATE SERVICE {"status":"play","position":0,"seek":63000,"duration":401,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"平沢進 Susumu Hirasawa - Snow Blind (Hybrid Phonon)","artist":"hrsw_vt","album":"YouTube","uri":"https://rr4---sn-ogul7n7s.googlevideo.com/videoplayback?expire=1752146157&ei=jUxvaNT2DNWx-dIPk7PF0Qw&ip=133.32.225.246&id=o-APvHs7AAzpWT4no2bUW5J8u3mOr4Yeqy4OvMt27f6RLz&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1752124557%2C&mh=JF&mm=31%2C29&mn=sn-ogul7n7s%2Csn-oguelnzy&ms=au%2Crdu&mv=m&mvi=4&pl=19&rms=au%2Cau&initcwndbps=2780000&bui=AY1jyLOVzst9wJFIi4oEPwkGK97-1vvhXFwKTEtDRYy22bVM8JYyyQgu-bXtZlaMMONSGqS9qnqo0Gbt&spc=l3OVKSyDnO1ASDbpB6BLLoZWB2VgejezTz7--SFyacqLnz5WnirgQg&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=ob6LAJPPb5UkUpJX36Rz95EQ&rqh=1&gir=yes&clen=6531091&dur=401.261&lmt=1669426681939773&mt=1752124147&fvip=3&keepalive=yes&fexp=51476174&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=6218224&n=nfu42lxoWwhwEQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgYRfO64gmFMgoLbeEXPT70TjdAbb0Z2XhlBT5Dewti5YCIBwDXA0hp9Hy3Sk4jVVk_u9rdqm_b153FVsrFeHMSoox&sig=AJfQdSswRQIhAOxXs8aWGlHyQ_bU7C0V5Ri0P6ajEEYmW5uRPRuGwjnBAiA3tneU0ULS3ZRorjRNrQ_sG7_oW6mNeHey4YS6m9dtAw%3D%3D&pot=Mni_eQLHpKeg2L9FnoEqmXRQzgwNJHHDZYKQZPt6-3GhlJT6DKJaMI2l52mCaWI-6K4Ftq4g4acJUzNCLJcUTfhd2Ile65OK-Xn67aojdzXItmrXvcTQlpNzhWsHT3g3FjS5_FZK-Da0tAWCvR9LTFB7Uooqvqy7_xY%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"}
Jul 10 14:16:08 volumio volumio[1078]: verbose: CURRENT POSITION 0
Jul 10 14:16:08 volumio volumio[1078]: info: CoreStateMachine::syncState stateService play
Jul 10 14:16:08 volumio volumio[1078]: info: CoreStateMachine::syncState currentStatus play
Jul 10 14:16:08 volumio volumio[1078]: info: Received an update from plugin. extracting info from payload
Jul 10 14:16:08 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:08 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:08 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:08 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:08 volumio volumio[1078]: info: ControllerMpd::pushState
Jul 10 14:16:08 volumio volumio[1078]: info: CoreCommandRouter::servicePushState
Jul 10 14:16:08 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:08 volumio volumio[1078]: verbose: STATE SERVICE {"status":"play","position":0,"seek":63000,"duration":401,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"平沢進 Susumu Hirasawa - Snow Blind (Hybrid Phonon)","artist":"hrsw_vt","album":"YouTube","uri":"https://rr4---sn-ogul7n7s.googlevideo.com/videoplayback?expire=1752146157&ei=jUxvaNT2DNWx-dIPk7PF0Qw&ip=133.32.225.246&id=o-APvHs7AAzpWT4no2bUW5J8u3mOr4Yeqy4OvMt27f6RLz&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1752124557%2C&mh=JF&mm=31%2C29&mn=sn-ogul7n7s%2Csn-oguelnzy&ms=au%2Crdu&mv=m&mvi=4&pl=19&rms=au%2Cau&initcwndbps=2780000&bui=AY1jyLOVzst9wJFIi4oEPwkGK97-1vvhXFwKTEtDRYy22bVM8JYyyQgu-bXtZlaMMONSGqS9qnqo0Gbt&spc=l3OVKSyDnO1ASDbpB6BLLoZWB2VgejezTz7--SFyacqLnz5WnirgQg&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=ob6LAJPPb5UkUpJX36Rz95EQ&rqh=1&gir=yes&clen=6531091&dur=401.261&lmt=1669426681939773&mt=1752124147&fvip=3&keepalive=yes&fexp=51476174&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=6218224&n=nfu42lxoWwhwEQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgYRfO64gmFMgoLbeEXPT70TjdAbb0Z2XhlBT5Dewti5YCIBwDXA0hp9Hy3Sk4jVVk_u9rdqm_b153FVsrFeHMSoox&sig=AJfQdSswRQIhAOxXs8aWGlHyQ_bU7C0V5Ri0P6ajEEYmW5uRPRuGwjnBAiA3tneU0ULS3ZRorjRNrQ_sG7_oW6mNeHey4YS6m9dtAw%3D%3D&pot=Mni_eQLHpKeg2L9FnoEqmXRQzgwNJHHDZYKQZPt6-3GhlJT6DKJaMI2l52mCaWI-6K4Ftq4g4acJUzNCLJcUTfhd2Ile65OK-Xn67aojdzXItmrXvcTQlpNzhWsHT3g3FjS5_FZK-Da0tAWCvR9LTFB7Uooqvqy7_xY%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"}
Jul 10 14:16:08 volumio volumio[1078]: verbose: CURRENT POSITION 0
Jul 10 14:16:08 volumio volumio[1078]: info: CoreStateMachine::syncState stateService play
Jul 10 14:16:08 volumio volumio[1078]: info: CoreStateMachine::syncState currentStatus play
Jul 10 14:16:08 volumio volumio[1078]: info: Received an update from plugin. extracting info from payload
Jul 10 14:16:08 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:08 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:08 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:08 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:08 volumio volumio[1078]: info: ------------------------------ 295ms
Jul 10 14:16:08 volumio volumio[1078]: info: ------------------------------ 300ms
Jul 10 14:16:08 volumio volumio[1078]: info: ------------------------------ 301ms
Jul 10 14:16:09 volumio mpd[1322]: ffmpeg/opus: Could not update timestamps for skipped samples.
Jul 10 14:16:14 volumio volumio[1078]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jul 10 14:16:14 volumio volumio[1078]: info: CURURI: music-library
Jul 10 14:16:14 volumio mpd[1322]: exception: No database
Jul 10 14:16:14 volumio volumio[1078]: error: Failed LSINFO: Error: [50@0] {lsinfo} No database
Jul 10 14:16:14 volumio volumio[1078]: info: Preload queue cleared
Jul 10 14:16:16 volumio volumio[1078]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jul 10 14:16:16 volumio volumio[1078]: info: CURURI: artists://
Jul 10 14:16:16 volumio mpd[1322]: exception: No database
Jul 10 14:16:16 volumio volumio[1078]: error: Failed to execute browseSource: Error: Cannot list artist
Jul 10 14:16:18 volumio volumio[1078]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jul 10 14:16:18 volumio volumio[1078]: info: CURURI: playlists
Jul 10 14:16:18 volumio volumio[1078]: info: Listing playlists
Jul 10 14:16:18 volumio volumio[1078]: info: Preload queue cleared
Jul 10 14:16:19 volumio volumio[1078]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jul 10 14:16:19 volumio volumio[1078]: info: CURURI: music-library
Jul 10 14:16:19 volumio mpd[1322]: exception: No database
Jul 10 14:16:19 volumio volumio[1078]: error: Failed LSINFO: Error: [50@0] {lsinfo} No database
Jul 10 14:16:19 volumio volumio[1078]: info: Preload queue cleared
Jul 10 14:16:25 volumio volumio[1078]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Jul 10 14:16:25 volumio volumio[1078]: info: Preload queue cleared
Jul 10 14:16:26 volumio volumio[1078]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Jul 10 14:16:26 volumio volumio[1078]: info: TuneIn handleBrowseUri: tunein/local
Jul 10 14:16:27 volumio volumio[1078]: info: Preload queue cleared
Jul 10 14:16:28 volumio volumio[1078]: info: Preload queue cleared
Jul 10 14:16:28 volumio volumio[1078]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jul 10 14:16:28 volumio volumio[1078]: info: CoreStateMachine::ClearQueue
Jul 10 14:16:28 volumio volumio[1078]: info: CoreStateMachine::stop
Jul 10 14:16:28 volumio volumio[1078]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 10 14:16:28 volumio volumio[1078]: info: CoreStateMachine::stPlaybackTimer
Jul 10 14:16:28 volumio volumio[1078]: info: CoreStateMachine::updateTrackBlock
Jul 10 14:16:28 volumio volumio[1078]: info: CorePlayQueue::getTrackBlock
Jul 10 14:16:28 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:28 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:28 volumio volumio[1078]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 10 14:16:28 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:28 volumio volumio[1078]: info: CoreStateMachine::serviceStop
Jul 10 14:16:28 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:28 volumio volumio[1078]: info: CoreCommandRouter::serviceStop
Jul 10 14:16:28 volumio volumio[1078]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 10 14:16:28 volumio volumio[1078]: info: ControllerMpd::stop
Jul 10 14:16:28 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand stop
Jul 10 14:16:28 volumio volumio[1078]: info: CorePlayQueue::clearPlayQueue
Jul 10 14:16:28 volumio volumio[1078]: info: CorePlayQueue::saveQueue
Jul 10 14:16:28 volumio volumio[1078]: info: CoreCommandRouter::volumioPushQueue
Jul 10 14:16:28 volumio volumio[1078]: info: CoreStateMachine::addQueueItems
Jul 10 14:16:28 volumio volumio[1078]: info: CorePlayQueue::addQueueItems
Jul 10 14:16:28 volumio volumio[1078]: info: Preload queue cleared
Jul 10 14:16:28 volumio volumio[1078]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s175253
Jul 10 14:16:28 volumio volumio[1078]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Jul 10 14:16:28 volumio mpd[1322]: player: played "https://rr4---sn-ogul7n7s.googlevideo.com/videoplayback?expire=1752146157&ei=jUxvaNT2DNWx-dIPk7PF0Qw&ip=133.32.225.246&id=o-APvHs7AAzpWT4no2bUW5J8u3mOr4Yeqy4OvMt27f6RLz&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1752124557%2C&mh=JF&mm=31%2C29&mn=sn-ogul7n7s%2Csn-oguelnzy&ms=au%2Crdu&mv=m&mvi=4&pl=19&rms=au%2Cau&initcwndbps=2780000&bui=AY1jyLOVzst9wJFIi4oEPwkGK97-1vvhXFwKTEtDRYy22bVM8JYyyQgu-bXtZlaMMONSGqS9qnqo0Gbt&spc=l3OVKSyDnO1ASDbpB6BLLoZWB2VgejezTz7--SFyacqLnz5WnirgQg&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=ob6LAJPPb5UkUpJX36Rz95EQ&rqh=1&gir=yes&clen=6531091&dur=401.261&lmt=1669426681939773&mt=1752124147&fvip=3&keepalive=yes&fexp=51476174&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=6218224&n=nfu42lxoWwhwEQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgYRfO64gmFMgoLbeEXPT70TjdAbb0Z2XhlBT5Dewti5YCIBwDXA0hp9Hy3Sk4jVVk_u9rdqm_b153FVsrFeHMSoox&sig=AJfQdSswRQIhAOxXs8aWGlHyQ_bU7C0V5Ri0P6ajEEYmW5uRPRuGwjnBAiA3tneU0ULS3ZRorjRNrQ_sG7_oW6mNeHey4YS6m9dtAw%3D%3D&pot=Mni_eQLHpKeg2L9FnoEqmXRQzgwNJHHDZYKQZPt6-3GhlJT6DKJaMI2l52mCaWI-6K4Ftq4g4acJUzNCLJcUTfhd2Ile65OK-Xn67aojdzXItmrXvcTQlpNzhWsHT3g3FjS5_FZK-Da0tAWCvR9LTFB7Uooqvqy7_xY%3D&cver=1.20250219.01.00&t.YouTube"
Jul 10 14:16:28 volumio volumio[1078]: info:
Jul 10 14:16:28 volumio volumio[1078]: ---------------------------- MPD announces state update: player
Jul 10 14:16:28 volumio volumio[1078]: info: sendMpdCommand stop took 180 milliseconds
Jul 10 14:16:28 volumio volumio[1078]: info: ControllerMpd::getState
Jul 10 14:16:28 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand status
Jul 10 14:16:28 volumio volumio[1078]: info:
Jul 10 14:16:28 volumio volumio[1078]: ---------------------------- MPD announces state update: player
Jul 10 14:16:28 volumio volumio[1078]: info: ControllerMpd::getState
Jul 10 14:16:28 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand status
Jul 10 14:16:28 volumio volumio[1078]: info:
Jul 10 14:16:28 volumio volumio[1078]: ---------------------------- MPD announces state update: player
Jul 10 14:16:28 volumio volumio[1078]: info: ControllerMpd::getState
Jul 10 14:16:28 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand status
Jul 10 14:16:28 volumio volumio[1078]: info: sendMpdCommand status took 39 milliseconds
Jul 10 14:16:28 volumio volumio[1078]: info: sendMpdCommand status took 16 milliseconds
Jul 10 14:16:28 volumio volumio[1078]: info: sendMpdCommand status took 12 milliseconds
Jul 10 14:16:28 volumio volumio[1078]: verbose: ControllerMpd::parseState
Jul 10 14:16:28 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 10 14:16:28 volumio volumio[1078]: verbose: ControllerMpd::parseState
Jul 10 14:16:28 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 10 14:16:28 volumio volumio[1078]: verbose: ControllerMpd::parseState
Jul 10 14:16:28 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 10 14:16:28 volumio volumio[1078]: info: sendMpdCommand playlistinfo took 15 milliseconds
Jul 10 14:16:28 volumio volumio[1078]: info: sendMpdCommand playlistinfo took 16 milliseconds
Jul 10 14:16:28 volumio volumio[1078]: info: sendMpdCommand playlistinfo took 17 milliseconds
Jul 10 14:16:28 volumio volumio[1078]: verbose: ControllerMpd::parseTrackInfo
Jul 10 14:16:28 volumio volumio[1078]: verbose: ControllerMpd::parseTrackInfo
Jul 10 14:16:28 volumio volumio[1078]: verbose: ControllerMpd::parseTrackInfo
Jul 10 14:16:28 volumio volumio[1078]: info: ControllerMpd::pushState
Jul 10 14:16:28 volumio volumio[1078]: info: CoreCommandRouter::servicePushState
Jul 10 14:16:28 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:28 volumio volumio[1078]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 10 14:16:28 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:28 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:28 volumio volumio[1078]: 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":"平沢進 Susumu Hirasawa - Snow Blind (Hybrid Phonon)","artist":"hrsw_vt","album":"YouTube","uri":"https://rr4---sn-ogul7n7s.googlevideo.com/videoplayback?expire=1752146157&ei=jUxvaNT2DNWx-dIPk7PF0Qw&ip=133.32.225.246&id=o-APvHs7AAzpWT4no2bUW5J8u3mOr4Yeqy4OvMt27f6RLz&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1752124557%2C&mh=JF&mm=31%2C29&mn=sn-ogul7n7s%2Csn-oguelnzy&ms=au%2Crdu&mv=m&mvi=4&pl=19&rms=au%2Cau&initcwndbps=2780000&bui=AY1jyLOVzst9wJFIi4oEPwkGK97-1vvhXFwKTEtDRYy22bVM8JYyyQgu-bXtZlaMMONSGqS9qnqo0Gbt&spc=l3OVKSyDnO1ASDbpB6BLLoZWB2VgejezTz7--SFyacqLnz5WnirgQg&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=ob6LAJPPb5UkUpJX36Rz95EQ&rqh=1&gir=yes&clen=6531091&dur=401.261&lmt=1669426681939773&mt=1752124147&fvip=3&keepalive=yes&fexp=51476174&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=6218224&n=nfu42lxoWwhwEQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgYRfO64gmFMgoLbeEXPT70TjdAbb0Z2XhlBT5Dewti5YCIBwDXA0hp9Hy3Sk4jVVk_u9rdqm_b153FVsrFeHMSoox&sig=AJfQdSswRQIhAOxXs8aWGlHyQ_bU7C0V5Ri0P6ajEEYmW5uRPRuGwjnBAiA3tneU0ULS3ZRorjRNrQ_sG7_oW6mNeHey4YS6m9dtAw%3D%3D&pot=Mni_eQLHpKeg2L9FnoEqmXRQzgwNJHHDZYKQZPt6-3GhlJT6DKJaMI2l52mCaWI-6K4Ftq4g4acJUzNCLJcUTfhd2Ile65OK-Xn67aojdzXItmrXvcTQlpNzhWsHT3g3FjS5_FZK-Da0tAWCvR9LTFB7Uooqvqy7_xY%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"}
Jul 10 14:16:28 volumio volumio[1078]: verbose: CURRENT POSITION 0
Jul 10 14:16:28 volumio volumio[1078]: info: CoreStateMachine::syncState stateService stop
Jul 10 14:16:28 volumio volumio[1078]: info: CoreStateMachine::syncState currentStatus stop
Jul 10 14:16:28 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:28 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:28 volumio volumio[1078]: info: No code
Jul 10 14:16:28 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:28 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:28 volumio volumio[1078]: info: ControllerMpd::pushState
Jul 10 14:16:28 volumio volumio[1078]: info: CoreCommandRouter::servicePushState
Jul 10 14:16:28 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:28 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:28 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:28 volumio volumio[1078]: 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":"平沢進 Susumu Hirasawa - Snow Blind (Hybrid Phonon)","artist":"hrsw_vt","album":"YouTube","uri":"https://rr4---sn-ogul7n7s.googlevideo.com/videoplayback?expire=1752146157&ei=jUxvaNT2DNWx-dIPk7PF0Qw&ip=133.32.225.246&id=o-APvHs7AAzpWT4no2bUW5J8u3mOr4Yeqy4OvMt27f6RLz&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1752124557%2C&mh=JF&mm=31%2C29&mn=sn-ogul7n7s%2Csn-oguelnzy&ms=au%2Crdu&mv=m&mvi=4&pl=19&rms=au%2Cau&initcwndbps=2780000&bui=AY1jyLOVzst9wJFIi4oEPwkGK97-1vvhXFwKTEtDRYy22bVM8JYyyQgu-bXtZlaMMONSGqS9qnqo0Gbt&spc=l3OVKSyDnO1ASDbpB6BLLoZWB2VgejezTz7--SFyacqLnz5WnirgQg&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=ob6LAJPPb5UkUpJX36Rz95EQ&rqh=1&gir=yes&clen=6531091&dur=401.261&lmt=1669426681939773&mt=1752124147&fvip=3&keepalive=yes&fexp=51476174&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=6218224&n=nfu42lxoWwhwEQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgYRfO64gmFMgoLbeEXPT70TjdAbb0Z2XhlBT5Dewti5YCIBwDXA0hp9Hy3Sk4jVVk_u9rdqm_b153FVsrFeHMSoox&sig=AJfQdSswRQIhAOxXs8aWGlHyQ_bU7C0V5Ri0P6ajEEYmW5uRPRuGwjnBAiA3tneU0ULS3ZRorjRNrQ_sG7_oW6mNeHey4YS6m9dtAw%3D%3D&pot=Mni_eQLHpKeg2L9FnoEqmXRQzgwNJHHDZYKQZPt6-3GhlJT6DKJaMI2l52mCaWI-6K4Ftq4g4acJUzNCLJcUTfhd2Ile65OK-Xn67aojdzXItmrXvcTQlpNzhWsHT3g3FjS5_FZK-Da0tAWCvR9LTFB7Uooqvqy7_xY%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"}
Jul 10 14:16:28 volumio volumio[1078]: verbose: CURRENT POSITION 0
Jul 10 14:16:28 volumio volumio[1078]: info: CoreStateMachine::syncState stateService stop
Jul 10 14:16:28 volumio volumio[1078]: info: CoreStateMachine::syncState currentStatus stop
Jul 10 14:16:28 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:28 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:28 volumio volumio[1078]: info: No code
Jul 10 14:16:28 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:28 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:28 volumio volumio[1078]: info: ControllerMpd::pushState
Jul 10 14:16:28 volumio volumio[1078]: info: CoreCommandRouter::servicePushState
Jul 10 14:16:28 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:28 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:28 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:28 volumio volumio[1078]: 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":"平沢進 Susumu Hirasawa - Snow Blind (Hybrid Phonon)","artist":"hrsw_vt","album":"YouTube","uri":"https://rr4---sn-ogul7n7s.googlevideo.com/videoplayback?expire=1752146157&ei=jUxvaNT2DNWx-dIPk7PF0Qw&ip=133.32.225.246&id=o-APvHs7AAzpWT4no2bUW5J8u3mOr4Yeqy4OvMt27f6RLz&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&met=1752124557%2C&mh=JF&mm=31%2C29&mn=sn-ogul7n7s%2Csn-oguelnzy&ms=au%2Crdu&mv=m&mvi=4&pl=19&rms=au%2Cau&initcwndbps=2780000&bui=AY1jyLOVzst9wJFIi4oEPwkGK97-1vvhXFwKTEtDRYy22bVM8JYyyQgu-bXtZlaMMONSGqS9qnqo0Gbt&spc=l3OVKSyDnO1ASDbpB6BLLoZWB2VgejezTz7--SFyacqLnz5WnirgQg&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=ob6LAJPPb5UkUpJX36Rz95EQ&rqh=1&gir=yes&clen=6531091&dur=401.261&lmt=1669426681939773&mt=1752124147&fvip=3&keepalive=yes&fexp=51476174&c=WEB_EMBEDDED_PLAYER&sefc=1&txp=6218224&n=nfu42lxoWwhwEQ&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Crqh%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=met%2Cmh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Crms%2Cinitcwndbps&lsig=APaTxxMwRAIgYRfO64gmFMgoLbeEXPT70TjdAbb0Z2XhlBT5Dewti5YCIBwDXA0hp9Hy3Sk4jVVk_u9rdqm_b153FVsrFeHMSoox&sig=AJfQdSswRQIhAOxXs8aWGlHyQ_bU7C0V5Ri0P6ajEEYmW5uRPRuGwjnBAiA3tneU0ULS3ZRorjRNrQ_sG7_oW6mNeHey4YS6m9dtAw%3D%3D&pot=Mni_eQLHpKeg2L9FnoEqmXRQzgwNJHHDZYKQZPt6-3GhlJT6DKJaMI2l52mCaWI-6K4Ftq4g4acJUzNCLJcUTfhd2Ile65OK-Xn67aojdzXItmrXvcTQlpNzhWsHT3g3FjS5_FZK-Da0tAWCvR9LTFB7Uooqvqy7_xY%3D&cver=1.20250219.01.00&t.YouTube","trackType":"YouTube"}
Jul 10 14:16:28 volumio volumio[1078]: verbose: CURRENT POSITION 0
Jul 10 14:16:28 volumio volumio[1078]: info: CoreStateMachine::syncState stateService stop
Jul 10 14:16:28 volumio volumio[1078]: info: CoreStateMachine::syncState currentStatus stop
Jul 10 14:16:28 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:28 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:28 volumio volumio[1078]: info: No code
Jul 10 14:16:28 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:28 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:28 volumio volumio[1078]: info: ------------------------------ 305ms
Jul 10 14:16:28 volumio volumio[1078]: info: ------------------------------ 295ms
Jul 10 14:16:28 volumio volumio[1078]: info: ------------------------------ 294ms
Jul 10 14:16:29 volumio volumio[1078]: info: CoreCommandRouter::volumioPushQueue
Jul 10 14:16:29 volumio volumio[1078]: info: CorePlayQueue::saveQueue
Jul 10 14:16:29 volumio volumio[1078]: info: CoreStateMachine::updateTrackBlock
Jul 10 14:16:29 volumio volumio[1078]: info: CorePlayQueue::getTrackBlock
Jul 10 14:16:29 volumio volumio[1078]: info: CoreCommandRouter::volumioPlay
Jul 10 14:16:29 volumio volumio[1078]: info: CoreStateMachine::play index 0
Jul 10 14:16:29 volumio volumio[1078]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 10 14:16:29 volumio volumio[1078]: info: CoreStateMachine::stop
Jul 10 14:16:29 volumio volumio[1078]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 10 14:16:29 volumio volumio[1078]: info: CoreStateMachine::play index undefined
Jul 10 14:16:29 volumio volumio[1078]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 10 14:16:29 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:29 volumio volumio[1078]: info: CoreStateMachine::startPlaybackTimer
Jul 10 14:16:29 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:29 volumio volumio[1078]: info: [1752124589066] ControllerWebradio::clearAddPlayTrack
Jul 10 14:16:29 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand stop
Jul 10 14:16:29 volumio volumio[1078]: info: sendMpdCommand stop took 3 milliseconds
Jul 10 14:16:29 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand clear
Jul 10 14:16:29 volumio volumio[1078]: info:
Jul 10 14:16:29 volumio volumio[1078]: ---------------------------- MPD announces system playlist update
Jul 10 14:16:29 volumio volumio[1078]: info: Ignoring MPD Status Update
Jul 10 14:16:29 volumio volumio[1078]: info: sendMpdCommand clear took 1 milliseconds
Jul 10 14:16:29 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand load "http://www.happyhardcore.com/livestreams/p/u9/"
Jul 10 14:16:29 volumio volumio[1078]: info:
Jul 10 14:16:29 volumio volumio[1078]: ---------------------------- MPD announces system playlist update
Jul 10 14:16:29 volumio volumio[1078]: info: Ignoring MPD Status Update
Jul 10 14:16:29 volumio volumio[1078]: info:
Jul 10 14:16:29 volumio volumio[1078]: ---------------------------- MPD announces system playlist update
Jul 10 14:16:29 volumio volumio[1078]: info: Ignoring MPD Status Update
Jul 10 14:16:29 volumio volumio[1078]: error: updateQueue error: null
Jul 10 14:16:29 volumio volumio[1078]: info: ------------------------------ 28ms
Jul 10 14:16:29 volumio systemd[1]: systemd-timedated.service: Deactivated successfully.
Jul 10 14:16:30 volumio volumio[1078]: info: CoreCommandRouter::volumioSeek
Jul 10 14:16:30 volumio volumio[1078]: info: CoreStateMachine::seek
Jul 10 14:16:30 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:30 volumio volumio[1078]: info: TRACKBLOCK {"service":"webradio","type":"track","uri":"http://www.happyhardcore.com/livestreams/p/u9/","name":"Happy Hardcore Radio","albumart":"http://cdn-profiles.tunein.com/s175253/images/logoq.jpg","samplerate":"","bitdepth":0,"channels":0}
Jul 10 14:16:30 volumio volumio[1078]: info: CoreStateMachine::startPlaybackTimer
Jul 10 14:16:30 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:30 volumio volumio[1078]: info: [1752124590684] ControllerWebradio::seek
Jul 10 14:16:30 volumio volumio[1078]: info: ControllerMpd::seek
Jul 10 14:16:30 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:30 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:30 volumio volumio[1078]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 10 14:16:30 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:33 volumio mpd[1322]: exception: No such playlist
Jul 10 14:16:33 volumio mpd[1322]: exception: Bad song index
Jul 10 14:16:33 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand add "http://www.happyhardcore.com/livestreams/p/u9/"
Jul 10 14:16:33 volumio volumio[1078]: error: updateQueue error: null
Jul 10 14:16:33 volumio volumio[1078]: error: updateQueue error: null
Jul 10 14:16:33 volumio volumio[1078]: error: [2@0] {seek} Bad song index
Jul 10 14:16:33 volumio volumio[1078]: info: ------------------------------ 4475ms
Jul 10 14:16:33 volumio volumio[1078]: info: ------------------------------ 4473ms
Jul 10 14:16:33 volumio volumio[1078]: info:
Jul 10 14:16:33 volumio volumio[1078]: ---------------------------- MPD announces system playlist update
Jul 10 14:16:33 volumio volumio[1078]: info: Ignoring MPD Status Update
Jul 10 14:16:33 volumio volumio[1078]: info: sendMpdCommand add "http://www.happyhardcore.com/livestreams/p/u9/" took 5 milliseconds
Jul 10 14:16:33 volumio volumio[1078]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 10 14:16:33 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand play
Jul 10 14:16:33 volumio volumio[1078]: info:
Jul 10 14:16:33 volumio volumio[1078]: ---------------------------- MPD announces system playlist update
Jul 10 14:16:33 volumio volumio[1078]: info: Ignoring MPD Status Update
Jul 10 14:16:33 volumio volumio[1078]: info:
Jul 10 14:16:33 volumio volumio[1078]: ---------------------------- MPD announces system playlist update
Jul 10 14:16:33 volumio volumio[1078]: info: Ignoring MPD Status Update
Jul 10 14:16:33 volumio volumio[1078]: info: ------------------------------ 7ms
Jul 10 14:16:33 volumio volumio[1078]: info: sendMpdCommand play took 5 milliseconds
Jul 10 14:16:33 volumio volumio[1078]: info: ------------------------------ 4ms
Jul 10 14:16:33 volumio volumio[1078]: info: ------------------------------ 3ms
Jul 10 14:16:33 volumio volumio[1078]: info: CoreCommandRouter::volumioPlay
Jul 10 14:16:33 volumio volumio[1078]: info: CoreStateMachine::play index undefined
Jul 10 14:16:33 volumio volumio[1078]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 10 14:16:33 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:33 volumio volumio[1078]: info: CoreStateMachine::startPlaybackTimer
Jul 10 14:16:33 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:33 volumio volumio[1078]: info: [1752124593577] ControllerWebradio::clearAddPlayTrack
Jul 10 14:16:33 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand stop
Jul 10 14:16:33 volumio mpd[1322]: player: played "http://www.happyhardcore.com/livestreams/p/u9/"
Jul 10 14:16:33 volumio volumio[1078]: info: sendMpdCommand stop took 4 milliseconds
Jul 10 14:16:33 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand clear
Jul 10 14:16:33 volumio volumio[1078]: info:
Jul 10 14:16:33 volumio volumio[1078]: ---------------------------- MPD announces state update: player
Jul 10 14:16:33 volumio volumio[1078]: info:
Jul 10 14:16:33 volumio volumio[1078]: ---------------------------- MPD announces system playlist update
Jul 10 14:16:33 volumio volumio[1078]: info: Ignoring MPD Status Update
Jul 10 14:16:33 volumio volumio[1078]: info: ControllerMpd::getState
Jul 10 14:16:33 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand status
Jul 10 14:16:33 volumio volumio[1078]: info: sendMpdCommand clear took 2 milliseconds
Jul 10 14:16:33 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand load "http://www.happyhardcore.com/livestreams/p/u9/"
Jul 10 14:16:33 volumio volumio[1078]: info:
Jul 10 14:16:33 volumio volumio[1078]: ---------------------------- MPD announces state update: player
Jul 10 14:16:33 volumio volumio[1078]: info: ControllerMpd::getState
Jul 10 14:16:33 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand status
Jul 10 14:16:33 volumio volumio[1078]: info:
Jul 10 14:16:33 volumio volumio[1078]: ---------------------------- MPD announces state update: player
Jul 10 14:16:33 volumio volumio[1078]: info: ControllerMpd::getState
Jul 10 14:16:33 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand status
Jul 10 14:16:33 volumio volumio[1078]: error: updateQueue error: null
Jul 10 14:16:33 volumio volumio[1078]: info: sendMpdCommand status took 17 milliseconds
Jul 10 14:16:33 volumio volumio[1078]: info: ------------------------------ 19ms
Jul 10 14:16:33 volumio volumio[1078]: verbose: ControllerMpd::parseState
Jul 10 14:16:33 volumio volumio[1078]: info: ControllerMpd::pushState
Jul 10 14:16:33 volumio volumio[1078]: info: CoreCommandRouter::servicePushState
Jul 10 14:16:33 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:33 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:33 volumio volumio[1078]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 10 14:16:33 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:33 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:33 volumio volumio[1078]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Jul 10 14:16:33 volumio volumio[1078]: info: ------------------------------ 61ms
Jul 10 14:16:36 volumio volumio[1078]: info: Preload queue cleared
Jul 10 14:16:36 volumio volumio[1078]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jul 10 14:16:36 volumio volumio[1078]: info: CoreStateMachine::ClearQueue
Jul 10 14:16:36 volumio volumio[1078]: info: CoreStateMachine::stop
Jul 10 14:16:36 volumio volumio[1078]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 10 14:16:36 volumio volumio[1078]: info: CorePlayQueue::clearPlayQueue
Jul 10 14:16:36 volumio volumio[1078]: info: CorePlayQueue::saveQueue
Jul 10 14:16:36 volumio volumio[1078]: info: CoreCommandRouter::volumioPushQueue
Jul 10 14:16:36 volumio volumio[1078]: info: CoreStateMachine::addQueueItems
Jul 10 14:16:36 volumio volumio[1078]: info: CorePlayQueue::addQueueItems
Jul 10 14:16:36 volumio volumio[1078]: info: Preload queue cleared
Jul 10 14:16:36 volumio volumio[1078]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s54003
Jul 10 14:16:36 volumio volumio[1078]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Jul 10 14:16:36 volumio mpd[1322]: exception: No such playlist
Jul 10 14:16:36 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand add "http://www.happyhardcore.com/livestreams/p/u9/"
Jul 10 14:16:36 volumio volumio[1078]: info: sendMpdCommand status took 2964 milliseconds
Jul 10 14:16:36 volumio volumio[1078]: info: sendMpdCommand status took 2963 milliseconds
Jul 10 14:16:36 volumio volumio[1078]: verbose: ControllerMpd::parseState
Jul 10 14:16:36 volumio volumio[1078]: verbose: ControllerMpd::parseState
Jul 10 14:16:36 volumio volumio[1078]: info: ControllerMpd::pushState
Jul 10 14:16:36 volumio volumio[1078]: info: CoreCommandRouter::servicePushState
Jul 10 14:16:36 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:36 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:36 volumio volumio[1078]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 10 14:16:36 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:36 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:36 volumio volumio[1078]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jul 10 14:16:36 volumio volumio[1078]: verbose: CURRENT POSITION 0
Jul 10 14:16:36 volumio volumio[1078]: info: CoreStateMachine::syncState stateService stop
Jul 10 14:16:36 volumio volumio[1078]: info: CoreStateMachine::syncState currentStatus stop
Jul 10 14:16:36 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:36 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:36 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:36 volumio volumio[1078]: info: No code
Jul 10 14:16:36 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:36 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:36 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:36 volumio volumio[1078]: info: ControllerMpd::pushState
Jul 10 14:16:36 volumio volumio[1078]: info: CoreCommandRouter::servicePushState
Jul 10 14:16:36 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:36 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:36 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:36 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:36 volumio volumio[1078]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jul 10 14:16:36 volumio volumio[1078]: verbose: CURRENT POSITION 0
Jul 10 14:16:36 volumio volumio[1078]: info: CoreStateMachine::syncState stateService stop
Jul 10 14:16:36 volumio volumio[1078]: info: CoreStateMachine::syncState currentStatus stop
Jul 10 14:16:36 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:36 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:36 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:36 volumio volumio[1078]: info: No code
Jul 10 14:16:36 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:36 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:36 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:36 volumio volumio[1078]: info: ------------------------------ 3133ms
Jul 10 14:16:36 volumio volumio[1078]: info: ------------------------------ 3132ms
Jul 10 14:16:36 volumio volumio[1078]: info:
Jul 10 14:16:36 volumio volumio[1078]: ---------------------------- MPD announces system playlist update
Jul 10 14:16:36 volumio volumio[1078]: info: Ignoring MPD Status Update
Jul 10 14:16:36 volumio volumio[1078]: info: sendMpdCommand add "http://www.happyhardcore.com/livestreams/p/u9/" took 202 milliseconds
Jul 10 14:16:36 volumio volumio[1078]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 10 14:16:36 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand play
Jul 10 14:16:36 volumio volumio[1078]: info:
Jul 10 14:16:36 volumio volumio[1078]: ---------------------------- MPD announces system playlist update
Jul 10 14:16:36 volumio volumio[1078]: info: Ignoring MPD Status Update
Jul 10 14:16:36 volumio volumio[1078]: info:
Jul 10 14:16:36 volumio volumio[1078]: ---------------------------- MPD announces system playlist update
Jul 10 14:16:36 volumio volumio[1078]: info: Ignoring MPD Status Update
Jul 10 14:16:36 volumio volumio[1078]: info: CoreCommandRouter::volumioPushQueue
Jul 10 14:16:36 volumio volumio[1078]: info: CorePlayQueue::saveQueue
Jul 10 14:16:36 volumio volumio[1078]: info: CoreStateMachine::updateTrackBlock
Jul 10 14:16:36 volumio volumio[1078]: info: CorePlayQueue::getTrackBlock
Jul 10 14:16:36 volumio volumio[1078]: info: CoreCommandRouter::volumioPlay
Jul 10 14:16:36 volumio volumio[1078]: info: CoreStateMachine::play index 0
Jul 10 14:16:36 volumio volumio[1078]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 10 14:16:36 volumio volumio[1078]: info: CoreStateMachine::stop
Jul 10 14:16:36 volumio volumio[1078]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 10 14:16:36 volumio volumio[1078]: info: CoreStateMachine::play index undefined
Jul 10 14:16:36 volumio volumio[1078]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 10 14:16:36 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:36 volumio volumio[1078]: info: CoreStateMachine::startPlaybackTimer
Jul 10 14:16:36 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:36 volumio volumio[1078]: info: [1752124596945] ControllerWebradio::clearAddPlayTrack
Jul 10 14:16:36 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand stop
Jul 10 14:16:36 volumio mpd[1322]: player: played "http://www.happyhardcore.com/livestreams/p/u9/"
Jul 10 14:16:36 volumio volumio[1078]: info:
Jul 10 14:16:36 volumio volumio[1078]: ---------------------------- MPD announces state update: player
Jul 10 14:16:36 volumio volumio[1078]: info: ------------------------------ 215ms
Jul 10 14:16:36 volumio volumio[1078]: info: sendMpdCommand play took 216 milliseconds
Jul 10 14:16:36 volumio volumio[1078]: info: ------------------------------ 203ms
Jul 10 14:16:36 volumio volumio[1078]: info: ------------------------------ 202ms
Jul 10 14:16:36 volumio volumio[1078]: info: sendMpdCommand stop took 32 milliseconds
Jul 10 14:16:36 volumio volumio[1078]: info: ControllerMpd::getState
Jul 10 14:16:36 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand status
Jul 10 14:16:36 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand clear
Jul 10 14:16:36 volumio volumio[1078]: info:
Jul 10 14:16:36 volumio volumio[1078]: ---------------------------- MPD announces system playlist update
Jul 10 14:16:36 volumio volumio[1078]: info: Ignoring MPD Status Update
Jul 10 14:16:36 volumio volumio[1078]: info:
Jul 10 14:16:36 volumio volumio[1078]: ---------------------------- MPD announces system playlist update
Jul 10 14:16:36 volumio volumio[1078]: info: Ignoring MPD Status Update
Jul 10 14:16:36 volumio mpd[1322]: exception: Bad song index
Jul 10 14:16:37 volumio volumio[1078]: info:
Jul 10 14:16:37 volumio volumio[1078]: ---------------------------- MPD announces system playlist update
Jul 10 14:16:37 volumio volumio[1078]: info: Ignoring MPD Status Update
Jul 10 14:16:37 volumio volumio[1078]: error: updateQueue error: null
Jul 10 14:16:37 volumio volumio[1078]: error: updateQueue error: null
Jul 10 14:16:37 volumio volumio[1078]: info: sendMpdCommand status took 37 milliseconds
Jul 10 14:16:37 volumio volumio[1078]: info: sendMpdCommand clear took 36 milliseconds
Jul 10 14:16:37 volumio volumio[1078]: info: ------------------------------ 36ms
Jul 10 14:16:37 volumio volumio[1078]: info: ------------------------------ 33ms
Jul 10 14:16:37 volumio volumio[1078]: verbose: ControllerMpd::parseState
Jul 10 14:16:37 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 10 14:16:37 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand load "http://radio.jphip.com:8800"
Jul 10 14:16:37 volumio volumio[1078]: info:
Jul 10 14:16:37 volumio volumio[1078]: ---------------------------- MPD announces system playlist update
Jul 10 14:16:37 volumio volumio[1078]: info: Ignoring MPD Status Update
Jul 10 14:16:37 volumio volumio[1078]: info:
Jul 10 14:16:37 volumio volumio[1078]: ---------------------------- MPD announces state update: player
Jul 10 14:16:37 volumio volumio[1078]: info: ControllerMpd::getState
Jul 10 14:16:37 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand status
Jul 10 14:16:37 volumio volumio[1078]: info:
Jul 10 14:16:37 volumio volumio[1078]: ---------------------------- MPD announces system playlist update
Jul 10 14:16:37 volumio volumio[1078]: info: Ignoring MPD Status Update
Jul 10 14:16:37 volumio volumio[1078]: info:
Jul 10 14:16:37 volumio volumio[1078]: ---------------------------- MPD announces state update: player
Jul 10 14:16:37 volumio volumio[1078]: info: ControllerMpd::getState
Jul 10 14:16:37 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand status
Jul 10 14:16:37 volumio volumio[1078]: error: updateQueue error: null
Jul 10 14:16:37 volumio volumio[1078]: info: ------------------------------ 47ms
Jul 10 14:16:37 volumio volumio[1078]: info: sendMpdCommand playlistinfo took 27 milliseconds
Jul 10 14:16:37 volumio volumio[1078]: verbose: ControllerMpd::parseTrackInfo
Jul 10 14:16:37 volumio volumio[1078]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Jul 10 14:16:37 volumio volumio[1078]: info: ------------------------------ 115ms
Jul 10 14:16:37 volumio mpd[1322]: exception: No such playlist
Jul 10 14:16:37 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand add "http://radio.jphip.com:8800"
Jul 10 14:16:37 volumio volumio[1078]: error: updateQueue error: null
Jul 10 14:16:37 volumio volumio[1078]: error: updateQueue error: null
Jul 10 14:16:37 volumio volumio[1078]: info:
Jul 10 14:16:37 volumio volumio[1078]: ---------------------------- MPD announces system playlist update
Jul 10 14:16:37 volumio volumio[1078]: info: Ignoring MPD Status Update
Jul 10 14:16:37 volumio volumio[1078]: info: ------------------------------ 697ms
Jul 10 14:16:37 volumio volumio[1078]: info: sendMpdCommand status took 695 milliseconds
Jul 10 14:16:37 volumio volumio[1078]: info: ------------------------------ 695ms
Jul 10 14:16:37 volumio volumio[1078]: info: sendMpdCommand status took 695 milliseconds
Jul 10 14:16:37 volumio volumio[1078]: info: sendMpdCommand add "http://radio.jphip.com:8800" took 14 milliseconds
Jul 10 14:16:37 volumio volumio[1078]: verbose: ControllerMpd::parseState
Jul 10 14:16:37 volumio volumio[1078]: verbose: ControllerMpd::parseState
Jul 10 14:16:37 volumio volumio[1078]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 10 14:16:37 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand play
Jul 10 14:16:37 volumio volumio[1078]: info: ControllerMpd::pushState
Jul 10 14:16:37 volumio volumio[1078]: info: CoreCommandRouter::servicePushState
Jul 10 14:16:37 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:37 volumio volumio[1078]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 10 14:16:37 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:37 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:37 volumio volumio[1078]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jul 10 14:16:37 volumio volumio[1078]: verbose: CURRENT POSITION 0
Jul 10 14:16:37 volumio volumio[1078]: info: CoreStateMachine::syncState stateService stop
Jul 10 14:16:37 volumio volumio[1078]: info: CoreStateMachine::syncState currentStatus stop
Jul 10 14:16:37 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:37 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:37 volumio volumio[1078]: info: No code
Jul 10 14:16:37 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:37 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:37 volumio volumio[1078]: info: ControllerMpd::pushState
Jul 10 14:16:37 volumio volumio[1078]: info: CoreCommandRouter::servicePushState
Jul 10 14:16:37 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:37 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:37 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:37 volumio volumio[1078]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jul 10 14:16:37 volumio volumio[1078]: verbose: CURRENT POSITION 0
Jul 10 14:16:37 volumio volumio[1078]: info: CoreStateMachine::syncState stateService stop
Jul 10 14:16:37 volumio volumio[1078]: info: CoreStateMachine::syncState currentStatus stop
Jul 10 14:16:37 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:37 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:37 volumio volumio[1078]: info: No code
Jul 10 14:16:37 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:37 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:37 volumio volumio[1078]: info: ------------------------------ 908ms
Jul 10 14:16:37 volumio volumio[1078]: info: ------------------------------ 937ms
Jul 10 14:16:37 volumio volumio[1078]: info:
Jul 10 14:16:37 volumio volumio[1078]: ---------------------------- MPD announces system playlist update
Jul 10 14:16:37 volumio volumio[1078]: info: Ignoring MPD Status Update
Jul 10 14:16:37 volumio volumio[1078]: info:
Jul 10 14:16:37 volumio volumio[1078]: ---------------------------- MPD announces system playlist update
Jul 10 14:16:37 volumio volumio[1078]: info: Ignoring MPD Status Update
Jul 10 14:16:37 volumio volumio[1078]: info: ------------------------------ 278ms
Jul 10 14:16:38 volumio volumio[1078]: info: sendMpdCommand play took 271 milliseconds
Jul 10 14:16:38 volumio volumio[1078]: info: ------------------------------ 29ms
Jul 10 14:16:38 volumio volumio[1078]: info: ------------------------------ 16ms
Jul 10 14:16:38 volumio mpd[1322]: exception: Failed to open "default detected output" (sndio); Requested audio params cannot be satisfied
Jul 10 14:16:38 volumio mpd[1322]: exception: Failed to open "default detected output" (sndio); Requested audio params cannot be satisfied
Jul 10 14:16:38 volumio mpd[1322]: player: problems opening audio device while playing "http://radio.jphip.com:8800"
Jul 10 14:16:38 volumio volumio[1078]: info:
Jul 10 14:16:38 volumio volumio[1078]: ---------------------------- MPD announces state update: player
Jul 10 14:16:38 volumio volumio[1078]: info: ControllerMpd::getState
Jul 10 14:16:38 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand status
Jul 10 14:16:38 volumio volumio[1078]: info:
Jul 10 14:16:38 volumio volumio[1078]: ---------------------------- MPD announces state update: player
Jul 10 14:16:38 volumio volumio[1078]: info: ControllerMpd::getState
Jul 10 14:16:38 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand status
Jul 10 14:16:38 volumio volumio[1078]: info:
Jul 10 14:16:38 volumio volumio[1078]: ---------------------------- MPD announces state update: player
Jul 10 14:16:38 volumio volumio[1078]: info:
Jul 10 14:16:38 volumio volumio[1078]: ---------------------------- MPD announces state update: player
Jul 10 14:16:38 volumio volumio[1078]: info: ControllerMpd::getState
Jul 10 14:16:38 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand status
Jul 10 14:16:38 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand clearerror
Jul 10 14:16:38 volumio volumio[1078]: info: sendMpdCommand status took 70 milliseconds
Jul 10 14:16:38 volumio volumio[1078]: info: ControllerMpd::getState
Jul 10 14:16:38 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand status
Jul 10 14:16:38 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand clearerror
Jul 10 14:16:38 volumio volumio[1078]: info: sendMpdCommand status took 63 milliseconds
Jul 10 14:16:38 volumio volumio[1078]: verbose: ControllerMpd::parseState
Jul 10 14:16:38 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 10 14:16:38 volumio volumio[1078]: verbose: ControllerMpd::parseState
Jul 10 14:16:38 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 10 14:16:38 volumio volumio[1078]: info:
Jul 10 14:16:38 volumio volumio[1078]: ---------------------------- MPD announces state update: player
Jul 10 14:16:38 volumio volumio[1078]: info: ControllerMpd::getState
Jul 10 14:16:38 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand status
Jul 10 14:16:38 volumio volumio[1078]: info:
Jul 10 14:16:38 volumio volumio[1078]: ---------------------------- MPD announces state update: player
Jul 10 14:16:38 volumio volumio[1078]: info: ControllerMpd::getState
Jul 10 14:16:38 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand status
Jul 10 14:16:38 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand clearerror
Jul 10 14:16:38 volumio volumio[1078]: info: sendMpdCommand status took 130 milliseconds
Jul 10 14:16:38 volumio volumio[1078]: info: sendMpdCommand clearerror took 91 milliseconds
Jul 10 14:16:38 volumio volumio[1078]: info: sendMpdCommand status took 90 milliseconds
Jul 10 14:16:38 volumio volumio[1078]: info: sendMpdCommand clearerror took 84 milliseconds
Jul 10 14:16:38 volumio volumio[1078]: info: sendMpdCommand playlistinfo took 54 milliseconds
Jul 10 14:16:38 volumio volumio[1078]: info: sendMpdCommand playlistinfo took 45 milliseconds
Jul 10 14:16:38 volumio volumio[1078]: info: sendMpdCommand status took 30 milliseconds
Jul 10 14:16:38 volumio volumio[1078]: info: sendMpdCommand status took 19 milliseconds
Jul 10 14:16:38 volumio volumio[1078]: verbose: ControllerMpd::parseState
Jul 10 14:16:38 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 10 14:16:38 volumio volumio[1078]: verbose: ControllerMpd::parseState
Jul 10 14:16:38 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 10 14:16:38 volumio volumio[1078]: verbose: ControllerMpd::parseTrackInfo
Jul 10 14:16:38 volumio volumio[1078]: verbose: ControllerMpd::parseTrackInfo
Jul 10 14:16:38 volumio volumio[1078]: verbose: ControllerMpd::parseState
Jul 10 14:16:38 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 10 14:16:38 volumio volumio[1078]: verbose: ControllerMpd::parseState
Jul 10 14:16:38 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 10 14:16:38 volumio volumio[1078]: info: ControllerMpd::pushState
Jul 10 14:16:38 volumio volumio[1078]: info: CoreCommandRouter::servicePushState
Jul 10 14:16:38 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:38 volumio volumio[1078]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"radio.jphip.com:8800","artist":null,"album":null,"uri":"http://radio.jphip.com:8800","trackType":"com:8800"}
Jul 10 14:16:38 volumio volumio[1078]: verbose: CURRENT POSITION 0
Jul 10 14:16:38 volumio volumio[1078]: info: CoreStateMachine::syncState stateService pause
Jul 10 14:16:38 volumio volumio[1078]: info: CoreStateMachine::syncState currentStatus stop
Jul 10 14:16:38 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:38 volumio volumio[1078]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 10 14:16:38 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:38 volumio volumio[1078]: info: ControllerMpd::pushState
Jul 10 14:16:38 volumio volumio[1078]: info: CoreCommandRouter::servicePushState
Jul 10 14:16:38 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:38 volumio volumio[1078]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"radio.jphip.com:8800","artist":null,"album":null,"uri":"http://radio.jphip.com:8800","trackType":"com:8800"}
Jul 10 14:16:38 volumio volumio[1078]: verbose: CURRENT POSITION 0
Jul 10 14:16:38 volumio volumio[1078]: info: CoreStateMachine::syncState stateService pause
Jul 10 14:16:38 volumio volumio[1078]: info: CoreStateMachine::syncState currentStatus stop
Jul 10 14:16:38 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:38 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:38 volumio volumio[1078]: info: ------------------------------ 236ms
Jul 10 14:16:38 volumio volumio[1078]: info: ------------------------------ 225ms
Jul 10 14:16:38 volumio volumio[1078]: info: sendMpdCommand clearerror took 118 milliseconds
Jul 10 14:16:38 volumio volumio[1078]: info: sendMpdCommand playlistinfo took 120 milliseconds
Jul 10 14:16:38 volumio volumio[1078]: info: sendMpdCommand playlistinfo took 115 milliseconds
Jul 10 14:16:38 volumio volumio[1078]: info: sendMpdCommand playlistinfo took 110 milliseconds
Jul 10 14:16:38 volumio volumio[1078]: info: sendMpdCommand playlistinfo took 109 milliseconds
Jul 10 14:16:38 volumio volumio[1078]: verbose: ControllerMpd::parseTrackInfo
Jul 10 14:16:38 volumio volumio[1078]: verbose: ControllerMpd::parseTrackInfo
Jul 10 14:16:38 volumio volumio[1078]: verbose: ControllerMpd::parseTrackInfo
Jul 10 14:16:38 volumio volumio[1078]: verbose: ControllerMpd::parseTrackInfo
Jul 10 14:16:38 volumio volumio[1078]: info: ControllerMpd::pushState
Jul 10 14:16:38 volumio volumio[1078]: info: CoreCommandRouter::servicePushState
Jul 10 14:16:38 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:38 volumio volumio[1078]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"radio.jphip.com:8800","artist":null,"album":null,"uri":"http://radio.jphip.com:8800","trackType":"com:8800"}
Jul 10 14:16:38 volumio volumio[1078]: verbose: CURRENT POSITION 0
Jul 10 14:16:38 volumio volumio[1078]: info: CoreStateMachine::syncState stateService pause
Jul 10 14:16:38 volumio volumio[1078]: info: CoreStateMachine::syncState currentStatus stop
Jul 10 14:16:38 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:38 volumio volumio[1078]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 10 14:16:38 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:38 volumio volumio[1078]: info: ControllerMpd::pushState
Jul 10 14:16:38 volumio volumio[1078]: info: CoreCommandRouter::servicePushState
Jul 10 14:16:38 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:38 volumio volumio[1078]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"radio.jphip.com:8800","artist":null,"album":null,"uri":"http://radio.jphip.com:8800","trackType":"com:8800"}
Jul 10 14:16:38 volumio volumio[1078]: verbose: CURRENT POSITION 0
Jul 10 14:16:38 volumio volumio[1078]: info: CoreStateMachine::syncState stateService pause
Jul 10 14:16:38 volumio volumio[1078]: info: CoreStateMachine::syncState currentStatus stop
Jul 10 14:16:38 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:38 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:38 volumio volumio[1078]: info: ControllerMpd::pushState
Jul 10 14:16:38 volumio volumio[1078]: info: CoreCommandRouter::servicePushState
Jul 10 14:16:38 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:38 volumio volumio[1078]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"radio.jphip.com:8800","artist":null,"album":null,"uri":"http://radio.jphip.com:8800","trackType":"com:8800"}
Jul 10 14:16:38 volumio volumio[1078]: verbose: CURRENT POSITION 0
Jul 10 14:16:38 volumio volumio[1078]: info: CoreStateMachine::syncState stateService pause
Jul 10 14:16:38 volumio volumio[1078]: info: CoreStateMachine::syncState currentStatus stop
Jul 10 14:16:38 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:38 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:38 volumio volumio[1078]: info: ControllerMpd::pushState
Jul 10 14:16:38 volumio volumio[1078]: info: CoreCommandRouter::servicePushState
Jul 10 14:16:38 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:38 volumio volumio[1078]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"radio.jphip.com:8800","artist":null,"album":null,"uri":"http://radio.jphip.com:8800","trackType":"com:8800"}
Jul 10 14:16:38 volumio volumio[1078]: verbose: CURRENT POSITION 0
Jul 10 14:16:38 volumio volumio[1078]: info: CoreStateMachine::syncState stateService pause
Jul 10 14:16:38 volumio volumio[1078]: info: CoreStateMachine::syncState currentStatus stop
Jul 10 14:16:38 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:38 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:38 volumio volumio[1078]: info: ------------------------------ 385ms
Jul 10 14:16:38 volumio volumio[1078]: info: ------------------------------ 395ms
Jul 10 14:16:38 volumio volumio[1078]: info: ------------------------------ 306ms
Jul 10 14:16:38 volumio volumio[1078]: info: ------------------------------ 295ms
Jul 10 14:16:41 volumio volumio[1078]: info: CoreCommandRouter::volumioSeek
Jul 10 14:16:41 volumio volumio[1078]: info: CoreStateMachine::seek
Jul 10 14:16:41 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:41 volumio volumio[1078]: info: TRACKBLOCK {"service":"webradio","type":"track","uri":"http://radio.jphip.com:8800","name":"JPHiP Radio","albumart":"http://cdn-radiotime-logos.tunein.com/s54003q.png","samplerate":"","bitdepth":0,"channels":0}
Jul 10 14:16:41 volumio volumio[1078]: info: CoreStateMachine::startPlaybackTimer
Jul 10 14:16:41 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:41 volumio volumio[1078]: info: [1752124601246] ControllerWebradio::seek
Jul 10 14:16:41 volumio volumio[1078]: info: ControllerMpd::seek
Jul 10 14:16:41 volumio mpd[1322]: exception: Not seekable
Jul 10 14:16:41 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:41 volumio volumio[1078]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 10 14:16:41 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:41 volumio volumio[1078]: error: [5@0] {seek} Not seekable
Jul 10 14:16:41 volumio volumio[1078]: info:
Jul 10 14:16:41 volumio volumio[1078]: ---------------------------- MPD announces state update: player
Jul 10 14:16:41 volumio volumio[1078]: info: ControllerMpd::getState
Jul 10 14:16:41 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand status
Jul 10 14:16:41 volumio volumio[1078]: info:
Jul 10 14:16:41 volumio volumio[1078]: ---------------------------- MPD announces state update: player
Jul 10 14:16:41 volumio volumio[1078]: info: ControllerMpd::getState
Jul 10 14:16:41 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand status
Jul 10 14:16:41 volumio volumio[1078]: info:
Jul 10 14:16:41 volumio volumio[1078]: ---------------------------- MPD announces state update: player
Jul 10 14:16:41 volumio volumio[1078]: info: ControllerMpd::getState
Jul 10 14:16:41 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand status
Jul 10 14:16:41 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand clearerror
Jul 10 14:16:41 volumio volumio[1078]: info: sendMpdCommand status took 57 milliseconds
Jul 10 14:16:41 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand clearerror
Jul 10 14:16:41 volumio volumio[1078]: info: sendMpdCommand status took 54 milliseconds
Jul 10 14:16:41 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand clearerror
Jul 10 14:16:41 volumio volumio[1078]: info: sendMpdCommand status took 56 milliseconds
Jul 10 14:16:41 volumio volumio[1078]: verbose: ControllerMpd::parseState
Jul 10 14:16:41 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 10 14:16:41 volumio volumio[1078]: verbose: ControllerMpd::parseState
Jul 10 14:16:41 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 10 14:16:41 volumio volumio[1078]: verbose: ControllerMpd::parseState
Jul 10 14:16:41 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 10 14:16:41 volumio volumio[1078]: info: sendMpdCommand clearerror took 57 milliseconds
Jul 10 14:16:41 volumio volumio[1078]: info: sendMpdCommand clearerror took 50 milliseconds
Jul 10 14:16:41 volumio volumio[1078]: info: sendMpdCommand clearerror took 41 milliseconds
Jul 10 14:16:41 volumio volumio[1078]: info: sendMpdCommand playlistinfo took 15 milliseconds
Jul 10 14:16:41 volumio volumio[1078]: info: sendMpdCommand playlistinfo took 12 milliseconds
Jul 10 14:16:41 volumio volumio[1078]: info: sendMpdCommand playlistinfo took 4 milliseconds
Jul 10 14:16:41 volumio volumio[1078]: verbose: ControllerMpd::parseTrackInfo
Jul 10 14:16:41 volumio volumio[1078]: verbose: ControllerMpd::parseTrackInfo
Jul 10 14:16:41 volumio volumio[1078]: verbose: ControllerMpd::parseTrackInfo
Jul 10 14:16:41 volumio volumio[1078]: info: ControllerMpd::pushState
Jul 10 14:16:41 volumio volumio[1078]: info: CoreCommandRouter::servicePushState
Jul 10 14:16:41 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:41 volumio volumio[1078]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"radio.jphip.com:8800","artist":null,"album":null,"uri":"http://radio.jphip.com:8800","trackType":"com:8800"}
Jul 10 14:16:41 volumio volumio[1078]: verbose: CURRENT POSITION 0
Jul 10 14:16:41 volumio volumio[1078]: info: CoreStateMachine::syncState stateService pause
Jul 10 14:16:41 volumio volumio[1078]: info: CoreStateMachine::syncState currentStatus stop
Jul 10 14:16:41 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:41 volumio volumio[1078]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 10 14:16:41 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:41 volumio volumio[1078]: info: ControllerMpd::pushState
Jul 10 14:16:41 volumio volumio[1078]: info: CoreCommandRouter::servicePushState
Jul 10 14:16:41 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:41 volumio volumio[1078]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"radio.jphip.com:8800","artist":null,"album":null,"uri":"http://radio.jphip.com:8800","trackType":"com:8800"}
Jul 10 14:16:41 volumio volumio[1078]: verbose: CURRENT POSITION 0
Jul 10 14:16:41 volumio volumio[1078]: info: CoreStateMachine::syncState stateService pause
Jul 10 14:16:41 volumio volumio[1078]: info: CoreStateMachine::syncState currentStatus stop
Jul 10 14:16:41 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:41 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:41 volumio volumio[1078]: info: ControllerMpd::pushState
Jul 10 14:16:41 volumio volumio[1078]: info: CoreCommandRouter::servicePushState
Jul 10 14:16:41 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:41 volumio volumio[1078]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"radio.jphip.com:8800","artist":null,"album":null,"uri":"http://radio.jphip.com:8800","trackType":"com:8800"}
Jul 10 14:16:41 volumio volumio[1078]: verbose: CURRENT POSITION 0
Jul 10 14:16:41 volumio volumio[1078]: info: CoreStateMachine::syncState stateService pause
Jul 10 14:16:41 volumio volumio[1078]: info: CoreStateMachine::syncState currentStatus stop
Jul 10 14:16:41 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:41 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:41 volumio volumio[1078]: info: ------------------------------ 161ms
Jul 10 14:16:41 volumio volumio[1078]: info: ------------------------------ 157ms
Jul 10 14:16:41 volumio volumio[1078]: info: ------------------------------ 150ms
Jul 10 14:16:45 volumio volumio[1078]: info: Preload queue cleared
Jul 10 14:16:45 volumio volumio[1078]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jul 10 14:16:45 volumio volumio[1078]: info: CoreStateMachine::ClearQueue
Jul 10 14:16:45 volumio volumio[1078]: info: CoreStateMachine::stop
Jul 10 14:16:45 volumio volumio[1078]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 10 14:16:45 volumio volumio[1078]: info: CorePlayQueue::clearPlayQueue
Jul 10 14:16:45 volumio volumio[1078]: info: CorePlayQueue::saveQueue
Jul 10 14:16:45 volumio volumio[1078]: info: CoreCommandRouter::volumioPushQueue
Jul 10 14:16:45 volumio volumio[1078]: info: CoreStateMachine::addQueueItems
Jul 10 14:16:45 volumio volumio[1078]: info: CorePlayQueue::addQueueItems
Jul 10 14:16:45 volumio volumio[1078]: info: Preload queue cleared
Jul 10 14:16:45 volumio volumio[1078]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s256764
Jul 10 14:16:45 volumio volumio[1078]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Jul 10 14:16:45 volumio volumio[1078]: info: CoreCommandRouter::volumioPushQueue
Jul 10 14:16:45 volumio volumio[1078]: info: CorePlayQueue::saveQueue
Jul 10 14:16:45 volumio volumio[1078]: info: CoreStateMachine::updateTrackBlock
Jul 10 14:16:45 volumio volumio[1078]: info: CorePlayQueue::getTrackBlock
Jul 10 14:16:45 volumio volumio[1078]: info: CoreCommandRouter::volumioPlay
Jul 10 14:16:45 volumio volumio[1078]: info: CoreStateMachine::play index 0
Jul 10 14:16:45 volumio volumio[1078]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 10 14:16:45 volumio volumio[1078]: info: CoreStateMachine::stop
Jul 10 14:16:45 volumio volumio[1078]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 10 14:16:45 volumio volumio[1078]: info: CoreStateMachine::play index undefined
Jul 10 14:16:45 volumio volumio[1078]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 10 14:16:45 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:45 volumio volumio[1078]: info: CoreStateMachine::startPlaybackTimer
Jul 10 14:16:45 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:45 volumio volumio[1078]: info: [1752124605893] ControllerWebradio::clearAddPlayTrack
Jul 10 14:16:45 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand stop
Jul 10 14:16:45 volumio mpd[1322]: player: played "http://radio.jphip.com:8800"
Jul 10 14:16:45 volumio volumio[1078]: info:
Jul 10 14:16:45 volumio volumio[1078]: ---------------------------- MPD announces state update: player
Jul 10 14:16:45 volumio volumio[1078]: info: sendMpdCommand stop took 19 milliseconds
Jul 10 14:16:45 volumio volumio[1078]: info: ControllerMpd::getState
Jul 10 14:16:45 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand status
Jul 10 14:16:45 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand clear
Jul 10 14:16:45 volumio volumio[1078]: info:
Jul 10 14:16:45 volumio volumio[1078]: ---------------------------- MPD announces system playlist update
Jul 10 14:16:45 volumio volumio[1078]: info: Ignoring MPD Status Update
Jul 10 14:16:45 volumio volumio[1078]: info: sendMpdCommand status took 13 milliseconds
Jul 10 14:16:45 volumio volumio[1078]: info: sendMpdCommand clear took 13 milliseconds
Jul 10 14:16:45 volumio volumio[1078]: verbose: ControllerMpd::parseState
Jul 10 14:16:45 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 10 14:16:45 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand load "https://radio.plaza.one/mp3"
Jul 10 14:16:45 volumio volumio[1078]: info:
Jul 10 14:16:45 volumio volumio[1078]: ---------------------------- MPD announces state update: player
Jul 10 14:16:45 volumio volumio[1078]: info: ControllerMpd::getState
Jul 10 14:16:45 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand status
Jul 10 14:16:45 volumio volumio[1078]: info:
Jul 10 14:16:45 volumio volumio[1078]: ---------------------------- MPD announces state update: player
Jul 10 14:16:45 volumio volumio[1078]: info: ControllerMpd::getState
Jul 10 14:16:45 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand status
Jul 10 14:16:45 volumio volumio[1078]: error: updateQueue error: null
Jul 10 14:16:45 volumio volumio[1078]: info: ------------------------------ 35ms
Jul 10 14:16:45 volumio volumio[1078]: info: sendMpdCommand playlistinfo took 32 milliseconds
Jul 10 14:16:45 volumio volumio[1078]: verbose: ControllerMpd::parseTrackInfo
Jul 10 14:16:45 volumio volumio[1078]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Jul 10 14:16:45 volumio volumio[1078]: info: ------------------------------ 60ms
Jul 10 14:16:47 volumio mpd[1322]: exception: No such playlist
Jul 10 14:16:47 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand add "https://radio.plaza.one/mp3"
Jul 10 14:16:47 volumio volumio[1078]: info: sendMpdCommand status took 1669 milliseconds
Jul 10 14:16:47 volumio volumio[1078]: info: sendMpdCommand status took 1663 milliseconds
Jul 10 14:16:47 volumio volumio[1078]: verbose: ControllerMpd::parseState
Jul 10 14:16:47 volumio volumio[1078]: verbose: ControllerMpd::parseState
Jul 10 14:16:47 volumio volumio[1078]: info: ControllerMpd::pushState
Jul 10 14:16:47 volumio volumio[1078]: info: CoreCommandRouter::servicePushState
Jul 10 14:16:47 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:47 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:47 volumio volumio[1078]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 10 14:16:47 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:47 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:47 volumio volumio[1078]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Jul 10 14:16:47 volumio volumio[1078]: info: ControllerMpd::pushState
Jul 10 14:16:47 volumio volumio[1078]: info: CoreCommandRouter::servicePushState
Jul 10 14:16:47 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:47 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:47 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:47 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:47 volumio volumio[1078]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Jul 10 14:16:47 volumio volumio[1078]: info: ------------------------------ 1755ms
Jul 10 14:16:47 volumio volumio[1078]: info: ------------------------------ 1767ms
Jul 10 14:16:47 volumio volumio[1078]: info:
Jul 10 14:16:47 volumio volumio[1078]: ---------------------------- MPD announces system playlist update
Jul 10 14:16:47 volumio volumio[1078]: info: Ignoring MPD Status Update
Jul 10 14:16:47 volumio volumio[1078]: info: sendMpdCommand add "https://radio.plaza.one/mp3" took 109 milliseconds
Jul 10 14:16:47 volumio volumio[1078]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 10 14:16:47 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand play
Jul 10 14:16:47 volumio volumio[1078]: info:
Jul 10 14:16:47 volumio volumio[1078]: ---------------------------- MPD announces system playlist update
Jul 10 14:16:47 volumio volumio[1078]: info: Ignoring MPD Status Update
Jul 10 14:16:47 volumio volumio[1078]: info:
Jul 10 14:16:47 volumio volumio[1078]: ---------------------------- MPD announces system playlist update
Jul 10 14:16:47 volumio volumio[1078]: info: Ignoring MPD Status Update
Jul 10 14:16:47 volumio volumio[1078]: info: ------------------------------ 67ms
Jul 10 14:16:47 volumio volumio[1078]: info: sendMpdCommand play took 57 milliseconds
Jul 10 14:16:47 volumio volumio[1078]: info: ------------------------------ 57ms
Jul 10 14:16:47 volumio volumio[1078]: info: ------------------------------ 50ms
Jul 10 14:16:47 volumio volumio[1078]: info:
Jul 10 14:16:47 volumio volumio[1078]: ---------------------------- MPD announces system playlist update
Jul 10 14:16:47 volumio volumio[1078]: info: Ignoring MPD Status Update
Jul 10 14:16:47 volumio volumio[1078]: info:
Jul 10 14:16:47 volumio volumio[1078]: ---------------------------- MPD announces system playlist update
Jul 10 14:16:47 volumio volumio[1078]: info: Ignoring MPD Status Update
Jul 10 14:16:47 volumio volumio[1078]: info: ------------------------------ 18ms
Jul 10 14:16:47 volumio volumio[1078]: info: ------------------------------ 5ms
Jul 10 14:16:49 volumio mpd[1322]: exception: Failed to open "default detected output" (sndio); Requested audio params cannot be satisfied
Jul 10 14:16:49 volumio mpd[1322]: exception: Failed to open "default detected output" (sndio); Requested audio params cannot be satisfied
Jul 10 14:16:49 volumio mpd[1322]: player: problems opening audio device while playing "https://radio.plaza.one/mp3"
Jul 10 14:16:49 volumio volumio[1078]: info:
Jul 10 14:16:49 volumio volumio[1078]: ---------------------------- MPD announces state update: player
Jul 10 14:16:49 volumio volumio[1078]: info: ControllerMpd::getState
Jul 10 14:16:49 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand status
Jul 10 14:16:49 volumio volumio[1078]: info:
Jul 10 14:16:49 volumio volumio[1078]: ---------------------------- MPD announces state update: player
Jul 10 14:16:49 volumio volumio[1078]: info: ControllerMpd::getState
Jul 10 14:16:49 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand status
Jul 10 14:16:49 volumio volumio[1078]: info:
Jul 10 14:16:49 volumio volumio[1078]: ---------------------------- MPD announces state update: player
Jul 10 14:16:49 volumio volumio[1078]: info:
Jul 10 14:16:49 volumio volumio[1078]: ---------------------------- MPD announces state update: player
Jul 10 14:16:49 volumio volumio[1078]: info: ControllerMpd::getState
Jul 10 14:16:49 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand status
Jul 10 14:16:49 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand clearerror
Jul 10 14:16:49 volumio volumio[1078]: info: sendMpdCommand status took 28 milliseconds
Jul 10 14:16:49 volumio volumio[1078]: info: ControllerMpd::getState
Jul 10 14:16:49 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand status
Jul 10 14:16:49 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand clearerror
Jul 10 14:16:49 volumio volumio[1078]: info: sendMpdCommand status took 22 milliseconds
Jul 10 14:16:49 volumio volumio[1078]: verbose: ControllerMpd::parseState
Jul 10 14:16:49 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 10 14:16:49 volumio volumio[1078]: verbose: ControllerMpd::parseState
Jul 10 14:16:49 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 10 14:16:49 volumio volumio[1078]: info:
Jul 10 14:16:49 volumio volumio[1078]: ---------------------------- MPD announces state update: player
Jul 10 14:16:49 volumio volumio[1078]: info: ControllerMpd::getState
Jul 10 14:16:49 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand status
Jul 10 14:16:49 volumio volumio[1078]: info:
Jul 10 14:16:49 volumio volumio[1078]: ---------------------------- MPD announces state update: player
Jul 10 14:16:49 volumio volumio[1078]: info: ControllerMpd::getState
Jul 10 14:16:49 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand status
Jul 10 14:16:49 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand clearerror
Jul 10 14:16:49 volumio volumio[1078]: info: sendMpdCommand status took 63 milliseconds
Jul 10 14:16:49 volumio volumio[1078]: info: sendMpdCommand clearerror took 46 milliseconds
Jul 10 14:16:49 volumio volumio[1078]: info: sendMpdCommand status took 46 milliseconds
Jul 10 14:16:49 volumio volumio[1078]: info: sendMpdCommand clearerror took 45 milliseconds
Jul 10 14:16:49 volumio volumio[1078]: verbose: ControllerMpd::parseState
Jul 10 14:16:49 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 10 14:16:49 volumio volumio[1078]: verbose: ControllerMpd::parseState
Jul 10 14:16:49 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 10 14:16:49 volumio volumio[1078]: info: sendMpdCommand playlistinfo took 59 milliseconds
Jul 10 14:16:49 volumio volumio[1078]: info: sendMpdCommand playlistinfo took 49 milliseconds
Jul 10 14:16:49 volumio volumio[1078]: info: sendMpdCommand status took 49 milliseconds
Jul 10 14:16:49 volumio volumio[1078]: info: sendMpdCommand status took 51 milliseconds
Jul 10 14:16:49 volumio volumio[1078]: info: sendMpdCommand clearerror took 47 milliseconds
Jul 10 14:16:49 volumio volumio[1078]: info: sendMpdCommand playlistinfo took 16 milliseconds
Jul 10 14:16:49 volumio volumio[1078]: info: sendMpdCommand playlistinfo took 16 milliseconds
Jul 10 14:16:49 volumio volumio[1078]: verbose: ControllerMpd::parseTrackInfo
Jul 10 14:16:49 volumio volumio[1078]: verbose: ControllerMpd::parseTrackInfo
Jul 10 14:16:49 volumio volumio[1078]: verbose: ControllerMpd::parseState
Jul 10 14:16:49 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 10 14:16:49 volumio volumio[1078]: verbose: ControllerMpd::parseState
Jul 10 14:16:49 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 10 14:16:49 volumio volumio[1078]: verbose: ControllerMpd::parseTrackInfo
Jul 10 14:16:49 volumio volumio[1078]: verbose: ControllerMpd::parseTrackInfo
Jul 10 14:16:49 volumio volumio[1078]: info: ControllerMpd::pushState
Jul 10 14:16:49 volumio volumio[1078]: info: CoreCommandRouter::servicePushState
Jul 10 14:16:49 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:49 volumio volumio[1078]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"mp3","artist":null,"album":null,"uri":"https://radio.plaza.one/mp3","trackType":"one/mp3"}
Jul 10 14:16:49 volumio volumio[1078]: verbose: CURRENT POSITION 0
Jul 10 14:16:49 volumio volumio[1078]: info: CoreStateMachine::syncState stateService pause
Jul 10 14:16:49 volumio volumio[1078]: info: CoreStateMachine::syncState currentStatus stop
Jul 10 14:16:49 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:49 volumio volumio[1078]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 10 14:16:49 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:49 volumio volumio[1078]: info: ControllerMpd::pushState
Jul 10 14:16:49 volumio volumio[1078]: info: CoreCommandRouter::servicePushState
Jul 10 14:16:49 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:49 volumio volumio[1078]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"mp3","artist":null,"album":null,"uri":"https://radio.plaza.one/mp3","trackType":"one/mp3"}
Jul 10 14:16:49 volumio volumio[1078]: verbose: CURRENT POSITION 0
Jul 10 14:16:49 volumio volumio[1078]: info: CoreStateMachine::syncState stateService pause
Jul 10 14:16:49 volumio volumio[1078]: info: CoreStateMachine::syncState currentStatus stop
Jul 10 14:16:49 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:49 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:49 volumio volumio[1078]: info: ControllerMpd::pushState
Jul 10 14:16:49 volumio volumio[1078]: info: CoreCommandRouter::servicePushState
Jul 10 14:16:49 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:49 volumio volumio[1078]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"mp3","artist":null,"album":null,"uri":"https://radio.plaza.one/mp3","trackType":"one/mp3"}
Jul 10 14:16:49 volumio volumio[1078]: verbose: CURRENT POSITION 0
Jul 10 14:16:49 volumio volumio[1078]: info: CoreStateMachine::syncState stateService pause
Jul 10 14:16:49 volumio volumio[1078]: info: CoreStateMachine::syncState currentStatus stop
Jul 10 14:16:49 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:49 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:49 volumio volumio[1078]: info: ControllerMpd::pushState
Jul 10 14:16:49 volumio volumio[1078]: info: CoreCommandRouter::servicePushState
Jul 10 14:16:49 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:49 volumio volumio[1078]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"mp3","artist":null,"album":null,"uri":"https://radio.plaza.one/mp3","trackType":"one/mp3"}
Jul 10 14:16:49 volumio volumio[1078]: verbose: CURRENT POSITION 0
Jul 10 14:16:49 volumio volumio[1078]: info: CoreStateMachine::syncState stateService pause
Jul 10 14:16:49 volumio volumio[1078]: info: CoreStateMachine::syncState currentStatus stop
Jul 10 14:16:49 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:49 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:49 volumio volumio[1078]: info: ------------------------------ 233ms
Jul 10 14:16:49 volumio volumio[1078]: info: ------------------------------ 251ms
Jul 10 14:16:49 volumio volumio[1078]: info: ------------------------------ 243ms
Jul 10 14:16:49 volumio volumio[1078]: info: ------------------------------ 244ms
Jul 10 14:16:49 volumio volumio[1078]: info: sendMpdCommand playlistinfo took 134 milliseconds
Jul 10 14:16:49 volumio volumio[1078]: info: sendMpdCommand playlistinfo took 135 milliseconds
Jul 10 14:16:49 volumio volumio[1078]: verbose: ControllerMpd::parseTrackInfo
Jul 10 14:16:49 volumio volumio[1078]: verbose: ControllerMpd::parseTrackInfo
Jul 10 14:16:49 volumio volumio[1078]: info: ControllerMpd::pushState
Jul 10 14:16:49 volumio volumio[1078]: info: CoreCommandRouter::servicePushState
Jul 10 14:16:49 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:49 volumio volumio[1078]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"mp3","artist":null,"album":null,"uri":"https://radio.plaza.one/mp3","trackType":"one/mp3"}
Jul 10 14:16:49 volumio volumio[1078]: verbose: CURRENT POSITION 0
Jul 10 14:16:49 volumio volumio[1078]: info: CoreStateMachine::syncState stateService pause
Jul 10 14:16:49 volumio volumio[1078]: info: CoreStateMachine::syncState currentStatus stop
Jul 10 14:16:49 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:49 volumio volumio[1078]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 10 14:16:49 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:49 volumio volumio[1078]: info: ControllerMpd::pushState
Jul 10 14:16:49 volumio volumio[1078]: info: CoreCommandRouter::servicePushState
Jul 10 14:16:49 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:49 volumio volumio[1078]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"mp3","artist":null,"album":null,"uri":"https://radio.plaza.one/mp3","trackType":"one/mp3"}
Jul 10 14:16:49 volumio volumio[1078]: verbose: CURRENT POSITION 0
Jul 10 14:16:49 volumio volumio[1078]: info: CoreStateMachine::syncState stateService pause
Jul 10 14:16:49 volumio volumio[1078]: info: CoreStateMachine::syncState currentStatus stop
Jul 10 14:16:49 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:49 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:49 volumio volumio[1078]: info: ------------------------------ 270ms
Jul 10 14:16:49 volumio volumio[1078]: info: ------------------------------ 280ms
Jul 10 14:16:53 volumio volumio[1078]: info: Preload queue cleared
Jul 10 14:16:53 volumio volumio[1078]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jul 10 14:16:53 volumio volumio[1078]: info: CoreStateMachine::ClearQueue
Jul 10 14:16:53 volumio volumio[1078]: info: CoreStateMachine::stop
Jul 10 14:16:53 volumio volumio[1078]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 10 14:16:53 volumio volumio[1078]: info: CorePlayQueue::clearPlayQueue
Jul 10 14:16:53 volumio volumio[1078]: info: CorePlayQueue::saveQueue
Jul 10 14:16:53 volumio volumio[1078]: info: CoreCommandRouter::volumioPushQueue
Jul 10 14:16:53 volumio volumio[1078]: info: CoreStateMachine::addQueueItems
Jul 10 14:16:53 volumio volumio[1078]: info: CorePlayQueue::addQueueItems
Jul 10 14:16:53 volumio volumio[1078]: info: Preload queue cleared
Jul 10 14:16:53 volumio volumio[1078]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s136422
Jul 10 14:16:53 volumio volumio[1078]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Jul 10 14:16:54 volumio volumio[1078]: info: CoreCommandRouter::volumioPushQueue
Jul 10 14:16:54 volumio volumio[1078]: info: CorePlayQueue::saveQueue
Jul 10 14:16:54 volumio volumio[1078]: info: CoreStateMachine::updateTrackBlock
Jul 10 14:16:54 volumio volumio[1078]: info: CorePlayQueue::getTrackBlock
Jul 10 14:16:54 volumio volumio[1078]: info: CoreCommandRouter::volumioPlay
Jul 10 14:16:54 volumio volumio[1078]: info: CoreStateMachine::play index 0
Jul 10 14:16:54 volumio volumio[1078]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 10 14:16:54 volumio volumio[1078]: info: CoreStateMachine::stop
Jul 10 14:16:54 volumio volumio[1078]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 10 14:16:54 volumio volumio[1078]: info: CoreStateMachine::play index undefined
Jul 10 14:16:54 volumio volumio[1078]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 10 14:16:54 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:54 volumio volumio[1078]: info: CoreStateMachine::startPlaybackTimer
Jul 10 14:16:54 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:54 volumio volumio[1078]: info: [1752124614188] ControllerWebradio::clearAddPlayTrack
Jul 10 14:16:54 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand stop
Jul 10 14:16:54 volumio mpd[1322]: player: played "https://radio.plaza.one/mp3"
Jul 10 14:16:54 volumio volumio[1078]: info:
Jul 10 14:16:54 volumio volumio[1078]: ---------------------------- MPD announces state update: player
Jul 10 14:16:54 volumio volumio[1078]: info: sendMpdCommand stop took 24 milliseconds
Jul 10 14:16:54 volumio volumio[1078]: info: ControllerMpd::getState
Jul 10 14:16:54 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand status
Jul 10 14:16:54 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand clear
Jul 10 14:16:54 volumio volumio[1078]: info:
Jul 10 14:16:54 volumio volumio[1078]: ---------------------------- MPD announces state update: player
Jul 10 14:16:54 volumio volumio[1078]: info: ControllerMpd::getState
Jul 10 14:16:54 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand status
Jul 10 14:16:54 volumio volumio[1078]: info:
Jul 10 14:16:54 volumio volumio[1078]: ---------------------------- MPD announces state update: player
Jul 10 14:16:54 volumio volumio[1078]: info: ControllerMpd::getState
Jul 10 14:16:54 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand status
Jul 10 14:16:54 volumio volumio[1078]: info:
Jul 10 14:16:54 volumio volumio[1078]: ---------------------------- MPD announces system playlist update
Jul 10 14:16:54 volumio volumio[1078]: info: Ignoring MPD Status Update
Jul 10 14:16:54 volumio volumio[1078]: info: sendMpdCommand status took 28 milliseconds
Jul 10 14:16:54 volumio volumio[1078]: info: sendMpdCommand clear took 30 milliseconds
Jul 10 14:16:54 volumio volumio[1078]: info: sendMpdCommand status took 24 milliseconds
Jul 10 14:16:54 volumio volumio[1078]: info: sendMpdCommand status took 19 milliseconds
Jul 10 14:16:54 volumio volumio[1078]: verbose: ControllerMpd::parseState
Jul 10 14:16:54 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 10 14:16:54 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand load "http://jpopsuki.fm:8000/stream"
Jul 10 14:16:54 volumio volumio[1078]: verbose: ControllerMpd::parseState
Jul 10 14:16:54 volumio volumio[1078]: verbose: ControllerMpd::parseState
Jul 10 14:16:54 volumio volumio[1078]: info: ControllerMpd::pushState
Jul 10 14:16:54 volumio volumio[1078]: info: CoreCommandRouter::servicePushState
Jul 10 14:16:54 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:54 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:54 volumio volumio[1078]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 10 14:16:54 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:54 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:54 volumio volumio[1078]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Jul 10 14:16:54 volumio volumio[1078]: info: ControllerMpd::pushState
Jul 10 14:16:54 volumio volumio[1078]: info: CoreCommandRouter::servicePushState
Jul 10 14:16:54 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:54 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:54 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:54 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:54 volumio volumio[1078]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Jul 10 14:16:54 volumio volumio[1078]: info: ------------------------------ 122ms
Jul 10 14:16:54 volumio volumio[1078]: info: ------------------------------ 117ms
Jul 10 14:16:54 volumio volumio[1078]: info:
Jul 10 14:16:54 volumio volumio[1078]: ---------------------------- MPD announces system playlist update
Jul 10 14:16:54 volumio volumio[1078]: info: Ignoring MPD Status Update
Jul 10 14:16:54 volumio volumio[1078]: info:
Jul 10 14:16:54 volumio volumio[1078]: ---------------------------- MPD announces system playlist update
Jul 10 14:16:54 volumio volumio[1078]: info: Ignoring MPD Status Update
Jul 10 14:16:54 volumio volumio[1078]: error: updateQueue error: null
Jul 10 14:16:54 volumio volumio[1078]: info: ------------------------------ 132ms
Jul 10 14:16:54 volumio volumio[1078]: info: sendMpdCommand playlistinfo took 113 milliseconds
Jul 10 14:16:54 volumio volumio[1078]: verbose: ControllerMpd::parseTrackInfo
Jul 10 14:16:54 volumio volumio[1078]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Jul 10 14:16:54 volumio volumio[1078]: info: ------------------------------ 158ms
Jul 10 14:16:55 volumio mpd[1322]: exception: No such playlist
Jul 10 14:16:55 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand add "http://jpopsuki.fm:8000/stream"
Jul 10 14:16:55 volumio volumio[1078]: error: updateQueue error: null
Jul 10 14:16:55 volumio volumio[1078]: error: updateQueue error: null
Jul 10 14:16:55 volumio volumio[1078]: info:
Jul 10 14:16:55 volumio volumio[1078]: ---------------------------- MPD announces system playlist update
Jul 10 14:16:55 volumio volumio[1078]: info: Ignoring MPD Status Update
Jul 10 14:16:55 volumio volumio[1078]: info: ------------------------------ 885ms
Jul 10 14:16:55 volumio volumio[1078]: info: ------------------------------ 884ms
Jul 10 14:16:55 volumio volumio[1078]: info: sendMpdCommand add "http://jpopsuki.fm:8000/stream" took 8 milliseconds
Jul 10 14:16:55 volumio volumio[1078]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 10 14:16:55 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand play
Jul 10 14:16:55 volumio volumio[1078]: info:
Jul 10 14:16:55 volumio volumio[1078]: ---------------------------- MPD announces system playlist update
Jul 10 14:16:55 volumio volumio[1078]: info: Ignoring MPD Status Update
Jul 10 14:16:55 volumio volumio[1078]: info:
Jul 10 14:16:55 volumio volumio[1078]: ---------------------------- MPD announces system playlist update
Jul 10 14:16:55 volumio volumio[1078]: info: Ignoring MPD Status Update
Jul 10 14:16:55 volumio volumio[1078]: info: ------------------------------ 23ms
Jul 10 14:16:55 volumio volumio[1078]: info: sendMpdCommand play took 23 milliseconds
Jul 10 14:16:55 volumio volumio[1078]: info: ------------------------------ 15ms
Jul 10 14:16:55 volumio volumio[1078]: info: ------------------------------ 13ms
Jul 10 14:16:56 volumio mpd[1322]: exception: Failed to open "default detected output" (sndio); Requested audio params cannot be satisfied
Jul 10 14:16:56 volumio mpd[1322]: exception: Failed to open "default detected output" (sndio); Requested audio params cannot be satisfied
Jul 10 14:16:56 volumio mpd[1322]: player: problems opening audio device while playing "http://jpopsuki.fm:8000/stream"
Jul 10 14:16:56 volumio volumio[1078]: info:
Jul 10 14:16:56 volumio volumio[1078]: ---------------------------- MPD announces state update: player
Jul 10 14:16:56 volumio volumio[1078]: info: ControllerMpd::getState
Jul 10 14:16:56 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand status
Jul 10 14:16:56 volumio volumio[1078]: info:
Jul 10 14:16:56 volumio volumio[1078]: ---------------------------- MPD announces state update: player
Jul 10 14:16:56 volumio volumio[1078]: info: ControllerMpd::getState
Jul 10 14:16:56 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand status
Jul 10 14:16:56 volumio volumio[1078]: info:
Jul 10 14:16:56 volumio volumio[1078]: ---------------------------- MPD announces state update: player
Jul 10 14:16:56 volumio volumio[1078]: info:
Jul 10 14:16:56 volumio volumio[1078]: ---------------------------- MPD announces state update: player
Jul 10 14:16:56 volumio volumio[1078]: info: ControllerMpd::getState
Jul 10 14:16:56 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand status
Jul 10 14:16:56 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand clearerror
Jul 10 14:16:56 volumio volumio[1078]: info: sendMpdCommand status took 30 milliseconds
Jul 10 14:16:56 volumio volumio[1078]: info: ControllerMpd::getState
Jul 10 14:16:56 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand status
Jul 10 14:16:56 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand clearerror
Jul 10 14:16:56 volumio volumio[1078]: info: sendMpdCommand status took 26 milliseconds
Jul 10 14:16:56 volumio volumio[1078]: verbose: ControllerMpd::parseState
Jul 10 14:16:56 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 10 14:16:56 volumio volumio[1078]: verbose: ControllerMpd::parseState
Jul 10 14:16:56 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 10 14:16:56 volumio volumio[1078]: info:
Jul 10 14:16:56 volumio volumio[1078]: ---------------------------- MPD announces state update: player
Jul 10 14:16:56 volumio volumio[1078]: info: ControllerMpd::getState
Jul 10 14:16:56 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand status
Jul 10 14:16:56 volumio volumio[1078]: info:
Jul 10 14:16:56 volumio volumio[1078]: ---------------------------- MPD announces state update: player
Jul 10 14:16:56 volumio volumio[1078]: info: ControllerMpd::getState
Jul 10 14:16:56 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand status
Jul 10 14:16:56 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand clearerror
Jul 10 14:16:56 volumio volumio[1078]: info: sendMpdCommand status took 95 milliseconds
Jul 10 14:16:56 volumio volumio[1078]: info: sendMpdCommand clearerror took 79 milliseconds
Jul 10 14:16:56 volumio volumio[1078]: info: sendMpdCommand status took 79 milliseconds
Jul 10 14:16:56 volumio volumio[1078]: info: sendMpdCommand clearerror took 78 milliseconds
Jul 10 14:16:56 volumio volumio[1078]: info: sendMpdCommand playlistinfo took 55 milliseconds
Jul 10 14:16:56 volumio volumio[1078]: info: sendMpdCommand playlistinfo took 41 milliseconds
Jul 10 14:16:56 volumio volumio[1078]: info: sendMpdCommand status took 39 milliseconds
Jul 10 14:16:56 volumio volumio[1078]: info: sendMpdCommand status took 27 milliseconds
Jul 10 14:16:56 volumio volumio[1078]: verbose: ControllerMpd::parseState
Jul 10 14:16:56 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 10 14:16:56 volumio volumio[1078]: verbose: ControllerMpd::parseState
Jul 10 14:16:56 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 10 14:16:56 volumio volumio[1078]: verbose: ControllerMpd::parseTrackInfo
Jul 10 14:16:56 volumio volumio[1078]: verbose: ControllerMpd::parseTrackInfo
Jul 10 14:16:56 volumio volumio[1078]: verbose: ControllerMpd::parseState
Jul 10 14:16:56 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 10 14:16:56 volumio volumio[1078]: verbose: ControllerMpd::parseState
Jul 10 14:16:56 volumio volumio[1078]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 10 14:16:56 volumio volumio[1078]: info: ControllerMpd::pushState
Jul 10 14:16:56 volumio volumio[1078]: info: CoreCommandRouter::servicePushState
Jul 10 14:16:56 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:56 volumio volumio[1078]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://jpopsuki.fm:8000/stream","trackType":""}
Jul 10 14:16:56 volumio volumio[1078]: verbose: CURRENT POSITION 0
Jul 10 14:16:56 volumio volumio[1078]: info: CoreStateMachine::syncState stateService pause
Jul 10 14:16:56 volumio volumio[1078]: info: CoreStateMachine::syncState currentStatus stop
Jul 10 14:16:56 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:56 volumio volumio[1078]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 10 14:16:56 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:56 volumio volumio[1078]: info: ControllerMpd::pushState
Jul 10 14:16:56 volumio volumio[1078]: info: CoreCommandRouter::servicePushState
Jul 10 14:16:56 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:56 volumio volumio[1078]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://jpopsuki.fm:8000/stream","trackType":""}
Jul 10 14:16:56 volumio volumio[1078]: verbose: CURRENT POSITION 0
Jul 10 14:16:56 volumio volumio[1078]: info: CoreStateMachine::syncState stateService pause
Jul 10 14:16:56 volumio volumio[1078]: info: CoreStateMachine::syncState currentStatus stop
Jul 10 14:16:56 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:56 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:56 volumio volumio[1078]: info: ------------------------------ 267ms
Jul 10 14:16:56 volumio volumio[1078]: info: ------------------------------ 260ms
Jul 10 14:16:56 volumio volumio[1078]: info: sendMpdCommand clearerror took 188 milliseconds
Jul 10 14:16:56 volumio volumio[1078]: info: sendMpdCommand playlistinfo took 187 milliseconds
Jul 10 14:16:56 volumio volumio[1078]: info: sendMpdCommand playlistinfo took 187 milliseconds
Jul 10 14:16:56 volumio volumio[1078]: info: sendMpdCommand playlistinfo took 186 milliseconds
Jul 10 14:16:56 volumio volumio[1078]: info: sendMpdCommand playlistinfo took 160 milliseconds
Jul 10 14:16:56 volumio volumio[1078]: verbose: ControllerMpd::parseTrackInfo
Jul 10 14:16:56 volumio volumio[1078]: verbose: ControllerMpd::parseTrackInfo
Jul 10 14:16:56 volumio volumio[1078]: verbose: ControllerMpd::parseTrackInfo
Jul 10 14:16:56 volumio volumio[1078]: verbose: ControllerMpd::parseTrackInfo
Jul 10 14:16:56 volumio volumio[1078]: info: ControllerMpd::pushState
Jul 10 14:16:56 volumio volumio[1078]: info: CoreCommandRouter::servicePushState
Jul 10 14:16:56 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:56 volumio volumio[1078]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://jpopsuki.fm:8000/stream","trackType":""}
Jul 10 14:16:56 volumio volumio[1078]: verbose: CURRENT POSITION 0
Jul 10 14:16:56 volumio volumio[1078]: info: CoreStateMachine::syncState stateService pause
Jul 10 14:16:56 volumio volumio[1078]: info: CoreStateMachine::syncState currentStatus stop
Jul 10 14:16:56 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:56 volumio volumio[1078]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 10 14:16:56 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:56 volumio volumio[1078]: info: ControllerMpd::pushState
Jul 10 14:16:56 volumio volumio[1078]: info: CoreCommandRouter::servicePushState
Jul 10 14:16:56 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:56 volumio volumio[1078]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://jpopsuki.fm:8000/stream","trackType":""}
Jul 10 14:16:56 volumio volumio[1078]: verbose: CURRENT POSITION 0
Jul 10 14:16:56 volumio volumio[1078]: info: CoreStateMachine::syncState stateService pause
Jul 10 14:16:56 volumio volumio[1078]: info: CoreStateMachine::syncState currentStatus stop
Jul 10 14:16:56 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:56 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:56 volumio volumio[1078]: info: ControllerMpd::pushState
Jul 10 14:16:56 volumio volumio[1078]: info: CoreCommandRouter::servicePushState
Jul 10 14:16:56 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:56 volumio volumio[1078]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://jpopsuki.fm:8000/stream","trackType":""}
Jul 10 14:16:56 volumio volumio[1078]: verbose: CURRENT POSITION 0
Jul 10 14:16:56 volumio volumio[1078]: info: CoreStateMachine::syncState stateService pause
Jul 10 14:16:56 volumio volumio[1078]: info: CoreStateMachine::syncState currentStatus stop
Jul 10 14:16:56 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:56 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:56 volumio volumio[1078]: info: ControllerMpd::pushState
Jul 10 14:16:56 volumio volumio[1078]: info: CoreCommandRouter::servicePushState
Jul 10 14:16:56 volumio volumio[1078]: info: CorePlayQueue::getTrack 0
Jul 10 14:16:56 volumio volumio[1078]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://jpopsuki.fm:8000/stream","trackType":""}
Jul 10 14:16:56 volumio volumio[1078]: verbose: CURRENT POSITION 0
Jul 10 14:16:56 volumio volumio[1078]: info: CoreStateMachine::syncState stateService pause
Jul 10 14:16:56 volumio volumio[1078]: info: CoreStateMachine::syncState currentStatus stop
Jul 10 14:16:56 volumio volumio[1078]: info: CoreStateMachine::pushState
Jul 10 14:16:56 volumio volumio[1078]: info: CoreCommandRouter::volumioPushState
Jul 10 14:16:56 volumio volumio[1078]: info: ------------------------------ 479ms
Jul 10 14:16:56 volumio volumio[1078]: info: ------------------------------ 490ms
Jul 10 14:16:56 volumio volumio[1078]: info: ------------------------------ 434ms
Jul 10 14:16:56 volumio volumio[1078]: info: ------------------------------ 422ms
Jul 10 14:17:03 volumio volumio[1078]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Jul 10 14:17:04 volumio volumio[1078]: Use XMLElement.setAttribute instead
Jul 10 14:17:04 volumio volumio[1078]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 10 14:17:04 volumio volumio[1078]: TypeError: children[i].attr(...).value is not a function
Jul 10 14:17:04 volumio volumio[1078]: at /volumio/app/plugins/music_service/webradio/index.js:428:46
Jul 10 14:17:04 volumio volumio[1078]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5)
Jul 10 14:17:04 volumio volumio[1078]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 10 14:17:07 volumio sudo[1956]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-07-10 14:16'
Jul 10 14:17:07 volumio sudo[1956]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)"
NAME="Raspbian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
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="26d819930af572ef184e636a18ef1127de78f391"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed May 21 13:47:54 UTC 2025"
VOLUMIO_VERSION="0.068"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="82c7b61aa1619bd495d6c4f648975de8"