-- Logs begin at Sat 2025-03-08 03:10:37 CET, end at Sun 2025-03-09 11:32:57 CET. -- Mar 09 11:31:02 volumio volumio[1203]: info: New access token = BQC-_RTUPFpzrhsGFnE3ewwrF-knLNT9R3hpAH5MtDuLl3oiku_IKR3ofJL6feh8n8ytQA21df51JkH9oWXgXHSlkJGpxaujArZh0xuCkIG7fFSxaAT2ExthsyLmufivQNr9SDehd3oVVgQ6poWhs7tuPQsGVSOMUb6kyln2s58QAmlpLyA1jxZ1fLK8D1WQHEgNc_J9lT1Io5f8HhFoRtSvFMUyT4YtIGTlIlr3fLtS2DmBl2OwVaTFfaqfmXO4-umirCdKfuHa5VLnLTlSF1hLjzC4UXxJzO7zC5iuaSM Mar 09 11:31:02 volumio volumio[1203]: info: New access token = BQC-i4uQZizlzfLB_5pFvWQIN98eZmsEI6NEbKyS1DU4HrR69MaM1Ye0ZdzdqU_fm2SewWMMJoXcZTM0vWEJCHrAmWfj_RRdOJXk598Ak8MLgQHDFv2Ohcj5xoNyrFGx7rGoq4zgNvSjYybPmzN-mlJIQ-VU1VwW1ryuyITKXhI32rEIpNtntPchZzhS7eDuBZxasHDpyI9LEbftUdzUpv8Zr8JfT3rVIou1lHzkRajfqv5fWP_MzeuFbx-m3Pjjtfx2oPV0auVcFCeWbNwuEFbyj_ms6RlVHJYXb5hSvyg Mar 09 11:31:04 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Mar 09 11:31:07 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Mar 09 11:31:07 volumio volumio[1203]: info: New access token = BQBt9eDhd3lOVYolwwzxM3Og2QZ_zy6h1Q-ObRhPZw4vPk2ylPpH3bojS-3-_bUh-iFKyLjn2jlwvIaNyhZmVLS6pGqo4rpb7oVMVtSh7xA_ek33bv09UskwBenZGibgPZMKk9gj7vXiSfh0HE9O9id9lWztIK4WB9yyBgAwxsta5-2hoIovLNnPfLkvYHwH81KLDvEkMSD20Ys3spEwkgHV4En6pIgDQPIOmxqiUe5NjdMTRx7yGA6mbjngLn8cGzPC2c1hJcZW06pfJH8k3orjP6FCcndHRXivTvkrpWc Mar 09 11:31:07 volumio volumio[1203]: info: New access token = BQD1FgXRJWhMEGu__BdP9A-k1WjzfVGGjWvvjLZRd3AAsYFDFdkuRu_3fJkZr2Kn1fs2u8OAsQBzy4niwWerNeBudwNyukEJSXqm5lBVcATlsEVqp_nuaX36j8mzDb4pKbtzHEFuuNO2VuhuNlZJUAyYa7uypnNO6DUCqdvkyiVFiFh_UefcBBUEHwspcTU1JFaQ8nWgBj2aiYK5up4bE4RUskGHawefqCctEoWlitIzb9y1iavSH-KYd7Ajx04N1_yp5_fYT4gYoXZAn1H4A7RJ-WXB01r5HXfgDpckM5E Mar 09 11:31:12 volumio volumio[1203]: info: New access token = BQB7YsxOhlyrbNuK5gKjBSB-Lei7gWGSLb7D4Cqwmohv4Vp5nrwmbQoi_lSbwhg491M04bGLqgLLlfRNC1QvHQeqrrwtFvXyN_dyv2iy-gJ2_ko9rSj2guJbzQlJDQ4ZpnIc8lofvR5bQwZu4M7lRcQg3GnG_xVWSWpEQg6vlBMm0UyaVuZq4Azl5MQDU1QGs91QAdIagPUumdZG6YqB1LrHOU8JlAB9E4QrpsQIw5HADvpy7nZEepDI--Ul1bL9So8ZjA7W30gICbxo-iKGqc5qAn9sDxNnGFzRFZsG1yI Mar 09 11:31:12 volumio volumio[1203]: info: New access token = BQBh4tTEPx8NHyPBDaV2gryHqyIYFnzm0xtt4G0aMZTxKPOmXXGn9jFj4eIYQ3_9-UidpsQI6u2biTnDk8l-W4vHrmCT07tLCG8UHVNgVaFH8Z8p7U42qMIJbCGMbnqI4Z_SrTPWBkMGcyPJq3nIGwUR0ef7uF8j07F0zrrnYSFCujO-XYZSI1aLVm4BUUDz39T_7YmrLb-3UhzMazi96raWGPksqy49Ul3EdXJ3rlbzH5GpIw4_46sOqvep1ETcIwbIhS1kuQ02kD6s-SJczRpoh1O3g-qVnn0Dnyb_my0 Mar 09 11:31:17 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Mar 09 11:31:17 volumio volumio[1203]: info: TuneIn handleBrowseUri: tunein/popular Mar 09 11:31:17 volumio volumio[1203]: info: New access token = BQDPhs7W6uDIBRywVr2b3xhPi0TpGYoJlvcyIbH-DXXXkM-sh0_-rDFx3VT2Y7kgHbRMqWJA8PsAiqMD_gHFQdLkRq66wM2BQeUbp20eJm7E1D7FuJjfvh47fY6TmEryS_LuyeXtvceCpsidEIpfw88Abzrp-wwVp0WocXZWXIN6EjcWoJQ-qd2DXvIRVYMPdvJ-GZvhsznNOdCE5Fjfuax_vLWb6jDYELbqvbSRuc_Tb4sBcxTNKKyN3-GnhG5efBMh77MQvMDLVVt1-oPZlAXU8E22jS2OODKjGrEew90 Mar 09 11:31:17 volumio volumio[1203]: info: New access token = BQBMiXItSnQtSK4Qp9J_F73FIpBLirx7MtqOEbb-yTOrLiunYmwEwiJ5udsnJ_O8-GjXLgy7q2xVmHy-PLnr7EpBon0ton476faMhiFECo4k3DVohbRSkawk4SN8cAH1wSPajzQrx-2C-NAl-kk7Aef2j8sOtUV2kXUH19aTo32onI8x9ZGIjak6L2Dol6mnvKxFa3Qc3fa2q24-bOzPXdpzgRnIrpot8krSX9wx07K5ZpRAaIVx9en9NvNLQVJ5L7YzKNuGBiKr4dwru5kfLDIIrorcg4PYTaHYm1qzyCU Mar 09 11:31:18 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Mar 09 11:31:18 volumio volumio[1203]: info: TuneIn handleBrowseUri: tunein/popular Mar 09 11:31:19 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Mar 09 11:31:19 volumio volumio[1203]: info: TuneIn handleBrowseUri: tunein/best Mar 09 11:31:20 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Mar 09 11:31:20 volumio volumio[1203]: info: Getting BBC Radios Mar 09 11:31:22 volumio volumio[1203]: info: New access token = BQCx9jHF6CuHNRVfpYe2nGsykUog82AmITuiF8ePm8XEln2JKYvO1BiJ4kpyHYk20N6jFbEzAuKLDCfPdavH4wR5ECU7ca4v4LLLiGfOHh1lbFtabH8jkgBk-U95QqQBflDutkdRq9nCp-T2aqVb7gisKsf-I_MFmmvjlGlE8JxNV30xGUgr9QeTCHz3we-pkKjzNDKXqXzvfLz8I3ClE37NCYdhtfxYlVONaciUTqAH7uhCErMdQzCwASqHcP3xHH1ZegGVqi-ku07TLgoBxJEymn2mBg8moNVrrIYaKv0 Mar 09 11:31:22 volumio volumio[1203]: info: New access token = BQBy-H6c2n-tBOdwMy5WRoQAAZh6__xs7BHvs4zxu2xnMoqUnPRN9QK3NATZPpXmEBKZXpgZsiwOkLMRoolbNdGL7kyTHilHbMJUFXGSB7YAw_rcwTLU_KHoIKJseotXPREb1yJBa-owjOPf31XaCKn7nozTyKA8AP7R9Dy2cIAcSyVBLxdhhlNJFuiqjDlqr5XjbrAVA2mQz6URMDHJcvXS8TwvJo8_-40jAraCG13VtCX_22JmUulQrVwI3Gacj5HlEcoqMs0FVazIIY31flnUkQcPtwP8LAPTRWAIazw Mar 09 11:31:23 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Mar 09 11:31:23 volumio volumio[1203]: info: Preload queue cleared Mar 09 11:31:25 volumio volumio[1203]: error: Failed to execute browseSource: [object Object] Mar 09 11:31:27 volumio volumio[1203]: info: New access token = BQDdz-svS0gMJyywbYcQ5jKhb5YFgkZtpcRfUwy43jBAyExSydD86Cfwqql-UDIZaIxAIpHXQdUhd6bRbqwGr9MUmHTkfFxdKSq2zl4glGVtw7GYSmvaguknsEtC_SjMGiZd22tJOqsHhEw5R6K4Tf5Nnm7RbuvDdori2h6WOsdfYzrugPr6PXNmnPsxEKg9lJlKsW7nuJOXQnGKBpGez2A_JcnYBV1xmOCLlJmNtr9eh4fAQhWTxAsM6dYvQrJSTLB9o9ELqzvDlknhLfYSCeo3QdZot2ZFey2N9ujxF0Y Mar 09 11:31:27 volumio volumio[1203]: info: New access token = BQA13ErpB1C5zj09b4jz0_BcaRJIkGT-Vv4kzaPCeUsM_s5TST4MJQMe-5NE7yTKlKgFOdCzxEG9wTmCXt1PGIpuZxFZi_qHB-Gt0leRON64yYhETNDN-HvRbQ2rYuviLdtPpwiV5A16hqt_iKhi6vUOLYqfEM2VQkVV5SD-o-L9Y5sK_lU2sjuiQQ0hgHERLhFa0kjKYf1N8PVzkRxoQRs_cNt-Wjpm2im-ZUHLjFeRz1zMUWeJ5hifI8WnM9R3ri_TgkworGwjrLN0PZUBH4jdLjZUjCOnXPumDv4H5rA Mar 09 11:31:32 volumio volumio[1203]: info: New access token = BQC6SVkf5_GOLpHSI9nH-L4PG5xucbFO3g4bWXjIlzRQEfDaqzgCtkXkzofjagCxTo4h3hhIG5nskylCp9L7l1ira7n45z-t67RbcsIZ2a3vQCJgVGIf_zdhb58JBO1CB66oPucbendlQRwi_96PJhMj4PStej0AXzHtM2_S-A0juy0jgw8UOmNhLW1KV4iCYm88hJr7xZRV85tQuLXhpU675S62CzPMEXH0MPCRkDbJwQ74FPEbOb_Vd5TYV-IitH2e02F2suk4dbDo2rWMqoKY7kFsstGpH3ueWnXqV9g Mar 09 11:31:32 volumio volumio[1203]: info: New access token = BQBWXJAqP_4whFtgIa2ex_KFKMN0CrmO1yKbMp6XH85o0bFh_PbeALMhOYFWcx-dL-Ci4T9y2uAxbCALpfeuw4ziLSZbrLIWSAWUTdW_-160CDbXDLX-tZRA58bv4khgWRU__EavBZiiboES19CqWQa3j2_2bz01-oyvM4sOXvCyQoz4iJyxuD-7Ou__62x_OfYkTRer4NTzYKq-Q5fNu-rQajmakMlbqmN_vxzLUSoOc-xkvE5rEwKHTd86GF3_VfoGJNwvV7ACP8qrkEDYP3Lmsb4ZIEkJyNYvDYckXEs Mar 09 11:31:32 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: 80s80s , handleBrowseUri Mar 09 11:31:32 volumio volumio[1203]: info: [1741516292647] [80s80s] handleBrowseUri curUri: 80s80s Mar 09 11:31:32 volumio volumio[1203]: info: Preload queue cleared Mar 09 11:31:34 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: 80s80s , handleBrowseUri Mar 09 11:31:34 volumio volumio[1203]: info: [1741516294798] [80s80s] handleBrowseUri curUri: 80s80s/eighties Mar 09 11:31:34 volumio volumio[1203]: info: [1741516294798] [80s80s] getRadioContent url: eighties Mar 09 11:31:34 volumio volumio[1203]: info: Preload queue cleared Mar 09 11:31:37 volumio volumio[1203]: info: New access token = BQBYGhrkfPa9H_kzU1xj-OciThRAy9kawuhmIqacZWNFg-nAFmytwMN0WIyJkle8-wMMyHnB1Hv0u_cqGJ21AjdEjm6gS58elkeOt3wbPosqMZAmJ5nIK3HOILcIcLXVGTba7OCSViiK-YLNvBTy6UKcmf28td1ogozHIF_Y4wJJze1MVb6ac1u-R_xS_1jajmdVyyEBlgpZoje1OFgoKPAg9kZbQGCCtomA_CMlcXJEz-W_KvDfJxMQ3rGaoNK6xChC0ZspEndcOHM_giWqnxsrBYfBnq2ieOxIzC7Go8Y Mar 09 11:31:37 volumio volumio[1203]: info: New access token = BQCj5yCkyxrqDSwHlrFsFAl2kOtahgJpDIGWo0FNaq4UZTvOlMxgey8mEb1o-ndCo8Z_87PVepUN4yIRGKZdU0kaZ4JmIhUn72PVnz55yhehGUX4pxgaze31BoV4fjjc_-tcXlK4RIlhck-wlxl_cjqK2SDrsqO1hgujHE18kfCqcjIMTAj5vmkO0yxkTkosNi5LIOPe2xFqn1I4vFuxoLK5OmbcJsMrDld-t43_IJNjbPOwLuG9vDwvUjvOB-1KNo67mHsg6-CrJOmT75glCcxRkfFwe9Y79NwWkny4E00 Mar 09 11:31:42 volumio volumio[1203]: info: New access token = BQB_wqqzy2TN4DSRMrwx1YsfMPi3wBQV_k8lYbcGKwvBlIG0wqm5QQY40J9FqXZKauYTSJyQK6YrQuuleuyiedWC84pTPWoU6qVGAtx7DbD21rdYPbkG-7alCGC-qlV4ebZUBe_DeimaZkD46Cyip2hbmOczAVtdAYWx8KhtYqXkdHTwpSRxVyI4TU7BB1rCuHUCpiK_yZ0BniNAdESjy28E88Mf66jml1ptZolJAXqukYVKYni-Ca5mSb2XgBPV4XNtb3HvOKuANCvprtSxHmc6iX6fnpgljKP6n4u6dhc Mar 09 11:31:42 volumio volumio[1203]: info: New access token = BQCD7ZJ2kVKnwLZaJh31GqnofAH_5_krFOwk4zYqarknbykgIqIYxYqml17S7JoieSxmLI0v98D9LToX6fSi5eZgiXhpg4vGHK1l8oQg3OlKnK0iOiZO0almPCrO8V09xOy0GdMkeYf4dZp326Yr7tYJ2HWu5DLMhK-HQQAjm2DLT7QRHiD-iFDqdniNdzPX3oSV90RjDJFmbj2CkdOE5r2NNfZp4gSH_wkDZB9SqsrRsO4bNUmF-DORoCfORWAaqSgFHUM6hbFrEUhz5xF6z-Cb-Z0Q7PIxnCjrMdvhKDk Mar 09 11:31:43 volumio volumio[1203]: info: Preload queue cleared Mar 09 11:31:43 volumio volumio[1203]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 09 11:31:43 volumio volumio[1203]: info: CoreStateMachine::ClearQueue Mar 09 11:31:43 volumio volumio[1203]: info: CoreStateMachine::stop Mar 09 11:31:43 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:31:43 volumio volumio[1203]: info: CoreStateMachine::stPlaybackTimer Mar 09 11:31:43 volumio volumio[1203]: info: CoreStateMachine::updateTrackBlock Mar 09 11:31:43 volumio volumio[1203]: info: CorePlayQueue::getTrackBlock Mar 09 11:31:43 volumio volumio[1203]: info: CoreStateMachine::pushState Mar 09 11:31:43 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:31:43 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 11:31:43 volumio volumio[1203]: info: CoreCommandRouter::volumioPushState Mar 09 11:31:43 volumio volumio[1203]: info: CoreStateMachine::serviceStop Mar 09 11:31:43 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:31:43 volumio volumio[1203]: info: CoreCommandRouter::serviceStop Mar 09 11:31:43 volumio volumio[1203]: info: ControllerMpd::stop Mar 09 11:31:43 volumio volumio[1203]: verbose: ControllerMpd::sendMpdCommand stop Mar 09 11:31:43 volumio volumio[1203]: info: CorePlayQueue::clearPlayQueue Mar 09 11:31:43 volumio volumio[1203]: info: CorePlayQueue::saveQueue Mar 09 11:31:43 volumio volumio[1203]: info: CoreCommandRouter::volumioPushQueue Mar 09 11:31:43 volumio volumio[1203]: info: CoreStateMachine::addQueueItems Mar 09 11:31:43 volumio volumio[1203]: info: CorePlayQueue::addQueueItems Mar 09 11:31:43 volumio volumio[1203]: info: Preload queue cleared Mar 09 11:31:43 volumio volumio[1203]: info: Adding Item to queue: webeighties/5 Mar 09 11:31:43 volumio volumio[1203]: info: Exploding uri webeighties/5 in service 80s80s Mar 09 11:31:43 volumio volumio[1203]: info: [1741516303387] [80s80s] explodeUri: webeighties/5 Mar 09 11:31:43 volumio volumio[1203]: info: CoreCommandRouter::volumioPushQueue Mar 09 11:31:43 volumio volumio[1203]: info: CorePlayQueue::saveQueue Mar 09 11:31:43 volumio volumio[1203]: info: CoreStateMachine::updateTrackBlock Mar 09 11:31:43 volumio volumio[1203]: info: CorePlayQueue::getTrackBlock Mar 09 11:31:43 volumio volumio[1203]: info: CoreCommandRouter::volumioPlay Mar 09 11:31:43 volumio volumio[1203]: info: CoreStateMachine::play index 0 Mar 09 11:31:43 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:31:43 volumio volumio[1203]: info: CoreStateMachine::stop Mar 09 11:31:43 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:31:43 volumio volumio[1203]: info: CoreStateMachine::play index undefined Mar 09 11:31:43 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:31:43 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:31:43 volumio volumio[1203]: info: CoreStateMachine::startPlaybackTimer Mar 09 11:31:43 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:31:43 volumio volumio[1203]: info: CoreCommandRouter::volumioGetVisibleSources Mar 09 11:31:43 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 09 11:31:43 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 09 11:31:43 volumio volumio[1203]: info: [1741516303395] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/italohits/mp3-192/volumio Mar 09 11:31:43 volumio volumio[1203]: info: [1741516303395] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=283&count=2 Mar 09 11:31:43 volumio volumio[1203]: info: [ASDebug] CurState: stop PrevState: play Mar 09 11:31:43 volumio volumio[1203]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Mar 09 11:31:43 volumio volumio[1203]: info: [GPIO_Control] Status changed: stop Mar 09 11:31:43 volumio volumio[1203]: info: [GPIO_Control] Handling event: musicStop Mar 09 11:31:43 volumio volumio[1203]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Mar 09 11:31:43 volumio volumio[1203]: info: sendMpdCommand stop took 17 milliseconds Mar 09 11:31:43 volumio volumio[1203]: info: CoreCommandRouter::servicePushState Mar 09 11:31:43 volumio volumio[1203]: info: CoreStateMachine::pushState Mar 09 11:31:43 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:31:43 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 11:31:43 volumio volumio[1203]: info: CoreCommandRouter::volumioPushState Mar 09 11:31:43 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:31:43 volumio volumio[1203]: verbose: STATE SERVICE {"status":"stop","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is3-ssl.mzstatic.com/image/thumb/Music115/v4/18/53/16/18531677-1097-4220-9fa6-9f9aedd2e764/source/600x600bb.jpg","name":"George Michael - Faith","title":"Faith","artist":"80s80s DAB Hamburg","album":"","streaming":true,"disableUiControls":true,"duration":"156","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Mar 09 11:31:43 volumio volumio[1203]: verbose: CURRENT POSITION 0 Mar 09 11:31:43 volumio volumio[1203]: info: CoreStateMachine::syncState stateService stop Mar 09 11:31:43 volumio volumio[1203]: info: CoreStateMachine::syncState currentStatus stop Mar 09 11:31:43 volumio volumio[1203]: info: CoreStateMachine::pushState Mar 09 11:31:43 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:31:43 volumio volumio[1203]: info: CoreCommandRouter::volumioPushState Mar 09 11:31:43 volumio volumio[1203]: info: No code Mar 09 11:31:43 volumio volumio[1203]: info: CoreStateMachine::pushState Mar 09 11:31:43 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:31:43 volumio volumio[1203]: info: CoreCommandRouter::volumioPushState Mar 09 11:31:43 volumio volumio[1203]: info: [ASDebug] CurState: stop PrevState: play Mar 09 11:31:43 volumio volumio[1203]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Mar 09 11:31:43 volumio volumio[1203]: info: [ASDebug] CurState: stop PrevState: play Mar 09 11:31:43 volumio volumio[1203]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Mar 09 11:31:43 volumio volumio[1203]: info: [ASDebug] CurState: stop PrevState: play Mar 09 11:31:43 volumio volumio[1203]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Mar 09 11:31:43 volumio volumio[1203]: info: [GPIO_Control] Status changed: stop Mar 09 11:31:43 volumio volumio[1203]: info: [GPIO_Control] Status changed: stop Mar 09 11:31:43 volumio volumio[1203]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Mar 09 11:31:43 volumio volumio[1203]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Mar 09 11:31:43 volumio volumio[1203]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Mar 09 11:31:43 volumio volumio[1203]: info: touch_display: Setting screensaver timeout to 600 seconds. Mar 09 11:31:44 volumio volumio[1203]: info: [ASDebug] Togle GPIO: OFF Mar 09 11:31:45 volumio volumio[1203]: info: Preload queue cleared Mar 09 11:31:45 volumio volumio[1203]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 09 11:31:45 volumio volumio[1203]: info: CoreStateMachine::ClearQueue Mar 09 11:31:45 volumio volumio[1203]: info: CoreStateMachine::stop Mar 09 11:31:45 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:31:45 volumio volumio[1203]: info: CorePlayQueue::clearPlayQueue Mar 09 11:31:45 volumio volumio[1203]: info: CorePlayQueue::saveQueue Mar 09 11:31:45 volumio volumio[1203]: info: CoreCommandRouter::volumioPushQueue Mar 09 11:31:45 volumio volumio[1203]: info: CoreStateMachine::addQueueItems Mar 09 11:31:45 volumio volumio[1203]: info: CorePlayQueue::addQueueItems Mar 09 11:31:45 volumio volumio[1203]: info: Preload queue cleared Mar 09 11:31:45 volumio volumio[1203]: info: Adding Item to queue: webeighties/5 Mar 09 11:31:45 volumio volumio[1203]: info: Using cached record of: webeighties/5 Mar 09 11:31:45 volumio volumio[1203]: info: CoreCommandRouter::volumioPushQueue Mar 09 11:31:45 volumio volumio[1203]: info: CorePlayQueue::saveQueue Mar 09 11:31:45 volumio volumio[1203]: info: CoreStateMachine::updateTrackBlock Mar 09 11:31:45 volumio volumio[1203]: info: CorePlayQueue::getTrackBlock Mar 09 11:31:45 volumio volumio[1203]: info: CoreCommandRouter::volumioPlay Mar 09 11:31:45 volumio volumio[1203]: info: CoreStateMachine::play index 0 Mar 09 11:31:45 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:31:45 volumio volumio[1203]: info: CoreStateMachine::stop Mar 09 11:31:45 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:31:45 volumio volumio[1203]: info: CoreStateMachine::play index undefined Mar 09 11:31:45 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:31:45 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:31:45 volumio volumio[1203]: info: CoreStateMachine::startPlaybackTimer Mar 09 11:31:45 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:31:45 volumio volumio[1203]: info: CoreCommandRouter::volumioGetVisibleSources Mar 09 11:31:45 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 09 11:31:45 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 09 11:31:45 volumio volumio[1203]: info: [1741516305438] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/italohits/mp3-192/volumio Mar 09 11:31:45 volumio volumio[1203]: info: [1741516305439] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=283&count=2 Mar 09 11:31:47 volumio volumio[1203]: info: New access token = BQBhLGSN3-I7ik-vyEDOXfshNns2V5tUoPxyoJwz3xCDkQ4TK1PozgNbIV5r_xwySQD6Fm5T9_Z-Kgyz8dLFg9upQD56e04OKE5N0l-BrFPQB84YOUXMKGat2NW-veSH2zk02H-8O_vh_2-C6lSO55QAzN5uu37TV9ufmcoABSZYYytwoDL1CbsISgvTBxCr1YR9U_cY63obaEew4Vr7b5qtQqcT6KGWsrTEpPV-M7kJUfQ5bqhegsbXZ1qHIrpw5_qfu9fRdwq-n5qnPvD0be3l8iHgLuIYRKWreQ1j2t0 Mar 09 11:31:47 volumio volumio[1203]: info: New access token = BQCuEHpGUdONlhIuMN5XY3VwqxGJUAVjRKmjwMbHOqvbmibfzwqK-VUBCGXR-181tdSQZNprOMalt6rgAAZy5orsQ5K7zSkTXcWk40kpBlHK7OXV56gsmox3AvH_17hlvxmCYVuS3TOX6FnSUmkxvHej5qe_1fQtjxqiiFZ-eUM6C8F09icY1rrhvvCuQQFxVoSgYNnPzvy5pg7nwL6Ew7UHyRL_9XI5ByAxtBxiYGqEbzhPWdoCByL2bUg3jTXW6cF9nlsfgvCI2Px30wufUQtyrYQnci3YIjjsM-Z_CXI Mar 09 11:31:50 volumio volumio[1203]: info: VolumeController::SetAlsaVolume- Mar 09 11:31:50 volumio volumio[1203]: info: CoreCommandRouter::volumioGetState Mar 09 11:31:50 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:31:50 volumio volumio[1203]: info: CoreStateMachine::pushState Mar 09 11:31:50 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:31:50 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 11:31:50 volumio volumio[1203]: info: CoreCommandRouter::volumioPushState Mar 09 11:31:50 volumio volumio[1203]: info: [ASDebug] CurState: stop PrevState: stop Mar 09 11:31:50 volumio volumio[1203]: info: [GPIO_Control] Status changed: stop Mar 09 11:31:50 volumio volumio[1203]: SPOTIFY: RECEIVED VOLUMIO VOLUME 15 Mar 09 11:31:50 volumio volumio[1203]: SPOTIFY: SPOTIFY VOLUME 17 Mar 09 11:31:50 volumio volumio[1203]: SPOTIFY: VOLUMIO VOLUME 15 Mar 09 11:31:50 volumio volumio[1203]: SPOTIFY: DELTA VOLUME ENOUGH: true Mar 09 11:31:50 volumio volumio[1203]: info: Setting Spotify Volume from Volumio: 15 Mar 09 11:31:50 volumio volumio[1203]: info: VolumeController::SetAlsaVolume- Mar 09 11:31:50 volumio volumio[1203]: info: CoreCommandRouter::volumioGetState Mar 09 11:31:50 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:31:50 volumio volumio[1203]: info: CoreStateMachine::pushState Mar 09 11:31:50 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:31:50 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 11:31:50 volumio volumio[1203]: info: CoreCommandRouter::volumioPushState Mar 09 11:31:50 volumio volumio[1203]: info: [ASDebug] CurState: stop PrevState: stop Mar 09 11:31:50 volumio volumio[1203]: info: [GPIO_Control] Status changed: stop Mar 09 11:31:50 volumio volumio[1203]: SPOTIFY: RECEIVED VOLUMIO VOLUME 13 Mar 09 11:31:50 volumio volumio[1203]: SPOTIFY: SPOTIFY VOLUME 15 Mar 09 11:31:50 volumio volumio[1203]: SPOTIFY: VOLUMIO VOLUME 13 Mar 09 11:31:50 volumio volumio[1203]: SPOTIFY: DELTA VOLUME ENOUGH: true Mar 09 11:31:50 volumio volumio[1203]: info: Setting Spotify Volume from Volumio: 13 Mar 09 11:31:51 volumio volumio[1203]: info: VolumeController::SetAlsaVolume+ Mar 09 11:31:51 volumio volumio[1203]: info: CoreCommandRouter::volumioGetState Mar 09 11:31:51 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:31:51 volumio volumio[1203]: info: CoreStateMachine::pushState Mar 09 11:31:51 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:31:51 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 11:31:51 volumio volumio[1203]: info: CoreCommandRouter::volumioPushState Mar 09 11:31:51 volumio volumio[1203]: info: [ASDebug] CurState: stop PrevState: stop Mar 09 11:31:51 volumio volumio[1203]: info: [GPIO_Control] Status changed: stop Mar 09 11:31:51 volumio volumio[1203]: SPOTIFY: RECEIVED VOLUMIO VOLUME 15 Mar 09 11:31:51 volumio volumio[1203]: SPOTIFY: SPOTIFY VOLUME 13 Mar 09 11:31:51 volumio volumio[1203]: SPOTIFY: VOLUMIO VOLUME 15 Mar 09 11:31:51 volumio volumio[1203]: SPOTIFY: DELTA VOLUME ENOUGH: true Mar 09 11:31:51 volumio volumio[1203]: info: Setting Spotify Volume from Volumio: 15 Mar 09 11:31:52 volumio volumio[1203]: info: New access token = BQArSwe8vQ8FotdyyQyduMjhydz_Wkvgd5g40vBAwE-KCJXDaML-hBvkfjzx7RoHy710Ev8I4dfxuVa3DOrk8y8tsxY4cWekU59u0X8ctHqAEw9fwk70JUKYGcrqvWquFv5admWb0UDf1cIkPU5Vd61cvzupLlbPB_5XY4BD4-dG90RhlcK84Lef1ME60w0K46oV4lJpf98sQ729rYdWEOL7ncObbs9RXlvPtV4pEf1J9Ir4XFEBywC2GTM0h2Ax_JtUd9rGJzrbzVs_HAuDhQN9UkgfMtXnJW7R8yo5qH8 Mar 09 11:31:52 volumio volumio[1203]: info: New access token = BQDvIOA2p_52lBZrwbH8AjEYWH0abwLdKqo2BodQYlYWIAA0uhgxk9JCwsXE-OGEc-57ASyPunyLFfj9uZaUfh7ioeI19DOKrLp_B_6QlPsQAdE4a1dU_LB9uwjC9MozKH4bQb94FybI0rRTqtYZJNswhzOSnlMublggDEqNCkdCGC3OHmgeOge46XeJtLNx8aZGj5G0hxnMN2SAU6UldYuTJbgRPW7JNDpv3kjC7pFMRvH9baSIswvCbX2aCeZ16rfiBPPimTCoAO5_OdU5VPB9ZCibhOi6oUSJuYXy7gY Mar 09 11:31:52 volumio volumio[1203]: SPOTIFY: SETTING SPOTIFY VOLUME 15 Mar 09 11:31:52 volumio volumio[1203]: info: Sending Spotify command with payload to local API: /player/volume Mar 09 11:31:52 volumio go-librespot[1511]: time="2025-03-09T11:31:52+01:00" level=debug msg="update volume to 9830/65535" Mar 09 11:31:52 volumio go-librespot[1511]: time="2025-03-09T11:31:52+01:00" level=debug msg="put connect state because VOLUME_CHANGED" Mar 09 11:31:52 volumio go-librespot[1511]: time="2025-03-09T11:31:52+01:00" level=trace msg="emitting websocket event: volume" Mar 09 11:31:52 volumio volumio[1203]: SPOTIFY: received: {"type":"volume","data":{"value":15,"max":100}} Mar 09 11:31:52 volumio volumio[1203]: SPOTIFY: RECEIVED SPOTIFY VOLUME 15 Mar 09 11:31:52 volumio volumio[1203]: info: Preload queue cleared Mar 09 11:31:52 volumio volumio[1203]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 09 11:31:52 volumio volumio[1203]: info: CoreStateMachine::ClearQueue Mar 09 11:31:52 volumio volumio[1203]: info: CoreStateMachine::stop Mar 09 11:31:52 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:31:52 volumio volumio[1203]: info: CorePlayQueue::clearPlayQueue Mar 09 11:31:52 volumio volumio[1203]: info: CorePlayQueue::saveQueue Mar 09 11:31:52 volumio volumio[1203]: info: CoreCommandRouter::volumioPushQueue Mar 09 11:31:53 volumio volumio[1203]: info: CoreStateMachine::addQueueItems Mar 09 11:31:53 volumio volumio[1203]: info: CorePlayQueue::addQueueItems Mar 09 11:31:53 volumio volumio[1203]: info: Preload queue cleared Mar 09 11:31:53 volumio volumio[1203]: info: Adding Item to queue: webeighties/5 Mar 09 11:31:53 volumio volumio[1203]: info: Using cached record of: webeighties/5 Mar 09 11:31:53 volumio volumio[1203]: info: CoreCommandRouter::volumioPushQueue Mar 09 11:31:53 volumio volumio[1203]: info: CorePlayQueue::saveQueue Mar 09 11:31:53 volumio volumio[1203]: info: CoreStateMachine::updateTrackBlock Mar 09 11:31:53 volumio volumio[1203]: info: CorePlayQueue::getTrackBlock Mar 09 11:31:53 volumio volumio[1203]: info: CoreCommandRouter::volumioPlay Mar 09 11:31:53 volumio volumio[1203]: info: CoreStateMachine::play index 0 Mar 09 11:31:53 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:31:53 volumio volumio[1203]: info: CoreStateMachine::stop Mar 09 11:31:53 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:31:53 volumio volumio[1203]: info: CoreStateMachine::play index undefined Mar 09 11:31:53 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:31:53 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:31:53 volumio volumio[1203]: info: CoreStateMachine::startPlaybackTimer Mar 09 11:31:53 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:31:53 volumio volumio[1203]: info: CoreCommandRouter::volumioGetVisibleSources Mar 09 11:31:53 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 09 11:31:53 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 09 11:31:53 volumio volumio[1203]: info: [1741516313003] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/italohits/mp3-192/volumio Mar 09 11:31:53 volumio volumio[1203]: info: [1741516313003] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=283&count=2 Mar 09 11:31:53 volumio volumio[1203]: info: Preload queue cleared Mar 09 11:31:53 volumio volumio[1203]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 09 11:31:53 volumio volumio[1203]: info: CoreStateMachine::ClearQueue Mar 09 11:31:53 volumio volumio[1203]: info: CoreStateMachine::stop Mar 09 11:31:53 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:31:53 volumio volumio[1203]: info: CorePlayQueue::clearPlayQueue Mar 09 11:31:53 volumio volumio[1203]: info: CorePlayQueue::saveQueue Mar 09 11:31:53 volumio volumio[1203]: info: CoreCommandRouter::volumioPushQueue Mar 09 11:31:53 volumio volumio[1203]: info: CoreStateMachine::addQueueItems Mar 09 11:31:53 volumio volumio[1203]: info: CorePlayQueue::addQueueItems Mar 09 11:31:53 volumio volumio[1203]: info: Preload queue cleared Mar 09 11:31:53 volumio volumio[1203]: info: Adding Item to queue: webeighties/5 Mar 09 11:31:53 volumio volumio[1203]: info: Using cached record of: webeighties/5 Mar 09 11:31:53 volumio volumio[1203]: info: CoreCommandRouter::volumioPushQueue Mar 09 11:31:53 volumio volumio[1203]: info: CorePlayQueue::saveQueue Mar 09 11:31:53 volumio volumio[1203]: info: CoreStateMachine::updateTrackBlock Mar 09 11:31:53 volumio volumio[1203]: info: CorePlayQueue::getTrackBlock Mar 09 11:31:53 volumio volumio[1203]: info: CoreCommandRouter::volumioPlay Mar 09 11:31:53 volumio volumio[1203]: info: CoreStateMachine::play index 0 Mar 09 11:31:53 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:31:53 volumio volumio[1203]: info: CoreStateMachine::stop Mar 09 11:31:53 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:31:53 volumio volumio[1203]: info: CoreStateMachine::play index undefined Mar 09 11:31:53 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:31:53 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:31:53 volumio volumio[1203]: info: CoreStateMachine::startPlaybackTimer Mar 09 11:31:53 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:31:53 volumio volumio[1203]: info: CoreCommandRouter::volumioGetVisibleSources Mar 09 11:31:53 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 09 11:31:53 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 09 11:31:53 volumio volumio[1203]: info: [1741516313567] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/italohits/mp3-192/volumio Mar 09 11:31:53 volumio volumio[1203]: info: [1741516313567] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=283&count=2 Mar 09 11:31:54 volumio volumio[1203]: info: Preload queue cleared Mar 09 11:31:54 volumio volumio[1203]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 09 11:31:54 volumio volumio[1203]: info: CoreStateMachine::ClearQueue Mar 09 11:31:54 volumio volumio[1203]: info: CoreStateMachine::stop Mar 09 11:31:54 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:31:54 volumio volumio[1203]: info: CorePlayQueue::clearPlayQueue Mar 09 11:31:54 volumio volumio[1203]: info: CorePlayQueue::saveQueue Mar 09 11:31:54 volumio volumio[1203]: info: CoreCommandRouter::volumioPushQueue Mar 09 11:31:54 volumio volumio[1203]: info: CoreStateMachine::addQueueItems Mar 09 11:31:54 volumio volumio[1203]: info: CorePlayQueue::addQueueItems Mar 09 11:31:54 volumio volumio[1203]: info: Preload queue cleared Mar 09 11:31:54 volumio volumio[1203]: info: Adding Item to queue: webeighties/4 Mar 09 11:31:54 volumio volumio[1203]: info: Exploding uri webeighties/4 in service 80s80s Mar 09 11:31:54 volumio volumio[1203]: info: [1741516314221] [80s80s] explodeUri: webeighties/4 Mar 09 11:31:54 volumio volumio[1203]: info: CoreCommandRouter::volumioPushQueue Mar 09 11:31:54 volumio volumio[1203]: info: CorePlayQueue::saveQueue Mar 09 11:31:54 volumio volumio[1203]: info: CoreStateMachine::updateTrackBlock Mar 09 11:31:54 volumio volumio[1203]: info: CorePlayQueue::getTrackBlock Mar 09 11:31:54 volumio volumio[1203]: info: CoreCommandRouter::volumioPlay Mar 09 11:31:54 volumio volumio[1203]: info: CoreStateMachine::play index 0 Mar 09 11:31:54 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:31:54 volumio volumio[1203]: info: CoreStateMachine::stop Mar 09 11:31:54 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:31:54 volumio volumio[1203]: info: CoreStateMachine::play index undefined Mar 09 11:31:54 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:31:54 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:31:54 volumio volumio[1203]: info: CoreStateMachine::startPlaybackTimer Mar 09 11:31:54 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:31:54 volumio volumio[1203]: info: CoreCommandRouter::volumioGetVisibleSources Mar 09 11:31:54 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 09 11:31:54 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 09 11:31:54 volumio volumio[1203]: info: [1741516314223] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/wave/mp3-192/volumio Mar 09 11:31:54 volumio volumio[1203]: info: [1741516314223] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=284&count=2 Mar 09 11:31:54 volumio volumio[1203]: info: Preload queue cleared Mar 09 11:31:54 volumio volumio[1203]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 09 11:31:54 volumio volumio[1203]: info: CoreStateMachine::ClearQueue Mar 09 11:31:54 volumio volumio[1203]: info: CoreStateMachine::stop Mar 09 11:31:54 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:31:54 volumio volumio[1203]: info: CorePlayQueue::clearPlayQueue Mar 09 11:31:54 volumio volumio[1203]: info: CorePlayQueue::saveQueue Mar 09 11:31:54 volumio volumio[1203]: info: CoreCommandRouter::volumioPushQueue Mar 09 11:31:54 volumio volumio[1203]: info: CoreStateMachine::addQueueItems Mar 09 11:31:54 volumio volumio[1203]: info: CorePlayQueue::addQueueItems Mar 09 11:31:54 volumio volumio[1203]: info: Preload queue cleared Mar 09 11:31:54 volumio volumio[1203]: info: Adding Item to queue: webeighties/5 Mar 09 11:31:54 volumio volumio[1203]: info: Using cached record of: webeighties/5 Mar 09 11:31:54 volumio volumio[1203]: info: CoreCommandRouter::volumioPushQueue Mar 09 11:31:54 volumio volumio[1203]: info: CorePlayQueue::saveQueue Mar 09 11:31:54 volumio volumio[1203]: info: CoreStateMachine::updateTrackBlock Mar 09 11:31:54 volumio volumio[1203]: info: CorePlayQueue::getTrackBlock Mar 09 11:31:54 volumio volumio[1203]: info: CoreCommandRouter::volumioPlay Mar 09 11:31:54 volumio volumio[1203]: info: CoreStateMachine::play index 0 Mar 09 11:31:54 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:31:54 volumio volumio[1203]: info: CoreStateMachine::stop Mar 09 11:31:54 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:31:54 volumio volumio[1203]: info: CoreStateMachine::play index undefined Mar 09 11:31:54 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:31:54 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:31:54 volumio volumio[1203]: info: CoreStateMachine::startPlaybackTimer Mar 09 11:31:54 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:31:54 volumio volumio[1203]: info: CoreCommandRouter::volumioGetVisibleSources Mar 09 11:31:54 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 09 11:31:54 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 09 11:31:54 volumio volumio[1203]: info: [1741516314801] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/italohits/mp3-192/volumio Mar 09 11:31:54 volumio volumio[1203]: info: [1741516314801] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=283&count=2 Mar 09 11:31:55 volumio volumio[1203]: info: Preload queue cleared Mar 09 11:31:55 volumio volumio[1203]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 09 11:31:55 volumio volumio[1203]: info: CoreStateMachine::ClearQueue Mar 09 11:31:55 volumio volumio[1203]: info: CoreStateMachine::stop Mar 09 11:31:55 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:31:55 volumio volumio[1203]: info: CorePlayQueue::clearPlayQueue Mar 09 11:31:55 volumio volumio[1203]: info: CorePlayQueue::saveQueue Mar 09 11:31:55 volumio volumio[1203]: info: CoreCommandRouter::volumioPushQueue Mar 09 11:31:55 volumio volumio[1203]: info: CoreStateMachine::addQueueItems Mar 09 11:31:55 volumio volumio[1203]: info: CorePlayQueue::addQueueItems Mar 09 11:31:55 volumio volumio[1203]: info: Preload queue cleared Mar 09 11:31:55 volumio volumio[1203]: info: Adding Item to queue: webeighties/5 Mar 09 11:31:55 volumio volumio[1203]: info: Using cached record of: webeighties/5 Mar 09 11:31:55 volumio volumio[1203]: info: CoreCommandRouter::volumioPushQueue Mar 09 11:31:55 volumio volumio[1203]: info: CorePlayQueue::saveQueue Mar 09 11:31:55 volumio volumio[1203]: info: CoreStateMachine::updateTrackBlock Mar 09 11:31:55 volumio volumio[1203]: info: CorePlayQueue::getTrackBlock Mar 09 11:31:55 volumio volumio[1203]: info: CoreCommandRouter::volumioPlay Mar 09 11:31:55 volumio volumio[1203]: info: CoreStateMachine::play index 0 Mar 09 11:31:55 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:31:55 volumio volumio[1203]: info: CoreStateMachine::stop Mar 09 11:31:55 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:31:55 volumio volumio[1203]: info: CoreStateMachine::play index undefined Mar 09 11:31:55 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:31:55 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:31:55 volumio volumio[1203]: info: CoreStateMachine::startPlaybackTimer Mar 09 11:31:55 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:31:55 volumio volumio[1203]: info: CoreCommandRouter::volumioGetVisibleSources Mar 09 11:31:55 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 09 11:31:55 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 09 11:31:55 volumio volumio[1203]: info: [1741516315083] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/italohits/mp3-192/volumio Mar 09 11:31:55 volumio volumio[1203]: info: [1741516315083] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=283&count=2 Mar 09 11:31:55 volumio volumio[1203]: info: Preload queue cleared Mar 09 11:31:55 volumio volumio[1203]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 09 11:31:55 volumio volumio[1203]: info: CoreStateMachine::ClearQueue Mar 09 11:31:55 volumio volumio[1203]: info: CoreStateMachine::stop Mar 09 11:31:55 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:31:55 volumio volumio[1203]: info: CorePlayQueue::clearPlayQueue Mar 09 11:31:55 volumio volumio[1203]: info: CorePlayQueue::saveQueue Mar 09 11:31:55 volumio volumio[1203]: info: CoreCommandRouter::volumioPushQueue Mar 09 11:31:55 volumio volumio[1203]: info: CoreStateMachine::addQueueItems Mar 09 11:31:55 volumio volumio[1203]: info: CorePlayQueue::addQueueItems Mar 09 11:31:55 volumio volumio[1203]: info: Preload queue cleared Mar 09 11:31:55 volumio volumio[1203]: info: Adding Item to queue: webeighties/5 Mar 09 11:31:55 volumio volumio[1203]: info: Using cached record of: webeighties/5 Mar 09 11:31:55 volumio volumio[1203]: info: CoreCommandRouter::volumioPushQueue Mar 09 11:31:55 volumio volumio[1203]: info: CorePlayQueue::saveQueue Mar 09 11:31:55 volumio volumio[1203]: info: CoreStateMachine::updateTrackBlock Mar 09 11:31:55 volumio volumio[1203]: info: CorePlayQueue::getTrackBlock Mar 09 11:31:55 volumio volumio[1203]: info: CoreCommandRouter::volumioPlay Mar 09 11:31:55 volumio volumio[1203]: info: CoreStateMachine::play index 0 Mar 09 11:31:55 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:31:55 volumio volumio[1203]: info: CoreStateMachine::stop Mar 09 11:31:55 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:31:55 volumio volumio[1203]: info: CoreStateMachine::play index undefined Mar 09 11:31:55 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:31:55 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:31:55 volumio volumio[1203]: info: CoreStateMachine::startPlaybackTimer Mar 09 11:31:55 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:31:55 volumio volumio[1203]: info: CoreCommandRouter::volumioGetVisibleSources Mar 09 11:31:55 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 09 11:31:55 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 09 11:31:55 volumio volumio[1203]: info: [1741516315718] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/italohits/mp3-192/volumio Mar 09 11:31:55 volumio volumio[1203]: info: [1741516315718] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=283&count=2 Mar 09 11:31:57 volumio volumio[1203]: info: New access token = BQDliSjURi14ux0DFlZsAgvSjQCHAh6t_WwIt-cyE0Wf6SPKMkCxE2Cz2YjkkFJnSOwmJ-0DWPGw0ZXDD7IaHBYHdyvBPdTb2RdU9kLKvOp7T57MxVSOD7hfCqpuWmvciTCrcggCrjgys_XwiOxntICJpDh0AXxitQ7LSqEWa_sFoJ2thxtI_i8xqsYE_DfLPTPorH3k8YI9D92X9W5gD0cRqYh-aj_BfyKuix6htn_aB5u1qBSIT7ghPt-GqGm3hFsDiG-L3FYXWmF3Mq8oM0CAy9ScbEKh_57zGKQig7w Mar 09 11:31:57 volumio volumio[1203]: info: New access token = BQB33hpMpRVu0I_SaHyZbsePA6hzUXLW4zchrZOaAb-WWeTsFTuXjv-erfeL0OlKTFaTf3jpSwjLxgK8B7zvdBC6hPjUQP7V2OJsqHWHFZQSbdc-Kq5nkagXF8ZxtibwmjUhinoQvOzAkFcmXvVSKdIgxzWy67_ioStBdFLZblY3dqNP6US0-6YN5PZN1wwPZV7ElBe_OObad9alUjAxYUmFXhfPDALDooDFxKAnyQQSUQQ0VxgFHej0g3d9A2lcjKUiyZGtjCMTNxwXy4V1og-FJvUrf5kUc0mLkioi814 Mar 09 11:32:01 volumio volumio[1203]: info: VolumeController::SetAlsaVolume- Mar 09 11:32:01 volumio volumio[1203]: info: CoreCommandRouter::volumioGetState Mar 09 11:32:01 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:01 volumio volumio[1203]: info: CoreStateMachine::pushState Mar 09 11:32:01 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:01 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 11:32:01 volumio volumio[1203]: info: CoreCommandRouter::volumioPushState Mar 09 11:32:01 volumio volumio[1203]: info: [ASDebug] CurState: stop PrevState: stop Mar 09 11:32:01 volumio volumio[1203]: info: [GPIO_Control] Status changed: stop Mar 09 11:32:01 volumio volumio[1203]: SPOTIFY: RECEIVED VOLUMIO VOLUME 13 Mar 09 11:32:01 volumio volumio[1203]: SPOTIFY: SPOTIFY VOLUME 15 Mar 09 11:32:01 volumio volumio[1203]: SPOTIFY: VOLUMIO VOLUME 13 Mar 09 11:32:01 volumio volumio[1203]: SPOTIFY: DELTA VOLUME ENOUGH: true Mar 09 11:32:01 volumio volumio[1203]: info: Setting Spotify Volume from Volumio: 13 Mar 09 11:32:01 volumio volumio[1203]: info: VolumeController::SetAlsaVolume- Mar 09 11:32:01 volumio volumio[1203]: info: CoreCommandRouter::volumioGetState Mar 09 11:32:01 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:01 volumio volumio[1203]: info: CoreStateMachine::pushState Mar 09 11:32:01 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:01 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 11:32:01 volumio volumio[1203]: info: CoreCommandRouter::volumioPushState Mar 09 11:32:01 volumio volumio[1203]: info: [ASDebug] CurState: stop PrevState: stop Mar 09 11:32:01 volumio volumio[1203]: info: [GPIO_Control] Status changed: stop Mar 09 11:32:01 volumio volumio[1203]: SPOTIFY: RECEIVED VOLUMIO VOLUME 11 Mar 09 11:32:01 volumio volumio[1203]: SPOTIFY: SPOTIFY VOLUME 13 Mar 09 11:32:01 volumio volumio[1203]: SPOTIFY: VOLUMIO VOLUME 11 Mar 09 11:32:01 volumio volumio[1203]: SPOTIFY: DELTA VOLUME ENOUGH: true Mar 09 11:32:01 volumio volumio[1203]: info: Setting Spotify Volume from Volumio: 11 Mar 09 11:32:02 volumio volumio[1203]: info: VolumeController::SetAlsaVolume+ Mar 09 11:32:02 volumio volumio[1203]: info: CoreCommandRouter::volumioGetState Mar 09 11:32:02 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:02 volumio volumio[1203]: info: CoreStateMachine::pushState Mar 09 11:32:02 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:02 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 11:32:02 volumio volumio[1203]: info: CoreCommandRouter::volumioPushState Mar 09 11:32:02 volumio volumio[1203]: info: [ASDebug] CurState: stop PrevState: stop Mar 09 11:32:02 volumio volumio[1203]: info: [GPIO_Control] Status changed: stop Mar 09 11:32:02 volumio volumio[1203]: SPOTIFY: RECEIVED VOLUMIO VOLUME 13 Mar 09 11:32:02 volumio volumio[1203]: SPOTIFY: SPOTIFY VOLUME 11 Mar 09 11:32:02 volumio volumio[1203]: SPOTIFY: VOLUMIO VOLUME 13 Mar 09 11:32:02 volumio volumio[1203]: SPOTIFY: DELTA VOLUME ENOUGH: true Mar 09 11:32:02 volumio volumio[1203]: info: Setting Spotify Volume from Volumio: 13 Mar 09 11:32:02 volumio volumio[1203]: info: New access token = BQDOD91MESs-4imZpuapL7Fx-STrITr36qiLPbAC1s56BKTz3pV7ii9nDZCE-FK7EgV0XphcnGfj8BBwd3mb4spl9NcgN9MUb1A0lrojbYE76Zoq39ryYWTAZg0382Gb6FzxSH8SrB0ufrTO93jWnyYsgsmDHocKueUcDSbJ-fXtc0elr7ePz4AKa67b82uoBxeVlOcSCsltGt4iw7Mr91uyGPMPO7XMPXcbE9KNZIylgFTdmur--cBiLKVW4j0SPuMaCbqWNekKlKDW9Wv2pWyItYY7ht20wpj3t2neN2w Mar 09 11:32:02 volumio volumio[1203]: info: New access token = BQBrQk3kAP2-iiL-A0FuECYtbt2MrORVd8mNVL-5Yu-Lfr3N5ufSpqvRfmhgsRZXWCkF4qe9eFuFqaoqDZUD_zWPSBjEotelhX0L8D9SkNM1Er4UAhUon2OBzPo6dK6-fbvjACRhIl2nvK-uSB18kALH5oWevWzKR4_vzzJ4WHSA8UHJDH5DY-TE1n88AxL9eTv1wHlkV-hTW3Zf83xTliGUeQtIg_SmZ8JGY_vC9Ljllf0TwLxJR7_VZ6b5KECDpZHFslkQy5avvCKvqcwKXsjt7o5oLgXRWkr-Ac1V09I Mar 09 11:32:02 volumio volumio[1203]: info: VolumeController::SetAlsaVolume+ Mar 09 11:32:02 volumio volumio[1203]: info: CoreCommandRouter::volumioGetState Mar 09 11:32:02 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:02 volumio volumio[1203]: info: CoreStateMachine::pushState Mar 09 11:32:02 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:02 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 11:32:02 volumio volumio[1203]: info: CoreCommandRouter::volumioPushState Mar 09 11:32:02 volumio volumio[1203]: info: [ASDebug] CurState: stop PrevState: stop Mar 09 11:32:02 volumio volumio[1203]: info: [GPIO_Control] Status changed: stop Mar 09 11:32:02 volumio volumio[1203]: SPOTIFY: RECEIVED VOLUMIO VOLUME 15 Mar 09 11:32:02 volumio volumio[1203]: SPOTIFY: SPOTIFY VOLUME 13 Mar 09 11:32:02 volumio volumio[1203]: SPOTIFY: VOLUMIO VOLUME 15 Mar 09 11:32:02 volumio volumio[1203]: SPOTIFY: DELTA VOLUME ENOUGH: true Mar 09 11:32:02 volumio volumio[1203]: info: Setting Spotify Volume from Volumio: 15 Mar 09 11:32:04 volumio volumio[1203]: SPOTIFY: SETTING SPOTIFY VOLUME 15 Mar 09 11:32:04 volumio volumio[1203]: info: Sending Spotify command with payload to local API: /player/volume Mar 09 11:32:04 volumio volumio[1203]: info: Preload queue cleared Mar 09 11:32:04 volumio volumio[1203]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 09 11:32:04 volumio volumio[1203]: info: CoreStateMachine::ClearQueue Mar 09 11:32:04 volumio volumio[1203]: info: CoreStateMachine::stop Mar 09 11:32:04 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:32:04 volumio volumio[1203]: info: CorePlayQueue::clearPlayQueue Mar 09 11:32:04 volumio volumio[1203]: info: CorePlayQueue::saveQueue Mar 09 11:32:04 volumio volumio[1203]: info: CoreCommandRouter::volumioPushQueue Mar 09 11:32:04 volumio volumio[1203]: info: CoreStateMachine::addQueueItems Mar 09 11:32:04 volumio volumio[1203]: info: CorePlayQueue::addQueueItems Mar 09 11:32:04 volumio volumio[1203]: info: Preload queue cleared Mar 09 11:32:04 volumio volumio[1203]: info: Adding Item to queue: webeighties/5 Mar 09 11:32:04 volumio volumio[1203]: info: Using cached record of: webeighties/5 Mar 09 11:32:04 volumio volumio[1203]: info: CoreCommandRouter::volumioPushQueue Mar 09 11:32:04 volumio volumio[1203]: info: CorePlayQueue::saveQueue Mar 09 11:32:04 volumio volumio[1203]: info: CoreStateMachine::updateTrackBlock Mar 09 11:32:04 volumio volumio[1203]: info: CorePlayQueue::getTrackBlock Mar 09 11:32:04 volumio volumio[1203]: info: CoreCommandRouter::volumioPlay Mar 09 11:32:04 volumio volumio[1203]: info: CoreStateMachine::play index 0 Mar 09 11:32:04 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:32:04 volumio volumio[1203]: info: CoreStateMachine::stop Mar 09 11:32:04 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:32:04 volumio volumio[1203]: info: CoreStateMachine::play index undefined Mar 09 11:32:04 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:32:04 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:04 volumio volumio[1203]: info: CoreStateMachine::startPlaybackTimer Mar 09 11:32:04 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:04 volumio volumio[1203]: info: CoreCommandRouter::volumioGetVisibleSources Mar 09 11:32:04 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 09 11:32:04 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 09 11:32:04 volumio volumio[1203]: info: [1741516324839] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/italohits/mp3-192/volumio Mar 09 11:32:04 volumio volumio[1203]: info: [1741516324839] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=283&count=2 Mar 09 11:32:05 volumio volumio[1203]: info: Preload queue cleared Mar 09 11:32:05 volumio volumio[1203]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 09 11:32:05 volumio volumio[1203]: info: CoreStateMachine::ClearQueue Mar 09 11:32:05 volumio volumio[1203]: info: CoreStateMachine::stop Mar 09 11:32:05 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:32:05 volumio volumio[1203]: info: CorePlayQueue::clearPlayQueue Mar 09 11:32:05 volumio volumio[1203]: info: CorePlayQueue::saveQueue Mar 09 11:32:05 volumio volumio[1203]: info: CoreCommandRouter::volumioPushQueue Mar 09 11:32:05 volumio volumio[1203]: info: CoreStateMachine::addQueueItems Mar 09 11:32:05 volumio volumio[1203]: info: CorePlayQueue::addQueueItems Mar 09 11:32:05 volumio volumio[1203]: info: Preload queue cleared Mar 09 11:32:05 volumio volumio[1203]: info: Adding Item to queue: webeighties/5 Mar 09 11:32:05 volumio volumio[1203]: info: Using cached record of: webeighties/5 Mar 09 11:32:05 volumio volumio[1203]: info: CoreCommandRouter::volumioPushQueue Mar 09 11:32:05 volumio volumio[1203]: info: CorePlayQueue::saveQueue Mar 09 11:32:05 volumio volumio[1203]: info: CoreStateMachine::updateTrackBlock Mar 09 11:32:05 volumio volumio[1203]: info: CorePlayQueue::getTrackBlock Mar 09 11:32:05 volumio volumio[1203]: info: CoreCommandRouter::volumioPlay Mar 09 11:32:05 volumio volumio[1203]: info: CoreStateMachine::play index 0 Mar 09 11:32:05 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:32:05 volumio volumio[1203]: info: CoreStateMachine::stop Mar 09 11:32:05 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:32:05 volumio volumio[1203]: info: CoreStateMachine::play index undefined Mar 09 11:32:05 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:32:05 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:05 volumio volumio[1203]: info: CoreStateMachine::startPlaybackTimer Mar 09 11:32:05 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:05 volumio volumio[1203]: info: CoreCommandRouter::volumioGetVisibleSources Mar 09 11:32:05 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 09 11:32:05 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 09 11:32:05 volumio volumio[1203]: info: [1741516325474] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/italohits/mp3-192/volumio Mar 09 11:32:05 volumio volumio[1203]: info: [1741516325474] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=283&count=2 Mar 09 11:32:06 volumio volumio[1203]: info: Preload queue cleared Mar 09 11:32:06 volumio volumio[1203]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 09 11:32:06 volumio volumio[1203]: info: CoreStateMachine::ClearQueue Mar 09 11:32:06 volumio volumio[1203]: info: CoreStateMachine::stop Mar 09 11:32:06 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:32:06 volumio volumio[1203]: info: CorePlayQueue::clearPlayQueue Mar 09 11:32:06 volumio volumio[1203]: info: CorePlayQueue::saveQueue Mar 09 11:32:06 volumio volumio[1203]: info: CoreCommandRouter::volumioPushQueue Mar 09 11:32:06 volumio volumio[1203]: info: CoreStateMachine::addQueueItems Mar 09 11:32:06 volumio volumio[1203]: info: CorePlayQueue::addQueueItems Mar 09 11:32:06 volumio volumio[1203]: info: Preload queue cleared Mar 09 11:32:06 volumio volumio[1203]: info: Adding Item to queue: webeighties/5 Mar 09 11:32:06 volumio volumio[1203]: info: Using cached record of: webeighties/5 Mar 09 11:32:06 volumio volumio[1203]: info: CoreCommandRouter::volumioPushQueue Mar 09 11:32:06 volumio volumio[1203]: info: CorePlayQueue::saveQueue Mar 09 11:32:06 volumio volumio[1203]: info: CoreStateMachine::updateTrackBlock Mar 09 11:32:06 volumio volumio[1203]: info: CorePlayQueue::getTrackBlock Mar 09 11:32:06 volumio volumio[1203]: info: CoreCommandRouter::volumioPlay Mar 09 11:32:06 volumio volumio[1203]: info: CoreStateMachine::play index 0 Mar 09 11:32:06 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:32:06 volumio volumio[1203]: info: CoreStateMachine::stop Mar 09 11:32:06 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:32:06 volumio volumio[1203]: info: CoreStateMachine::play index undefined Mar 09 11:32:06 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:32:06 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:06 volumio volumio[1203]: info: CoreStateMachine::startPlaybackTimer Mar 09 11:32:06 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:06 volumio volumio[1203]: info: CoreCommandRouter::volumioGetVisibleSources Mar 09 11:32:06 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 09 11:32:06 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 09 11:32:06 volumio volumio[1203]: info: [1741516326450] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/italohits/mp3-192/volumio Mar 09 11:32:06 volumio volumio[1203]: info: [1741516326450] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=283&count=2 Mar 09 11:32:08 volumio volumio[1203]: info: CoreCommandRouter::volumioGetState Mar 09 11:32:08 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:10 volumio volumio[1203]: info: Executing endpoint metavolumio Mar 09 11:32:10 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 09 11:32:10 volumio volumio[1203]: info: New access token = BQB6iJVMIZXu6Jxq7-1XlCsQ8KBs5RIjzmxMs2RWMHAlIqmZNpEpmDfck_287yHMvpLzke0B5rPQBmbgemYuUcxPogspeprsldWf505Irsr4G1UDZ_5VoOKFT63XB0xW5CS8ZFdXSsvaJWZb0awt50uO2-oPUyptHkQZ6m3klXfFeMrSnyoMarj1DqCiZICkUSv_0c251zkBH6Dr-HU7_KpzYh3FyihV5lY2GXfW57Wjzr74YQCpcJWfvyeKDB3Siv3zMPYRY4i_G2_bCriv_jKRrCLTNtP5yW18kw7PC8A Mar 09 11:32:10 volumio volumio[1203]: info: New access token = BQA3VfxZp-kQW7K5nEKqtOgb4PlHSPYHoyc88GhqpzZsljoq-9_PAeaR9ceWLe1xwHZEe6PQO62XuVBvPvX3_QR26IawPyiCXdqxXp0u1jVPtbrypWY08ustCd_Sy8oa7bL_Y6zsUhnAVInwUxE6gUQQvCavy6IU2SCcaI2xFQ0GDalwNDS3bqkyTnoQamKk9Y_VsAUsDVBLQH21dCSE-XPx5kgnE-SqS2UdVYUej9-vpkJJ5u63gZCQV32kESmnUkX1YGEWujk0YSNRKYxfKPSRIE7AukVmaUl3tErfNN0 Mar 09 11:32:10 volumio volumio[1203]: info: VolumeController::SetAlsaVolume+ Mar 09 11:32:10 volumio volumio[1203]: info: CoreCommandRouter::volumioGetState Mar 09 11:32:10 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:10 volumio volumio[1203]: info: CoreStateMachine::pushState Mar 09 11:32:10 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:10 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 11:32:10 volumio volumio[1203]: info: CoreCommandRouter::volumioPushState Mar 09 11:32:10 volumio volumio[1203]: info: [ASDebug] CurState: stop PrevState: stop Mar 09 11:32:10 volumio volumio[1203]: info: [GPIO_Control] Status changed: stop Mar 09 11:32:10 volumio volumio[1203]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Mar 09 11:32:10 volumio volumio[1203]: SPOTIFY: SPOTIFY VOLUME 15 Mar 09 11:32:10 volumio volumio[1203]: SPOTIFY: VOLUMIO VOLUME 17 Mar 09 11:32:10 volumio volumio[1203]: SPOTIFY: DELTA VOLUME ENOUGH: true Mar 09 11:32:10 volumio volumio[1203]: info: Setting Spotify Volume from Volumio: 17 Mar 09 11:32:11 volumio volumio[1203]: info: VolumeController::SetAlsaVolume+ Mar 09 11:32:11 volumio volumio[1203]: info: CoreCommandRouter::volumioGetState Mar 09 11:32:11 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:11 volumio volumio[1203]: info: CoreStateMachine::pushState Mar 09 11:32:11 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:11 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 11:32:11 volumio volumio[1203]: info: CoreCommandRouter::volumioPushState Mar 09 11:32:11 volumio volumio[1203]: info: [ASDebug] CurState: stop PrevState: stop Mar 09 11:32:11 volumio volumio[1203]: info: [GPIO_Control] Status changed: stop Mar 09 11:32:11 volumio volumio[1203]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Mar 09 11:32:11 volumio volumio[1203]: SPOTIFY: SPOTIFY VOLUME 17 Mar 09 11:32:11 volumio volumio[1203]: SPOTIFY: VOLUMIO VOLUME 19 Mar 09 11:32:11 volumio volumio[1203]: SPOTIFY: DELTA VOLUME ENOUGH: true Mar 09 11:32:11 volumio volumio[1203]: info: Setting Spotify Volume from Volumio: 19 Mar 09 11:32:11 volumio volumio[1203]: info: VolumeController::SetAlsaVolume+ Mar 09 11:32:11 volumio volumio[1203]: info: CoreCommandRouter::volumioGetState Mar 09 11:32:11 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:11 volumio volumio[1203]: info: CoreStateMachine::pushState Mar 09 11:32:11 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:11 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 11:32:11 volumio volumio[1203]: info: CoreCommandRouter::volumioPushState Mar 09 11:32:11 volumio volumio[1203]: info: [ASDebug] CurState: stop PrevState: stop Mar 09 11:32:11 volumio volumio[1203]: info: [GPIO_Control] Status changed: stop Mar 09 11:32:11 volumio volumio[1203]: SPOTIFY: RECEIVED VOLUMIO VOLUME 21 Mar 09 11:32:11 volumio volumio[1203]: SPOTIFY: SPOTIFY VOLUME 19 Mar 09 11:32:11 volumio volumio[1203]: SPOTIFY: VOLUMIO VOLUME 21 Mar 09 11:32:11 volumio volumio[1203]: SPOTIFY: DELTA VOLUME ENOUGH: true Mar 09 11:32:11 volumio volumio[1203]: info: Setting Spotify Volume from Volumio: 21 Mar 09 11:32:11 volumio volumio[1203]: info: VolumeController::SetAlsaVolume+ Mar 09 11:32:11 volumio volumio[1203]: info: CoreCommandRouter::volumioGetState Mar 09 11:32:11 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:11 volumio volumio[1203]: info: CoreStateMachine::pushState Mar 09 11:32:11 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:11 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 11:32:11 volumio volumio[1203]: info: CoreCommandRouter::volumioPushState Mar 09 11:32:11 volumio volumio[1203]: info: [ASDebug] CurState: stop PrevState: stop Mar 09 11:32:11 volumio volumio[1203]: info: [GPIO_Control] Status changed: stop Mar 09 11:32:11 volumio volumio[1203]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Mar 09 11:32:11 volumio volumio[1203]: SPOTIFY: SPOTIFY VOLUME 21 Mar 09 11:32:11 volumio volumio[1203]: SPOTIFY: VOLUMIO VOLUME 23 Mar 09 11:32:11 volumio volumio[1203]: SPOTIFY: DELTA VOLUME ENOUGH: true Mar 09 11:32:11 volumio volumio[1203]: info: Setting Spotify Volume from Volumio: 23 Mar 09 11:32:11 volumio volumio[1203]: info: VolumeController::SetAlsaVolume+ Mar 09 11:32:11 volumio volumio[1203]: info: CoreCommandRouter::volumioGetState Mar 09 11:32:11 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:11 volumio volumio[1203]: info: CoreStateMachine::pushState Mar 09 11:32:11 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:11 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 11:32:11 volumio volumio[1203]: info: CoreCommandRouter::volumioPushState Mar 09 11:32:11 volumio volumio[1203]: info: [ASDebug] CurState: stop PrevState: stop Mar 09 11:32:11 volumio volumio[1203]: info: [GPIO_Control] Status changed: stop Mar 09 11:32:11 volumio volumio[1203]: SPOTIFY: RECEIVED VOLUMIO VOLUME 25 Mar 09 11:32:11 volumio volumio[1203]: SPOTIFY: SPOTIFY VOLUME 23 Mar 09 11:32:11 volumio volumio[1203]: SPOTIFY: VOLUMIO VOLUME 25 Mar 09 11:32:11 volumio volumio[1203]: SPOTIFY: DELTA VOLUME ENOUGH: true Mar 09 11:32:11 volumio volumio[1203]: info: Setting Spotify Volume from Volumio: 25 Mar 09 11:32:11 volumio volumio[1203]: info: VolumeController::SetAlsaVolume+ Mar 09 11:32:11 volumio volumio[1203]: info: CoreCommandRouter::volumioGetState Mar 09 11:32:11 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:11 volumio volumio[1203]: info: CoreStateMachine::pushState Mar 09 11:32:11 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:11 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 11:32:11 volumio volumio[1203]: info: CoreCommandRouter::volumioPushState Mar 09 11:32:11 volumio volumio[1203]: info: [ASDebug] CurState: stop PrevState: stop Mar 09 11:32:11 volumio volumio[1203]: info: [GPIO_Control] Status changed: stop Mar 09 11:32:11 volumio volumio[1203]: SPOTIFY: RECEIVED VOLUMIO VOLUME 27 Mar 09 11:32:11 volumio volumio[1203]: SPOTIFY: SPOTIFY VOLUME 25 Mar 09 11:32:11 volumio volumio[1203]: SPOTIFY: VOLUMIO VOLUME 27 Mar 09 11:32:11 volumio volumio[1203]: SPOTIFY: DELTA VOLUME ENOUGH: true Mar 09 11:32:11 volumio volumio[1203]: info: Setting Spotify Volume from Volumio: 27 Mar 09 11:32:12 volumio volumio[1203]: info: New access token = BQDoTLV7jSuUCwZyQ9Ndfi3ojQrRxfsZY0CdOmcKO-OYTbRVXeabk_SL6Oy20Bdmd98GjhZUsYDrECvsBTqQ44AJ7s3juTcHXzu2gdrHXE5Mm4sfFTmhmpiG6CJ51lsFy79_JzZ1htdbGGbEjut56Jamez_lbtxeaOi7m-ZcSfadGF52_vYrU8senyRRKMvf7AJGqKhkn9mQ9omWx0qvaWcw31q2_oTDILW4tXcor_u3A9-9Arzpky4LqZ40T6aiXHNvAzy4o-zMAYr9QOML0AgI6mIQdjQF5z8sWvgJu3w Mar 09 11:32:12 volumio volumio[1203]: info: New access token = BQDd6TFQB1mof66YHE263H9h7VOLznnGkbGt6naBUJRnORAecUjngzIlogxYy6JpMkq7-7gPp-78C6ITbBaYxF8F7AVeEUq3wlHAKq6W8umgMOFqvSG9gCdf7HxOMZVG7MFPVjG12PwaZMHJmO2VyU2CWF3VqAEzdm-1i7sD8SkSxQSOZv6UgLTXbQ8NjQ7fKuHiy4Ag74KYd5zIqomKuig3h0-63ZfHjHC7yIjS-ytZ-tcZ1HM9qnm-wY2_8AfXj8Q5qzaH30glb36rw2GZrEZRzZ44-Tww-NjRGM7nXEM Mar 09 11:32:12 volumio volumio[1203]: info: VolumeController::SetAlsaVolume- Mar 09 11:32:12 volumio volumio[1203]: info: CoreCommandRouter::volumioGetState Mar 09 11:32:12 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:12 volumio volumio[1203]: info: CoreStateMachine::pushState Mar 09 11:32:12 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:12 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 11:32:12 volumio volumio[1203]: info: CoreCommandRouter::volumioPushState Mar 09 11:32:12 volumio volumio[1203]: info: [ASDebug] CurState: stop PrevState: stop Mar 09 11:32:12 volumio volumio[1203]: info: [GPIO_Control] Status changed: stop Mar 09 11:32:12 volumio volumio[1203]: SPOTIFY: RECEIVED VOLUMIO VOLUME 25 Mar 09 11:32:12 volumio volumio[1203]: SPOTIFY: SPOTIFY VOLUME 27 Mar 09 11:32:12 volumio volumio[1203]: SPOTIFY: VOLUMIO VOLUME 25 Mar 09 11:32:12 volumio volumio[1203]: SPOTIFY: DELTA VOLUME ENOUGH: true Mar 09 11:32:12 volumio volumio[1203]: info: Setting Spotify Volume from Volumio: 25 Mar 09 11:32:12 volumio volumio[1203]: info: Executing endpoint metavolumio Mar 09 11:32:12 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 09 11:32:13 volumio volumio[1203]: info: VolumeController::SetAlsaVolume- Mar 09 11:32:13 volumio volumio[1203]: info: CoreCommandRouter::volumioGetState Mar 09 11:32:13 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:13 volumio volumio[1203]: info: CoreStateMachine::pushState Mar 09 11:32:13 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:13 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 11:32:13 volumio volumio[1203]: info: CoreCommandRouter::volumioPushState Mar 09 11:32:13 volumio volumio[1203]: info: [ASDebug] CurState: stop PrevState: stop Mar 09 11:32:13 volumio volumio[1203]: info: [GPIO_Control] Status changed: stop Mar 09 11:32:13 volumio volumio[1203]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Mar 09 11:32:13 volumio volumio[1203]: SPOTIFY: SPOTIFY VOLUME 25 Mar 09 11:32:13 volumio volumio[1203]: SPOTIFY: VOLUMIO VOLUME 23 Mar 09 11:32:13 volumio volumio[1203]: SPOTIFY: DELTA VOLUME ENOUGH: true Mar 09 11:32:13 volumio volumio[1203]: info: Setting Spotify Volume from Volumio: 23 Mar 09 11:32:14 volumio volumio[1203]: SPOTIFY: SETTING SPOTIFY VOLUME 23 Mar 09 11:32:14 volumio volumio[1203]: info: Sending Spotify command with payload to local API: /player/volume Mar 09 11:32:14 volumio go-librespot[1511]: time="2025-03-09T11:32:14+01:00" level=debug msg="update volume to 15073/65535" Mar 09 11:32:14 volumio go-librespot[1511]: time="2025-03-09T11:32:14+01:00" level=debug msg="put connect state because VOLUME_CHANGED" Mar 09 11:32:14 volumio go-librespot[1511]: time="2025-03-09T11:32:14+01:00" level=trace msg="emitting websocket event: volume" Mar 09 11:32:14 volumio volumio[1203]: SPOTIFY: received: {"type":"volume","data":{"value":23,"max":100}} Mar 09 11:32:14 volumio volumio[1203]: SPOTIFY: RECEIVED SPOTIFY VOLUME 23 Mar 09 11:32:14 volumio volumio[1203]: info: CoreCommandRouter::volumioPlay Mar 09 11:32:14 volumio volumio[1203]: info: CoreStateMachine::play index undefined Mar 09 11:32:14 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:32:14 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:14 volumio volumio[1203]: info: CoreStateMachine::startPlaybackTimer Mar 09 11:32:14 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:14 volumio volumio[1203]: info: CoreCommandRouter::volumioGetVisibleSources Mar 09 11:32:14 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 09 11:32:14 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 09 11:32:14 volumio volumio[1203]: info: [1741516334671] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/italohits/mp3-192/volumio Mar 09 11:32:14 volumio volumio[1203]: info: [1741516334671] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=283&count=2 Mar 09 11:32:16 volumio volumio[1203]: info: VolumeController::SetAlsaVolume- Mar 09 11:32:16 volumio volumio[1203]: info: CoreCommandRouter::volumioGetState Mar 09 11:32:16 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:16 volumio volumio[1203]: info: CoreStateMachine::pushState Mar 09 11:32:16 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:16 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 11:32:16 volumio volumio[1203]: info: CoreCommandRouter::volumioPushState Mar 09 11:32:16 volumio volumio[1203]: info: [ASDebug] CurState: stop PrevState: stop Mar 09 11:32:16 volumio volumio[1203]: info: [GPIO_Control] Status changed: stop Mar 09 11:32:16 volumio volumio[1203]: SPOTIFY: RECEIVED VOLUMIO VOLUME 21 Mar 09 11:32:16 volumio volumio[1203]: SPOTIFY: SPOTIFY VOLUME 23 Mar 09 11:32:16 volumio volumio[1203]: SPOTIFY: VOLUMIO VOLUME 21 Mar 09 11:32:16 volumio volumio[1203]: SPOTIFY: DELTA VOLUME ENOUGH: true Mar 09 11:32:16 volumio volumio[1203]: info: Setting Spotify Volume from Volumio: 21 Mar 09 11:32:16 volumio volumio[1203]: info: VolumeController::SetAlsaVolume- Mar 09 11:32:16 volumio volumio[1203]: info: CoreCommandRouter::volumioGetState Mar 09 11:32:16 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:16 volumio volumio[1203]: info: CoreStateMachine::pushState Mar 09 11:32:16 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:16 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 11:32:16 volumio volumio[1203]: info: CoreCommandRouter::volumioPushState Mar 09 11:32:16 volumio volumio[1203]: info: [ASDebug] CurState: stop PrevState: stop Mar 09 11:32:16 volumio volumio[1203]: info: [GPIO_Control] Status changed: stop Mar 09 11:32:16 volumio volumio[1203]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Mar 09 11:32:16 volumio volumio[1203]: SPOTIFY: SPOTIFY VOLUME 21 Mar 09 11:32:16 volumio volumio[1203]: SPOTIFY: VOLUMIO VOLUME 19 Mar 09 11:32:16 volumio volumio[1203]: SPOTIFY: DELTA VOLUME ENOUGH: true Mar 09 11:32:16 volumio volumio[1203]: info: Setting Spotify Volume from Volumio: 19 Mar 09 11:32:16 volumio volumio[1203]: info: VolumeController::SetAlsaVolume- Mar 09 11:32:16 volumio volumio[1203]: info: CoreCommandRouter::volumioGetState Mar 09 11:32:16 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:16 volumio volumio[1203]: info: CoreStateMachine::pushState Mar 09 11:32:16 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:16 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 11:32:16 volumio volumio[1203]: info: CoreCommandRouter::volumioPushState Mar 09 11:32:16 volumio volumio[1203]: info: [ASDebug] CurState: stop PrevState: stop Mar 09 11:32:16 volumio volumio[1203]: info: [GPIO_Control] Status changed: stop Mar 09 11:32:16 volumio volumio[1203]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Mar 09 11:32:16 volumio volumio[1203]: SPOTIFY: SPOTIFY VOLUME 19 Mar 09 11:32:16 volumio volumio[1203]: SPOTIFY: VOLUMIO VOLUME 17 Mar 09 11:32:16 volumio volumio[1203]: SPOTIFY: DELTA VOLUME ENOUGH: true Mar 09 11:32:16 volumio volumio[1203]: info: Setting Spotify Volume from Volumio: 17 Mar 09 11:32:17 volumio volumio[1203]: info: VolumeController::SetAlsaVolume- Mar 09 11:32:17 volumio volumio[1203]: info: CoreCommandRouter::volumioGetState Mar 09 11:32:17 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:17 volumio volumio[1203]: info: CoreStateMachine::pushState Mar 09 11:32:17 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:17 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 11:32:17 volumio volumio[1203]: info: CoreCommandRouter::volumioPushState Mar 09 11:32:17 volumio volumio[1203]: info: [ASDebug] CurState: stop PrevState: stop Mar 09 11:32:17 volumio volumio[1203]: info: [GPIO_Control] Status changed: stop Mar 09 11:32:17 volumio volumio[1203]: SPOTIFY: RECEIVED VOLUMIO VOLUME 15 Mar 09 11:32:17 volumio volumio[1203]: SPOTIFY: SPOTIFY VOLUME 17 Mar 09 11:32:17 volumio volumio[1203]: SPOTIFY: VOLUMIO VOLUME 15 Mar 09 11:32:17 volumio volumio[1203]: SPOTIFY: DELTA VOLUME ENOUGH: true Mar 09 11:32:17 volumio volumio[1203]: info: Setting Spotify Volume from Volumio: 15 Mar 09 11:32:17 volumio volumio[1203]: error: Failed request for metavolumio API Mar 09 11:32:17 volumio volumio[1203]: info: New access token = BQC05EewKzD9_xqYo_tw-MZ9Z8U1EEEHUsfZaCFHAb0dxUpUjg-nOOVvFrBcnF-HmV1f5Fbzi9x2KvbNKIxdGxCUhe4F5mi5OyqVKSV1EIzfJsQ6t9ZI5C5f97xkIwnLOmdqTxd0K54T72R4SkFJmAy2sCIE-ivbomwQcu8xo7xf4XDiwanSaeC0pGAsPDZ-KEWmAQFzFokDH506pubNhTee-qkhQWAc3ENbG_P1p5-PBMEefwxgo0zgvC5LW6A4TQsn4M89_uHvDbQ8gCcLu7mspMIDDiE-CNf5lbIF-28 Mar 09 11:32:17 volumio volumio[1203]: info: New access token = BQBw8nikMqsKYkg4RjK_2Izy1vVyEhHDQ8lg3GBAQ3_k8YQMgluNmTxdIyljv1m0Q417SArH5m7hwabDbYeYESxekfintgJL7pvQo1WS64GwNxu7K5liIzIpnJ4ZfoAGbhOEHMB2D4gImnVKX0SeBtZzfRR0OZhP_2qMYAeR27S6fDpB8fL-OwbimE4QqcQtQDVNw35cdFtGTvx8i-zdfCdlozdksytf4vH2OEgYdVxgqPNqBM9HvR-j1NJX0xxo0mI_4otD-JGY1ExlMhaofU46r1ysxlZj7zP2Of1JZrc Mar 09 11:32:18 volumio volumio[1203]: SPOTIFY: SETTING SPOTIFY VOLUME 15 Mar 09 11:32:18 volumio volumio[1203]: info: Sending Spotify command with payload to local API: /player/volume Mar 09 11:32:18 volumio go-librespot[1511]: time="2025-03-09T11:32:18+01:00" level=debug msg="update volume to 9830/65535" Mar 09 11:32:18 volumio go-librespot[1511]: time="2025-03-09T11:32:18+01:00" level=debug msg="put connect state because VOLUME_CHANGED" Mar 09 11:32:18 volumio go-librespot[1511]: time="2025-03-09T11:32:18+01:00" level=trace msg="emitting websocket event: volume" Mar 09 11:32:18 volumio volumio[1203]: SPOTIFY: received: {"type":"volume","data":{"value":15,"max":100}} Mar 09 11:32:18 volumio volumio[1203]: SPOTIFY: RECEIVED SPOTIFY VOLUME 15 Mar 09 11:32:19 volumio volumio[1203]: info: VolumeController::SetAlsaVolume+ Mar 09 11:32:19 volumio volumio[1203]: info: CoreCommandRouter::volumioGetState Mar 09 11:32:19 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:19 volumio volumio[1203]: info: CoreStateMachine::pushState Mar 09 11:32:19 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:19 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 11:32:19 volumio volumio[1203]: info: CoreCommandRouter::volumioPushState Mar 09 11:32:19 volumio volumio[1203]: info: [ASDebug] CurState: stop PrevState: stop Mar 09 11:32:19 volumio volumio[1203]: info: [GPIO_Control] Status changed: stop Mar 09 11:32:19 volumio volumio[1203]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Mar 09 11:32:19 volumio volumio[1203]: SPOTIFY: SPOTIFY VOLUME 15 Mar 09 11:32:19 volumio volumio[1203]: SPOTIFY: VOLUMIO VOLUME 17 Mar 09 11:32:19 volumio volumio[1203]: SPOTIFY: DELTA VOLUME ENOUGH: true Mar 09 11:32:19 volumio volumio[1203]: info: Setting Spotify Volume from Volumio: 17 Mar 09 11:32:19 volumio volumio[1203]: error: Failed request for metavolumio API Mar 09 11:32:19 volumio volumio[1203]: info: VolumeController::SetAlsaVolume+ Mar 09 11:32:19 volumio volumio[1203]: info: CoreCommandRouter::volumioGetState Mar 09 11:32:19 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:19 volumio volumio[1203]: info: CoreStateMachine::pushState Mar 09 11:32:19 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:19 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 11:32:19 volumio volumio[1203]: info: CoreCommandRouter::volumioPushState Mar 09 11:32:19 volumio volumio[1203]: info: [ASDebug] CurState: stop PrevState: stop Mar 09 11:32:19 volumio volumio[1203]: info: [GPIO_Control] Status changed: stop Mar 09 11:32:19 volumio volumio[1203]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Mar 09 11:32:19 volumio volumio[1203]: SPOTIFY: SPOTIFY VOLUME 17 Mar 09 11:32:19 volumio volumio[1203]: SPOTIFY: VOLUMIO VOLUME 19 Mar 09 11:32:19 volumio volumio[1203]: SPOTIFY: DELTA VOLUME ENOUGH: true Mar 09 11:32:19 volumio volumio[1203]: info: Setting Spotify Volume from Volumio: 19 Mar 09 11:32:20 volumio volumio[1203]: info: VolumeController::SetAlsaVolume- Mar 09 11:32:20 volumio volumio[1203]: info: CoreCommandRouter::volumioGetState Mar 09 11:32:20 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:20 volumio volumio[1203]: info: CoreStateMachine::pushState Mar 09 11:32:20 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:20 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 11:32:20 volumio volumio[1203]: info: CoreCommandRouter::volumioPushState Mar 09 11:32:20 volumio volumio[1203]: info: [ASDebug] CurState: stop PrevState: stop Mar 09 11:32:20 volumio volumio[1203]: info: [GPIO_Control] Status changed: stop Mar 09 11:32:20 volumio volumio[1203]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Mar 09 11:32:20 volumio volumio[1203]: SPOTIFY: SPOTIFY VOLUME 19 Mar 09 11:32:20 volumio volumio[1203]: SPOTIFY: VOLUMIO VOLUME 17 Mar 09 11:32:20 volumio volumio[1203]: SPOTIFY: DELTA VOLUME ENOUGH: true Mar 09 11:32:20 volumio volumio[1203]: info: Setting Spotify Volume from Volumio: 17 Mar 09 11:32:22 volumio volumio[1203]: SPOTIFY: SETTING SPOTIFY VOLUME 17 Mar 09 11:32:22 volumio volumio[1203]: info: Sending Spotify command with payload to local API: /player/volume Mar 09 11:32:22 volumio go-librespot[1511]: time="2025-03-09T11:32:22+01:00" level=debug msg="update volume to 11140/65535" Mar 09 11:32:22 volumio go-librespot[1511]: time="2025-03-09T11:32:22+01:00" level=debug msg="put connect state because VOLUME_CHANGED" Mar 09 11:32:22 volumio go-librespot[1511]: time="2025-03-09T11:32:22+01:00" level=trace msg="emitting websocket event: volume" Mar 09 11:32:22 volumio volumio[1203]: SPOTIFY: received: {"type":"volume","data":{"value":17,"max":100}} Mar 09 11:32:22 volumio volumio[1203]: SPOTIFY: RECEIVED SPOTIFY VOLUME 17 Mar 09 11:32:22 volumio volumio[1203]: info: New access token = BQBMbOLxthZNsxSucVXM58_WbjbtPUsgmauX1E2bXswcOjF-3QXT5UoMa98SrUegNaZE1z-DCDkPiqcVmDTkUlrSQAkpyv8x98lllJu1MDuX_2VPZl6RluYpyb6gLTDu-jfDrS6yB-Z2RREsGIP3FygoBxkMBmC7IYLg8Q0S1ojyhOE4C7tgAmVZqqP5CmBpHjGR1__7CbWOejr7926fGr1c-Inaee73AfaBkleaC_DkK9yXUFjEVBSfSJXuCbDJ-EhTMKH2tWbd7mv_Gd8f1SuTEcX8EW0uhHqh8DtYwOI Mar 09 11:32:22 volumio volumio[1203]: info: New access token = BQB_XTd-jjkCRwohpkSOs2-En6LMG1TeZRXMTRDbfSWPEQLbLzI_o_tXvDCqDL0_6hUJ6tM-KwDNqElC39yCFw_6ne1_pFg8uVxkqTo3r12Lp0sz05prGwSDunU8FTbPaWAVxU8A65xL-ABkfEGoA1QAXO6JaLFguQgEOEb4lbCkHAFIZt0CGY8Vpol9oRPegVNgrX8sevvK7dW1YifmvXRs1YmDi-MwlwxmXCGP9AMmvCBlS1Djt-ggLahhw4T6xi6wyK0_WTyy0U70F0XSm0KDmuUjMmf9ysuvkd4g-fo Mar 09 11:32:22 volumio volumio[1203]: info: CoreCommandRouter::volumioPlay Mar 09 11:32:22 volumio volumio[1203]: info: CoreStateMachine::play index undefined Mar 09 11:32:22 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:32:22 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:22 volumio volumio[1203]: info: CoreStateMachine::startPlaybackTimer Mar 09 11:32:22 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:22 volumio volumio[1203]: info: CoreCommandRouter::volumioGetVisibleSources Mar 09 11:32:22 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 09 11:32:22 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 09 11:32:22 volumio volumio[1203]: info: [1741516342588] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/italohits/mp3-192/volumio Mar 09 11:32:22 volumio volumio[1203]: info: [1741516342588] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=283&count=2 Mar 09 11:32:25 volumio volumio[1203]: info: CoreCommandRouter::volumioPlay Mar 09 11:32:25 volumio volumio[1203]: info: CoreStateMachine::play index undefined Mar 09 11:32:25 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:32:25 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:25 volumio volumio[1203]: info: CoreStateMachine::startPlaybackTimer Mar 09 11:32:25 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:25 volumio volumio[1203]: info: CoreCommandRouter::volumioGetVisibleSources Mar 09 11:32:25 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 09 11:32:25 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 09 11:32:25 volumio volumio[1203]: info: [1741516345384] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/italohits/mp3-192/volumio Mar 09 11:32:25 volumio volumio[1203]: info: [1741516345384] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=283&count=2 Mar 09 11:32:27 volumio volumio[1203]: info: New access token = BQA-DMg4AalSC1S8UOn9KcYyO4YokqKT1t00okpFmfNPxXdVtrtmelB5pqzum3ysDmBKWpeK2NpoLnRsnHuQfBKdOcPCcJDVKeOMIiJByMfGwqJ3XlVPsbcG0NzXMDq3dI5zo8z2tmRCbeeQUaumkFgoi1MTEN0b31FN3KdBEj-kTAHz_c_QGOC-Bqkg-FWQPpqrFIMt2797mTyGSUgZe_CspHmlrZKAz9q5d_nN1cVqSPhzsvYu-2zBU_f7gGXc2OftOBaQaLV_OJa1gJAv9T_tQxczRgy2FWm3hq-n5Ts Mar 09 11:32:27 volumio volumio[1203]: info: New access token = BQD-s4yJvW1gVwfQZ1havxtZDzQvGXYakV6vnyLSkKOkM1MGFPRY0Cdgir7T-6u7dUg1QtDmeXRr0s3DJdfpyhOU3M21WpfqTSDt3o8MEiIFeCmrKT8kmbTF7ne24Yz6qm_Qhp7jt_AjoRzNMgrYwtUpWZI8sF0uFoTKfUQZtO77wZQEzThU7rPHGppvlpUM6vgTsPhqT8Al2E8PlThpmnScvCHWY1UBVT5qsLQ4YvdHsKKxHfsNWxwDzZArU9D3o2kYyZLA8XIEA8Oa4sSkT965C8PmAYJUagsfR510-i4 Mar 09 11:32:32 volumio volumio[1203]: info: New access token = BQBS_GEuYLKh1mFxqbcGXUkYhNpjD5QgCrWh-ec8YvX6XO-_x67GsejKs54n3PwojG6r8XEqGWl8k-tub7GcThWf6Vh8bh_825yYAN-LIeHtmM-NpLEtLFtdTMncr-dk2sHHKDa_QMMSn6sZETnSfGJ__u-bef3jDU5xuh_6QtP2vEpdxmaut95buemVvxDobc2y-ANNoUQadynovU6Kkto7vNr6t4AhCFFQBqpRBHXAIjZ1AtH-d_aiUGRgw8ZetBCi9py_qo8p7p_OyqmrKmNzYzoYb4qGZQLkQdEttSw Mar 09 11:32:32 volumio volumio[1203]: info: New access token = BQBpymF_SI3rvM3myT6Poc0PE2CyfJyjGuTVqM_QGHGaEqyM77qQmYgUzXsm4Nqc8I0pOOq7HD1FfA9le3MnjIItqdo7YTZpaQ1u-KyQIkxNei9_Xumn0tfUjYOT_M6wFyobqI92q04wRHxMIZ_cR5x-W5-WzCNcy9utBCXSIUxOEVsItu-K0jMSHfsGFq7VXg15VAoG6y2sM4HQlDi8fdFAbc1CAHZPATPm2Bk1x-OFuSDej0CyWjHKBdfF1D1gB1I2Fydw9JnL_IFFYbmMkrenc909dH0e8-CTy9yqWIY Mar 09 11:32:37 volumio volumio[1203]: info: New access token = BQCYre6c29BmNHIQI3GzDEjd5xBzboSencp4IB1nttE477mBmLesUf0iFp1-HJ7YHaUuGsqdr-OxGOR11WxVzfYgTVHJmqRbZqb2A0Y1L7_eFjNdV1Znqf_bmYddUWEcj0gCtfbLxT6JWzjashjILdQCBzNFUqxPzcnSgf_4KDsKKPgxo633r5SJfFVTPETesg2ZYR0cOB6pBx9sBaTyokrirtQWRg8Dx-MXvN2dOItOPBUFU_fUhTFlifiKzNAThUmXBhvKKpMSUdW7rr4KbVBvpTJWWX9gQ0tHh4gh39U Mar 09 11:32:37 volumio volumio[1203]: info: New access token = BQD6Sj6I2fUv3Pt1FkiQCaPl9Arx7ihjcjTufJ7q6usIaZUOu7vCmMhEbSbHaL1hSAVp7090L0GeprJsTDP9NntHToFsDga_28BTOmL_F-iCIzNVn5kIKCIooipAIApAGAy5QhUceKICQntUWegt4Mcece753R0smaFXmXSK5D-eJi9mL-PQTIIqeFCQoNnz8zguIvrW1r2ObAlZBIWGmuRAm45d_5QuP6fSrxqAXJ8dtF7CuUpI3zMCX5kMaOmpf3vbuklBaj_lyrwcNuZp4r2UOk9Nxr7j6Qt4oJhPCRs Mar 09 11:32:38 volumio volumio[1203]: info: CoreCommandRouter::volumioRandom Mar 09 11:32:38 volumio volumio[1203]: info: CoreCommandRouter::writePlayerControls Mar 09 11:32:38 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:38 volumio volumio[1203]: info: CoreStateMachine::setRepeat true single false Mar 09 11:32:38 volumio volumio[1203]: info: CoreStateMachine::pushState Mar 09 11:32:38 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:38 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 11:32:38 volumio volumio[1203]: info: CoreCommandRouter::volumioPushState Mar 09 11:32:38 volumio volumio[1203]: info: [ASDebug] CurState: stop PrevState: stop Mar 09 11:32:38 volumio volumio[1203]: info: [GPIO_Control] Status changed: stop Mar 09 11:32:38 volumio volumio[1203]: info: [GPIO_Control] Handling event: repeatOn Mar 09 11:32:38 volumio volumio[1203]: info: [GPIO_Control] Handling event: repeatAllOn Mar 09 11:32:38 volumio volumio[1203]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Mar 09 11:32:40 volumio volumio[1203]: info: CoreCommandRouter::volumioPlay Mar 09 11:32:40 volumio volumio[1203]: info: CoreStateMachine::play index undefined Mar 09 11:32:40 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:32:40 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:40 volumio volumio[1203]: info: CoreStateMachine::startPlaybackTimer Mar 09 11:32:40 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:40 volumio volumio[1203]: info: CoreCommandRouter::volumioGetVisibleSources Mar 09 11:32:40 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 09 11:32:40 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 09 11:32:40 volumio volumio[1203]: info: [1741516360098] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/italohits/mp3-192/volumio Mar 09 11:32:40 volumio volumio[1203]: info: [1741516360098] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=283&count=2 Mar 09 11:32:41 volumio volumio[1203]: info: VolumeController::SetAlsaVolume+ Mar 09 11:32:41 volumio volumio[1203]: info: CoreCommandRouter::volumioGetState Mar 09 11:32:41 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:41 volumio volumio[1203]: info: CoreStateMachine::pushState Mar 09 11:32:41 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:41 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 11:32:41 volumio volumio[1203]: info: CoreCommandRouter::volumioPushState Mar 09 11:32:41 volumio volumio[1203]: info: [ASDebug] CurState: stop PrevState: stop Mar 09 11:32:41 volumio volumio[1203]: info: [GPIO_Control] Status changed: stop Mar 09 11:32:41 volumio volumio[1203]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Mar 09 11:32:41 volumio volumio[1203]: SPOTIFY: SPOTIFY VOLUME 17 Mar 09 11:32:41 volumio volumio[1203]: SPOTIFY: VOLUMIO VOLUME 19 Mar 09 11:32:41 volumio volumio[1203]: SPOTIFY: DELTA VOLUME ENOUGH: true Mar 09 11:32:41 volumio volumio[1203]: info: Setting Spotify Volume from Volumio: 19 Mar 09 11:32:41 volumio volumio[1203]: info: VolumeController::SetAlsaVolume+ Mar 09 11:32:41 volumio volumio[1203]: info: CoreCommandRouter::volumioGetState Mar 09 11:32:41 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:41 volumio volumio[1203]: info: CoreStateMachine::pushState Mar 09 11:32:41 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:41 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 11:32:41 volumio volumio[1203]: info: CoreCommandRouter::volumioPushState Mar 09 11:32:41 volumio volumio[1203]: info: [ASDebug] CurState: stop PrevState: stop Mar 09 11:32:41 volumio volumio[1203]: info: [GPIO_Control] Status changed: stop Mar 09 11:32:41 volumio volumio[1203]: SPOTIFY: RECEIVED VOLUMIO VOLUME 21 Mar 09 11:32:41 volumio volumio[1203]: SPOTIFY: SPOTIFY VOLUME 19 Mar 09 11:32:41 volumio volumio[1203]: SPOTIFY: VOLUMIO VOLUME 21 Mar 09 11:32:41 volumio volumio[1203]: SPOTIFY: DELTA VOLUME ENOUGH: true Mar 09 11:32:41 volumio volumio[1203]: info: Setting Spotify Volume from Volumio: 21 Mar 09 11:32:41 volumio volumio[1203]: info: VolumeController::SetAlsaVolume+ Mar 09 11:32:41 volumio volumio[1203]: info: CoreCommandRouter::volumioGetState Mar 09 11:32:41 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:41 volumio volumio[1203]: info: CoreStateMachine::pushState Mar 09 11:32:41 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:41 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 11:32:41 volumio volumio[1203]: info: CoreCommandRouter::volumioPushState Mar 09 11:32:41 volumio volumio[1203]: info: [ASDebug] CurState: stop PrevState: stop Mar 09 11:32:41 volumio volumio[1203]: info: [GPIO_Control] Status changed: stop Mar 09 11:32:41 volumio volumio[1203]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Mar 09 11:32:41 volumio volumio[1203]: SPOTIFY: SPOTIFY VOLUME 21 Mar 09 11:32:41 volumio volumio[1203]: SPOTIFY: VOLUMIO VOLUME 23 Mar 09 11:32:41 volumio volumio[1203]: SPOTIFY: DELTA VOLUME ENOUGH: true Mar 09 11:32:41 volumio volumio[1203]: info: Setting Spotify Volume from Volumio: 23 Mar 09 11:32:42 volumio volumio[1203]: info: VolumeController::SetAlsaVolume- Mar 09 11:32:42 volumio volumio[1203]: info: CoreCommandRouter::volumioGetState Mar 09 11:32:42 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:42 volumio volumio[1203]: info: CoreStateMachine::pushState Mar 09 11:32:42 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:42 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 11:32:42 volumio volumio[1203]: info: CoreCommandRouter::volumioPushState Mar 09 11:32:42 volumio volumio[1203]: info: [ASDebug] CurState: stop PrevState: stop Mar 09 11:32:42 volumio volumio[1203]: info: [GPIO_Control] Status changed: stop Mar 09 11:32:42 volumio volumio[1203]: SPOTIFY: RECEIVED VOLUMIO VOLUME 21 Mar 09 11:32:42 volumio volumio[1203]: SPOTIFY: SPOTIFY VOLUME 23 Mar 09 11:32:42 volumio volumio[1203]: SPOTIFY: VOLUMIO VOLUME 21 Mar 09 11:32:42 volumio volumio[1203]: SPOTIFY: DELTA VOLUME ENOUGH: true Mar 09 11:32:42 volumio volumio[1203]: info: Setting Spotify Volume from Volumio: 21 Mar 09 11:32:42 volumio volumio[1203]: info: VolumeController::SetAlsaVolume- Mar 09 11:32:42 volumio volumio[1203]: info: CoreCommandRouter::volumioGetState Mar 09 11:32:42 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:42 volumio volumio[1203]: info: CoreStateMachine::pushState Mar 09 11:32:42 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:42 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 11:32:42 volumio volumio[1203]: info: CoreCommandRouter::volumioPushState Mar 09 11:32:42 volumio volumio[1203]: info: [ASDebug] CurState: stop PrevState: stop Mar 09 11:32:42 volumio volumio[1203]: info: [GPIO_Control] Status changed: stop Mar 09 11:32:42 volumio volumio[1203]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Mar 09 11:32:42 volumio volumio[1203]: SPOTIFY: SPOTIFY VOLUME 21 Mar 09 11:32:42 volumio volumio[1203]: SPOTIFY: VOLUMIO VOLUME 19 Mar 09 11:32:42 volumio volumio[1203]: SPOTIFY: DELTA VOLUME ENOUGH: true Mar 09 11:32:42 volumio volumio[1203]: info: Setting Spotify Volume from Volumio: 19 Mar 09 11:32:42 volumio volumio[1203]: info: VolumeController::SetAlsaVolume- Mar 09 11:32:42 volumio volumio[1203]: info: CoreCommandRouter::volumioGetState Mar 09 11:32:42 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:42 volumio volumio[1203]: info: CoreStateMachine::pushState Mar 09 11:32:42 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:42 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 11:32:42 volumio volumio[1203]: info: CoreCommandRouter::volumioPushState Mar 09 11:32:42 volumio volumio[1203]: info: [ASDebug] CurState: stop PrevState: stop Mar 09 11:32:42 volumio volumio[1203]: info: [GPIO_Control] Status changed: stop Mar 09 11:32:42 volumio volumio[1203]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Mar 09 11:32:42 volumio volumio[1203]: SPOTIFY: SPOTIFY VOLUME 19 Mar 09 11:32:42 volumio volumio[1203]: SPOTIFY: VOLUMIO VOLUME 17 Mar 09 11:32:42 volumio volumio[1203]: SPOTIFY: DELTA VOLUME ENOUGH: true Mar 09 11:32:42 volumio volumio[1203]: info: Setting Spotify Volume from Volumio: 17 Mar 09 11:32:42 volumio volumio[1203]: info: New access token = BQAfikVsHBoC7mB2s1suq_RyyrAnUwrvfPO4izqh5NK0CacujxsPK06ThYyzuYdd29QJyg3g0RsRbK96c4uM19pRgZ6mXij37gl6_n9ubF-S4gznKAFxiEZss0QglURUiB_BWkQqAosYkw3_RUWw8kFphBvz5KzLMnz66PR6BU05MKZx8H90DMgbEgV50LVm6bfXIr_0GPpjyJ-lQYjJjLd4cmjuajy_O5Qqj1_WCkwkQv-A8Lq9vDVLMsYnEsRid0KMu_D4xTVDEbBt8OAFdOMC-phcoemIQt1VYc_p3h8 Mar 09 11:32:42 volumio volumio[1203]: info: New access token = BQB-lEg7s_4PJB3s0ijfm6r-VYYmrIUB3OZmUjMGib0kd-WsR13jxfRbT3R7NjcSczBS7O5lbztCnrWeI-K3tW8U9-AOqRRjCYg0FfPWBROycrq1PKoNpm9vYWA5vwLDSu0rtZsHW9gvEQvL6OToVzcCENhDsCEKkiYs5kkYK2JYnuhLWbKblSHnAYqckjSM2Ys7A3Y32Bqc8XA42KQXhMS-WlC5HQyG0hSCOzpkIHXZmKnL3zFafALu4NbPbOXYFdRzqimekGlrj2XnupFVnXVRJd6GbRmk4ZmoFNrLKpU Mar 09 11:32:42 volumio volumio[1203]: info: VolumeController::SetAlsaVolume- Mar 09 11:32:42 volumio volumio[1203]: info: CoreCommandRouter::volumioGetState Mar 09 11:32:42 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:42 volumio volumio[1203]: info: CoreStateMachine::pushState Mar 09 11:32:42 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:42 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 11:32:42 volumio volumio[1203]: info: CoreCommandRouter::volumioPushState Mar 09 11:32:42 volumio volumio[1203]: info: [ASDebug] CurState: stop PrevState: stop Mar 09 11:32:42 volumio volumio[1203]: info: [GPIO_Control] Status changed: stop Mar 09 11:32:42 volumio volumio[1203]: SPOTIFY: RECEIVED VOLUMIO VOLUME 15 Mar 09 11:32:42 volumio volumio[1203]: SPOTIFY: SPOTIFY VOLUME 17 Mar 09 11:32:42 volumio volumio[1203]: SPOTIFY: VOLUMIO VOLUME 15 Mar 09 11:32:42 volumio volumio[1203]: SPOTIFY: DELTA VOLUME ENOUGH: true Mar 09 11:32:42 volumio volumio[1203]: info: Setting Spotify Volume from Volumio: 15 Mar 09 11:32:44 volumio volumio[1203]: SPOTIFY: SETTING SPOTIFY VOLUME 15 Mar 09 11:32:44 volumio volumio[1203]: info: Sending Spotify command with payload to local API: /player/volume Mar 09 11:32:44 volumio go-librespot[1511]: time="2025-03-09T11:32:44+01:00" level=debug msg="update volume to 9830/65535" Mar 09 11:32:44 volumio go-librespot[1511]: time="2025-03-09T11:32:44+01:00" level=debug msg="put connect state because VOLUME_CHANGED" Mar 09 11:32:44 volumio go-librespot[1511]: time="2025-03-09T11:32:44+01:00" level=trace msg="emitting websocket event: volume" Mar 09 11:32:44 volumio volumio[1203]: SPOTIFY: received: {"type":"volume","data":{"value":15,"max":100}} Mar 09 11:32:44 volumio volumio[1203]: SPOTIFY: RECEIVED SPOTIFY VOLUME 15 Mar 09 11:32:44 volumio volumio[1203]: info: VolumeController::SetAlsaVolume+ Mar 09 11:32:44 volumio volumio[1203]: info: CoreCommandRouter::volumioGetState Mar 09 11:32:44 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:44 volumio volumio[1203]: info: CoreStateMachine::pushState Mar 09 11:32:44 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:44 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 11:32:44 volumio volumio[1203]: info: CoreCommandRouter::volumioPushState Mar 09 11:32:44 volumio volumio[1203]: info: [ASDebug] CurState: stop PrevState: stop Mar 09 11:32:44 volumio volumio[1203]: info: [GPIO_Control] Status changed: stop Mar 09 11:32:44 volumio volumio[1203]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Mar 09 11:32:44 volumio volumio[1203]: SPOTIFY: SPOTIFY VOLUME 15 Mar 09 11:32:44 volumio volumio[1203]: SPOTIFY: VOLUMIO VOLUME 17 Mar 09 11:32:44 volumio volumio[1203]: SPOTIFY: DELTA VOLUME ENOUGH: true Mar 09 11:32:44 volumio volumio[1203]: info: Setting Spotify Volume from Volumio: 17 Mar 09 11:32:44 volumio volumio[1203]: info: VolumeController::SetAlsaVolume+ Mar 09 11:32:44 volumio volumio[1203]: info: CoreCommandRouter::volumioGetState Mar 09 11:32:44 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:44 volumio volumio[1203]: info: CoreStateMachine::pushState Mar 09 11:32:44 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:44 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 11:32:44 volumio volumio[1203]: info: CoreCommandRouter::volumioPushState Mar 09 11:32:44 volumio volumio[1203]: info: [ASDebug] CurState: stop PrevState: stop Mar 09 11:32:44 volumio volumio[1203]: info: [GPIO_Control] Status changed: stop Mar 09 11:32:44 volumio volumio[1203]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Mar 09 11:32:44 volumio volumio[1203]: SPOTIFY: SPOTIFY VOLUME 17 Mar 09 11:32:44 volumio volumio[1203]: SPOTIFY: VOLUMIO VOLUME 19 Mar 09 11:32:44 volumio volumio[1203]: SPOTIFY: DELTA VOLUME ENOUGH: true Mar 09 11:32:44 volumio volumio[1203]: info: Setting Spotify Volume from Volumio: 19 Mar 09 11:32:45 volumio volumio[1203]: info: VolumeController::SetAlsaVolume+ Mar 09 11:32:45 volumio volumio[1203]: info: CoreCommandRouter::volumioGetState Mar 09 11:32:45 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:45 volumio volumio[1203]: info: CoreStateMachine::pushState Mar 09 11:32:45 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:45 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 11:32:45 volumio volumio[1203]: info: CoreCommandRouter::volumioPushState Mar 09 11:32:45 volumio volumio[1203]: info: [ASDebug] CurState: stop PrevState: stop Mar 09 11:32:45 volumio volumio[1203]: info: [GPIO_Control] Status changed: stop Mar 09 11:32:45 volumio volumio[1203]: SPOTIFY: RECEIVED VOLUMIO VOLUME 21 Mar 09 11:32:45 volumio volumio[1203]: SPOTIFY: SPOTIFY VOLUME 19 Mar 09 11:32:45 volumio volumio[1203]: SPOTIFY: VOLUMIO VOLUME 21 Mar 09 11:32:45 volumio volumio[1203]: SPOTIFY: DELTA VOLUME ENOUGH: true Mar 09 11:32:45 volumio volumio[1203]: info: Setting Spotify Volume from Volumio: 21 Mar 09 11:32:45 volumio volumio[1203]: info: VolumeController::SetAlsaVolume- Mar 09 11:32:45 volumio volumio[1203]: info: CoreCommandRouter::volumioGetState Mar 09 11:32:45 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:45 volumio volumio[1203]: info: CoreStateMachine::pushState Mar 09 11:32:45 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:45 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 11:32:45 volumio volumio[1203]: info: CoreCommandRouter::volumioPushState Mar 09 11:32:45 volumio volumio[1203]: info: [ASDebug] CurState: stop PrevState: stop Mar 09 11:32:45 volumio volumio[1203]: info: [GPIO_Control] Status changed: stop Mar 09 11:32:45 volumio volumio[1203]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Mar 09 11:32:45 volumio volumio[1203]: SPOTIFY: SPOTIFY VOLUME 21 Mar 09 11:32:45 volumio volumio[1203]: SPOTIFY: VOLUMIO VOLUME 19 Mar 09 11:32:45 volumio volumio[1203]: SPOTIFY: DELTA VOLUME ENOUGH: true Mar 09 11:32:45 volumio volumio[1203]: info: Setting Spotify Volume from Volumio: 19 Mar 09 11:32:46 volumio volumio[1203]: info: VolumeController::SetAlsaVolume- Mar 09 11:32:46 volumio volumio[1203]: info: CoreCommandRouter::volumioGetState Mar 09 11:32:46 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:46 volumio volumio[1203]: info: CoreStateMachine::pushState Mar 09 11:32:46 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:46 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 11:32:46 volumio volumio[1203]: info: CoreCommandRouter::volumioPushState Mar 09 11:32:46 volumio volumio[1203]: info: [ASDebug] CurState: stop PrevState: stop Mar 09 11:32:46 volumio volumio[1203]: info: [GPIO_Control] Status changed: stop Mar 09 11:32:46 volumio volumio[1203]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Mar 09 11:32:46 volumio volumio[1203]: SPOTIFY: SPOTIFY VOLUME 19 Mar 09 11:32:46 volumio volumio[1203]: SPOTIFY: VOLUMIO VOLUME 17 Mar 09 11:32:46 volumio volumio[1203]: SPOTIFY: DELTA VOLUME ENOUGH: true Mar 09 11:32:46 volumio volumio[1203]: info: Setting Spotify Volume from Volumio: 17 Mar 09 11:32:46 volumio volumio[1203]: info: VolumeController::SetAlsaVolume- Mar 09 11:32:46 volumio volumio[1203]: info: CoreCommandRouter::volumioGetState Mar 09 11:32:46 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:46 volumio volumio[1203]: info: CoreStateMachine::pushState Mar 09 11:32:46 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:46 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 11:32:46 volumio volumio[1203]: info: CoreCommandRouter::volumioPushState Mar 09 11:32:46 volumio volumio[1203]: info: [ASDebug] CurState: stop PrevState: stop Mar 09 11:32:46 volumio volumio[1203]: info: [GPIO_Control] Status changed: stop Mar 09 11:32:46 volumio volumio[1203]: SPOTIFY: RECEIVED VOLUMIO VOLUME 15 Mar 09 11:32:46 volumio volumio[1203]: SPOTIFY: SPOTIFY VOLUME 17 Mar 09 11:32:46 volumio volumio[1203]: SPOTIFY: VOLUMIO VOLUME 15 Mar 09 11:32:46 volumio volumio[1203]: SPOTIFY: DELTA VOLUME ENOUGH: true Mar 09 11:32:46 volumio volumio[1203]: info: Setting Spotify Volume from Volumio: 15 Mar 09 11:32:46 volumio volumio[1203]: info: VolumeController::SetAlsaVolume- Mar 09 11:32:46 volumio volumio[1203]: info: CoreCommandRouter::volumioGetState Mar 09 11:32:46 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:46 volumio volumio[1203]: info: CoreStateMachine::pushState Mar 09 11:32:46 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:46 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 11:32:46 volumio volumio[1203]: info: CoreCommandRouter::volumioPushState Mar 09 11:32:46 volumio volumio[1203]: info: [ASDebug] CurState: stop PrevState: stop Mar 09 11:32:46 volumio volumio[1203]: info: [GPIO_Control] Status changed: stop Mar 09 11:32:46 volumio volumio[1203]: SPOTIFY: RECEIVED VOLUMIO VOLUME 13 Mar 09 11:32:46 volumio volumio[1203]: SPOTIFY: SPOTIFY VOLUME 15 Mar 09 11:32:46 volumio volumio[1203]: SPOTIFY: VOLUMIO VOLUME 13 Mar 09 11:32:46 volumio volumio[1203]: SPOTIFY: DELTA VOLUME ENOUGH: true Mar 09 11:32:46 volumio volumio[1203]: info: Setting Spotify Volume from Volumio: 13 Mar 09 11:32:46 volumio volumio[1203]: info: VolumeController::SetAlsaVolume- Mar 09 11:32:46 volumio volumio[1203]: info: CoreCommandRouter::volumioGetState Mar 09 11:32:46 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:46 volumio volumio[1203]: info: CoreStateMachine::pushState Mar 09 11:32:46 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:46 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 11:32:46 volumio volumio[1203]: info: CoreCommandRouter::volumioPushState Mar 09 11:32:46 volumio volumio[1203]: info: [ASDebug] CurState: stop PrevState: stop Mar 09 11:32:46 volumio volumio[1203]: info: [GPIO_Control] Status changed: stop Mar 09 11:32:46 volumio volumio[1203]: SPOTIFY: RECEIVED VOLUMIO VOLUME 11 Mar 09 11:32:46 volumio volumio[1203]: SPOTIFY: SPOTIFY VOLUME 13 Mar 09 11:32:46 volumio volumio[1203]: SPOTIFY: VOLUMIO VOLUME 11 Mar 09 11:32:46 volumio volumio[1203]: SPOTIFY: DELTA VOLUME ENOUGH: true Mar 09 11:32:46 volumio volumio[1203]: info: Setting Spotify Volume from Volumio: 11 Mar 09 11:32:46 volumio volumio[1203]: info: VolumeController::SetAlsaVolume- Mar 09 11:32:46 volumio volumio[1203]: info: CoreCommandRouter::volumioGetState Mar 09 11:32:46 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:46 volumio volumio[1203]: info: CoreStateMachine::pushState Mar 09 11:32:46 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:46 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 11:32:46 volumio volumio[1203]: info: CoreCommandRouter::volumioPushState Mar 09 11:32:46 volumio volumio[1203]: info: [ASDebug] CurState: stop PrevState: stop Mar 09 11:32:46 volumio volumio[1203]: info: [GPIO_Control] Status changed: stop Mar 09 11:32:46 volumio volumio[1203]: SPOTIFY: RECEIVED VOLUMIO VOLUME 9 Mar 09 11:32:46 volumio volumio[1203]: SPOTIFY: SPOTIFY VOLUME 11 Mar 09 11:32:46 volumio volumio[1203]: SPOTIFY: VOLUMIO VOLUME 9 Mar 09 11:32:46 volumio volumio[1203]: SPOTIFY: DELTA VOLUME ENOUGH: true Mar 09 11:32:46 volumio volumio[1203]: info: Setting Spotify Volume from Volumio: 9 Mar 09 11:32:47 volumio volumio[1203]: info: VolumeController::SetAlsaVolume- Mar 09 11:32:47 volumio volumio[1203]: info: CoreCommandRouter::volumioGetState Mar 09 11:32:47 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:47 volumio volumio[1203]: info: CoreStateMachine::pushState Mar 09 11:32:47 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:47 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 11:32:47 volumio volumio[1203]: info: CoreCommandRouter::volumioPushState Mar 09 11:32:47 volumio volumio[1203]: info: [ASDebug] CurState: stop PrevState: stop Mar 09 11:32:47 volumio volumio[1203]: info: [GPIO_Control] Status changed: stop Mar 09 11:32:47 volumio volumio[1203]: SPOTIFY: RECEIVED VOLUMIO VOLUME 7 Mar 09 11:32:47 volumio volumio[1203]: SPOTIFY: SPOTIFY VOLUME 9 Mar 09 11:32:47 volumio volumio[1203]: SPOTIFY: VOLUMIO VOLUME 7 Mar 09 11:32:47 volumio volumio[1203]: SPOTIFY: DELTA VOLUME ENOUGH: true Mar 09 11:32:47 volumio volumio[1203]: info: Setting Spotify Volume from Volumio: 7 Mar 09 11:32:47 volumio volumio[1203]: info: VolumeController::SetAlsaVolume- Mar 09 11:32:47 volumio volumio[1203]: info: CoreCommandRouter::volumioGetState Mar 09 11:32:47 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:47 volumio volumio[1203]: info: CoreStateMachine::pushState Mar 09 11:32:47 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:47 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 11:32:47 volumio volumio[1203]: info: CoreCommandRouter::volumioPushState Mar 09 11:32:47 volumio volumio[1203]: info: [ASDebug] CurState: stop PrevState: stop Mar 09 11:32:47 volumio volumio[1203]: info: [GPIO_Control] Status changed: stop Mar 09 11:32:47 volumio volumio[1203]: SPOTIFY: RECEIVED VOLUMIO VOLUME 5 Mar 09 11:32:47 volumio volumio[1203]: SPOTIFY: SPOTIFY VOLUME 7 Mar 09 11:32:47 volumio volumio[1203]: SPOTIFY: VOLUMIO VOLUME 5 Mar 09 11:32:47 volumio volumio[1203]: SPOTIFY: DELTA VOLUME ENOUGH: true Mar 09 11:32:47 volumio volumio[1203]: info: Setting Spotify Volume from Volumio: 5 Mar 09 11:32:47 volumio volumio[1203]: info: New access token = BQAFoEwG5s8gj2y7F1clu2zIJ2VryF1EJPX-u2qn97rWuOP2xHWkDxWr5IOSJRe-4e3yaWUzZA1rrbec9X-OJCJBP_6OVYSA76B9PfnNmrsDVixKph8UwYZGyz1llvTtN4T3MlOA5-BFQrc49qykLRmsUgPUIYckdlLUH90gibBOSJaQoiNT0YcN-N8pqNdDKS4NnqxAubPqU8FPHJZqHIWrEAX03Q6x_JW6Oe1-Qf7Yi4ptdInUYqmuu_w1FDcP5lAR4HXrOqCDiI8UMclfvMcjw7V2WtHllm3WyH0kpD0 Mar 09 11:32:47 volumio volumio[1203]: info: New access token = BQC9DJCcuRC74ZHBDuxaG6t7tbAqsqTrm1Pd9CKKlMO5o8tvU_QBLQFcTbLBnDxyEr8EWGFLK_NBEjoKlmsRdt0Qbs4RNUUGxAlJrHMom5LSivy7d2bcKnIfqb3DAGhTM7O2BapSPJx2yjjaZSa-MDHsCTFWbrabPXbv-UpibJ4HlOdxriDKBFLhjmH6ZeNwehCR42pxefZ1ciTvVNX02wc5LZnGwOFKFPw-qt0vpKaFT_Ce8d4Ie2-FAUPBMjT6f6MP2xqYE1NgMBWY1VJclIhgj6Bw0WQ9vdwInKZjF74 Mar 09 11:32:47 volumio volumio[1203]: info: VolumeController::SetAlsaVolume- Mar 09 11:32:47 volumio volumio[1203]: info: CoreCommandRouter::volumioGetState Mar 09 11:32:47 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:47 volumio volumio[1203]: info: CoreStateMachine::pushState Mar 09 11:32:47 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:47 volumio volumio[1203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 11:32:47 volumio volumio[1203]: info: CoreCommandRouter::volumioPushState Mar 09 11:32:47 volumio volumio[1203]: info: [ASDebug] CurState: stop PrevState: stop Mar 09 11:32:47 volumio volumio[1203]: info: [GPIO_Control] Status changed: stop Mar 09 11:32:47 volumio volumio[1203]: SPOTIFY: RECEIVED VOLUMIO VOLUME 3 Mar 09 11:32:47 volumio volumio[1203]: SPOTIFY: SPOTIFY VOLUME 5 Mar 09 11:32:47 volumio volumio[1203]: SPOTIFY: VOLUMIO VOLUME 3 Mar 09 11:32:47 volumio volumio[1203]: SPOTIFY: DELTA VOLUME ENOUGH: true Mar 09 11:32:47 volumio volumio[1203]: info: Setting Spotify Volume from Volumio: 3 Mar 09 11:32:49 volumio volumio[1203]: SPOTIFY: SETTING SPOTIFY VOLUME 3 Mar 09 11:32:49 volumio volumio[1203]: info: Sending Spotify command with payload to local API: /player/volume Mar 09 11:32:49 volumio go-librespot[1511]: time="2025-03-09T11:32:49+01:00" level=debug msg="update volume to 1966/65535" Mar 09 11:32:49 volumio go-librespot[1511]: time="2025-03-09T11:32:49+01:00" level=debug msg="put connect state because VOLUME_CHANGED" Mar 09 11:32:49 volumio go-librespot[1511]: time="2025-03-09T11:32:49+01:00" level=trace msg="emitting websocket event: volume" Mar 09 11:32:49 volumio volumio[1203]: SPOTIFY: received: {"type":"volume","data":{"value":3,"max":100}} Mar 09 11:32:49 volumio volumio[1203]: SPOTIFY: RECEIVED SPOTIFY VOLUME 3 Mar 09 11:32:52 volumio volumio[1203]: info: New access token = BQABeSDg1QvrhdrX4-o1LSgZ61mJpbQ1Spk8pVfzKfDUz7YLZEFBjmd704ye9d1Mzx3YIfwRWWtJ3cXXqFst6CpluKS4qBoSBFxKTzNb4kTcED6hybiA28l3cLddDTLBdGYFgl0CD5Ld-eyI1SliecxtgYCJlKBJxGY9FssLjN20NXUqMoLu-jolxvNHL1X7ILa7EHXRz50u9FEAy3Vy1U--vSYRwv36sGcALtJgoL1yc5nxvJ_Xu4QrUF0bBm5IhCmlsjkAteuih8sCQvlXtwksvw5xXyF7PWFFIJs3Xsk Mar 09 11:32:52 volumio volumio[1203]: info: New access token = BQAIRCLvJor3TyovY0eJy3VWweN34IdPTl0zn8cpwMRi5sqmFQeh54im6lEB3sdSbabtTDMA8cCCibGQCgsodlYOL__hv2onfz2ILKmDpNWMJ66ML97PjGdLdQx7H8SNJgmaCtFGbxICUHUKTLF2XfF95yHocV49yLlauKSI3fuAJZIieoJF2yNRnRuwLZGGF8491C9E2nBI0tc305c4uoo-r0mCjOkN-M0gUW_f09FqRKyy451ScBHbMmhYhlk56mOC88dhJWalKrsCSOKfP09xjl2lIRC56fFgj9vcwDI Mar 09 11:32:56 volumio volumio[1203]: info: CoreCommandRouter::volumioRemoveQueueItem Mar 09 11:32:56 volumio volumio[1203]: info: CoreStateMachine::removeQueueItem Mar 09 11:32:56 volumio volumio[1203]: info: CoreStateMachine::stop Mar 09 11:32:56 volumio volumio[1203]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 11:32:56 volumio volumio[1203]: info: CorePlayQueue::removeQueueItem 0 Mar 09 11:32:56 volumio volumio[1203]: info: CorePlayQueue::saveQueue Mar 09 11:32:56 volumio volumio[1203]: info: CoreCommandRouter::volumioPushQueue Mar 09 11:32:56 volumio volumio[1203]: info: [1741516376865] [80s80s] Pushing the next song state Mr. Mister - Broken Wings and getting next track. Mar 09 11:32:56 volumio volumio[1203]: info: CorePlayQueue::getTrack 0 Mar 09 11:32:56 volumio volumio[1203]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 09 11:32:56 volumio volumio[1203]: TypeError: Cannot set property 'name' of undefined Mar 09 11:32:56 volumio volumio[1203]: at Controller80s80s.pushSongState (/data/plugins/music_service/80s80s/index.js:565:20) Mar 09 11:32:56 volumio volumio[1203]: at Controller80s80s.playNextTrack (/data/plugins/music_service/80s80s/index.js:665:34) Mar 09 11:32:56 volumio volumio[1203]: at NanoTimer.setTimeout (/data/plugins/music_service/80s80s/node_modules/nanotimer/lib/nanotimer.js:343:9) Mar 09 11:32:56 volumio volumio[1203]: at Immediate. (/data/plugins/music_service/80s80s/node_modules/nanotimer/lib/nanotimer.js:327:66) Mar 09 11:32:56 volumio volumio[1203]: at processImmediate (internal/timers.js:461:21) Mar 09 11:32:56 volumio volumio[1203]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 09 11:32:57 volumio sudo[13978]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-09 11:31 Mar 09 11:32:57 volumio sudo[13978]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="a01a833dd28483f88cb390596f5090b7187992af" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 27 Feb 2025 11:42:54 AM CET" VOLUMIO_VERSION="3.795" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4049a67f1c09d4a94e033ba35a80a144"